builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0321 starttime: 1467946143.16 results: success (0) buildid: 20160707180225 builduid: 62be7f5594694d4b9cd35c04dbdaa939 revision: be469964755162110602a8690cc9e7034fd3981b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 19:49:03.160599) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 19:49:03.161201) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 19:49:03.161601) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 19:49:03.188807) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:49:03.189536) ========= 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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-07-07 19:49:03-- 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% 52.9M=0s 2016-07-07 19:49:03 (52.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106522 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:49:03.413615) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:49:03.413939) ========= 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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.028246 ========= master_lag: 0.25 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:49:03.687645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 19:49:03.688098) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev be469964755162110602a8690cc9e7034fd3981b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev be469964755162110602a8690cc9e7034fd3981b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DiO9t2Wgnw/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.xvZTKodZrR/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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-07-07 19:49:03,771 truncating revision to first 12 chars 2016-07-07 19:49:03,772 Setting DEBUG logging. 2016-07-07 19:49:03,772 attempt 1/10 2016-07-07 19:49:03,772 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/be4699647551?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 19:49:04,811 unpacking tar archive at: autoland-be4699647551/testing/mozharness/ program finished with exit code 0 elapsedTime=1.308228 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 19:49:05.020485) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 19:49:05.020816) ========= script_repo_revision: be469964755162110602a8690cc9e7034fd3981b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 19:49:05.021241) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 19:49:05.021682) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 19:49:05.042067) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-07 19:49:05.042360) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DiO9t2Wgnw/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.xvZTKodZrR/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 19:49:05 INFO - MultiFileLogger online at 20160707 19:49:05 in /builds/slave/test 19:49:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 19:49:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:49:05 INFO - {'append_to_log': False, 19:49:05 INFO - 'base_work_dir': '/builds/slave/test', 19:49:05 INFO - 'blob_upload_branch': 'Autoland', 19:49:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:49:05 INFO - 'branch': 'Autoland', 19:49:05 INFO - 'buildbot_json_path': 'buildprops.json', 19:49:05 INFO - 'config_files': ('talos/mac_config.py',), 19:49:05 INFO - 'default_actions': ('clobber', 19:49:05 INFO - 'read-buildbot-config', 19:49:05 INFO - 'download-and-extract', 19:49:05 INFO - 'populate-webroot', 19:49:05 INFO - 'create-virtualenv', 19:49:05 INFO - 'install', 19:49:05 INFO - 'run-tests'), 19:49:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:49:05 INFO - 'download_minidump_stackwalk': True, 19:49:05 INFO - 'download_symbols': 'ondemand', 19:49:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:49:05 INFO - 'tooltool.py': '/tools/tooltool.py', 19:49:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:49:05 INFO - '/tools/misc-python/virtualenv.py')}, 19:49:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:49:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:49:05 INFO - 'installer_path': 'installer.exe', 19:49:05 INFO - 'log_level': 'info', 19:49:05 INFO - 'log_name': 'talos', 19:49:05 INFO - 'log_to_console': True, 19:49:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:49:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:49:05 INFO - 'opt_config_files': (), 19:49:05 INFO - 'pip_index': False, 19:49:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:49:05 INFO - 'cmd': ('bash', 19:49:05 INFO - '-c', 19:49:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:49:05 INFO - 'enabled': True, 19:49:05 INFO - 'halt_on_failure': False, 19:49:05 INFO - 'name': 'check_screen_resolution'},), 19:49:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:49:05 INFO - 'cmd': ('bash', 19:49:05 INFO - '-c', 19:49:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:49:05 INFO - 'enabled': True, 19:49:05 INFO - 'halt_on_failure': False, 19:49:05 INFO - 'name': 'check_screen_resolution'},), 19:49:05 INFO - 'run_cmd_checks_enabled': True, 19:49:05 INFO - 'sps_profile': False, 19:49:05 INFO - 'sps_profile_interval': 0, 19:49:05 INFO - 'suite': 'dromaeojs', 19:49:05 INFO - 'system_bits': '32', 19:49:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:49:05 INFO - 'title': 't-yosemite-r7-0321', 19:49:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:49:05 INFO - 'use_talos_json': True, 19:49:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:49:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:49:05 INFO - 'work_dir': 'build'} 19:49:05 INFO - ##### 19:49:05 INFO - ##### Running clobber step. 19:49:05 INFO - ##### 19:49:05 INFO - Running pre-action listener: _resource_record_pre_action 19:49:05 INFO - Running main action method: clobber 19:49:05 INFO - rmtree: /builds/slave/test/build 19:49:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:49:07 INFO - Running post-action listener: _resource_record_post_action 19:49:07 INFO - ##### 19:49:07 INFO - ##### Finished clobber step (success) 19:49:07 INFO - ##### 19:49:07 INFO - ##### 19:49:07 INFO - ##### Running read-buildbot-config step. 19:49:07 INFO - ##### 19:49:07 INFO - Running pre-action listener: _resource_record_pre_action 19:49:07 INFO - Running main action method: read_buildbot_config 19:49:07 INFO - Using buildbot properties: 19:49:07 INFO - { 19:49:07 INFO - "project": "", 19:49:07 INFO - "product": "firefox", 19:49:07 INFO - "script_repo_revision": "production", 19:49:07 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 19:49:07 INFO - "repository": "", 19:49:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 19:49:07 INFO - "buildid": "20160707180225", 19:49:07 INFO - "pgo_build": "False", 19:49:07 INFO - "basedir": "/builds/slave/test", 19:49:07 INFO - "buildnumber": 43, 19:49:07 INFO - "slavename": "t-yosemite-r7-0321", 19:49:07 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:49:07 INFO - "platform": "yosemite_r7", 19:49:07 INFO - "scheduler": "tests-autoland-macosx64-talos", 19:49:07 INFO - "branch": "autoland", 19:49:07 INFO - "repo_path": "integration/autoland", 19:49:07 INFO - "revision": "be469964755162110602a8690cc9e7034fd3981b", 19:49:07 INFO - "stage_platform": "macosx64", 19:49:07 INFO - "builduid": "62be7f5594694d4b9cd35c04dbdaa939", 19:49:07 INFO - "slavebuilddir": "test" 19:49:07 INFO - } 19:49:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 19:49:07 INFO - Running post-action listener: _resource_record_post_action 19:49:07 INFO - ##### 19:49:07 INFO - ##### Finished read-buildbot-config step (success) 19:49:07 INFO - ##### 19:49:07 INFO - ##### 19:49:07 INFO - ##### Running download-and-extract step. 19:49:07 INFO - ##### 19:49:07 INFO - Running pre-action listener: _resource_record_pre_action 19:49:07 INFO - Running main action method: download_and_extract 19:49:07 INFO - mkdir: /builds/slave/test/build/tests 19:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:07 INFO - https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:49:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 19:49:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 19:49:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:49:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 19:49:08 INFO - Downloaded 1199 bytes. 19:49:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:49:08 INFO - Using the following test package requirements: 19:49:08 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:49:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:49:08 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 19:49:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:49:08 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 19:49:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:49:08 INFO - u'jsshell-mac.zip'], 19:49:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:49:08 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 19:49:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:49:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:49:08 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 19:49:08 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:49:08 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 19:49:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:49:08 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 19:49:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:49:08 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 19:49:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:08 INFO - https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:49:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:49:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:49:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:49:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:49:09 INFO - Downloaded 18806322 bytes. 19:49:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:49:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:49:12 INFO - Return code: 0 19:49:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:12 INFO - https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:49:15 INFO - Downloaded 18806322 bytes. 19:49:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:49:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:49:18 INFO - Return code: 0 19:49:18 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:18 INFO - https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:49:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:49:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:49:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:49:19 INFO - Downloaded 14403333 bytes. 19:49:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:49:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:49:19 INFO - Return code: 0 19:49:19 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:19 INFO - https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 19:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 19:49:22 INFO - Downloaded 112442370 bytes. 19:49:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:49:22 INFO - mkdir: /builds/slave/test/properties 19:49:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:49:22 INFO - Writing to file /builds/slave/test/properties/build_url 19:49:22 INFO - Contents: 19:49:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:49:23 INFO - Running post-action listener: _resource_record_post_action 19:49:23 INFO - Running post-action listener: set_extra_try_arguments 19:49:23 INFO - ##### 19:49:23 INFO - ##### Finished download-and-extract step (success) 19:49:23 INFO - ##### 19:49:23 INFO - ##### 19:49:23 INFO - ##### Running populate-webroot step. 19:49:23 INFO - ##### 19:49:23 INFO - Running pre-action listener: _resource_record_pre_action 19:49:23 INFO - Running main action method: populate_webroot 19:49:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:49:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:49:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:49:23 INFO - '--tppagecycles', 19:49:23 INFO - '7'], 19:49:23 INFO - 'tests': ['tsvgm']}}, 19:49:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:49:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:49:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:49:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:49:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:49:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:49:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:23 INFO - 'talos_options': ['--disable-e10s'], 19:49:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:49:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:23 INFO - 'talos_options': ['--disable-e10s'], 19:49:23 INFO - 'tests': ['damp', 'tps']}, 19:49:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:23 INFO - 'tests': ['damp', 'tps']}, 19:49:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:49:23 INFO - 'tests': ['dromaeo_dom']}, 19:49:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:49:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:49:23 INFO - 'tests': ['basic_compositor_video']}, 19:49:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:49:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:49:23 INFO - 'tests': ['a11yr', 19:49:23 INFO - 'ts_paint', 19:49:23 INFO - 'tpaint', 19:49:23 INFO - 'sessionrestore', 19:49:23 INFO - 'sessionrestore_no_auto_restore', 19:49:23 INFO - 'tabpaint']}, 19:49:23 INFO - 'other-e10s': {'tests': ['a11yr', 19:49:23 INFO - 'ts_paint', 19:49:23 INFO - 'tpaint', 19:49:23 INFO - 'sessionrestore', 19:49:23 INFO - 'sessionrestore_no_auto_restore', 19:49:23 INFO - 'tabpaint']}, 19:49:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:49:23 INFO - 'ts_paint', 19:49:23 INFO - 'tpaint', 19:49:23 INFO - 'sessionrestore', 19:49:23 INFO - 'sessionrestore_no_auto_restore', 19:49:23 INFO - 'tabpaint']}, 19:49:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:49:23 INFO - 'ts_paint', 19:49:23 INFO - 'tpaint', 19:49:23 INFO - 'sessionrestore', 19:49:23 INFO - 'sessionrestore_no_auto_restore', 19:49:23 INFO - 'tabpaint']}, 19:49:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:49:23 INFO - 'tests': ['a11yr', 19:49:23 INFO - 'ts_paint', 19:49:23 INFO - 'tpaint', 19:49:23 INFO - 'sessionrestore', 19:49:23 INFO - 'sessionrestore_no_auto_restore', 19:49:23 INFO - 'tabpaint']}, 19:49:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:49:23 INFO - 'tests': ['a11yr', 19:49:23 INFO - 'ts_paint', 19:49:23 INFO - 'tpaint', 19:49:23 INFO - 'sessionrestore', 19:49:23 INFO - 'sessionrestore_no_auto_restore', 19:49:23 INFO - 'tabpaint']}, 19:49:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:49:23 INFO - 'tests': ['tsvgx', 19:49:23 INFO - 'tsvgr_opacity', 19:49:23 INFO - 'tart', 19:49:23 INFO - 'tscrollx', 19:49:23 INFO - 'cart']}, 19:49:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:49:23 INFO - 'tsvgr_opacity', 19:49:23 INFO - 'tart', 19:49:23 INFO - 'tscrollx', 19:49:23 INFO - 'cart']}, 19:49:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:23 INFO - 'talos_options': ['--disable-e10s'], 19:49:23 INFO - 'tests': ['tp5o']}, 19:49:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:23 INFO - 'tests': ['tp5o']}, 19:49:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:23 INFO - 'talos_options': ['--disable-e10s', 19:49:23 INFO - '--xperf_path', 19:49:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:23 INFO - 'tests': ['tp5n']}, 19:49:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:49:23 INFO - 'talos_options': ['--xperf_path', 19:49:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:49:23 INFO - 'tests': ['tp5n']}}, 19:49:23 INFO - 'talos.zip': {'path': '', 19:49:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:49:23 INFO - Running post-action listener: _resource_record_post_action 19:49:23 INFO - ##### 19:49:23 INFO - ##### Finished populate-webroot step (success) 19:49:23 INFO - ##### 19:49:23 INFO - ##### 19:49:23 INFO - ##### Running create-virtualenv step. 19:49:23 INFO - ##### 19:49:23 INFO - Running pre-action listener: _resource_record_pre_action 19:49:23 INFO - Running main action method: create_virtualenv 19:49:23 INFO - Creating virtualenv /builds/slave/test/build/venv 19:49:23 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 19:49:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:49:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:49:24 INFO - Using real prefix '/tools/python27' 19:49:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:49:24 INFO - Installing distribute.............................................................................................................................................................................................done. 19:49:27 INFO - Installing pip.................done. 19:49:27 INFO - Return code: 0 19:49:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:49:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:27 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 0x10d123a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcada4995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d087d30>, '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 0x10cdecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07fb20>, '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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 19:49:27 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 19:49:27 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 19:49:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DiO9t2Wgnw/Render', 19:49:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:49:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:49:27 INFO - 'HOME': '/Users/cltbld', 19:49:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:49:27 INFO - 'LOGNAME': 'cltbld', 19:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:27 INFO - 'MOZ_NO_REMOTE': '1', 19:49:27 INFO - 'NO_EM_RESTART': '1', 19:49:27 INFO - 'PAGER': '/bin/cat', 19:49:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:27 INFO - 'PWD': '/builds/slave/test', 19:49:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:49:27 INFO - 'SHELL': '/bin/bash', 19:49:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvZTKodZrR/Listeners', 19:49:27 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 19:49:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:49:27 INFO - 'USER': 'cltbld', 19:49:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:49:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:27 INFO - 'XPC_FLAGS': '0x0', 19:49:27 INFO - 'XPC_SERVICE_NAME': '0', 19:49:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:27 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 19:49:27 INFO - Cleaning up... 19:49:27 INFO - Return code: 0 19:49:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:49:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:27 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 0x10d123a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcada4995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d087d30>, '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 0x10cdecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07fb20>, '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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 19:49:27 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 19:49:27 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 19:49:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DiO9t2Wgnw/Render', 19:49:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:49:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:49:27 INFO - 'HOME': '/Users/cltbld', 19:49:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:49:27 INFO - 'LOGNAME': 'cltbld', 19:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:27 INFO - 'MOZ_NO_REMOTE': '1', 19:49:27 INFO - 'NO_EM_RESTART': '1', 19:49:27 INFO - 'PAGER': '/bin/cat', 19:49:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:27 INFO - 'PWD': '/builds/slave/test', 19:49:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:49:27 INFO - 'SHELL': '/bin/bash', 19:49:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvZTKodZrR/Listeners', 19:49:27 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 19:49:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:49:27 INFO - 'USER': 'cltbld', 19:49:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:49:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:27 INFO - 'XPC_FLAGS': '0x0', 19:49:27 INFO - 'XPC_SERVICE_NAME': '0', 19:49:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:28 INFO - Downloading/unpacking psutil>=3.1.1 19:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:49:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:30 INFO - Installing collected packages: psutil 19:49:30 INFO - Running setup.py install for psutil 19:49:30 INFO - building 'psutil._psutil_osx' extension 19:49:30 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 19:49:31 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 19:49:31 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 19:49:31 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 19:49:31 INFO - building 'psutil._psutil_posix' extension 19:49:31 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 19:49:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:49:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:49:31 INFO - ^ 19:49:31 INFO - 1 warning generated. 19:49:31 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 19:49:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:49:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:49:31 INFO - Successfully installed psutil 19:49:31 INFO - Cleaning up... 19:49:31 INFO - Return code: 0 19:49:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d123a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcada4995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d087d30>, '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 0x10cdecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07fb20>, '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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 19:49:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:49:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DiO9t2Wgnw/Render', 19:49:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:49:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:49:31 INFO - 'HOME': '/Users/cltbld', 19:49:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:49:31 INFO - 'LOGNAME': 'cltbld', 19:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:31 INFO - 'MOZ_NO_REMOTE': '1', 19:49:31 INFO - 'NO_EM_RESTART': '1', 19:49:31 INFO - 'PAGER': '/bin/cat', 19:49:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:31 INFO - 'PWD': '/builds/slave/test', 19:49:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:49:31 INFO - 'SHELL': '/bin/bash', 19:49:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvZTKodZrR/Listeners', 19:49:31 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 19:49:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:49:31 INFO - 'USER': 'cltbld', 19:49:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:49:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:31 INFO - 'XPC_FLAGS': '0x0', 19:49:31 INFO - 'XPC_SERVICE_NAME': '0', 19:49:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:49:32 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 19:49:32 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 19:49:32 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 19:49:32 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 19:49:32 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 19:49:32 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 19:49:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:49:34 INFO - Installing collected packages: mozsystemmonitor 19:49:34 INFO - Running setup.py install for mozsystemmonitor 19:49:34 INFO - Successfully installed mozsystemmonitor 19:49:34 INFO - Cleaning up... 19:49:34 INFO - Return code: 0 19:49:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:49:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:34 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:34 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 0x10d123a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcada4995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d087d30>, '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 0x10cdecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07fb20>, '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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 19:49:34 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 19:49:34 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 19:49:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DiO9t2Wgnw/Render', 19:49:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:49:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:49:34 INFO - 'HOME': '/Users/cltbld', 19:49:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:49:34 INFO - 'LOGNAME': 'cltbld', 19:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:34 INFO - 'MOZ_NO_REMOTE': '1', 19:49:34 INFO - 'NO_EM_RESTART': '1', 19:49:34 INFO - 'PAGER': '/bin/cat', 19:49:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:34 INFO - 'PWD': '/builds/slave/test', 19:49:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:49:34 INFO - 'SHELL': '/bin/bash', 19:49:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvZTKodZrR/Listeners', 19:49:34 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 19:49:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:49:34 INFO - 'USER': 'cltbld', 19:49:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:49:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:34 INFO - 'XPC_FLAGS': '0x0', 19:49:34 INFO - 'XPC_SERVICE_NAME': '0', 19:49:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:35 INFO - Downloading/unpacking jsonschema==2.5.1 19:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:49:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:49:37 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 19:49:37 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 19:49:37 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 19:49:37 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 19:49:37 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 19:49:37 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 19:49:37 INFO - Downloading functools32-3.2.3-2.tar.gz 19:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:49:38 INFO - warning: no files found matching '*.txt' 19:49:38 INFO - no previously-included directories found matching 'build' 19:49:38 INFO - no previously-included directories found matching 'dist' 19:49:38 INFO - no previously-included directories found matching '.git*' 19:49:38 INFO - Installing collected packages: jsonschema, functools32 19:49:38 INFO - Running setup.py install for functools32 19:49:38 INFO - warning: no files found matching '*.txt' 19:49:38 INFO - no previously-included directories found matching 'build' 19:49:38 INFO - no previously-included directories found matching 'dist' 19:49:38 INFO - no previously-included directories found matching '.git*' 19:49:38 INFO - Successfully installed jsonschema functools32 19:49:38 INFO - Cleaning up... 19:49:38 INFO - Return code: 0 19:49:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:49:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:38 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:38 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 0x10d123a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcada4995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d087d30>, '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 0x10cdecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07fb20>, '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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 19:49:38 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 19:49:38 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 19:49:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DiO9t2Wgnw/Render', 19:49:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:49:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:49:38 INFO - 'HOME': '/Users/cltbld', 19:49:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:49:38 INFO - 'LOGNAME': 'cltbld', 19:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:38 INFO - 'MOZ_NO_REMOTE': '1', 19:49:38 INFO - 'NO_EM_RESTART': '1', 19:49:38 INFO - 'PAGER': '/bin/cat', 19:49:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:38 INFO - 'PWD': '/builds/slave/test', 19:49:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:49:38 INFO - 'SHELL': '/bin/bash', 19:49:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvZTKodZrR/Listeners', 19:49:38 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 19:49:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:49:38 INFO - 'USER': 'cltbld', 19:49:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:49:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:38 INFO - 'XPC_FLAGS': '0x0', 19:49:38 INFO - 'XPC_SERVICE_NAME': '0', 19:49:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:38 INFO - Downloading/unpacking blobuploader==1.2.4 19:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:49:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:49:40 INFO - Downloading blobuploader-1.2.4.tar.gz 19:49:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:49:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:49:41 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 19:49:41 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 19:49:41 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 19:49:41 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 19:49:41 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 19:49:41 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 19:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:49:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:49:41 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 19:49:41 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 19:49:41 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 19:49:41 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 19:49:41 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 19:49:41 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 19:49:42 INFO - Downloading docopt-0.6.1.tar.gz 19:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:49:42 INFO - Installing collected packages: blobuploader, requests, docopt 19:49:42 INFO - Running setup.py install for blobuploader 19:49:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:49:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:49:42 INFO - Running setup.py install for requests 19:49:42 INFO - Running setup.py install for docopt 19:49:43 INFO - Successfully installed blobuploader requests docopt 19:49:43 INFO - Cleaning up... 19:49:43 INFO - Return code: 0 19:49:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:43 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 0x10d123a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcada4995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d087d30>, '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 0x10cdecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07fb20>, '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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 19:49:43 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 19:49:43 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 19:49:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DiO9t2Wgnw/Render', 19:49:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:49:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:49:43 INFO - 'HOME': '/Users/cltbld', 19:49:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:49:43 INFO - 'LOGNAME': 'cltbld', 19:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:43 INFO - 'MOZ_NO_REMOTE': '1', 19:49:43 INFO - 'NO_EM_RESTART': '1', 19:49:43 INFO - 'PAGER': '/bin/cat', 19:49:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:43 INFO - 'PWD': '/builds/slave/test', 19:49:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:49:43 INFO - 'SHELL': '/bin/bash', 19:49:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvZTKodZrR/Listeners', 19:49:43 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 19:49:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:49:43 INFO - 'USER': 'cltbld', 19:49:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:49:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:43 INFO - 'XPC_FLAGS': '0x0', 19:49:43 INFO - 'XPC_SERVICE_NAME': '0', 19:49:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:49:43 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-iticI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:49:43 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-nY0ihr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:49:43 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-N7UttF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:49:43 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-KcUdwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:49:43 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-XAmpVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:49:43 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-HJ57JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:49:44 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-_3N27D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:49:44 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Qi8vwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:49:44 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-kBu4UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:49:44 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-TkSg3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:49:44 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-riBgEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:49:44 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-VDYPdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:49:44 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-MuGjY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:49:44 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-rMhxkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:49:44 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-41gp5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:49:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-A9hbY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:49:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:49:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-yIxdfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:49:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:49:45 INFO - Running setup.py install for manifestparser 19:49:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:49:45 INFO - Running setup.py install for mozcrash 19:49:45 INFO - Running setup.py install for mozdebug 19:49:45 INFO - Running setup.py install for mozdevice 19:49:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:49:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:49:45 INFO - Running setup.py install for mozfile 19:49:45 INFO - Running setup.py install for mozhttpd 19:49:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:49:46 INFO - Running setup.py install for mozinfo 19:49:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:49:46 INFO - Running setup.py install for mozInstall 19:49:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:49:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:49:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:49:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:49:46 INFO - Running setup.py install for mozleak 19:49:46 INFO - Running setup.py install for mozlog 19:49:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:49:46 INFO - Running setup.py install for moznetwork 19:49:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:49:46 INFO - Running setup.py install for mozprocess 19:49:46 INFO - Running setup.py install for mozprofile 19:49:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:49:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:49:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:49:47 INFO - Running setup.py install for mozrunner 19:49:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:49:47 INFO - Running setup.py install for mozscreenshot 19:49:47 INFO - Running setup.py install for moztest 19:49:47 INFO - Running setup.py install for mozversion 19:49:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:49:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:49:47 INFO - Cleaning up... 19:49:47 INFO - Return code: 0 19:49:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:49:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:48 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 0x10d123a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcada4995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d087d30>, '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 0x10cdecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07fb20>, '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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 19:49:48 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 19:49:48 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 19:49:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DiO9t2Wgnw/Render', 19:49:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:49:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:49:48 INFO - 'HOME': '/Users/cltbld', 19:49:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:49:48 INFO - 'LOGNAME': 'cltbld', 19:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:48 INFO - 'MOZ_NO_REMOTE': '1', 19:49:48 INFO - 'NO_EM_RESTART': '1', 19:49:48 INFO - 'PAGER': '/bin/cat', 19:49:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:48 INFO - 'PWD': '/builds/slave/test', 19:49:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:49:48 INFO - 'SHELL': '/bin/bash', 19:49:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvZTKodZrR/Listeners', 19:49:48 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 19:49:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:49:48 INFO - 'USER': 'cltbld', 19:49:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:49:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:48 INFO - 'XPC_FLAGS': '0x0', 19:49:48 INFO - 'XPC_SERVICE_NAME': '0', 19:49:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:49:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Ajf8GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:49:48 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)) 19:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:49:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-sAR8pT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:49:48 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)) 19:49:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:49:48 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-wgou4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:49:49 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)) 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:49:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-_Y3Th7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:49:49 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)) 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:49:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-8bqbPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:49:49 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)) 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:49:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Beup51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:49:49 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)) 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:49:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-4bXg7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:49:49 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)) 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:49:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-CGsBCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:49:49 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)) 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:49:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-rJxQM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:49:49 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)) 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:49:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-dMSh5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:49:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:49:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ZpKZY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:49:49 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)) 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:49:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-CmGdwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:49:49 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)) 19:49:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:49:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-vwmSnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:49:50 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)) 19:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:49:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Jd9ifj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:49:50 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)) 19:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:49:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-Pq3YdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:49:50 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)) 19:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:49:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ufzgmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:49:50 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)) 19:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:49:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-0o28ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:49:50 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)) 19:49:50 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)) 19:49:50 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)) 19:49:50 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)) 19:49:50 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)) 19:49:50 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)) 19:49:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:49:50 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 19:49:50 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 19:49:50 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 19:49:50 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 19:49:50 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 19:49:50 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 19:49:53 INFO - Downloading blessings-1.6.tar.gz 19:49:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:49:53 INFO - Installing collected packages: blessings 19:49:53 INFO - Running setup.py install for blessings 19:49:53 INFO - Successfully installed blessings 19:49:53 INFO - Cleaning up... 19:49:53 INFO - Return code: 0 19:49:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:49:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:49:53 INFO - Reading from file tmpfile_stdout 19:49:53 INFO - Current package versions: 19:49:53 INFO - blessings == 1.6 19:49:53 INFO - blobuploader == 1.2.4 19:49:53 INFO - docopt == 0.6.1 19:49:53 INFO - functools32 == 3.2.3-2 19:49:53 INFO - jsonschema == 2.5.1 19:49:53 INFO - manifestparser == 1.1 19:49:53 INFO - mozInstall == 1.12 19:49:53 INFO - mozcrash == 0.17 19:49:53 INFO - mozdebug == 0.1 19:49:53 INFO - mozdevice == 0.48 19:49:53 INFO - mozfile == 1.2 19:49:53 INFO - mozhttpd == 0.7 19:49:53 INFO - mozinfo == 0.9 19:49:53 INFO - mozleak == 0.1 19:49:53 INFO - mozlog == 3.2 19:49:53 INFO - moznetwork == 0.27 19:49:53 INFO - mozprocess == 0.23 19:49:53 INFO - mozprofile == 0.28 19:49:53 INFO - mozrunner == 6.12 19:49:53 INFO - mozscreenshot == 0.1 19:49:53 INFO - mozsystemmonitor == 0.3 19:49:53 INFO - moztest == 0.7 19:49:53 INFO - mozversion == 1.4 19:49:53 INFO - psutil == 3.1.1 19:49:53 INFO - requests == 1.2.3 19:49:53 INFO - wsgiref == 0.1.2 19:49:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:53 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 0x10d123a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcada4995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d087d30>, '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 0x10cdecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07fb20>, '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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 19:49:53 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 19:49:53 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 19:49:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DiO9t2Wgnw/Render', 19:49:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:49:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:49:53 INFO - 'HOME': '/Users/cltbld', 19:49:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:49:53 INFO - 'LOGNAME': 'cltbld', 19:49:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:53 INFO - 'MOZ_NO_REMOTE': '1', 19:49:53 INFO - 'NO_EM_RESTART': '1', 19:49:53 INFO - 'PAGER': '/bin/cat', 19:49:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:49:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:53 INFO - 'PWD': '/builds/slave/test', 19:49:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:49:53 INFO - 'SHELL': '/bin/bash', 19:49:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvZTKodZrR/Listeners', 19:49:53 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 19:49:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:49:53 INFO - 'USER': 'cltbld', 19:49:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:49:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:49:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:53 INFO - 'XPC_FLAGS': '0x0', 19:49:53 INFO - 'XPC_SERVICE_NAME': '0', 19:49:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:54 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)) 19:49:54 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)) 19:49:54 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)) 19:49:54 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)) 19:49:54 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)) 19:49:54 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)) 19:49:54 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)) 19:49:54 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)) 19:49:54 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)) 19:49:54 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)) 19:49:54 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)) 19:49:54 INFO - Cleaning up... 19:49:54 INFO - Return code: 0 19:49:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:49:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d123a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d1b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcada4995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d087d30>, '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 0x10cdecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07fb20>, '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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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 19:49:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DiO9t2Wgnw/Render', 19:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:49:54 INFO - 'HOME': '/Users/cltbld', 19:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:49:54 INFO - 'LOGNAME': 'cltbld', 19:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:54 INFO - 'MOZ_NO_REMOTE': '1', 19:49:54 INFO - 'NO_EM_RESTART': '1', 19:49:54 INFO - 'PAGER': '/bin/cat', 19:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:54 INFO - 'PWD': '/builds/slave/test', 19:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:49:54 INFO - 'SHELL': '/bin/bash', 19:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvZTKodZrR/Listeners', 19:49:54 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 19:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:49:54 INFO - 'USER': 'cltbld', 19:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:54 INFO - 'XPC_FLAGS': '0x0', 19:49:54 INFO - 'XPC_SERVICE_NAME': '0', 19:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:49:54 INFO - Cleaning up... 19:49:54 INFO - Return code: 0 19:49:54 INFO - Running post-action listener: _resource_record_post_action 19:49:54 INFO - Running post-action listener: _start_resource_monitoring 19:49:54 INFO - Starting resource monitoring. 19:49:54 INFO - ##### 19:49:54 INFO - ##### Finished create-virtualenv step (success) 19:49:54 INFO - ##### 19:49:54 INFO - ##### 19:49:54 INFO - ##### Running install step. 19:49:54 INFO - ##### 19:49:54 INFO - Running pre-action listener: _resource_record_pre_action 19:49:54 INFO - Running main action method: install 19:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:49:54 INFO - Reading from file tmpfile_stdout 19:49:54 INFO - Detecting whether we're running mozinstall >=1.0... 19:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:49:54 INFO - Reading from file tmpfile_stdout 19:49:54 INFO - Output received: 19:49:54 INFO - Usage: mozinstall [options] installer 19:49:54 INFO - Options: 19:49:54 INFO - -h, --help show this help message and exit 19:49:54 INFO - -d DEST, --destination=DEST 19:49:54 INFO - Directory to install application into. [default: 19:49:54 INFO - "/builds/slave/test"] 19:49:54 INFO - --app=APP Application being installed. [default: firefox] 19:49:54 INFO - mkdir: /builds/slave/test/build/application 19:49:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:49:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:50:29 INFO - Reading from file tmpfile_stdout 19:50:29 INFO - Output received: 19:50:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:50:29 INFO - Running post-action listener: _resource_record_post_action 19:50:29 INFO - ##### 19:50:29 INFO - ##### Finished install step (success) 19:50:29 INFO - ##### 19:50:29 INFO - ##### 19:50:29 INFO - ##### Running run-tests step. 19:50:29 INFO - ##### 19:50:29 INFO - Running pre-action listener: _resource_record_pre_action 19:50:29 INFO - Running main action method: run_tests 19:50:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:50:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:50:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:50:29 INFO - 2016-07-07 19:50:29.557 screenresolution[1633:7433] starting screenresolution argv=screenresolution get 19:50:29 INFO - 2016-07-07 19:50:29.560 screenresolution[1633:7433] Display 0: 1600x1200x32@60 19:50:29 INFO - 2016-07-07 19:50:29.566 screenresolution[1634:7435] starting screenresolution argv=screenresolution list 19:50:29 INFO - Available Modes on Display 0 19:50:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:50:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:50:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:50:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:50:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:50:29 INFO - Intel Iris: 19:50:29 INFO - Chipset Model: Intel Iris 19:50:29 INFO - Type: GPU 19:50:29 INFO - Bus: Built-In 19:50:29 INFO - VRAM (Dynamic, Max): 1536 MB 19:50:29 INFO - Vendor: Intel (0x8086) 19:50:29 INFO - Device ID: 0x0a2e 19:50:29 INFO - Revision ID: 0x0009 19:50:29 INFO - Displays: 19:50:29 INFO - Display: 19:50:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:50:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:50:29 INFO - Display Serial Number: 1600x1200 60 19:50:29 INFO - Main Display: Yes 19:50:29 INFO - Mirror: Off 19:50:29 INFO - Online: Yes 19:50:29 INFO - Rotation: Supported 19:50:29 INFO - Return code: 0 19:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:50:29 INFO - Python 2.7.3 19:50:29 INFO - Return code: 0 19:50:29 INFO - grabbing minidump binary from tooltool 19:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:50:29 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 0x10d087d30>, '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 0x10cdecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d07fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:50:29 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 19:50:29 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 19:50:29 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 19:50:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:50:29 INFO - Return code: 0 19:50:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:50:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:50:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:50:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:50:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 19:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0321 --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 19:50:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DiO9t2Wgnw/Render', 19:50:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:50:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:50:29 INFO - 'HOME': '/Users/cltbld', 19:50:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:50:29 INFO - 'LOGNAME': 'cltbld', 19:50:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:50:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:50:29 INFO - 'MOZ_NO_REMOTE': '1', 19:50:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:50:29 INFO - 'NO_EM_RESTART': '1', 19:50:29 INFO - 'PAGER': '/bin/cat', 19:50:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:50:29 INFO - 'PWD': '/builds/slave/test', 19:50:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:50:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:50:29 INFO - 'SHELL': '/bin/bash', 19:50:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xvZTKodZrR/Listeners', 19:50:29 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 19:50:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:50:29 INFO - 'USER': 'cltbld', 19:50:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:50:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:50:29 INFO - 'XPC_FLAGS': '0x0', 19:50:29 INFO - 'XPC_SERVICE_NAME': '0', 19:50:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:50:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--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 19:50:30 INFO - mozversion application_buildid: 20160707180225 19:50:30 INFO - mozversion application_changeset: be469964755162110602a8690cc9e7034fd3981b 19:50:30 INFO - mozversion application_display_name: Nightly 19:50:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:50:30 INFO - mozversion application_name: Firefox 19:50:30 INFO - mozversion application_remotingname: firefox 19:50:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:50:30 INFO - mozversion application_vendor: Mozilla 19:50:30 INFO - mozversion application_version: 50.0a1 19:50:30 INFO - mozversion platform_buildid: 20160707180225 19:50:30 INFO - mozversion platform_changeset: be469964755162110602a8690cc9e7034fd3981b 19:50:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:50:30 INFO - mozversion platform_version: 50.0a1 19:50:30 INFO - using testdate: 1467946230 19:50:30 INFO - actual date: 1467946230 19:50:30 INFO - starting webserver on 'localhost:49271' 19:50:30 INFO - SUITE-START | Running 2 tests 19:50:30 INFO - TEST-START | dromaeo_css 19:50:30 INFO - operating with platform_type : mac_ 19:50:30 INFO - Initialising browser for dromaeo_css test... 19:50:30 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmprjmJKv/profile http://localhost:49271/getInfo.html) 19:50:32 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 19:50:32 INFO - PROCESS | 1644 | colorDepth:24 19:50:32 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 19:50:32 INFO - PROCESS | 1644 | __metrics 19:50:32 INFO - PROCESS | 1644 | 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" 19:50:32 INFO - PROCESS | 1644 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:50:33 INFO - TEST-INFO | 1644: exit 0 19:50:33 INFO - Browser initialized. 19:50:33 INFO - Running cycle 1/1 for dromaeo_css test... 19:50:33 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmprjmJKv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:50:45 INFO - PROCESS | 1646 | RSS: Main: 243949568 19:50:45 INFO - PROCESS | 1646 | 19:51:36 INFO - PROCESS | 1646 | 1467946296553 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] 19:53:48 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 19:53:49 INFO - PROCESS | 1646 | RSS: Main: 333807616 19:53:49 INFO - PROCESS | 1646 | 19:56:52 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 19:56:53 INFO - PROCESS | 1646 | RSS: Main: 375238656 19:56:53 INFO - PROCESS | 1646 | 19:59:55 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 19:59:55 INFO - PROCESS | 1646 | RSS: Main: 374370304 19:59:55 INFO - PROCESS | 1646 | 20:02:58 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 20:02:58 INFO - PROCESS | 1646 | RSS: Main: 367235072 20:02:58 INFO - PROCESS | 1646 | 20:06:02 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 20:06:02 INFO - PROCESS | 1646 | RSS: Main: 337125376 20:06:02 INFO - PROCESS | 1646 | 20:09:06 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 20:09:06 INFO - PROCESS | 1646 | RSS: Main: 387018752 20:09:06 INFO - PROCESS | 1646 | 20:09:06 INFO - PROCESS | 1646 | __start_tp_report 20:09:06 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 20:09:06 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 20:09:06 INFO - PROCESS | 1646 | |i|pagename|runs| 20:09:06 INFO - PROCESS | 1646 | |0;dojo.html;3353.8993830185095;3414.470757032659;3422.4695172248303;3422.57217847769;3464.774789638673;5687.232223649806;5759.424057594239;5793.68134752589;5940.702964851762;5957.851053723659;5816.738246778895;5842.795502157425;5857.8828423431505;5861.824145275638;5871.970640146793;5233.162693968966;5280.339957505312;5315.309009828717;5323.361196656388;5365.651232669864;5352.170413585881;5361.946380536203;5376.784928602851;5383.67697938123;5383.973080134594;5268.631195816294;5304.946950530484;5309.150535914255;5313.867153321178;5349;5379.246905433242;5384.865378365533;5385.21914322423;5391.4608539145775;5399.19012148177;5125.897482050338;5223.190405487156;5249.501297376743;5330.520253177194;5336.985972665181;5707.058335374658;5720.342160651537;5743.195952566644;5770.913436298459;5777.59556831022;6335.8416039598915;6351.809445716636;6354.9364506354805;6355.046742988542;6365.968170159166;6152.87694246117;6286.842828929268;6337.366263373672;6345.397187267202;6349.4602958748565;5972.402759723993;5981.730822113015;6002.129691194752;6005.309389420186;6016.2479690038745;6355.110284560165;6362.586431881913;6365.681715914278;6367.172267605274;6372.076048972873;6122.112293717386;6127.111568822585;6141.293751218578;6141.363270730659;6244.562880598405;6304.65324407162;6315.5894866833505;6323.494120470444;6327.841803954846;6331.68341582919;6057.303410107894;6246.718897649616;6299.811005669837;6307.747690092437;6313.684315784192;6155.969220153871;6200.441960223601;6207;6237.781677641261;6327.114204011442;5017.096922553902;5030.572401345853;5057.671251368649;5063.746812659352;5104.464031276737;4533.909321813545;4537.296719008559;4543.932175938652;4562.361269422284;4577.496475387705;5691.715414229272;5763.769449222068;5766.769329226868;5842.065269556851;5845.532357411397;6302.243730752248;6304.936950630527;6322;6334.081558174039;6365.618062916147;5826.766929322865;5833.883322333614;5857.326407463196;5870.823875283749;5922.615030023035;5393.379761327497;5429.212764149176;5473.67157970523;5495.917561236584;5508.862278443071;6316.810495685137;6331.778387756499;6367;6400.839979000562;6408.6475243861105;6166.414190651881;6280.152179455715;6318.936810631835;6331.366863313632;6344.968275158594;6259.718312676032;6297.496200304056;6348.682565871781;6403.615783053032;6416.518761092843;6302.180716506825;6307.400796924285;6311.810645680637;6323.146375239284;6348.682565871781;6180.196574445294;6262.123302737529;6340.682965851597;6364.840878978062;6366.681665916593;5568.220449137043;6143.96928015357;6220.720067596879;6228.844278893064;6243.469305109116;6165.612971420551;6213.2233470816145;6213.316535181036;6214.875702486015;6224.502039836892;5865.354810970704;6052.243469566304;6097.524678803442;6099.054646529795;6101.671357587044;5372.140457526777;5994.831007953408;6079.635221886701;6106.5820131054825;6173.753049877954;5992.250968628921;6073.696315184311;6111.113888486056;6112.786052488142;6114.633122012693 20:09:06 INFO - PROCESS | 1646 | |1;ext.html;471.7263986887605;487.8024400117951;489.7991823352425;529.5869222006834;553.7342075803614;33454.330913381746;42527;42592.361114583306;42643.36034959478;44377.77811110948;44148.89627759308;44562.554374456246;44614.55385446145;44658.77670611643;44714.7764261179;8869.201771840533;9080.137386948229;9798.999999999982;9981.251406144533;9985.900140998607;8832.690855820048;8933.374663773506;8934.151255630737;11873.52505899763;12115.757684846298;12141.57504487343;12209.450574724115;12214.32821194834;12215.816762748522;12257.14200006;12067.336296503689;12130.757384852343;12143.089268304913;12162.270263784201;12167.209131406431;8688.695895643685;11622.418879056013;11936.462859171272;11938;12169.452374643162;41804;42048.36927446091;42188;42265.788671056755;42298;3592.9820350898076;3653.5433070866143;3681.042928838521;3695.170800885737;4234.153169366139;31651.683483165336;32935.835320823484;33237.50143747846;33302;33408.83295583531;3286.5398844161837;3359.6808303211155;3381.7487529613954;3389.67798059184;3412.4198886189406;523890;524497;525676;528109;528526;51892.740536297075;62868.05697914535;63185.36814631887;63353.04970425355;63398.68300658467;65731;65856.34143658598;65943;66075.66962165158;66119.66940165269;16746.4138755143;16961.745573816403;16965;16982.23579938906;17021.914890425716;11802.055835533136;13100.082994190316;13148.868511314955;13175.945924326032;13209.273489958145;15145.697086058217;17165.399211027554;17584.208710608054;17594;18049.819501805076;5803.984302747002;6904.516683832084;6991.265917078634;7043.647817609201;7127.7148914042855;894.9373543851868;983.4836710726926;992.9325974577358;1073.1575713065206;1091.7270682329417;25643;30327;30410.54384184239;31221;31554.36891262162;1053.0206907575875;1066.4294602387686;1106.1372129738816;1138.5047504335641;1147.1568397228032;15523;15853.762193567105;16071.35714571404;16188.595285117966;16352.892811681195;191905;192604;192870;193032.06967930423;716950;60209;61029.77940441166;61253.69373153195;65465.01802472967;65470.67264663742;1420.5383250443647;1431.3701971132668;1447.0883343493742;1449.2029383838847;1451.078565111141;31721;31768.364632706754;31776.841115794272;32706.67293327036;32997;52800.735996319774;58529.12206316824;59426.405735943816;59804.40195598162;63408.68295658492;616257;623521;624971;625412;627989;27087.322816929733;27365.86317068402;27459.862700686368;27551.035713749923;27564.724352756217;48956.75521622369;49301.75349123232;49991.75004125101;50977.490225097274;50996;40977;41131.97170070772;41713.79143104265;42543;42738.78630606827;40395.3940690884;40480.1903961925;40606.187876242904;41537.37693934654;41769;38640.921899064575;39607;39735;39876.401853971634;41530.37704434375;33139.50290745689;36053.27893442064;36186.638133618326;43129.35305970476;43754;31324.843375782973;33201.16997074996;33342.99971000874;33496.33007339888;33674.54643219852 20:09:06 INFO - PROCESS | 1646 | |2;jquery.html;349.85830738550897;376.7136975898317;380.714464151886;383.88099689096384;399.28328650073115;15701.685966280682;15802.13088280144;20470.181192752272;21099.6835047474;21654;21117.788822111812;21251;21781;21801.563968720617;22096.22663206788;5214.400343960437;5804.767809287634;5968.462838344548;6255.749770009194;6256.749730010794;6128.479079278267;6201.255849298068;6232;6238.500919926395;6244.718987645544;5993.88012239755;6090.188750886817;6117.082437634368;6123.540734444912;6187.938120618804;5947.791827286068;6082;6137.969310153443;6177.073438984144;6178.320384757673;5312.309399778004;5322.3879253885525;5327.520523152934;5329.360476742777;5336.092864213093;13721.725565488734;22720.54558908829;24119.638205426934;25556.616650750253;26684.19947401581;2157.094020511389;2244.236959433784;2351.165336305604;2402.5435167318155;2409.638554216864;9951.950240248825;10122.392656440637;10155.187584993182;10161.288709790319;10498.475076246157;1742.30307876849;1821.1895706410653;1935.3516571948414;1985.0670185013166;2038.7043878637514;118817;122485.38757306157;124139.37930310381;124503.37748311291;126678;9432.528373581294;11505;11568.479418426192;11673.416329183507;11783.764324713458;14427.278636068155;14509.782353264709;14515.201663908587;14551.3451894665;14555.854441455662;8394.412391132684;8594.269487093543;8612.397132200686;8688.739337819748;8705.825883482295;8508.191721786421;8515.40392172542;8525.01962274334;8647.783805404915;8652.653893844301;3732.869349572752;4478.753668548196;4557.088582283556;4611.746353950565;4617.746023968714;1872;1913.9425817225506;1924.6054558815408;1944.6888497840278;1964.2830366915973;830.9169083091642;840.9537475438788;949.9525023748923;950.9144177024101;988.1748739802202;20346.694799578017;21462.78537214639;21607.91960402005;21636.45908852291;21718.348449546538;934.8550974598948;942.7696855603366;956.5073986896754;962.5764663548016;988.6737376665683;10890.23768336209;11392.715182120348;11420.37187954654;11422.828657570142;11433.656990290305;610758;610867;611134;615424;633025;134568;135585.322073389;136238;137530;139268;946.1531928923575;1004.542932965499;1005.9245556583286;1007.7480629842539;1008.5763979128931;18826.811731882506;19199.424017279503;19203.615927681647;19284.903575482032;19289.807101929364;52371.47628523818;52517.7374113127;52618.94762104813;53169.99999999845;53625.731871340395;77147.22852771624;77443.06392340011;78037;78129.82805257812;79806.20193797987;8064.274215320649;8082.313003394777;8144.389170812095;8156.877646835183;8313.584320784057;12438.440270187682;12635.494580217057;12851.550195743104;12943.805842912552;13216.933915330363;11076.335419874833;11192.328460292409;11286.604968826052;11379.487923043318;11469.541218351173;11138.832917506083;11255.493502792231;11344;11406.885931140583;11464.656060318204;11409.714757131138;11498.885011149781;11576.24754390962;11705.005074568757;11706.239094458833;8039.437239393186;8057.758267251992;8085.110637829952;8137.389695772722;8297.792555186168;8270.2556769891;10711.94644026775;11166.888331116585;11215.66353009411;11247.268927520012 20:09:06 INFO - PROCESS | 1646 | |3;mootools.html;1389.034620938447;1547.6517783498712;1579.8262191158974;1796.9730454043192;1949.941501754947;7924.881126783102;8750.343724220686;9004.864927026092;9018.774530636738;9108.089191080888;8742.694005709802;8943.686970956018;8966;8970.641174353035;8976.281897448205;2086.3740877736695;2164.967525487119;2295;2360.5396947595227;2388.856668599881;1990.8407327413845;2025.9392218233477;2381.226101517005;2419.806415486757;2430.963535546968;2026.9865067466267;2341.4497593065616;2343.50786334869;2360.33910505058;2386.713594368678;2053.3634573282256;2235.7093577834776;2321.292005938188;2321.9883900580558;2353.788159065684;2371.193794110011;2391.366287933699;2391.5216956608574;2396.125414223813;2401.807855371566;8871.911280887172;8945.642174313085;8947.32895032875;8955.462672239686;8961.46231226122;5245.501677340647;5264.341957255343;5401.891962160735;5405.864853378657;5414.40441551429;3544.043108360754;3602.8018458984743;3666.5783434904793;3673.4673472346626;3676.356637588411;1062.6918193723811;1084.4957094950807;1084.5282302198568;1104.1884215101893;1111.0778054214982;11926.522939082513;11928.343941083323;11938.462769175409;11938.985186259179;11954.701132471671;4575.107853968444;4688.249880019249;4816.422029356429;4862.78117484714;4863.927041094386;7889.6844126235455;10053.04496072872;10081.49592520371;10088.192944564416;10113.544890479947;5379.623426360117;5379.9778042171865;5383.0041442333295;5384.6769193848495;5386.461353864583;4379.802908869108;4541.43232095988;4749.168895443353;4884.291777692215;4898.681585696918;3879.2241551689776;3924.823382947774;4026.859059932947;4044.8179831907637;4045.8988525287104;1172.6013155526991;1268.5496648689766;1280.270245959794;1281.532240732126;1292.043887523226;796.8844517544924;917.2020342302106;941.8398872191743;942.3827393057559;978.6134476881734;5447.400785913546;6098.664573448503;6116.694165291718;6190.3190649028575;6212.06818977157;807.769785611098;930.9813803723888;934.3833070173789;957.4398976598628;988.8862780780158;4050.7164498485413;4099.692523060723;4111.362738775495;4167.937480937789;4177.644900183458;10569.471526423647;10791.892081079088;10889.455527223607;10898.455077246106;10939.671809845717;9627.855582166274;10357.75706915175;10877.945610271898;10902.400367979679;10911.23621346514;7886.250806173404;8297.211764882326;8298.21166989147;8324.500529968222;8395.454295470898;6091.573589848668;6133;6137.079438084144;6141.293751218667;6278.811635650938;9418.199453046294;10030.699079027641;10271.332363396356;10276;10303.484825758833;10202.285839991426;10237.590496380062;10427.635032773816;10485.003924627148;10522.631707890187;6702.899456508058;7046.823829404306;7319.74380896666;7581.090269167735;8012.278894899254;8345.707900223462;8432.409731318749;8460.619272132892;8522.403431759965;8523.616437260462;7462.8507429850015;7570.545767253982;7571.621418928921;7581.469297149367;7582.886256706043;7310.853782924418;7438.516496427715;7459.477836551607;7548.584827834522;7555.244475552401;6997.685104170223;7013.929860701328;7049.9647501762165;7052.118485189351;7059.964700176466;4426.247537918497;4922.4585295616735;5081.390233172043;5148.330717006766;5169.224616307433;5157.329547158845;5169.560587349967;5222.921656175236;5246.8163614274845;5331.733413329395 20:09:06 INFO - PROCESS | 1646 | |4;prototype.html;293.923579869234;306.26190879979254;307.32848725534706;312.45320688794607;313.6299166982959;4711.246200607903;5407.215618845781;5470.933168032236;5489.972550137249;5548.91676624851;4456.398386217859;4527.845399423142;4621.468531118922;5489.945100548994;5497.615166938306;3837.347650899354;3981.741186822862;4044.2720310344125;4130.524989626187;4135.27632664284;3530.9823450882836;3594.19130695594;4086.2031903778775;4127.401526778615;4179.623833854953;3582.7133829293725;3897.7466464679705;3940.4089386591954;3981.362981922893;4144.97927510362;3311.3708395404915;3885.339492286318;4058.0057885818164;4071;4186.727862688916;3556.6621170988715;3597.9280414391565;3598.784072955631;3604.297162053401;3615.14403621139;4675.064987002613;4964;5242.501962313574;5259.316288882459;5336.172893201521;4486.415633937079;4742.217534106868;4749.9762501187615;4755.667103302771;4772.141014617368;4612.95387046132;5133;5244.318238628992;5661.886762264731;5731.656100633975;3990.6009399060154;4006.6193711597352;4012.3179059559943;4017.4733601231346;4028.4561584186054;4905.77923993414;4988.975055124701;5241.030409374278;5459.890802183934;5964.284285885721;3865.091703449687;3873.341531939577;3891.221755648825;3895.9610403896163;3900.395438707005;3520.9261175341253;3638.9818050909576;3908.7068469864876;3948.4008976364044;3964.623360780721;3968.7420317679257;3989.5212574491247;4560.042391097906;4643.767811609406;4689.249720044844;4961.751912404366;5704.20317599963;5710.543156547549;5717.485426311652;5736.537183018304;1392.735380277744;1413.6923345904997;1416.730821144;1419.7373485904934;1420.666143456287;738.5236522442995;807.9030516337959;822.1778221778221;879.5514287713185;883.6686242659002;5058.671186372948;5101.240072175094;5247.763850626731;5274.92087618686;5280.577553795687;4515.63874890008;4699.013207226452;5344.786208551692;5715.657060576379;5890.263717035371;4276.465441819772;4989.875253118701;5272.868178295496;5304.522592966651;5320.536852365553;2676.5776971840514;2877.525208340642;3006.428778532072;3037.255872311254;3051.2066862615434;5294.411676497036;5475.631092226943;5578.442155784389;6011.6693581853415;6064.696765161724;4831.396075490564;4933.01339732055;5645.689487078168;6023.518118550505;6172;5477.1510415885605;5942.494887934487;6077.845209410198;6189.319174890848;6207.379262073847;5665.405132461032;5987.5808693391045;6007.699615019319;6034.969825150846;6048;5331.533828197277;5699.658020518782;5782.508486778671;5837.219648007229;5853.1220316952795;6087.634741915499;6145.0028740660355;6155.84610384744;6171.228596425447;6181.907271390843;3339.933201336008;3433.2275238072234;3798.24035192957;3908.459501324162;3925.391564307537;4758.881027974328;5002.623753717101;5843.211166492639;5850.765969361178;5865.618734782225;4640.767961601839;5745.827625171251;5775.162601422854;5794.449527294901;5817.621854579439;5498.0653288940175;5667.659940403424;5687.829365119053;5719;5775.306963164448;5563.638363506359;5586.636868603528;5601.271834661468;5632.605717599728;5710.3433105193435;4577.473590537131;5449.964506743706;5583.5103060587135;5595.251181708347;5658.886822263449;5541.944580554143;5595.468430499096;5656.9717151415625;5671.8865622688145;5673.8865222694485 20:09:06 INFO - PROCESS | 1646 | |5;yui.html;734.966926488308;750.2272659161066;791.3827214772476;807.37428492918;846.382141037043;14943.850561494382;15629.765553516692;16362.918185409086;16377.344906203767;16412.343506259764;14723.190224537646;14936.701265974674;14950.10299382038;14959;14996.10023398594;700.8738427083123;723.5947869193242;870.4516154822453;875.7941883657336;906.9274458043341;866.2290561400328;879.3404946290283;880.3881302494768;881.8853549038648;884.3014018925073;942.1473566422399;943.5518128888791;944.773254418938;945.1021529546923;945.957431915562;728.752224243757;928.2666693312275;938.1697197979769;960.011188475871;962.5091203486203;693.6219760230636;701.3302296307014;702.9191642961023;703.9824004399879;704.6441547018774;13033.413496392684;15700.842991570053;15703.293351799197;15708.842911570966;15739.134347610876;14815;14824.407023719039;14880.107193568312;14988.47540336083;14992.870035201011;11997.34014629195;12246.44890979908;12457.065720070941;12481.625551233386;12579.245245285312;3826.9617303826885;3844.2119365529998;4059.025833799896;4087.1008378156757;4094.1197642506704;115811.42094289475;115981;116234;116251.41874290575;116321.41839290834;11558.30650160993;11626.302421854716;11645.88354116448;11690.590829320932;11718.121140914465;24459.510809783704;24473.510529789306;24507.01971921139;24520.754792452204;24525.877370613034;7909.7231596893835;8114.310283625958;8164.836703265902;8223.54770487629;8224.97281677769;4229.175310814423;4427.480916030547;4449.555044495524;4556.225441674923;4734.976325118352;3592.2815436912724;3709.2025214578994;3710.05393624624;3712.3688972874675;3724.031751744512;545.8007827143143;553.5516231852213;625.5464788028734;643.9001954697029;655.6951017776756;559.2366419836893;617.8353803081135;634.9714262858182;665.9996714799893;681.465049935798;7787.844243115106;9170.816583668422;9277.58250878712;9311.301652376098;9386.85919711205;536.1102115044422;569.7720911635296;582.5485248932112;592.9673867937305;623.2614351992903;4287.957120428819;4411.830864820825;4741.974928174473;4760.33355330254;4850.563449289511;96153;133468;141004.2949785265;159942;163299;106207;135458;138599;141640;142201;74665;85415.71876421859;97634;99961;110233;6330.8100756977365;8767.473951562926;8778.429402088845;8912.598933048159;9004.144606262656;44805.32792008188;51819.704507387614;61613.69193154185;64595.671583656556;65320.673396632716;83958.58020710101;90072;93303;93985;94102;11959.760804783682;12078.818817717565;12090;12244.204126731735;12468.5012599495;13174;13175.407106680032;13349.933250333686;13406.798898016732;13921.025528212927;11982.161248712506;12101.818472723093;12223.327716975651;12483.12618116723;12576.119671622899;12080.637580872588;12136.33250171249;12210.694732631755;12229;12540.498380064695;11940.52237910474;12073.818892716792;12339.75320493603;12453.75092498163;12480.875191248335;10341.689749307532;10666.466676665981;10755.354678719303;10771.246012779031;10911.727206819576;10274.845877311996;10513.474326283502;10529.315594486334;10531;10587.682369528926 20:09:06 INFO - PROCESS | 1646 | __end_tp_report 20:09:06 INFO - PROCESS | 1646 | __start_cc_report 20:09:06 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1281 20:09:06 INFO - PROCESS | 1646 | __end_cc_report 20:09:06 INFO - PROCESS | 1646 | __startTimestamp1467947346311__endTimestamp 20:09:06 INFO - PROCESS | 1646 | 20:09:06 INFO - PROCESS | 1646 | ------- Summary: start ------- 20:09:06 INFO - PROCESS | 1646 | Number of tests: 6 20:09:06 INFO - PROCESS | 1646 | 20:09:06 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5831.21 Median:6073.70 stddev:629.63 (10.4%) stddev-sans-first:600.82 20:09:06 INFO - PROCESS | 1646 | Values: 3353.9 3414.5 3422.5 3422.6 3464.8 5687.2 5759.4 5793.7 5940.7 5957.9 5816.7 5842.8 5857.9 5861.8 5872.0 5233.2 5280.3 5315.3 5323.4 5365.7 5352.2 5361.9 5376.8 5383.7 5384.0 5268.6 5304.9 5309.2 5313.9 5349.0 5379.2 5384.9 5385.2 5391.5 5399.2 5125.9 5223.2 5249.5 5330.5 5337.0 5707.1 5720.3 5743.2 5770.9 5777.6 6335.8 6351.8 6354.9 6355.0 6366.0 6152.9 6286.8 6337.4 6345.4 6349.5 5972.4 5981.7 6002.1 6005.3 6016.2 6355.1 6362.6 6365.7 6367.2 6372.1 6122.1 6127.1 6141.3 6141.4 6244.6 6304.7 6315.6 6323.5 6327.8 6331.7 6057.3 6246.7 6299.8 6307.7 6313.7 6156.0 6200.4 6207.0 6237.8 6327.1 5017.1 5030.6 5057.7 5063.7 5104.5 4533.9 4537.3 4543.9 4562.4 4577.5 5691.7 5763.8 5766.8 5842.1 5845.5 6302.2 6304.9 6322.0 6334.1 6365.6 5826.8 5833.9 5857.3 5870.8 5922.6 5393.4 5429.2 5473.7 5495.9 5508.9 6316.8 6331.8 6367.0 6400.8 6408.6 6166.4 6280.2 6318.9 6331.4 6345.0 6259.7 6297.5 6348.7 6403.6 6416.5 6302.2 6307.4 6311.8 6323.1 6348.7 6180.2 6262.1 6340.7 6364.8 6366.7 5568.2 6144.0 6220.7 6228.8 6243.5 6165.6 6213.2 6213.3 6214.9 6224.5 5865.4 6052.2 6097.5 6099.1 6101.7 5372.1 5994.8 6079.6 6106.6 6173.8 5992.3 6073.7 6111.1 6112.8 6114.6 20:09:06 INFO - PROCESS | 1646 | 20:09:06 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:64613.20 Median:39123.96 stddev:138272.29 (353.4%) stddev-sans-first:138576.31 20:09:06 INFO - PROCESS | 1646 | Values: 471.7 487.8 489.8 529.6 553.7 33454.3 42527.0 42592.4 42643.4 44377.8 44148.9 44562.6 44614.6 44658.8 44714.8 8869.2 9080.1 9799.0 9981.3 9985.9 8832.7 8933.4 8934.2 11873.5 12115.8 12141.6 12209.5 12214.3 12215.8 12257.1 12067.3 12130.8 12143.1 12162.3 12167.2 8688.7 11622.4 11936.5 11938.0 12169.5 41804.0 42048.4 42188.0 42265.8 42298.0 3593.0 3653.5 3681.0 3695.2 4234.2 31651.7 32935.8 33237.5 33302.0 33408.8 3286.5 3359.7 3381.7 3389.7 3412.4 523890.0 524497.0 525676.0 528109.0 528526.0 51892.7 62868.1 63185.4 63353.0 63398.7 65731.0 65856.3 65943.0 66075.7 66119.7 16746.4 16961.7 16965.0 16982.2 17021.9 11802.1 13100.1 13148.9 13175.9 13209.3 15145.7 17165.4 17584.2 17594.0 18049.8 5804.0 6904.5 6991.3 7043.6 7127.7 894.9 983.5 992.9 1073.2 1091.7 25643.0 30327.0 30410.5 31221.0 31554.4 1053.0 1066.4 1106.1 1138.5 1147.2 15523.0 15853.8 16071.4 16188.6 16352.9 191905.0 192604.0 192870.0 193032.1 716950.0 60209.0 61029.8 61253.7 65465.0 65470.7 1420.5 1431.4 1447.1 1449.2 1451.1 31721.0 31768.4 31776.8 32706.7 32997.0 52800.7 58529.1 59426.4 59804.4 63408.7 616257.0 623521.0 624971.0 625412.0 627989.0 27087.3 27365.9 27459.9 27551.0 27564.7 48956.8 49301.8 49991.8 50977.5 50996.0 40977.0 41132.0 41713.8 42543.0 42738.8 40395.4 40480.2 40606.2 41537.4 41769.0 38640.9 39607.0 39735.0 39876.4 41530.4 33139.5 36053.3 36186.6 43129.4 43754.0 31324.8 33201.2 33343.0 33496.3 33674.5 20:09:06 INFO - PROCESS | 1646 | 20:09:06 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:35899.83 Median:2376.85 stddev:103044.17 (4335.3%) stddev-sans-first:103298.66 20:09:06 INFO - PROCESS | 1646 | Values: 349.9 376.7 380.7 383.9 399.3 15701.7 15802.1 20470.2 21099.7 21654.0 21117.8 21251.0 21781.0 21801.6 22096.2 5214.4 5804.8 5968.5 6255.7 6256.7 6128.5 6201.3 6232.0 6238.5 6244.7 5993.9 6090.2 6117.1 6123.5 6187.9 5947.8 6082.0 6138.0 6177.1 6178.3 5312.3 5322.4 5327.5 5329.4 5336.1 13721.7 22720.5 24119.6 25556.6 26684.2 2157.1 2244.2 2351.2 2402.5 2409.6 9952.0 10122.4 10155.2 10161.3 10498.5 1742.3 1821.2 1935.4 1985.1 2038.7 118817.0 122485.4 124139.4 124503.4 126678.0 9432.5 11505.0 11568.5 11673.4 11783.8 14427.3 14509.8 14515.2 14551.3 14555.9 8394.4 8594.3 8612.4 8688.7 8705.8 8508.2 8515.4 8525.0 8647.8 8652.7 3732.9 4478.8 4557.1 4611.7 4617.7 1872.0 1913.9 1924.6 1944.7 1964.3 830.9 841.0 950.0 950.9 988.2 20346.7 21462.8 21607.9 21636.5 21718.3 934.9 942.8 956.5 962.6 988.7 10890.2 11392.7 11420.4 11422.8 11433.7 610758.0 610867.0 611134.0 615424.0 633025.0 134568.0 135585.3 136238.0 137530.0 139268.0 946.2 1004.5 1005.9 1007.7 1008.6 18826.8 19199.4 19203.6 19284.9 19289.8 52371.5 52517.7 52618.9 53170.0 53625.7 77147.2 77443.1 78037.0 78129.8 79806.2 8064.3 8082.3 8144.4 8156.9 8313.6 12438.4 12635.5 12851.6 12943.8 13216.9 11076.3 11192.3 11286.6 11379.5 11469.5 11138.8 11255.5 11344.0 11406.9 11464.7 11409.7 11498.9 11576.2 11705.0 11706.2 8039.4 8057.8 8085.1 8137.4 8297.8 8270.3 10711.9 11166.9 11215.7 11247.3 20:09:06 INFO - PROCESS | 1646 | 20:09:06 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5767.28 Median:4874.11 stddev:3241.42 (66.5%) stddev-sans-first:3233.81 20:09:06 INFO - PROCESS | 1646 | Values: 1389.0 1547.7 1579.8 1797.0 1949.9 7924.9 8750.3 9004.9 9018.8 9108.1 8742.7 8943.7 8966.0 8970.6 8976.3 2086.4 2165.0 2295.0 2360.5 2388.9 1990.8 2025.9 2381.2 2419.8 2431.0 2027.0 2341.4 2343.5 2360.3 2386.7 2053.4 2235.7 2321.3 2322.0 2353.8 2371.2 2391.4 2391.5 2396.1 2401.8 8871.9 8945.6 8947.3 8955.5 8961.5 5245.5 5264.3 5401.9 5405.9 5414.4 3544.0 3602.8 3666.6 3673.5 3676.4 1062.7 1084.5 1084.5 1104.2 1111.1 11926.5 11928.3 11938.5 11939.0 11954.7 4575.1 4688.2 4816.4 4862.8 4863.9 7889.7 10053.0 10081.5 10088.2 10113.5 5379.6 5380.0 5383.0 5384.7 5386.5 4379.8 4541.4 4749.2 4884.3 4898.7 3879.2 3924.8 4026.9 4044.8 4045.9 1172.6 1268.5 1280.3 1281.5 1292.0 796.9 917.2 941.8 942.4 978.6 5447.4 6098.7 6116.7 6190.3 6212.1 807.8 931.0 934.4 957.4 988.9 4050.7 4099.7 4111.4 4167.9 4177.6 10569.5 10791.9 10889.5 10898.5 10939.7 9627.9 10357.8 10877.9 10902.4 10911.2 7886.3 8297.2 8298.2 8324.5 8395.5 6091.6 6133.0 6137.1 6141.3 6278.8 9418.2 10030.7 10271.3 10276.0 10303.5 10202.3 10237.6 10427.6 10485.0 10522.6 6702.9 7046.8 7319.7 7581.1 8012.3 8345.7 8432.4 8460.6 8522.4 8523.6 7462.9 7570.5 7571.6 7581.5 7582.9 7310.9 7438.5 7459.5 7548.6 7555.2 6997.7 7013.9 7050.0 7052.1 7060.0 4426.2 4922.5 5081.4 5148.3 5169.2 5157.3 5169.6 5222.9 5246.8 5331.7 20:09:06 INFO - PROCESS | 1646 | 20:09:06 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4569.48 Median:5079.96 stddev:1420.00 (28.0%) stddev-sans-first:1387.25 20:09:06 INFO - PROCESS | 1646 | Values: 293.9 306.3 307.3 312.5 313.6 4711.2 5407.2 5470.9 5490.0 5548.9 4456.4 4527.8 4621.5 5489.9 5497.6 3837.3 3981.7 4044.3 4130.5 4135.3 3531.0 3594.2 4086.2 4127.4 4179.6 3582.7 3897.7 3940.4 3981.4 4145.0 3311.4 3885.3 4058.0 4071.0 4186.7 3556.7 3597.9 3598.8 3604.3 3615.1 4675.1 4964.0 5242.5 5259.3 5336.2 4486.4 4742.2 4750.0 4755.7 4772.1 4613.0 5133.0 5244.3 5661.9 5731.7 3990.6 4006.6 4012.3 4017.5 4028.5 4905.8 4989.0 5241.0 5459.9 5964.3 3865.1 3873.3 3891.2 3896.0 3900.4 3520.9 3639.0 3908.7 3948.4 3964.6 3968.7 3989.5 4560.0 4643.8 4689.2 4961.8 5704.2 5710.5 5717.5 5736.5 1392.7 1413.7 1416.7 1419.7 1420.7 738.5 807.9 822.2 879.6 883.7 5058.7 5101.2 5247.8 5274.9 5280.6 4515.6 4699.0 5344.8 5715.7 5890.3 4276.5 4989.9 5272.9 5304.5 5320.5 2676.6 2877.5 3006.4 3037.3 3051.2 5294.4 5475.6 5578.4 6011.7 6064.7 4831.4 4933.0 5645.7 6023.5 6172.0 5477.2 5942.5 6077.8 6189.3 6207.4 5665.4 5987.6 6007.7 6035.0 6048.0 5331.5 5699.7 5782.5 5837.2 5853.1 6087.6 6145.0 6155.8 6171.2 6181.9 3339.9 3433.2 3798.2 3908.5 3925.4 4758.9 5002.6 5843.2 5850.8 5865.6 4640.8 5745.8 5775.2 5794.4 5817.6 5498.1 5667.7 5687.8 5719.0 5775.3 5563.6 5586.6 5601.3 5632.6 5710.3 4577.5 5450.0 5583.5 5595.3 5658.9 5541.9 5595.5 5657.0 5671.9 5673.9 20:09:06 INFO - PROCESS | 1646 | 20:09:06 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:24223.52 Median:3835.59 stddev:38745.86 (1010.2%) stddev-sans-first:38814.41 20:09:06 INFO - PROCESS | 1646 | Values: 735.0 750.2 791.4 807.4 846.4 14943.9 15629.8 16362.9 16377.3 16412.3 14723.2 14936.7 14950.1 14959.0 14996.1 700.9 723.6 870.5 875.8 906.9 866.2 879.3 880.4 881.9 884.3 942.1 943.6 944.8 945.1 946.0 728.8 928.3 938.2 960.0 962.5 693.6 701.3 702.9 704.0 704.6 13033.4 15700.8 15703.3 15708.8 15739.1 14815.0 14824.4 14880.1 14988.5 14992.9 11997.3 12246.4 12457.1 12481.6 12579.2 3827.0 3844.2 4059.0 4087.1 4094.1 115811.4 115981.0 116234.0 116251.4 116321.4 11558.3 11626.3 11645.9 11690.6 11718.1 24459.5 24473.5 24507.0 24520.8 24525.9 7909.7 8114.3 8164.8 8223.5 8225.0 4229.2 4427.5 4449.6 4556.2 4735.0 3592.3 3709.2 3710.1 3712.4 3724.0 545.8 553.6 625.5 643.9 655.7 559.2 617.8 635.0 666.0 681.5 7787.8 9170.8 9277.6 9311.3 9386.9 536.1 569.8 582.5 593.0 623.3 4288.0 4411.8 4742.0 4760.3 4850.6 96153.0 133468.0 141004.3 159942.0 163299.0 106207.0 135458.0 138599.0 141640.0 142201.0 74665.0 85415.7 97634.0 99961.0 110233.0 6330.8 8767.5 8778.4 8912.6 9004.1 44805.3 51819.7 61613.7 64595.7 65320.7 83958.6 90072.0 93303.0 93985.0 94102.0 11959.8 12078.8 12090.0 12244.2 12468.5 13174.0 13175.4 13349.9 13406.8 13921.0 11982.2 12101.8 12223.3 12483.1 12576.1 12080.6 12136.3 12210.7 12229.0 12540.5 11940.5 12073.8 12339.8 12453.8 12480.9 10341.7 10666.5 10755.4 10771.2 10911.7 10274.8 10513.5 10529.3 10531.0 10587.7 20:09:06 INFO - PROCESS | 1646 | -------- Summary: end -------- 20:09:06 INFO - PROCESS | 1646 | 20:09:06 INFO - TEST-INFO | 1646: exit 0 20:09:06 INFO - TEST-OK | dromaeo_css | took 1116794ms 20:09:06 INFO - TEST-START | kraken 20:09:06 INFO - operating with platform_type : mac_ 20:09:06 INFO - Initialising browser for kraken test... 20:09:06 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpbRcgeN/profile http://localhost:49271/getInfo.html) 20:09:09 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 20:09:09 INFO - PROCESS | 1655 | colorDepth:24 20:09:09 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 20:09:09 INFO - PROCESS | 1655 | __metrics 20:09:09 INFO - PROCESS | 1655 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:09:09 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:09:09 INFO - TEST-INFO | 1655: exit 0 20:09:09 INFO - Browser initialized. 20:09:09 INFO - Running cycle 1/1 for kraken test... 20:09:09 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpbRcgeN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:09:21 INFO - PROCESS | 1656 | RSS: Main: 244068352 20:09:21 INFO - PROCESS | 1656 | 20:09:24 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 20:09:25 INFO - PROCESS | 1656 | RSS: Main: 294440960 20:09:25 INFO - PROCESS | 1656 | 20:09:28 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 20:09:28 INFO - PROCESS | 1656 | RSS: Main: 304443392 20:09:28 INFO - PROCESS | 1656 | 20:09:32 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 20:09:32 INFO - PROCESS | 1656 | RSS: Main: 388354048 20:09:32 INFO - PROCESS | 1656 | 20:09:34 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 20:09:35 INFO - PROCESS | 1656 | RSS: Main: 289017856 20:09:35 INFO - PROCESS | 1656 | 20:09:37 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:09:38 INFO - PROCESS | 1656 | RSS: Main: 293249024 20:09:38 INFO - PROCESS | 1656 | 20:09:41 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 20:09:41 INFO - PROCESS | 1656 | RSS: Main: 331366400 20:09:41 INFO - PROCESS | 1656 | 20:09:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 20:09:45 INFO - PROCESS | 1656 | RSS: Main: 331751424 20:09:45 INFO - PROCESS | 1656 | 20:09:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 20:09:49 INFO - PROCESS | 1656 | RSS: Main: 330276864 20:09:49 INFO - PROCESS | 1656 | 20:09:50 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:09:51 INFO - PROCESS | 1656 | RSS: Main: 313184256 20:09:51 INFO - PROCESS | 1656 | 20:09:53 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:09:53 INFO - PROCESS | 1656 | RSS: Main: 321036288 20:09:53 INFO - PROCESS | 1656 | 20:09:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:09:56 INFO - PROCESS | 1656 | RSS: Main: 317489152 20:09:56 INFO - PROCESS | 1656 | 20:09:59 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:10:00 INFO - PROCESS | 1656 | RSS: Main: 326639616 20:10:00 INFO - PROCESS | 1656 | 20:10:02 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:10:03 INFO - PROCESS | 1656 | RSS: Main: 327946240 20:10:03 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 20:10:05 INFO - PROCESS | 1656 | RSS: Main: 371793920 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | __start_tp_report 20:10:05 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 20:10:05 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 20:10:05 INFO - PROCESS | 1656 | |i|pagename|runs| 20:10:05 INFO - PROCESS | 1656 | |0;ai-astar;100;112;112;113;113;112;112;114;112;112 20:10:05 INFO - PROCESS | 1656 | |1;audio-beat-detection;145;107;107;159;107;106;125;104;137;105 20:10:05 INFO - PROCESS | 1656 | |2;audio-dft;188;183;186;180;184;183;182;185;182;182 20:10:05 INFO - PROCESS | 1656 | |3;audio-fft;78;74;58;108;61;56;61;66;96;57 20:10:05 INFO - PROCESS | 1656 | |4;audio-oscillator;81;91;91;69;71;68;94;75;97;131 20:10:05 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;90;87;134;129;89;87;90;84;117;130 20:10:05 INFO - PROCESS | 1656 | |6;imaging-darkroom;95;95;95;95;95;98;120;95;94;94 20:10:05 INFO - PROCESS | 1656 | |7;imaging-desaturate;125;70;128;141;138;85;85;84;85;85 20:10:05 INFO - PROCESS | 1656 | |8;json-parse-financial;57;52;53;55;55;55;54;54;55;54 20:10:05 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;65;67;81;78;71;70;70;71;70;71 20:10:05 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;80;83;74;82;98;100;91;84;82;80 20:10:05 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;138;154;123;139;140;149;149;134;182;136 20:10:05 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;164;166;171;225;195;165;165;165;164;162 20:10:05 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;67;66;64;66;66;67;67;65;65;65 20:10:05 INFO - PROCESS | 1656 | __end_tp_report 20:10:05 INFO - PROCESS | 1656 | __start_cc_report 20:10:05 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,2020 20:10:05 INFO - PROCESS | 1656 | __end_cc_report 20:10:05 INFO - PROCESS | 1656 | __startTimestamp1467947405534__endTimestamp 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | ------- Summary: start ------- 20:10:05 INFO - PROCESS | 1656 | Number of tests: 14 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.99 (3.6%) stddev-sans-first:0.73 20:10:05 INFO - PROCESS | 1656 | Values: 100.0 112.0 112.0 113.0 113.0 112.0 112.0 114.0 112.0 112.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:120.20 Median:116.00 stddev:20.12 (17.3%) stddev-sans-first:19.24 20:10:05 INFO - PROCESS | 1656 | Values: 145.0 107.0 107.0 159.0 107.0 106.0 125.0 104.0 137.0 105.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:183.50 Median:183.50 stddev:2.32 (1.3%) stddev-sans-first:1.80 20:10:05 INFO - PROCESS | 1656 | Values: 188.0 183.0 186.0 180.0 184.0 183.0 182.0 185.0 182.0 182.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:71.50 Median:63.50 stddev:17.84 (28.1%) stddev-sans-first:18.77 20:10:05 INFO - PROCESS | 1656 | Values: 78.0 74.0 58.0 108.0 61.0 56.0 61.0 66.0 96.0 57.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:86.00 stddev:18.97 (22.1%) stddev-sans-first:20.00 20:10:05 INFO - PROCESS | 1656 | Values: 81.0 91.0 91.0 69.0 71.0 68.0 94.0 75.0 97.0 131.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:103.70 Median:87.00 stddev:20.99 (24.1%) stddev-sans-first:21.67 20:10:05 INFO - PROCESS | 1656 | Values: 90.0 87.0 134.0 129.0 89.0 87.0 90.0 84.0 117.0 130.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:97.60 Median:95.00 stddev:7.95 (8.4%) stddev-sans-first:8.37 20:10:05 INFO - PROCESS | 1656 | Values: 95.0 95.0 95.0 95.0 95.0 98.0 120.0 95.0 94.0 94.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:102.60 Median:84.50 stddev:26.92 (31.9%) stddev-sans-first:27.31 20:10:05 INFO - PROCESS | 1656 | Values: 125.0 70.0 128.0 141.0 138.0 85.0 85.0 84.0 85.0 85.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:1.35 (2.5%) stddev-sans-first:1.05 20:10:05 INFO - PROCESS | 1656 | Values: 57.0 52.0 53.0 55.0 55.0 55.0 54.0 54.0 55.0 54.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.00 stddev:4.74 (6.7%) stddev-sans-first:4.43 20:10:05 INFO - PROCESS | 1656 | Values: 65.0 67.0 81.0 78.0 71.0 70.0 70.0 71.0 70.0 71.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:82.50 stddev:8.32 (10.1%) stddev-sans-first:8.59 20:10:05 INFO - PROCESS | 1656 | Values: 80.0 83.0 74.0 82.0 98.0 100.0 91.0 84.0 82.0 80.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:144.50 stddev:15.90 (11.0%) stddev-sans-first:16.69 20:10:05 INFO - PROCESS | 1656 | Values: 138.0 154.0 123.0 139.0 140.0 149.0 149.0 134.0 182.0 136.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:165.50 stddev:20.28 (12.3%) stddev-sans-first:21.17 20:10:05 INFO - PROCESS | 1656 | Values: 164.0 166.0 171.0 225.0 195.0 165.0 165.0 165.0 164.0 162.0 20:10:05 INFO - PROCESS | 1656 | 20:10:05 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.03 (1.6%) stddev-sans-first:1.00 20:10:05 INFO - PROCESS | 1656 | Values: 67.0 66.0 64.0 66.0 66.0 67.0 67.0 65.0 65.0 65.0 20:10:05 INFO - PROCESS | 1656 | -------- Summary: end -------- 20:10:05 INFO - PROCESS | 1656 | 20:10:06 INFO - TEST-INFO | 1656: exit 0 20:10:06 INFO - TEST-OK | kraken | took 59559ms 20:10:06 INFO - SUITE-END | took 1176s 20:10:06 INFO - Completed test suite (00:19:36) 20:10:06 INFO - javascript benchmark 20:10:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.8993830185095, 3414.470757032659, 3422.4695172248303, 3422.57217847769, 3464.774789638673, 5687.232223649806, 5759.424057594239, 5793.68134752589, 5940.702964851762, 5957.851053723659, 5816.738246778895, 5842.795502157425, 5857.8828423431505, 5861.824145275638, 5871.970640146793, 5233.162693968966, 5280.339957505312, 5315.309009828717, 5323.361196656388, 5365.651232669864, 5352.170413585881, 5361.946380536203, 5376.784928602851, 5383.67697938123, 5383.973080134594, 5268.631195816294, 5304.946950530484, 5309.150535914255, 5313.867153321178, 5349.0, 5379.246905433242, 5384.865378365533, 5385.21914322423, 5391.4608539145775, 5399.19012148177, 5125.897482050338, 5223.190405487156, 5249.501297376743, 5330.520253177194, 5336.985972665181, 5707.058335374658, 5720.342160651537, 5743.195952566644, 5770.913436298459, 5777.59556831022, 6335.8416039598915, 6351.809445716636, 6354.9364506354805, 6355.046742988542, 6365.968170159166, 6152.87694246117, 6286.842828929268, 6337.366263373672, 6345.397187267202, 6349.4602958748565, 5972.402759723993, 5981.730822113015, 6002.129691194752, 6005.309389420186, 6016.2479690038745, 6355.110284560165, 6362.586431881913, 6365.681715914278, 6367.172267605274, 6372.076048972873, 6122.112293717386, 6127.111568822585, 6141.293751218578, 6141.363270730659, 6244.562880598405, 6304.65324407162, 6315.5894866833505, 6323.494120470444, 6327.841803954846, 6331.68341582919, 6057.303410107894, 6246.718897649616, 6299.811005669837, 6307.747690092437, 6313.684315784192, 6155.969220153871, 6200.441960223601, 6207.0, 6237.781677641261, 6327.114204011442, 5017.096922553902, 5030.572401345853, 5057.671251368649, 5063.746812659352, 5104.464031276737, 4533.909321813545, 4537.296719008559, 4543.932175938652, 4562.361269422284, 4577.496475387705, 5691.715414229272, 5763.769449222068, 5766.769329226868, 5842.065269556851, 5845.532357411397, 6302.243730752248, 6304.936950630527, 6322.0, 6334.081558174039, 6365.618062916147, 5826.766929322865, 5833.883322333614, 5857.326407463196, 5870.823875283749, 5922.615030023035, 5393.379761327497, 5429.212764149176, 5473.67157970523, 5495.917561236584, 5508.862278443071, 6316.810495685137, 6331.778387756499, 6367.0, 6400.839979000562, 6408.6475243861105, 6166.414190651881, 6280.152179455715, 6318.936810631835, 6331.366863313632, 6344.968275158594, 6259.718312676032, 6297.496200304056, 6348.682565871781, 6403.615783053032, 6416.518761092843, 6302.180716506825, 6307.400796924285, 6311.810645680637, 6323.146375239284, 6348.682565871781, 6180.196574445294, 6262.123302737529, 6340.682965851597, 6364.840878978062, 6366.681665916593, 5568.220449137043, 6143.96928015357, 6220.720067596879, 6228.844278893064, 6243.469305109116, 6165.612971420551, 6213.2233470816145, 6213.316535181036, 6214.875702486015, 6224.502039836892, 5865.354810970704, 6052.243469566304, 6097.524678803442, 6099.054646529795, 6101.671357587044, 5372.140457526777, 5994.831007953408, 6079.635221886701, 6106.5820131054825, 6173.753049877954, 5992.250968628921, 6073.696315184311, 6111.113888486056, 6112.786052488142, 6114.633122012693], "value": 5791.299253427586, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.7263986887605, 487.8024400117951, 489.7991823352425, 529.5869222006834, 553.7342075803614, 33454.330913381746, 42527.0, 42592.361114583306, 42643.36034959478, 44377.77811110948, 44148.89627759308, 44562.554374456246, 44614.55385446145, 44658.77670611643, 44714.7764261179, 8869.201771840533, 9080.137386948229, 9798.999999999982, 9981.251406144533, 9985.900140998607, 8832.690855820048, 8933.374663773506, 8934.151255630737, 11873.52505899763, 12115.757684846298, 12141.57504487343, 12209.450574724115, 12214.32821194834, 12215.816762748522, 12257.14200006, 12067.336296503689, 12130.757384852343, 12143.089268304913, 12162.270263784201, 12167.209131406431, 8688.695895643685, 11622.418879056013, 11936.462859171272, 11938.0, 12169.452374643162, 41804.0, 42048.36927446091, 42188.0, 42265.788671056755, 42298.0, 3592.9820350898076, 3653.5433070866143, 3681.042928838521, 3695.170800885737, 4234.153169366139, 31651.683483165336, 32935.835320823484, 33237.50143747846, 33302.0, 33408.83295583531, 3286.5398844161837, 3359.6808303211155, 3381.7487529613954, 3389.67798059184, 3412.4198886189406, 523890.0, 524497.0, 525676.0, 528109.0, 528526.0, 51892.740536297075, 62868.05697914535, 63185.36814631887, 63353.04970425355, 63398.68300658467, 65731.0, 65856.34143658598, 65943.0, 66075.66962165158, 66119.66940165269, 16746.4138755143, 16961.745573816403, 16965.0, 16982.23579938906, 17021.914890425716, 11802.055835533136, 13100.082994190316, 13148.868511314955, 13175.945924326032, 13209.273489958145, 15145.697086058217, 17165.399211027554, 17584.208710608054, 17594.0, 18049.819501805076, 5803.984302747002, 6904.516683832084, 6991.265917078634, 7043.647817609201, 7127.7148914042855, 894.9373543851868, 983.4836710726926, 992.9325974577358, 1073.1575713065206, 1091.7270682329417, 25643.0, 30327.0, 30410.54384184239, 31221.0, 31554.36891262162, 1053.0206907575875, 1066.4294602387686, 1106.1372129738816, 1138.5047504335641, 1147.1568397228032, 15523.0, 15853.762193567105, 16071.35714571404, 16188.595285117966, 16352.892811681195, 191905.0, 192604.0, 192870.0, 193032.06967930423, 716950.0, 60209.0, 61029.77940441166, 61253.69373153195, 65465.01802472967, 65470.67264663742, 1420.5383250443647, 1431.3701971132668, 1447.0883343493742, 1449.2029383838847, 1451.078565111141, 31721.0, 31768.364632706754, 31776.841115794272, 32706.67293327036, 32997.0, 52800.735996319774, 58529.12206316824, 59426.405735943816, 59804.40195598162, 63408.68295658492, 616257.0, 623521.0, 624971.0, 625412.0, 627989.0, 27087.322816929733, 27365.86317068402, 27459.862700686368, 27551.035713749923, 27564.724352756217, 48956.75521622369, 49301.75349123232, 49991.75004125101, 50977.490225097274, 50996.0, 40977.0, 41131.97170070772, 41713.79143104265, 42543.0, 42738.78630606827, 40395.3940690884, 40480.1903961925, 40606.187876242904, 41537.37693934654, 41769.0, 38640.921899064575, 39607.0, 39735.0, 39876.401853971634, 41530.37704434375, 33139.50290745689, 36053.27893442064, 36186.638133618326, 43129.35305970476, 43754.0, 31324.843375782973, 33201.16997074996, 33342.99971000874, 33496.33007339888, 33674.54643219852], "value": 20801.745991545846, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.85830738550897, 376.7136975898317, 380.714464151886, 383.88099689096384, 399.28328650073115, 15701.685966280682, 15802.13088280144, 20470.181192752272, 21099.6835047474, 21654.0, 21117.788822111812, 21251.0, 21781.0, 21801.563968720617, 22096.22663206788, 5214.400343960437, 5804.767809287634, 5968.462838344548, 6255.749770009194, 6256.749730010794, 6128.479079278267, 6201.255849298068, 6232.0, 6238.500919926395, 6244.718987645544, 5993.88012239755, 6090.188750886817, 6117.082437634368, 6123.540734444912, 6187.938120618804, 5947.791827286068, 6082.0, 6137.969310153443, 6177.073438984144, 6178.320384757673, 5312.309399778004, 5322.3879253885525, 5327.520523152934, 5329.360476742777, 5336.092864213093, 13721.725565488734, 22720.54558908829, 24119.638205426934, 25556.616650750253, 26684.19947401581, 2157.094020511389, 2244.236959433784, 2351.165336305604, 2402.5435167318155, 2409.638554216864, 9951.950240248825, 10122.392656440637, 10155.187584993182, 10161.288709790319, 10498.475076246157, 1742.30307876849, 1821.1895706410653, 1935.3516571948414, 1985.0670185013166, 2038.7043878637514, 118817.0, 122485.38757306157, 124139.37930310381, 124503.37748311291, 126678.0, 9432.528373581294, 11505.0, 11568.479418426192, 11673.416329183507, 11783.764324713458, 14427.278636068155, 14509.782353264709, 14515.201663908587, 14551.3451894665, 14555.854441455662, 8394.412391132684, 8594.269487093543, 8612.397132200686, 8688.739337819748, 8705.825883482295, 8508.191721786421, 8515.40392172542, 8525.01962274334, 8647.783805404915, 8652.653893844301, 3732.869349572752, 4478.753668548196, 4557.088582283556, 4611.746353950565, 4617.746023968714, 1872.0, 1913.9425817225506, 1924.6054558815408, 1944.6888497840278, 1964.2830366915973, 830.9169083091642, 840.9537475438788, 949.9525023748923, 950.9144177024101, 988.1748739802202, 20346.694799578017, 21462.78537214639, 21607.91960402005, 21636.45908852291, 21718.348449546538, 934.8550974598948, 942.7696855603366, 956.5073986896754, 962.5764663548016, 988.6737376665683, 10890.23768336209, 11392.715182120348, 11420.37187954654, 11422.828657570142, 11433.656990290305, 610758.0, 610867.0, 611134.0, 615424.0, 633025.0, 134568.0, 135585.322073389, 136238.0, 137530.0, 139268.0, 946.1531928923575, 1004.542932965499, 1005.9245556583286, 1007.7480629842539, 1008.5763979128931, 18826.811731882506, 19199.424017279503, 19203.615927681647, 19284.903575482032, 19289.807101929364, 52371.47628523818, 52517.7374113127, 52618.94762104813, 53169.99999999845, 53625.731871340395, 77147.22852771624, 77443.06392340011, 78037.0, 78129.82805257812, 79806.20193797987, 8064.274215320649, 8082.313003394777, 8144.389170812095, 8156.877646835183, 8313.584320784057, 12438.440270187682, 12635.494580217057, 12851.550195743104, 12943.805842912552, 13216.933915330363, 11076.335419874833, 11192.328460292409, 11286.604968826052, 11379.487923043318, 11469.541218351173, 11138.832917506083, 11255.493502792231, 11344.0, 11406.885931140583, 11464.656060318204, 11409.714757131138, 11498.885011149781, 11576.24754390962, 11705.005074568757, 11706.239094458833, 8039.437239393186, 8057.758267251992, 8085.110637829952, 8137.389695772722, 8297.792555186168, 8270.2556769891, 10711.94644026775, 11166.888331116585, 11215.66353009411, 11247.268927520012], "value": 9636.861356152674, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.034620938447, 1547.6517783498712, 1579.8262191158974, 1796.9730454043192, 1949.941501754947, 7924.881126783102, 8750.343724220686, 9004.864927026092, 9018.774530636738, 9108.089191080888, 8742.694005709802, 8943.686970956018, 8966.0, 8970.641174353035, 8976.281897448205, 2086.3740877736695, 2164.967525487119, 2295.0, 2360.5396947595227, 2388.856668599881, 1990.8407327413845, 2025.9392218233477, 2381.226101517005, 2419.806415486757, 2430.963535546968, 2026.9865067466267, 2341.4497593065616, 2343.50786334869, 2360.33910505058, 2386.713594368678, 2053.3634573282256, 2235.7093577834776, 2321.292005938188, 2321.9883900580558, 2353.788159065684, 2371.193794110011, 2391.366287933699, 2391.5216956608574, 2396.125414223813, 2401.807855371566, 8871.911280887172, 8945.642174313085, 8947.32895032875, 8955.462672239686, 8961.46231226122, 5245.501677340647, 5264.341957255343, 5401.891962160735, 5405.864853378657, 5414.40441551429, 3544.043108360754, 3602.8018458984743, 3666.5783434904793, 3673.4673472346626, 3676.356637588411, 1062.6918193723811, 1084.4957094950807, 1084.5282302198568, 1104.1884215101893, 1111.0778054214982, 11926.522939082513, 11928.343941083323, 11938.462769175409, 11938.985186259179, 11954.701132471671, 4575.107853968444, 4688.249880019249, 4816.422029356429, 4862.78117484714, 4863.927041094386, 7889.6844126235455, 10053.04496072872, 10081.49592520371, 10088.192944564416, 10113.544890479947, 5379.623426360117, 5379.9778042171865, 5383.0041442333295, 5384.6769193848495, 5386.461353864583, 4379.802908869108, 4541.43232095988, 4749.168895443353, 4884.291777692215, 4898.681585696918, 3879.2241551689776, 3924.823382947774, 4026.859059932947, 4044.8179831907637, 4045.8988525287104, 1172.6013155526991, 1268.5496648689766, 1280.270245959794, 1281.532240732126, 1292.043887523226, 796.8844517544924, 917.2020342302106, 941.8398872191743, 942.3827393057559, 978.6134476881734, 5447.400785913546, 6098.664573448503, 6116.694165291718, 6190.3190649028575, 6212.06818977157, 807.769785611098, 930.9813803723888, 934.3833070173789, 957.4398976598628, 988.8862780780158, 4050.7164498485413, 4099.692523060723, 4111.362738775495, 4167.937480937789, 4177.644900183458, 10569.471526423647, 10791.892081079088, 10889.455527223607, 10898.455077246106, 10939.671809845717, 9627.855582166274, 10357.75706915175, 10877.945610271898, 10902.400367979679, 10911.23621346514, 7886.250806173404, 8297.211764882326, 8298.21166989147, 8324.500529968222, 8395.454295470898, 6091.573589848668, 6133.0, 6137.079438084144, 6141.293751218667, 6278.811635650938, 9418.199453046294, 10030.699079027641, 10271.332363396356, 10276.0, 10303.484825758833, 10202.285839991426, 10237.590496380062, 10427.635032773816, 10485.003924627148, 10522.631707890187, 6702.899456508058, 7046.823829404306, 7319.74380896666, 7581.090269167735, 8012.278894899254, 8345.707900223462, 8432.409731318749, 8460.619272132892, 8522.403431759965, 8523.616437260462, 7462.8507429850015, 7570.545767253982, 7571.621418928921, 7581.469297149367, 7582.886256706043, 7310.853782924418, 7438.516496427715, 7459.477836551607, 7548.584827834522, 7555.244475552401, 6997.685104170223, 7013.929860701328, 7049.9647501762165, 7052.118485189351, 7059.964700176466, 4426.247537918497, 4922.4585295616735, 5081.390233172043, 5148.330717006766, 5169.224616307433, 5157.329547158845, 5169.560587349967, 5222.921656175236, 5246.8163614274845, 5331.733413329395], "value": 4622.142800887924, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.923579869234, 306.26190879979254, 307.32848725534706, 312.45320688794607, 313.6299166982959, 4711.246200607903, 5407.215618845781, 5470.933168032236, 5489.972550137249, 5548.91676624851, 4456.398386217859, 4527.845399423142, 4621.468531118922, 5489.945100548994, 5497.615166938306, 3837.347650899354, 3981.741186822862, 4044.2720310344125, 4130.524989626187, 4135.27632664284, 3530.9823450882836, 3594.19130695594, 4086.2031903778775, 4127.401526778615, 4179.623833854953, 3582.7133829293725, 3897.7466464679705, 3940.4089386591954, 3981.362981922893, 4144.97927510362, 3311.3708395404915, 3885.339492286318, 4058.0057885818164, 4071.0, 4186.727862688916, 3556.6621170988715, 3597.9280414391565, 3598.784072955631, 3604.297162053401, 3615.14403621139, 4675.064987002613, 4964.0, 5242.501962313574, 5259.316288882459, 5336.172893201521, 4486.415633937079, 4742.217534106868, 4749.9762501187615, 4755.667103302771, 4772.141014617368, 4612.95387046132, 5133.0, 5244.318238628992, 5661.886762264731, 5731.656100633975, 3990.6009399060154, 4006.6193711597352, 4012.3179059559943, 4017.4733601231346, 4028.4561584186054, 4905.77923993414, 4988.975055124701, 5241.030409374278, 5459.890802183934, 5964.284285885721, 3865.091703449687, 3873.341531939577, 3891.221755648825, 3895.9610403896163, 3900.395438707005, 3520.9261175341253, 3638.9818050909576, 3908.7068469864876, 3948.4008976364044, 3964.623360780721, 3968.7420317679257, 3989.5212574491247, 4560.042391097906, 4643.767811609406, 4689.249720044844, 4961.751912404366, 5704.20317599963, 5710.543156547549, 5717.485426311652, 5736.537183018304, 1392.735380277744, 1413.6923345904997, 1416.730821144, 1419.7373485904934, 1420.666143456287, 738.5236522442995, 807.9030516337959, 822.1778221778221, 879.5514287713185, 883.6686242659002, 5058.671186372948, 5101.240072175094, 5247.763850626731, 5274.92087618686, 5280.577553795687, 4515.63874890008, 4699.013207226452, 5344.786208551692, 5715.657060576379, 5890.263717035371, 4276.465441819772, 4989.875253118701, 5272.868178295496, 5304.522592966651, 5320.536852365553, 2676.5776971840514, 2877.525208340642, 3006.428778532072, 3037.255872311254, 3051.2066862615434, 5294.411676497036, 5475.631092226943, 5578.442155784389, 6011.6693581853415, 6064.696765161724, 4831.396075490564, 4933.01339732055, 5645.689487078168, 6023.518118550505, 6172.0, 5477.1510415885605, 5942.494887934487, 6077.845209410198, 6189.319174890848, 6207.379262073847, 5665.405132461032, 5987.5808693391045, 6007.699615019319, 6034.969825150846, 6048.0, 5331.533828197277, 5699.658020518782, 5782.508486778671, 5837.219648007229, 5853.1220316952795, 6087.634741915499, 6145.0028740660355, 6155.84610384744, 6171.228596425447, 6181.907271390843, 3339.933201336008, 3433.2275238072234, 3798.24035192957, 3908.459501324162, 3925.391564307537, 4758.881027974328, 5002.623753717101, 5843.211166492639, 5850.765969361178, 5865.618734782225, 4640.767961601839, 5745.827625171251, 5775.162601422854, 5794.449527294901, 5817.621854579439, 5498.0653288940175, 5667.659940403424, 5687.829365119053, 5719.0, 5775.306963164448, 5563.638363506359, 5586.636868603528, 5601.271834661468, 5632.605717599728, 5710.3433105193435, 4577.473590537131, 5449.964506743706, 5583.5103060587135, 5595.251181708347, 5658.886822263449, 5541.944580554143, 5595.468430499096, 5656.9717151415625, 5671.8865622688145, 5673.8865222694485], "value": 4116.085285493176, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.966926488308, 750.2272659161066, 791.3827214772476, 807.37428492918, 846.382141037043, 14943.850561494382, 15629.765553516692, 16362.918185409086, 16377.344906203767, 16412.343506259764, 14723.190224537646, 14936.701265974674, 14950.10299382038, 14959.0, 14996.10023398594, 700.8738427083123, 723.5947869193242, 870.4516154822453, 875.7941883657336, 906.9274458043341, 866.2290561400328, 879.3404946290283, 880.3881302494768, 881.8853549038648, 884.3014018925073, 942.1473566422399, 943.5518128888791, 944.773254418938, 945.1021529546923, 945.957431915562, 728.752224243757, 928.2666693312275, 938.1697197979769, 960.011188475871, 962.5091203486203, 693.6219760230636, 701.3302296307014, 702.9191642961023, 703.9824004399879, 704.6441547018774, 13033.413496392684, 15700.842991570053, 15703.293351799197, 15708.842911570966, 15739.134347610876, 14815.0, 14824.407023719039, 14880.107193568312, 14988.47540336083, 14992.870035201011, 11997.34014629195, 12246.44890979908, 12457.065720070941, 12481.625551233386, 12579.245245285312, 3826.9617303826885, 3844.2119365529998, 4059.025833799896, 4087.1008378156757, 4094.1197642506704, 115811.42094289475, 115981.0, 116234.0, 116251.41874290575, 116321.41839290834, 11558.30650160993, 11626.302421854716, 11645.88354116448, 11690.590829320932, 11718.121140914465, 24459.510809783704, 24473.510529789306, 24507.01971921139, 24520.754792452204, 24525.877370613034, 7909.7231596893835, 8114.310283625958, 8164.836703265902, 8223.54770487629, 8224.97281677769, 4229.175310814423, 4427.480916030547, 4449.555044495524, 4556.225441674923, 4734.976325118352, 3592.2815436912724, 3709.2025214578994, 3710.05393624624, 3712.3688972874675, 3724.031751744512, 545.8007827143143, 553.5516231852213, 625.5464788028734, 643.9001954697029, 655.6951017776756, 559.2366419836893, 617.8353803081135, 634.9714262858182, 665.9996714799893, 681.465049935798, 7787.844243115106, 9170.816583668422, 9277.58250878712, 9311.301652376098, 9386.85919711205, 536.1102115044422, 569.7720911635296, 582.5485248932112, 592.9673867937305, 623.2614351992903, 4287.957120428819, 4411.830864820825, 4741.974928174473, 4760.33355330254, 4850.563449289511, 96153.0, 133468.0, 141004.2949785265, 159942.0, 163299.0, 106207.0, 135458.0, 138599.0, 141640.0, 142201.0, 74665.0, 85415.71876421859, 97634.0, 99961.0, 110233.0, 6330.8100756977365, 8767.473951562926, 8778.429402088845, 8912.598933048159, 9004.144606262656, 44805.32792008188, 51819.704507387614, 61613.69193154185, 64595.671583656556, 65320.673396632716, 83958.58020710101, 90072.0, 93303.0, 93985.0, 94102.0, 11959.760804783682, 12078.818817717565, 12090.0, 12244.204126731735, 12468.5012599495, 13174.0, 13175.407106680032, 13349.933250333686, 13406.798898016732, 13921.025528212927, 11982.161248712506, 12101.818472723093, 12223.327716975651, 12483.12618116723, 12576.119671622899, 12080.637580872588, 12136.33250171249, 12210.694732631755, 12229.0, 12540.498380064695, 11940.52237910474, 12073.818892716792, 12339.75320493603, 12453.75092498163, 12480.875191248335, 10341.689749307532, 10666.466676665981, 10755.354678719303, 10771.246012779031, 10911.727206819576, 10274.845877311996, 10513.474326283502, 10529.315594486334, 10531.0, 10587.682369528926], "value": 7729.207233414666, "unit": "score"}], "name": "dromaeo_css", "value": 7448.236685886154, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 112.0, 113.0, 113.0, 112.0, 112.0, 114.0, 112.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 107.0, 107.0, 159.0, 107.0, 106.0, 125.0, 104.0, 137.0, 105.0], "value": 120.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 183.0, 186.0, 180.0, 184.0, 183.0, 182.0, 185.0, 182.0, 182.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 58.0, 108.0, 61.0, 56.0, 61.0, 66.0, 96.0, 57.0], "value": 71.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 91.0, 91.0, 69.0, 71.0, 68.0, 94.0, 75.0, 97.0, 131.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 134.0, 129.0, 89.0, 87.0, 90.0, 84.0, 117.0, 130.0], "value": 103.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 98.0, 120.0, 95.0, 94.0, 94.0], "value": 97.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 70.0, 128.0, 141.0, 138.0, 85.0, 85.0, 84.0, 85.0, 85.0], "value": 102.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 53.0, 55.0, 55.0, 55.0, 54.0, 54.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 81.0, 78.0, 71.0, 70.0, 70.0, 71.0, 70.0, 71.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 74.0, 82.0, 98.0, 100.0, 91.0, 84.0, 82.0, 80.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 154.0, 123.0, 139.0, 140.0, 149.0, 149.0, 134.0, 182.0, 136.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 171.0, 225.0, 195.0, 165.0, 165.0, 165.0, 164.0, 162.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 64.0, 66.0, 66.0, 67.0, 67.0, 65.0, 65.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1472.7, "alertThreshold": 2.0}]} 20:10:06 INFO - Return code: 0 20:10:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:10:06 INFO - # TBPL SUCCESS # 20:10:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:10:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:10:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:10:06 INFO - 2016-07-07 20:10:06.878 screenresolution[1660:9647] starting screenresolution argv=screenresolution get 20:10:06 INFO - 2016-07-07 20:10:06.881 screenresolution[1660:9647] Display 0: 1600x1200x32@60 20:10:06 INFO - 2016-07-07 20:10:06.888 screenresolution[1661:9650] starting screenresolution argv=screenresolution list 20:10:06 INFO - Available Modes on Display 0 20:10:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:10:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:10:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:10:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:10:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:10:07 INFO - Intel Iris: 20:10:07 INFO - Chipset Model: Intel Iris 20:10:07 INFO - Type: GPU 20:10:07 INFO - Bus: Built-In 20:10:07 INFO - VRAM (Dynamic, Max): 1536 MB 20:10:07 INFO - Vendor: Intel (0x8086) 20:10:07 INFO - Device ID: 0x0a2e 20:10:07 INFO - Revision ID: 0x0009 20:10:07 INFO - Displays: 20:10:07 INFO - Display: 20:10:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:10:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:10:07 INFO - Display Serial Number: 1600x1200 60 20:10:07 INFO - Main Display: Yes 20:10:07 INFO - Mirror: Off 20:10:07 INFO - Online: Yes 20:10:07 INFO - Rotation: Supported 20:10:07 INFO - Return code: 0 20:10:07 INFO - Running post-action listener: _resource_record_post_action 20:10:07 INFO - ##### 20:10:07 INFO - ##### Finished run-tests step (success) 20:10:07 INFO - ##### 20:10:07 INFO - Running post-run listener: _resource_record_post_run 20:10:07 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 36963840; Write bytes: 704530432; Read time: 241; Write time: 1968 20:10:07 INFO - TinderboxPrint: CPU usage
53.4% 20:10:07 INFO - TinderboxPrint: I/O read bytes / time
36,963,840 / 241 20:10:07 INFO - TinderboxPrint: I/O write bytes / time
704,530,432 / 1,968 20:10:07 INFO - TinderboxPrint: CPU idle
2,262.0 (46.6%) 20:10:07 INFO - TinderboxPrint: CPU system
965.8 (19.9%) 20:10:07 INFO - TinderboxPrint: CPU user
1,621.9 (33.4%) 20:10:07 INFO - TinderboxPrint: Swap in / out
443,875,328 / 0 20:10:07 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 408134144; Write bytes: 408901120; Read time: 30849; Write time: 875 20:10:07 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 34461184; Write bytes: 294072832; Read time: 219; Write time: 1087 20:10:07 INFO - Running post-run listener: _upload_blobber_files 20:10:07 INFO - Blob upload gear active. 20:10:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:10:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:10:07 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:10:07 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:10:07 INFO - (blobuploader) - INFO - Open directory for files ... 20:10:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:10:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:10:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:09 INFO - (blobuploader) - INFO - Done attempting. 20:10:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:10:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:10:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:10 INFO - (blobuploader) - INFO - Done attempting. 20:10:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:10:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:10:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:10:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:10:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:10:12 INFO - (blobuploader) - INFO - Done attempting. 20:10:12 INFO - (blobuploader) - INFO - Iteration through files over. 20:10:12 INFO - Return code: 0 20:10:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:10:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:10:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cb6172bf487eab40312e224853a1e45713d31e19eecbb88b5105d51c83557c9a067365f8967e8fd66c2ffa86a3c9d0057091e0a3fb65e0d14a53587bd6da1249", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb11949d08774507845c51440b461985c4f0b07347e591eef5d2e251663d955363c71d988cac01b89209cce0a7c9f9597f692fcee44ec893bee4a11f62c81daf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b2ee1bd469e2ddc4e50a61beb3fa249c15c103383964a2cfe69e31089309709c3ac5e07a2dee95e72317d3bfa06440127c679da0574d821681644d4562558cd8"} 20:10:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:10:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:10:12 INFO - Contents: 20:10:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cb6172bf487eab40312e224853a1e45713d31e19eecbb88b5105d51c83557c9a067365f8967e8fd66c2ffa86a3c9d0057091e0a3fb65e0d14a53587bd6da1249", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb11949d08774507845c51440b461985c4f0b07347e591eef5d2e251663d955363c71d988cac01b89209cce0a7c9f9597f692fcee44ec893bee4a11f62c81daf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b2ee1bd469e2ddc4e50a61beb3fa249c15c103383964a2cfe69e31089309709c3ac5e07a2dee95e72317d3bfa06440127c679da0574d821681644d4562558cd8"} 20:10:12 INFO - Running post-run listener: copy_logs_to_upload_dir 20:10:12 INFO - Copying logs to upload dir... 20:10:12 INFO - mkdir: /builds/slave/test/build/upload/logs 20:10:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.727036 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-07-07 20:10:12.807444) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 20:10:12.811632) ========= 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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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/Autoland/sha512/cb6172bf487eab40312e224853a1e45713d31e19eecbb88b5105d51c83557c9a067365f8967e8fd66c2ffa86a3c9d0057091e0a3fb65e0d14a53587bd6da1249", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb11949d08774507845c51440b461985c4f0b07347e591eef5d2e251663d955363c71d988cac01b89209cce0a7c9f9597f692fcee44ec893bee4a11f62c81daf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b2ee1bd469e2ddc4e50a61beb3fa249c15c103383964a2cfe69e31089309709c3ac5e07a2dee95e72317d3bfa06440127c679da0574d821681644d4562558cd8"} build_url:https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/Pn9BdOj0SfyWxD8KYlUzLg/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/cb6172bf487eab40312e224853a1e45713d31e19eecbb88b5105d51c83557c9a067365f8967e8fd66c2ffa86a3c9d0057091e0a3fb65e0d14a53587bd6da1249", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bb11949d08774507845c51440b461985c4f0b07347e591eef5d2e251663d955363c71d988cac01b89209cce0a7c9f9597f692fcee44ec893bee4a11f62c81daf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b2ee1bd469e2ddc4e50a61beb3fa249c15c103383964a2cfe69e31089309709c3ac5e07a2dee95e72317d3bfa06440127c679da0574d821681644d4562558cd8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 20:10:12.844140) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:10:12.844461) ========= 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.DiO9t2Wgnw/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.xvZTKodZrR/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/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.005240 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:10:12.893093) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 20:10:12.893448) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 20:10:12.893803) ========= ========= Total master_lag: 0.49 =========