builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0191 starttime: 1467753060.75 results: success (0) buildid: 20160705131323 builduid: 0baf696b986f4d169513d14bbb2c8328 revision: a74f88a7a05abe2b80eba43cab211199b30e7463 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 14:11:00.752810) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 14:11:00.753232) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 14:11:00.753506) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 14:11:00.776682) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:11:00.777088) ========= 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.kfZjq39UZq/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.fGFSRJI64P/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-05 14:11:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 6.58M=0.002s 2016-07-05 14:11:00 (6.58 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144650 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:11:00.944577) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:11:00.944989) ========= 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.kfZjq39UZq/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.fGFSRJI64P/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.020940 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:11:00.993297) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 14:11:00.993641) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a74f88a7a05abe2b80eba43cab211199b30e7463 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a74f88a7a05abe2b80eba43cab211199b30e7463 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kfZjq39UZq/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.fGFSRJI64P/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-05 14:11:01,064 truncating revision to first 12 chars 2016-07-05 14:11:01,064 Setting DEBUG logging. 2016-07-05 14:11:01,064 attempt 1/10 2016-07-05 14:11:01,064 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a74f88a7a05a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 14:11:02,323 unpacking tar archive at: fx-team-a74f88a7a05a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.546872 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 14:11:02.562228) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 14:11:02.562543) ========= script_repo_revision: a74f88a7a05abe2b80eba43cab211199b30e7463 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 14:11:02.562935) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 14:11:02.563198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 14:11:02.581658) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-05 14:11:02.582142) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kfZjq39UZq/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.fGFSRJI64P/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:11:02 INFO - MultiFileLogger online at 20160705 14:11:02 in /builds/slave/test 14:11:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:11:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:11:02 INFO - {'append_to_log': False, 14:11:02 INFO - 'base_work_dir': '/builds/slave/test', 14:11:02 INFO - 'blob_upload_branch': 'Fx-Team', 14:11:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:11:02 INFO - 'branch': 'Fx-Team', 14:11:02 INFO - 'buildbot_json_path': 'buildprops.json', 14:11:02 INFO - 'config_files': ('talos/mac_config.py',), 14:11:02 INFO - 'default_actions': ('clobber', 14:11:02 INFO - 'read-buildbot-config', 14:11:02 INFO - 'download-and-extract', 14:11:02 INFO - 'populate-webroot', 14:11:02 INFO - 'create-virtualenv', 14:11:02 INFO - 'install', 14:11:02 INFO - 'run-tests'), 14:11:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:11:02 INFO - 'download_minidump_stackwalk': True, 14:11:02 INFO - 'download_symbols': 'ondemand', 14:11:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:11:02 INFO - 'tooltool.py': '/tools/tooltool.py', 14:11:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:11:02 INFO - '/tools/misc-python/virtualenv.py')}, 14:11:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:11:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:11:02 INFO - 'installer_path': 'installer.exe', 14:11:02 INFO - 'log_level': 'info', 14:11:02 INFO - 'log_name': 'talos', 14:11:02 INFO - 'log_to_console': True, 14:11:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:11:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:11:02 INFO - 'opt_config_files': (), 14:11:02 INFO - 'pip_index': False, 14:11:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:11:02 INFO - 'cmd': ('bash', 14:11:02 INFO - '-c', 14:11:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:11:02 INFO - 'enabled': True, 14:11:02 INFO - 'halt_on_failure': False, 14:11:02 INFO - 'name': 'check_screen_resolution'},), 14:11:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:11:02 INFO - 'cmd': ('bash', 14:11:02 INFO - '-c', 14:11:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:11:02 INFO - 'enabled': True, 14:11:02 INFO - 'halt_on_failure': False, 14:11:02 INFO - 'name': 'check_screen_resolution'},), 14:11:02 INFO - 'run_cmd_checks_enabled': True, 14:11:02 INFO - 'sps_profile': False, 14:11:02 INFO - 'sps_profile_interval': 0, 14:11:02 INFO - 'suite': 'dromaeojs', 14:11:02 INFO - 'system_bits': '32', 14:11:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:11:02 INFO - 'title': 't-yosemite-r7-0191', 14:11:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:11:02 INFO - 'use_talos_json': True, 14:11:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:11:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:11:02 INFO - 'work_dir': 'build'} 14:11:02 INFO - ##### 14:11:02 INFO - ##### Running clobber step. 14:11:02 INFO - ##### 14:11:02 INFO - Running pre-action listener: _resource_record_pre_action 14:11:02 INFO - Running main action method: clobber 14:11:02 INFO - rmtree: /builds/slave/test/build 14:11:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:11:04 INFO - Running post-action listener: _resource_record_post_action 14:11:04 INFO - ##### 14:11:04 INFO - ##### Finished clobber step (success) 14:11:04 INFO - ##### 14:11:04 INFO - ##### 14:11:04 INFO - ##### Running read-buildbot-config step. 14:11:04 INFO - ##### 14:11:04 INFO - Running pre-action listener: _resource_record_pre_action 14:11:04 INFO - Running main action method: read_buildbot_config 14:11:04 INFO - Using buildbot properties: 14:11:04 INFO - { 14:11:04 INFO - "project": "", 14:11:04 INFO - "product": "firefox", 14:11:04 INFO - "script_repo_revision": "production", 14:11:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:11:04 INFO - "repository": "", 14:11:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:11:04 INFO - "buildid": "20160705131323", 14:11:04 INFO - "pgo_build": "False", 14:11:04 INFO - "basedir": "/builds/slave/test", 14:11:04 INFO - "buildnumber": 83, 14:11:04 INFO - "slavename": "t-yosemite-r7-0191", 14:11:04 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:11:04 INFO - "platform": "yosemite_r7", 14:11:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:11:04 INFO - "branch": "fx-team", 14:11:04 INFO - "repo_path": "integration/fx-team", 14:11:04 INFO - "revision": "a74f88a7a05abe2b80eba43cab211199b30e7463", 14:11:04 INFO - "stage_platform": "macosx64", 14:11:04 INFO - "builduid": "0baf696b986f4d169513d14bbb2c8328", 14:11:04 INFO - "slavebuilddir": "test" 14:11:04 INFO - } 14:11:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 14:11:04 INFO - Running post-action listener: _resource_record_post_action 14:11:04 INFO - ##### 14:11:04 INFO - ##### Finished read-buildbot-config step (success) 14:11:04 INFO - ##### 14:11:04 INFO - ##### 14:11:04 INFO - ##### Running download-and-extract step. 14:11:04 INFO - ##### 14:11:04 INFO - Running pre-action listener: _resource_record_pre_action 14:11:04 INFO - Running main action method: download_and_extract 14:11:04 INFO - mkdir: /builds/slave/test/build/tests 14:11:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:04 INFO - https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:11:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 14:11:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 14:11:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/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 14:11:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/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 14:11:05 INFO - Downloaded 1199 bytes. 14:11:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 14:11:05 INFO - Using the following test package requirements: 14:11:05 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 14:11:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:05 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 14:11:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:05 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 14:11:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:05 INFO - u'jsshell-mac.zip'], 14:11:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:05 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 14:11:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 14:11:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:05 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 14:11:05 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:05 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 14:11:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:05 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 14:11:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:11:05 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 14:11:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:11:05 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')]} 14:11:05 INFO - https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:11:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:11:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:11:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/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 14:11:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/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 14:11:06 INFO - Downloaded 18801501 bytes. 14:11:06 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'] 14:11:06 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 14:11:09 INFO - Return code: 0 14:11:09 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 14:11:09 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')]} 14:11:09 INFO - https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:11:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:11:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:11:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/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 14:11:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/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 14:11:11 INFO - Downloaded 18801501 bytes. 14:11:11 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'] 14:11:11 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 14:11:14 INFO - Return code: 0 14:11:14 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')]} 14:11:14 INFO - https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:11:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:11:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:11:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/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 14:11:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/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 14:11:15 INFO - Downloaded 14403333 bytes. 14:11:15 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'] 14:11:15 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 14:11:16 INFO - Return code: 0 14:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:16 INFO - https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:11:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:11:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:11:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 14:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GM6byGiDTc2rsrt76D1QGw/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 14:11:18 INFO - Downloaded 112506523 bytes. 14:11:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:11:18 INFO - mkdir: /builds/slave/test/properties 14:11:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:11:18 INFO - Writing to file /builds/slave/test/properties/build_url 14:11:18 INFO - Contents: 14:11:18 INFO - build_url:https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:11:20 INFO - Running post-action listener: _resource_record_post_action 14:11:20 INFO - Running post-action listener: set_extra_try_arguments 14:11:20 INFO - ##### 14:11:20 INFO - ##### Finished download-and-extract step (success) 14:11:20 INFO - ##### 14:11:20 INFO - ##### 14:11:20 INFO - ##### Running populate-webroot step. 14:11:20 INFO - ##### 14:11:20 INFO - Running pre-action listener: _resource_record_pre_action 14:11:20 INFO - Running main action method: populate_webroot 14:11:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:20 INFO - '--tppagecycles', 14:11:20 INFO - '7'], 14:11:20 INFO - 'tests': ['tsvgm']}}, 14:11:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:20 INFO - 'talos_options': ['--disable-e10s'], 14:11:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:20 INFO - 'talos_options': ['--disable-e10s'], 14:11:20 INFO - 'tests': ['damp', 'tps']}, 14:11:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:20 INFO - 'tests': ['damp', 'tps']}, 14:11:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:20 INFO - 'tests': ['dromaeo_dom']}, 14:11:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:11:20 INFO - 'tests': ['basic_compositor_video']}, 14:11:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:11:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:20 INFO - 'tests': ['a11yr', 14:11:20 INFO - 'ts_paint', 14:11:20 INFO - 'tpaint', 14:11:20 INFO - 'sessionrestore', 14:11:20 INFO - 'sessionrestore_no_auto_restore', 14:11:20 INFO - 'tabpaint']}, 14:11:20 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:20 INFO - 'ts_paint', 14:11:20 INFO - 'tpaint', 14:11:20 INFO - 'sessionrestore', 14:11:20 INFO - 'sessionrestore_no_auto_restore', 14:11:20 INFO - 'tabpaint']}, 14:11:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:20 INFO - 'ts_paint', 14:11:20 INFO - 'tpaint', 14:11:20 INFO - 'sessionrestore', 14:11:20 INFO - 'sessionrestore_no_auto_restore', 14:11:20 INFO - 'tabpaint']}, 14:11:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:20 INFO - 'ts_paint', 14:11:20 INFO - 'tpaint', 14:11:20 INFO - 'sessionrestore', 14:11:20 INFO - 'sessionrestore_no_auto_restore', 14:11:20 INFO - 'tabpaint']}, 14:11:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:20 INFO - 'tests': ['a11yr', 14:11:20 INFO - 'ts_paint', 14:11:20 INFO - 'tpaint', 14:11:20 INFO - 'sessionrestore', 14:11:20 INFO - 'sessionrestore_no_auto_restore', 14:11:20 INFO - 'tabpaint']}, 14:11:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:20 INFO - 'tests': ['a11yr', 14:11:20 INFO - 'ts_paint', 14:11:20 INFO - 'tpaint', 14:11:20 INFO - 'sessionrestore', 14:11:20 INFO - 'sessionrestore_no_auto_restore', 14:11:20 INFO - 'tabpaint']}, 14:11:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:20 INFO - 'tests': ['tsvgx', 14:11:20 INFO - 'tsvgr_opacity', 14:11:20 INFO - 'tart', 14:11:20 INFO - 'tscrollx', 14:11:20 INFO - 'cart']}, 14:11:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:20 INFO - 'tsvgr_opacity', 14:11:20 INFO - 'tart', 14:11:20 INFO - 'tscrollx', 14:11:20 INFO - 'cart']}, 14:11:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:20 INFO - 'talos_options': ['--disable-e10s'], 14:11:20 INFO - 'tests': ['tp5o']}, 14:11:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:20 INFO - 'tests': ['tp5o']}, 14:11:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:20 INFO - 'talos_options': ['--disable-e10s', 14:11:20 INFO - '--xperf_path', 14:11:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:20 INFO - 'tests': ['tp5n']}, 14:11:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:20 INFO - 'talos_options': ['--xperf_path', 14:11:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:20 INFO - 'tests': ['tp5n']}}, 14:11:20 INFO - 'talos.zip': {'path': '', 14:11:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:20 INFO - Running post-action listener: _resource_record_post_action 14:11:20 INFO - ##### 14:11:20 INFO - ##### Finished populate-webroot step (success) 14:11:20 INFO - ##### 14:11:20 INFO - ##### 14:11:20 INFO - ##### Running create-virtualenv step. 14:11:20 INFO - ##### 14:11:20 INFO - Running pre-action listener: _resource_record_pre_action 14:11:20 INFO - Running main action method: create_virtualenv 14:11:20 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:11:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:20 INFO - Using real prefix '/tools/python27' 14:11:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:20 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:23 INFO - Installing pip.................done. 14:11:23 INFO - Return code: 0 14:11:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106285a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02ad56c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061e9d30>, '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 0x105f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1061e1b20>, '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.kfZjq39UZq/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.fGFSRJI64P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:11:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:11:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:11:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfZjq39UZq/Render', 14:11:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:23 INFO - 'HOME': '/Users/cltbld', 14:11:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:23 INFO - 'LOGNAME': 'cltbld', 14:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:23 INFO - 'MOZ_NO_REMOTE': '1', 14:11:23 INFO - 'NO_EM_RESTART': '1', 14:11:23 INFO - 'PAGER': '/bin/cat', 14:11:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:23 INFO - 'PWD': '/builds/slave/test', 14:11:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:23 INFO - 'SHELL': '/bin/bash', 14:11:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fGFSRJI64P/Listeners', 14:11:23 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:11:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:23 INFO - 'USER': 'cltbld', 14:11:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:23 INFO - 'XPC_FLAGS': '0x0', 14:11:23 INFO - 'XPC_SERVICE_NAME': '0', 14:11:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:24 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 14:11:24 INFO - Cleaning up... 14:11:24 INFO - Return code: 0 14:11:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11:24 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')]} 14:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:24 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')]} 14:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:24 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 0x106285a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02ad56c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061e9d30>, '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 0x105f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1061e1b20>, '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.kfZjq39UZq/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.fGFSRJI64P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:11:24 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 14:11:24 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 14:11:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfZjq39UZq/Render', 14:11:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:24 INFO - 'HOME': '/Users/cltbld', 14:11:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:24 INFO - 'LOGNAME': 'cltbld', 14:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:24 INFO - 'MOZ_NO_REMOTE': '1', 14:11:24 INFO - 'NO_EM_RESTART': '1', 14:11:24 INFO - 'PAGER': '/bin/cat', 14:11:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:24 INFO - 'PWD': '/builds/slave/test', 14:11:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:24 INFO - 'SHELL': '/bin/bash', 14:11:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fGFSRJI64P/Listeners', 14:11:24 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:11:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:24 INFO - 'USER': 'cltbld', 14:11:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:24 INFO - 'XPC_FLAGS': '0x0', 14:11:24 INFO - 'XPC_SERVICE_NAME': '0', 14:11:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:24 INFO - Downloading/unpacking psutil>=3.1.1 14:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:27 INFO - Installing collected packages: psutil 14:11:27 INFO - Running setup.py install for psutil 14:11:27 INFO - building 'psutil._psutil_osx' extension 14:11:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:11:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:11:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:11:27 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 14:11:27 INFO - building 'psutil._psutil_posix' extension 14:11:27 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 14:11:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:11:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:11:28 INFO - ^ 14:11:28 INFO - 1 warning generated. 14:11:28 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:28 INFO - Successfully installed psutil 14:11:28 INFO - Cleaning up... 14:11:28 INFO - Return code: 0 14:11:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106285a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02ad56c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061e9d30>, '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 0x105f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1061e1b20>, '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.kfZjq39UZq/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.fGFSRJI64P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:11:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfZjq39UZq/Render', 14:11:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:28 INFO - 'HOME': '/Users/cltbld', 14:11:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:28 INFO - 'LOGNAME': 'cltbld', 14:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:28 INFO - 'MOZ_NO_REMOTE': '1', 14:11:28 INFO - 'NO_EM_RESTART': '1', 14:11:28 INFO - 'PAGER': '/bin/cat', 14:11:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:28 INFO - 'PWD': '/builds/slave/test', 14:11:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:28 INFO - 'SHELL': '/bin/bash', 14:11:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fGFSRJI64P/Listeners', 14:11:28 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:11:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:28 INFO - 'USER': 'cltbld', 14:11:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:28 INFO - 'XPC_FLAGS': '0x0', 14:11:28 INFO - 'XPC_SERVICE_NAME': '0', 14:11:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:31 INFO - Installing collected packages: mozsystemmonitor 14:11:31 INFO - Running setup.py install for mozsystemmonitor 14:11:31 INFO - Successfully installed mozsystemmonitor 14:11:31 INFO - Cleaning up... 14:11:31 INFO - Return code: 0 14:11:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106285a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02ad56c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061e9d30>, '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 0x105f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1061e1b20>, '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.kfZjq39UZq/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.fGFSRJI64P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:11:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfZjq39UZq/Render', 14:11:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:31 INFO - 'HOME': '/Users/cltbld', 14:11:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:31 INFO - 'LOGNAME': 'cltbld', 14:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:31 INFO - 'MOZ_NO_REMOTE': '1', 14:11:31 INFO - 'NO_EM_RESTART': '1', 14:11:31 INFO - 'PAGER': '/bin/cat', 14:11:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:31 INFO - 'PWD': '/builds/slave/test', 14:11:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:31 INFO - 'SHELL': '/bin/bash', 14:11:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fGFSRJI64P/Listeners', 14:11:31 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:11:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:31 INFO - 'USER': 'cltbld', 14:11:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:31 INFO - 'XPC_FLAGS': '0x0', 14:11:31 INFO - 'XPC_SERVICE_NAME': '0', 14:11:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:31 INFO - Downloading/unpacking jsonschema==2.5.1 14:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:34 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:34 INFO - warning: no files found matching '*.txt' 14:11:34 INFO - no previously-included directories found matching 'build' 14:11:34 INFO - no previously-included directories found matching 'dist' 14:11:34 INFO - no previously-included directories found matching '.git*' 14:11:34 INFO - Installing collected packages: jsonschema, functools32 14:11:34 INFO - Running setup.py install for functools32 14:11:34 INFO - warning: no files found matching '*.txt' 14:11:34 INFO - no previously-included directories found matching 'build' 14:11:34 INFO - no previously-included directories found matching 'dist' 14:11:34 INFO - no previously-included directories found matching '.git*' 14:11:34 INFO - Successfully installed jsonschema functools32 14:11:34 INFO - Cleaning up... 14:11:34 INFO - Return code: 0 14:11:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11: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')]} 14:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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')]} 14:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11: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', '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 0x106285a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02ad56c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061e9d30>, '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 0x105f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1061e1b20>, '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.kfZjq39UZq/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.fGFSRJI64P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:11: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:11: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 blobuploader==1.2.4 14:11:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfZjq39UZq/Render', 14:11:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:34 INFO - 'HOME': '/Users/cltbld', 14:11:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:34 INFO - 'LOGNAME': 'cltbld', 14:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:34 INFO - 'MOZ_NO_REMOTE': '1', 14:11:34 INFO - 'NO_EM_RESTART': '1', 14:11:34 INFO - 'PAGER': '/bin/cat', 14:11:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:34 INFO - 'PWD': '/builds/slave/test', 14:11:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:34 INFO - 'SHELL': '/bin/bash', 14:11:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fGFSRJI64P/Listeners', 14:11:34 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:11:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:34 INFO - 'USER': 'cltbld', 14:11:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:34 INFO - 'XPC_FLAGS': '0x0', 14:11:34 INFO - 'XPC_SERVICE_NAME': '0', 14:11:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:35 INFO - Downloading/unpacking blobuploader==1.2.4 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:37 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11: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 14:11:38 INFO - Downloading docopt-0.6.1.tar.gz 14:11:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:38 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:38 INFO - Running setup.py install for blobuploader 14:11:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:38 INFO - Running setup.py install for requests 14:11:39 INFO - Running setup.py install for docopt 14:11:39 INFO - Successfully installed blobuploader requests docopt 14:11:39 INFO - Cleaning up... 14:11:39 INFO - Return code: 0 14:11:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:39 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 0x106285a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02ad56c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061e9d30>, '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 0x105f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1061e1b20>, '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.kfZjq39UZq/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.fGFSRJI64P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:11:39 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 14:11:39 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 14:11:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfZjq39UZq/Render', 14:11:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:39 INFO - 'HOME': '/Users/cltbld', 14:11:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:39 INFO - 'LOGNAME': 'cltbld', 14:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:39 INFO - 'MOZ_NO_REMOTE': '1', 14:11:39 INFO - 'NO_EM_RESTART': '1', 14:11:39 INFO - 'PAGER': '/bin/cat', 14:11:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:39 INFO - 'PWD': '/builds/slave/test', 14:11:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:39 INFO - 'SHELL': '/bin/bash', 14:11:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fGFSRJI64P/Listeners', 14:11:39 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:11:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:39 INFO - 'USER': 'cltbld', 14:11:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:39 INFO - 'XPC_FLAGS': '0x0', 14:11:39 INFO - 'XPC_SERVICE_NAME': '0', 14:11:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:39 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-5P1gXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:39 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-kUyrni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:40 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-MJGiHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:40 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-BSOePm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:40 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-UXH2kp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:40 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-LQcwsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:40 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-qBvDjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:40 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-qe0Ozl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:40 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Rc1UpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:40 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-YfPzJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:40 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-sBl2mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-7b6L9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-vI2BPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-zyNN68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-qhufYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-iCSalb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:41 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-AmD3hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:41 INFO - Running setup.py install for manifestparser 14:11:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:41 INFO - Running setup.py install for mozcrash 14:11:41 INFO - Running setup.py install for mozdebug 14:11:42 INFO - Running setup.py install for mozdevice 14:11:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:42 INFO - Running setup.py install for mozfile 14:11:42 INFO - Running setup.py install for mozhttpd 14:11:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:42 INFO - Running setup.py install for mozinfo 14:11:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:42 INFO - Running setup.py install for mozInstall 14:11:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:42 INFO - Running setup.py install for mozleak 14:11:42 INFO - Running setup.py install for mozlog 14:11:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:43 INFO - Running setup.py install for moznetwork 14:11:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:43 INFO - Running setup.py install for mozprocess 14:11:43 INFO - Running setup.py install for mozprofile 14:11:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:43 INFO - Running setup.py install for mozrunner 14:11:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:43 INFO - Running setup.py install for mozscreenshot 14:11:43 INFO - Running setup.py install for moztest 14:11:44 INFO - Running setup.py install for mozversion 14:11:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:44 INFO - Cleaning up... 14:11:44 INFO - Return code: 0 14:11:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106285a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02ad56c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061e9d30>, '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 0x105f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1061e1b20>, '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.kfZjq39UZq/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.fGFSRJI64P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:11:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfZjq39UZq/Render', 14:11:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:44 INFO - 'HOME': '/Users/cltbld', 14:11:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:44 INFO - 'LOGNAME': 'cltbld', 14:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:44 INFO - 'MOZ_NO_REMOTE': '1', 14:11:44 INFO - 'NO_EM_RESTART': '1', 14:11:44 INFO - 'PAGER': '/bin/cat', 14:11:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:44 INFO - 'PWD': '/builds/slave/test', 14:11:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:44 INFO - 'SHELL': '/bin/bash', 14:11:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fGFSRJI64P/Listeners', 14:11:44 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:11:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:44 INFO - 'USER': 'cltbld', 14:11:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:44 INFO - 'XPC_FLAGS': '0x0', 14:11:44 INFO - 'XPC_SERVICE_NAME': '0', 14:11:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:44 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-CRv7YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:44 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)) 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:44 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-r_GfAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:44 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)) 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:44 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-P7CdUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:44 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)) 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:44 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-SbTo0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:44 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)) 14:11:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:44 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-CQrSSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:45 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-giuoO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:45 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Cp5J22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:45 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Xryate-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:45 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)) 14:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:45 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-qDTzyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:45 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)) 14:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:45 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-LbEOiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:45 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)) 14:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:45 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-0Slc2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:45 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)) 14:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:45 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-m3_3y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 14:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:45 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-qdmxeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:45 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)) 14:11:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:45 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-45UxzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 14:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:46 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-g2cPFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:46 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-_gbVeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:46 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-tEaqzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:11:46 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)) 14:11:46 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)) 14:11:46 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)) 14:11:46 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)) 14:11:46 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)) 14:11:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:46 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 14:11:46 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 14:11:46 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 14:11:46 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 14:11:46 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 14:11:46 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 14:11:48 INFO - Downloading blessings-1.6.tar.gz 14:11:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:48 INFO - Installing collected packages: blessings 14:11:48 INFO - Running setup.py install for blessings 14:11:48 INFO - Successfully installed blessings 14:11:48 INFO - Cleaning up... 14:11:49 INFO - Return code: 0 14:11:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:49 INFO - Reading from file tmpfile_stdout 14:11:49 INFO - Current package versions: 14:11:49 INFO - blessings == 1.6 14:11:49 INFO - blobuploader == 1.2.4 14:11:49 INFO - docopt == 0.6.1 14:11:49 INFO - functools32 == 3.2.3-2 14:11:49 INFO - jsonschema == 2.5.1 14:11:49 INFO - manifestparser == 1.1 14:11:49 INFO - mozInstall == 1.12 14:11:49 INFO - mozcrash == 0.17 14:11:49 INFO - mozdebug == 0.1 14:11:49 INFO - mozdevice == 0.48 14:11:49 INFO - mozfile == 1.2 14:11:49 INFO - mozhttpd == 0.7 14:11:49 INFO - mozinfo == 0.9 14:11:49 INFO - mozleak == 0.1 14:11:49 INFO - mozlog == 3.2 14:11:49 INFO - moznetwork == 0.27 14:11:49 INFO - mozprocess == 0.22 14:11:49 INFO - mozprofile == 0.28 14:11:49 INFO - mozrunner == 6.11 14:11:49 INFO - mozscreenshot == 0.1 14:11:49 INFO - mozsystemmonitor == 0.3 14:11:49 INFO - moztest == 0.7 14:11:49 INFO - mozversion == 1.4 14:11:49 INFO - psutil == 3.1.1 14:11:49 INFO - requests == 1.2.3 14:11:49 INFO - wsgiref == 0.1.2 14:11:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:49 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 0x106285a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02ad56c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061e9d30>, '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 0x105f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1061e1b20>, '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.kfZjq39UZq/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.fGFSRJI64P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:11:49 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 14:11:49 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 14:11:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfZjq39UZq/Render', 14:11:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:49 INFO - 'HOME': '/Users/cltbld', 14:11:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:49 INFO - 'LOGNAME': 'cltbld', 14:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:49 INFO - 'MOZ_NO_REMOTE': '1', 14:11:49 INFO - 'NO_EM_RESTART': '1', 14:11:49 INFO - 'PAGER': '/bin/cat', 14:11:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:49 INFO - 'PWD': '/builds/slave/test', 14:11:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:49 INFO - 'SHELL': '/bin/bash', 14:11:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fGFSRJI64P/Listeners', 14:11:49 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:11:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:49 INFO - 'USER': 'cltbld', 14:11:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:49 INFO - 'XPC_FLAGS': '0x0', 14:11:49 INFO - 'XPC_SERVICE_NAME': '0', 14:11:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:49 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)) 14:11:49 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)) 14:11:49 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)) 14:11:49 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)) 14:11:49 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)) 14:11:49 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)) 14:11:49 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)) 14:11:49 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)) 14:11:49 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)) 14:11:49 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)) 14:11:49 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)) 14:11:49 INFO - Cleaning up... 14:11:49 INFO - Return code: 0 14:11:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:49 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 0x106285a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10631a618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02ad56c30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061e9d30>, '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 0x105f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1061e1b20>, '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.kfZjq39UZq/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.fGFSRJI64P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 14:11:49 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 14:11:49 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 14:11:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfZjq39UZq/Render', 14:11:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:11:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:11:49 INFO - 'HOME': '/Users/cltbld', 14:11:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:11:49 INFO - 'LOGNAME': 'cltbld', 14:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:49 INFO - 'MOZ_NO_REMOTE': '1', 14:11:49 INFO - 'NO_EM_RESTART': '1', 14:11:49 INFO - 'PAGER': '/bin/cat', 14:11:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:49 INFO - 'PWD': '/builds/slave/test', 14:11:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:11:49 INFO - 'SHELL': '/bin/bash', 14:11:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fGFSRJI64P/Listeners', 14:11:49 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:11:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:11:49 INFO - 'USER': 'cltbld', 14:11:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:11:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:49 INFO - 'XPC_FLAGS': '0x0', 14:11:49 INFO - 'XPC_SERVICE_NAME': '0', 14:11:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:11:49 INFO - Cleaning up... 14:11:49 INFO - Return code: 0 14:11:49 INFO - Running post-action listener: _resource_record_post_action 14:11:49 INFO - Running post-action listener: _start_resource_monitoring 14:11:49 INFO - Starting resource monitoring. 14:11:49 INFO - ##### 14:11:49 INFO - ##### Finished create-virtualenv step (success) 14:11:49 INFO - ##### 14:11:49 INFO - ##### 14:11:49 INFO - ##### Running install step. 14:11:49 INFO - ##### 14:11:49 INFO - Running pre-action listener: _resource_record_pre_action 14:11:49 INFO - Running main action method: install 14:11:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:50 INFO - Reading from file tmpfile_stdout 14:11:50 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:50 INFO - Reading from file tmpfile_stdout 14:11:50 INFO - Output received: 14:11:50 INFO - Usage: mozinstall [options] installer 14:11:50 INFO - Options: 14:11:50 INFO - -h, --help show this help message and exit 14:11:50 INFO - -d DEST, --destination=DEST 14:11:50 INFO - Directory to install application into. [default: 14:11:50 INFO - "/builds/slave/test"] 14:11:50 INFO - --app=APP Application being installed. [default: firefox] 14:11:50 INFO - mkdir: /builds/slave/test/build/application 14:11:50 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'] 14:11:50 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 14:12:25 INFO - Reading from file tmpfile_stdout 14:12:25 INFO - Output received: 14:12:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:12:25 INFO - Running post-action listener: _resource_record_post_action 14:12:25 INFO - ##### 14:12:25 INFO - ##### Finished install step (success) 14:12:25 INFO - ##### 14:12:25 INFO - ##### 14:12:25 INFO - ##### Running run-tests step. 14:12:25 INFO - ##### 14:12:25 INFO - Running pre-action listener: _resource_record_pre_action 14:12:25 INFO - Running main action method: run_tests 14:12:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:12:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:12:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:12:25 INFO - 2016-07-05 14:12:25.211 screenresolution[2553:287821] starting screenresolution argv=screenresolution get 14:12:25 INFO - 2016-07-05 14:12:25.213 screenresolution[2553:287821] Display 0: 1600x1200x32@60 14:12:25 INFO - 2016-07-05 14:12:25.219 screenresolution[2554:287824] starting screenresolution argv=screenresolution list 14:12:25 INFO - Available Modes on Display 0 14:12:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:12:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:12:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:12:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:12:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:12:25 INFO - Intel Iris: 14:12:25 INFO - Chipset Model: Intel Iris 14:12:25 INFO - Type: GPU 14:12:25 INFO - Bus: Built-In 14:12:25 INFO - VRAM (Dynamic, Max): 1536 MB 14:12:25 INFO - Vendor: Intel (0x8086) 14:12:25 INFO - Device ID: 0x0a2e 14:12:25 INFO - Revision ID: 0x0009 14:12:25 INFO - Displays: 14:12:25 INFO - Display: 14:12:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:12:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:12:25 INFO - Display Serial Number: 1600x1200 60 14:12:25 INFO - Main Display: Yes 14:12:25 INFO - Mirror: Off 14:12:25 INFO - Online: Yes 14:12:25 INFO - Rotation: Supported 14:12:25 INFO - Return code: 0 14:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:12:25 INFO - Python 2.7.3 14:12:25 INFO - Return code: 0 14:12:25 INFO - grabbing minidump binary from tooltool 14:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 14:12:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061e9d30>, '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 0x105f4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1061e1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:12:25 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:12:25 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:12:25 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:12:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:12:25 INFO - Return code: 0 14:12:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:12:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:12:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:12:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:12:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 14:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --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 14:12:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfZjq39UZq/Render', 14:12:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:12:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:12:25 INFO - 'HOME': '/Users/cltbld', 14:12:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:12:25 INFO - 'LOGNAME': 'cltbld', 14:12:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:12:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:12:25 INFO - 'MOZ_NO_REMOTE': '1', 14:12:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:12:25 INFO - 'NO_EM_RESTART': '1', 14:12:25 INFO - 'PAGER': '/bin/cat', 14:12:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:12:25 INFO - 'PWD': '/builds/slave/test', 14:12:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:12:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:12:25 INFO - 'SHELL': '/bin/bash', 14:12:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fGFSRJI64P/Listeners', 14:12:25 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 14:12:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:12:25 INFO - 'USER': 'cltbld', 14:12:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:12:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:12:25 INFO - 'XPC_FLAGS': '0x0', 14:12:25 INFO - 'XPC_SERVICE_NAME': '0', 14:12:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:12:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 14:12:25 INFO - mozversion application_buildid: 20160705131323 14:12:25 INFO - mozversion application_changeset: a74f88a7a05abe2b80eba43cab211199b30e7463 14:12:25 INFO - mozversion application_display_name: Nightly 14:12:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:12:25 INFO - mozversion application_name: Firefox 14:12:25 INFO - mozversion application_remotingname: firefox 14:12:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:12:25 INFO - mozversion application_vendor: Mozilla 14:12:25 INFO - mozversion application_version: 50.0a1 14:12:25 INFO - mozversion platform_buildid: 20160705131323 14:12:25 INFO - mozversion platform_changeset: a74f88a7a05abe2b80eba43cab211199b30e7463 14:12:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:12:25 INFO - mozversion platform_version: 50.0a1 14:12:25 INFO - using testdate: 1467753145 14:12:25 INFO - actual date: 1467753145 14:12:25 INFO - starting webserver on 'localhost:52615' 14:12:25 INFO - SUITE-START | Running 2 tests 14:12:25 INFO - TEST-START | dromaeo_css 14:12:25 INFO - operating with platform_type : mac_ 14:12:25 INFO - Initialising browser for dromaeo_css test... 14:12:25 INFO - TEST-INFO | started process 2564 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpKXdbzT/profile http://localhost:52615/getInfo.html) 14:12:28 INFO - PROCESS | 2564 | __metrics Screen width/height:1600/1200 14:12:28 INFO - PROCESS | 2564 | colorDepth:24 14:12:28 INFO - PROCESS | 2564 | Browser inner width/height: 1024/689 14:12:28 INFO - PROCESS | 2564 | __metrics 14:12:28 INFO - PROCESS | 2564 | 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" 14:12:28 INFO - PROCESS | 2564 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:12:29 INFO - TEST-INFO | 2564: exit 0 14:12:29 INFO - Browser initialized. 14:12:29 INFO - Running cycle 1/1 for dromaeo_css test... 14:12:29 INFO - TEST-INFO | started process 2566 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpKXdbzT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:41 INFO - PROCESS | 2566 | RSS: Main: 244940800 14:12:41 INFO - PROCESS | 2566 | 14:13:32 INFO - PROCESS | 2566 | 1467753212039 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] 14:15:43 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:52615/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52615/tests/dromaeo/cssquery-ext.html) 14:15:45 INFO - PROCESS | 2566 | RSS: Main: 355123200 14:15:45 INFO - PROCESS | 2566 | 14:18:48 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:52615/tests/dromaeo/cssquery-ext.html (next: http://localhost:52615/tests/dromaeo/cssquery-jquery.html) 14:18:49 INFO - PROCESS | 2566 | RSS: Main: 382402560 14:18:49 INFO - PROCESS | 2566 | 14:21:51 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:52615/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52615/tests/dromaeo/cssquery-mootools.html) 14:21:52 INFO - PROCESS | 2566 | RSS: Main: 369393664 14:21:52 INFO - PROCESS | 2566 | 14:24:54 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:52615/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52615/tests/dromaeo/cssquery-prototype.html) 14:24:55 INFO - PROCESS | 2566 | RSS: Main: 369500160 14:24:55 INFO - PROCESS | 2566 | 14:27:58 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:52615/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52615/tests/dromaeo/cssquery-yui.html) 14:27:59 INFO - PROCESS | 2566 | RSS: Main: 341159936 14:27:59 INFO - PROCESS | 2566 | 14:31:02 INFO - PROCESS | 2566 | Cycle 1(1): loaded http://localhost:52615/tests/dromaeo/cssquery-yui.html (next: http://localhost:52615/tests/dromaeo/cssquery-dojo.html) 14:31:02 INFO - PROCESS | 2566 | RSS: Main: 381493248 14:31:02 INFO - PROCESS | 2566 | 14:31:02 INFO - PROCESS | 2566 | __start_tp_report 14:31:02 INFO - PROCESS | 2566 | _x_x_mozilla_page_load 14:31:02 INFO - PROCESS | 2566 | _x_x_mozilla_page_load_details 14:31:02 INFO - PROCESS | 2566 | |i|pagename|runs| 14:31:02 INFO - PROCESS | 2566 | |0;dojo.html;3310.917227069323;3321.5681961345026;3335.24956884701;3375.392429362717;3390.5083762854388;5564.081926482136;5641.605087643867;5652.208690783294;5740.569457290704;5758.337791154018;5745.942540574593;5750.079987202049;5848.941510584893;5863.736131874065;5911.93585154673;5140.100482415581;5142.151544995071;5211.140161873286;5212.739363031852;5303.946960530403;5282.286891269668;5303.628745987782;5312.6281160318795;5334.5999050071205;5357.142857142858;5128.256402821588;5154.123798954187;5169.715665638389;5200.609954253408;5212.895742085156;5167.431582525919;5191.039657663345;5208.895822083575;5217.060929032773;5249.055170069386;4442.311441726505;5194.3247377840635;5206.323177986876;5245.737713114368;5282.550983166436;5661.8584535386535;5700.40145784695;5713.171590119409;5735.4551317624755;5864.618799778001;6196.039613859859;6198.597091189058;6243;6261.405166509175;6293.244810622755;6177.598456100339;6245;6246.500279977591;6278.497720182374;6278.843028924313;5743.2246646703;5804.100364443518;5826.242588463558;5976.223090998186;5998.670073145975;6269.905951410732;6334.5249106317215;6334.588251763621;6345.841353966188;6350.682465876687;6168.383161683885;6186.381361863778;6187.938120618826;6192.195014648067;6211.16149319845;6125.021800333839;6137.846553836101;6155.199824022938;6182.752689892354;6237;6143.109249158847;6197.876042479215;6222.408871157233;6227.501799856001;6232.532560058014;6209.875802483925;6211.192544969125;6233.625982441068;6235.750569977241;6238.75044998195;4889.559939605452;4939.135651261015;4959.479254678206;4962.975185124052;5075.390953085654;3853.460515527828;4448.799804008828;4528.841490547815;4553.658475614276;4562.68061235717;5807.535397168301;5829.213056237439;5840.2991641003355;5854.795082172103;5882.264716910387;6147.262328520516;6177.722002509898;6192.349803270592;6221.253449586078;6247.781327653601;5562.97218513913;5707.4577915098;5714.657120572779;5753.424657534297;5767.798127065533;5453.7818487260065;5473.0969390050195;5475.342958844964;5477.342718873681;5518.558515318765;6341.8731625368155;6354.078658594478;6364.268109167412;6382.840428989312;6407.359264073555;5100.6429549931145;6088.969555152196;6156.045812899008;6159.692015399301;6265.843353916189;6267.905981410374;6316.494680425463;6318.115463835159;6323.272823625158;6335.461485773577;6200.410960958701;6222.751089956532;6245.500359971101;6251.531135164972;6252.843678907881;6108.433136212329;6226.439620434183;6267.5299352549655;6293.307736148929;6297.338779428277;5998.850028749316;6145.016797312409;6154.353792851686;6176.474999625082;6176.876462470816;6114.938850611437;6143.877122457437;6168.352323006199;6188.44304012623;6191.19514463117;5571;5774.942250577608;5852.824415267549;5854.151148083419;5923.703814809156;5196.376434827694;6146.293176284785;6184.628922264678;6212.534059945432;6212.720427580679;6069.605475644069;6071.332153463204;6073.665948372882;6081.756729730761;6093.451589356979 14:31:02 INFO - PROCESS | 2566 | |1;ext.html;457.96042982429884;472.84159806464834;486.36043602662517;505.0958783777039;511.6188439612489;31163.53254701181;33366.49950250748;35360;42646.36030459546;43243.35134972978;44541.331880021826;44892;44962.775186124105;45033.09933801322;45119.09761804762;9669.323147379686;9868.407895526256;9871.210303175729;9873.950630246838;9888.011198880127;8674.86987695185;8901.287896968228;11832.171747977645;12043.698907527294;12072.577459788909;12020.278783272988;12052.397380131002;12130;12141.392930353491;12145.453454594564;8722;11718.707032324175;11964.102692298069;12002.099842511847;12035.458404371824;11546.018588419995;11939.701507462296;11952.342621155833;11959;11974.820377694254;42108.578914210775;42555;42561.36157957633;42600.78699606513;42691;3537.6816086552076;3553.2919328657144;3929.7445666031617;4245.108527209259;4425.7565833879125;31728.841355793305;32883.34233315344;33520.83239583811;33535;33615.49576756351;3228.564044452407;3328.900132996014;3371.3088816792497;3438.4670376091744;3441.20852203992;553742;554136;555920;556722.4327756711;557374.2131289317;65816.6709166451;65988.67005664941;66373.69449902252;66439.66780166165;66445.6677716618;57275.71362143246;68776.31223687799;68803;68922;68938.31061689318;17405.042722650123;17610.559736006704;17613.7357939631;17620.647587048188;17640.558986025197;12135.968442682295;12378.938105309417;12388.690282743004;13235.73528529424;13309.667258318426;16353.81803310152;16438.095904725116;17185.39851105205;17283.654326913642;17351.958882467094;7897.565633890076;7899.881501777478;7909.327707144842;7944.523328600302;7966.362690984707;931.8695382646434;982.6216906491053;1006.8892421833592;1019.6686077024997;1053.8893416191343;30734;31061.378772424425;31119.844400778304;31238.68761312403;31986.520202196985;1018.8624535687735;1077.052194069214;1152.9565743002597;1159.263867444162;1171.1275100050348;15846.920765396098;16125.677486450206;16158.43445479426;16416.75374869378;16751.58121046959;719391;723684;723729;724208;724564.3771781108;61643.38356616466;62125.68937155376;62152.68923655353;62252;62421.06368404478;1237.047473445442;1237.189640785287;1403.9929800350933;1411.908225965309;1449.173970836613;31251.84374078115;31982.68017319797;32032.83983580067;32821;32833.343333132725;52052.47947520476;52804.47195528149;52810;52819;52881.47118528919;516306;518888;521905;522005;523899;27041.86479067592;28207.57688634631;28297.57553636738;28303;28375.71624283731;49679.00641987212;50521.49478505168;51121.48878511167;51724.74137629438;51748;34535.13662158365;40961.975950601474;41035;41144.38283425691;42257;40972;41200.35198592023;41312.58687413087;41557;42659.786701066296;39574.40638390369;40125.598744013354;40307.395389069774;40356.789296321156;40617.59382406256;35051.649483504836;35139.64860351364;36479.45280820737;36575.634243658285;36598.8170059148;24792.25623231306;25454.745452545238;26210;26269.474610508067;27001.59497607577 14:31:02 INFO - PROCESS | 2566 | |2;jquery.html;359.1344858890075;378.38323532641795;389.0371330955884;391.8138884030086;408.6710198290377;15564.221788910552;15921.442749503754;21497.99999999998;21570.460738481506;21899.233526826563;21446.463838404048;21942;21974.340769776893;22154.667679984774;22563.435914102156;5973.820785376435;6044.395560443964;6072.119542666311;6182.196314479134;6183.350748171445;4144.233316836395;4380.934285985697;4858.344123543312;6177.722002509875;6377.585456945284;6669;6727.932720672779;6735.427488663469;6739.22498912624;6751.966240168792;6362.968185159068;6666.433353164987;6674.466042716571;6681.465482761368;6686;5171.301874247004;5511.559075273968;5792.594518383715;5799.652020878719;5799.88400231993;13357.866421335759;13598.660033499144;13602.591922242349;13626.931865340708;23005.424864378358;2329.743728189898;2418.6734790803366;2451.080844683244;2750.2024412920227;3073.6926307369085;9442.339036267464;10431.478426078666;10443.582256709722;11292.604758833402;15627.92186039074;1785.4108144312477;1795.721663142215;1807.204829874851;1840.8159184081485;2033.9593208135755;86970;103489;115373;126507.36746316301;139409;9600.420557734962;11221.382823944597;11494.252873563191;11655.125865560118;11676.124290678234;14718.63203419923;14886.70226595462;14921.477748278758;14932.626684332761;14939.775903361458;8650.178233067974;8806.12755170241;8919.331050171264;8995.505247211466;9007.189352958265;8788;8961.417507861968;8987.775305617412;9095.590698418588;9141.81716365669;4574.656900732459;4646.233371493666;4646.581807637329;4651.046535460223;4702.694324868941;1614.9180049366717;1616.7009103315925;1618.281287437117;1707.581642497596;1914.2389002118084;810.8905297784842;861.2636196052285;867.2108381372921;879.8680197970227;1012.9949350253349;21543.46141346479;22438.775612243997;22473.988670509538;22524.324270271918;22596.983135758932;924.3806649544821;929.7303781903172;939.8637197606308;953.880764904387;989.1246247071393;8011.479253848481;11451.541938322374;11733.35466549348;11811.409429528489;11812.99589534882;589241;603685;607182;614289;615647;88518;92727;93804.53097734468;118760;121636.39181804212;853.3770347646253;910.7841032221926;940.4122423485321;972.0910948263396;972.8783902012249;18232.726509102107;19672.409827705193;19984.50038749043;20105;20166.798332016493;43247.783761080995;58075.41924580869;58605.5348616288;59343.40656593379;60005.69997149986;76296;78591;80927.3814523718;84679;84941.15058849333;5543.085390910454;7828.412869034732;8235.711750088718;8240.958795205986;8271.131531189138;11254;11588.536458541565;13495.527656531975;13818.86181138216;13820;10220.386776793119;11254.705708843589;11299.3785341807;11378.487968041292;11798.52805887755;11314.490847911698;11353.829692554784;11482.483288252215;11491.253068550517;11788.882111178778;9436.622535098793;9463.763405914908;11365.431728413381;11616.954474097372;11840.467178977138;7123.964380178066;7427.071616047994;7476.626168691652;7719.845603087794;8485.533295668798;8229.423940324119;10552.683419497427;11543.422828858691;11892.405379731152;11901.404929753304 14:31:02 INFO - PROCESS | 2566 | |3;mootools.html;1570.1364249662684;1591.7134915715171;1815.52796272969;1940.7865134835174;1942.7571553555806;8249.886265354175;8534.91465085349;8582.356323275755;8777.253933415668;8947.91052089479;7822.10045844728;8128.878066829002;8450.87323690145;8744.300455963523;8763.255123314526;2362.0197617988515;2397.2927986244013;2397.6883005209297;2402.699662542182;2406.6630671705975;2372.4543355028354;2380.5952987991996;2421.32202983165;2421.32202983165;2424.272718184546;2096.329174664108;2175.575762726269;2178.6078505868936;2179.8365122615787;2180.967285490719;2310.630299152136;2388.3432056184515;2394.341556072077;2394.964075538868;2396.724376696667;2326.209088909779;2350.0364850411247;2361.97638023621;2373.8813059346962;2381.190395265618;8724.78188045304;8768.079351668046;8770.035296117421;8781.692640757607;8825.51459669718;5198.246254293144;5322.627416080876;5372.7045012524295;5377.51602355786;5380.650257733274;3180.3321302526497;3537.5047493350953;3614.36748569002;3690.5017822593873;3698.8890333289773;967.1972263021676;1061.5912873543664;1100.818364969779;1114.2701530497536;1118.6867677050438;11330.376829274386;11533.308001519936;11555.53777848885;11563.884361156364;11574.53701851925;4659.254519276899;4728.17256980034;4774.212254977959;4830.236963508294;4831.106245344622;10025.649102281384;10175.033371829664;10187.898121018843;10206;10215.23385746072;5222.843314700565;5302.28419163408;5314.97342513285;5320.733963301819;5329.626926115212;4779.641526885497;4792.353032340659;4845.53967373099;4860.1008813369635;4861.003494283664;3276.8689252429635;3844.1735026968777;3879.631435013669;3922.1763429679518;3971.7418367806;1048.219076787798;1252.8371311729418;1254.9372531373394;1265.5380786013038;1269.9809502857465;870.5821205821242;937.2033771294346;939.2110627073155;971.2569884038716;994.1947022911465;5914.083317085859;5974.133750606138;6080.027195648675;6129.1419201311855;6184.165137706442;436.2844934307738;438.27246770361046;450.38747303666986;456.99314510282375;458.6262196309997;3997.2446466358147;4081.9591804082174;4151.377293406013;4161.4382058421725;4179.6029377209115;10089.394636321844;10501.684949451528;10661.253712240068;10679.932006799258;10686.625968091079;10542.525586348633;10698.732531686614;10708.678739637824;10718.035376816124;10735.83896241557;8020.398470114765;8039.115697273295;8251.587420628945;8297.8340433191;8344.998600168019;5190.636655434083;5990.64056156632;5998.430149135826;6006.459418652343;6045.549068223682;9793.85309220348;10114.241431892784;10127.544260508148;10131;10159.695209143738;9852.162566181669;10147.441890696082;10249.33379330341;10278.229132814919;10282.948585257025;6439.645819479973;7359.521631093961;7515.511491753018;7525.134609519756;7539;8121.75634730959;8147.714829980922;8243.381746369167;8245.051819040647;8252.546109964009;6138.5396095292135;7365.963170184329;7463.731165701953;7621.618919054136;7753.457257991887;7294.088238970129;7429.628518574158;7466.104067511933;7487.6630551626395;7622.504537205064;7023.122109736283;7077.5399599025895;7129.1445026595065;7147.035150254649;7156.391706704989;4934.827281045146;5112.514311140436;5118.462561431145;5155.32980712505;5211.817586384458;5115.667481613832;5123.129068058364;5131.743412829418;5211.9478805212975;5336.466353364633 14:31:02 INFO - PROCESS | 2566 | |4;prototype.html;307.98614062367193;314.7875184250632;318.1806847368028;319.0333290130904;323.43560486950275;5040.949590504094;5148.510891465314;5321.574274058075;5394.109971854639;5434.592405569583;5316.893662126765;5377;5385.973070134653;5407.918416316733;5412.753707211503;3567.94648080279;3849.7671350616715;3850.403187505934;4017.1521100293753;4076.5719599442077;3992;4053.7433395647445;4096.242195193884;4116.0121570823085;4116.650084742801;3453.49924260982;4035.1122752994293;4046.9967366153796;4053.61490658387;4092.4475195848627;3629.891103266906;3867.845286188549;4064.959350406488;4072.552019277877;4083.7743429830516;3484.61669216386;3562.4656301554714;3565.180008598037;3571.928561428783;3573.4103872860946;4286.828526858922;4290.0561876387455;4826.251930950708;5150.150225212836;5279.60402969775;4476.597106260452;4657.601335312317;4696.765161741933;4700.412448443944;4747.382840230783;4454.732716037048;5521.4478552144865;5532.889342213133;5569.331680198402;5599.356074051496;3319.40250754864;3919.862804801818;3961.98019009906;3966.2632783379377;3967.8016099195215;5096.490350964911;5387.622866399353;5856.89584520205;5883.79406720767;5918.2306300181135;3269.869205231764;3813.6567708905777;3853.7687738735767;3861.5366156061455;3903.0047337929213;3824.8661296854475;3922.4508568800393;3940.6650434712797;3942;3945.9013524662114;4176.0395109125075;4476.194285028726;4576.679632425765;4584.679072464962;4602.148602508547;5313.840584782462;5603.943960560424;5611.6352437091455;5620.634658747168;5655.208270842086;1298.3183828490119;1329.7672907241194;1330.6872884872048;1331.2145833958011;1331.780256257726;742.3615690506268;762.4472257613186;799.152897928198;816.5794615772882;821.1008945204991;3970.84845394838;4366.476022877211;5042.033606893315;5212;5241.397239317451;5048.7728052237735;5262.92105618416;5562.853047382584;5705.5720820938595;5728.283964504437;4864.494785185632;5191.377034755854;5201.817936372285;5205.427402985669;5225.451327610546;2527.4186937004224;2985.8056777289257;3006.4888968875343;3009.660700988083;3009.864556094981;5184.896302074013;5854.560907931922;5861.296644402699;5886.997631208029;5920.904632642889;5538.390777014606;5583.357913839879;5645.633033852787;5754;5790.668146326284;5110.4123025852505;5657.660540367591;5759.183224942754;6025.698715064317;6027.48766354856;4407.964128429752;4670.743109129031;5417.593680474059;5506.256655351476;5587.234319012115;5419.268398766274;5724.341700704473;5757.5393968481585;5766.682832444088;5769.307683078057;5928.407159284209;5971.7611295547695;5977.641341519523;5998.770252098222;6055.760168309933;3237.482002879528;3400.727941764603;3813.485179500732;3840.1551658635058;3861.8262178201485;5747.396523365153;5750.511206547323;5754.884902302014;5789.9710501447225;5886.264216972879;4892.192788189909;5552.722363881709;5619.971900140473;5631.971840140773;5682.272509195692;5242.082635538842;5544.22380866687;5571.526420254324;5634.774609015593;5658.717064146694;5149.459306772885;5172.7155006475;5209.801745598609;5427.887283107033;5548.583856210719;5286.312779338661;5346.732663366894;5471.841400535542;5586.329640443173;5599.80400685974;4564.977175114103;5446.373667028342;5459.781608735606;5459.962607104638;5481.808136715196 14:31:02 INFO - PROCESS | 2566 | |5;yui.html;737.686483244621;744.3896005275673;786.6774622404812;841.7011960753936;853.5604163855613;12136;15885.205739713012;15908.284127214274;15960.521184364488;15976.2011899405;13985.440582376717;14803.925980370082;14812.555623331318;14843.777343339858;14872.256387180652;718.6658203935169;888.7111688701182;893.2630579771682;905.8460061789478;906.1391677905983;735.808689740666;886.4902680958443;918.1277786103228;925.8055808280269;927.4620719982394;967.1585720423242;967.318040781251;968.9854652180223;970.3207754571793;972.8735264415651;745.4148493432683;775.1899265267753;957.8802649668792;960.2222200018008;960.7982323711994;572.0932322269208;573.3292048303495;574.8562859285179;695.183159787253;719.7696737044148;14925.25373731309;14938.775918361232;14961.40154393823;14964.551063468114;14975.101493910292;13854.376553055035;13929;13933.233672148028;14012.579622611338;14334.42662293507;12417.503299867994;12496.875031249752;12529.561465348668;12657.493700251978;12699.55551555691;4430.911381772379;4501.369808226851;4521.3896124023495;4567.588916997486;4741.407324084489;111404;112464;112886.01810791781;113090;114466;11075.280106793032;11157.888421115847;11170.162237832195;11172.385518796382;11581.710457238636;21802.563948720937;21832.78167218339;21834;21851.562968740534;21854.672179917314;7924.167962363984;7934.404919631051;7973.362131029504;8033.1966803320365;8136.227058429558;4412.24991751403;4451.59935605797;4485.708428952173;4607.608353289941;4648.047150334173;3486.633903440153;3598.982005089958;3599.8380072896784;3600.657937495986;3602.117481217066;640.9647469389229;651.9739210431625;658.8616390557941;666.7466362782112;669.8827705151579;520.898424807159;531.6889619572594;586.6949186423036;650.4763665249519;655.783591414832;7907.446478746432;8255.587220638945;8355.874661880076;9046.547672616343;9134.497602631785;592.7273454211111;603.2278683285401;631.643121636274;638.7604648256904;640.4236187431256;4179.874603761892;4363.585459381354;4370.8033138508845;4404.8458303959205;4447.577480139382;155594;155838;156148;158504;162198;126595;127375;129076;132511;136614;111026;115915;116237;116359.41820290845;116477.41761291139;8451.8732219018;8499.787505312417;8543.871841922251;8610.225079742853;8670.696525621574;51181.7440912793;58914.705426472596;61502.76994460175;62922.685386572775;65256;68701;72276.27723722695;75748.24251757412;79081.60459197668;80653;13559.254241016839;13650.317484125953;13652.522161724291;14163.291835407983;14374.568762937128;15000.774988375402;15436.768448473507;15601.453949111727;15825;16116.67766644637;14232.217228052143;14473.203973781121;14819.629509262355;14863.925680371529;15020;12654.620361389174;14222.715545689236;14280.500182493979;14713.190774507504;14716.926415367854;13566.321683915567;13691.178529288274;13791.379387927367;13855.445782168601;14007.159570425807;10156.339837910513;11116.110711142928;11163.330200188015;11654.825177622512;11839.704007399883;11284.526895416873;11366.261193022427;11528.769424611628;11618.825717614412;11659.300441973508 14:31:02 INFO - PROCESS | 2566 | __end_tp_report 14:31:02 INFO - PROCESS | 2566 | __start_cc_report 14:31:02 INFO - PROCESS | 2566 | _x_x_mozilla_cycle_collect,1232 14:31:02 INFO - PROCESS | 2566 | __end_cc_report 14:31:02 INFO - PROCESS | 2566 | __startTimestamp1467754262420__endTimestamp 14:31:02 INFO - PROCESS | 2566 | 14:31:02 INFO - PROCESS | 2566 | ------- Summary: start ------- 14:31:02 INFO - PROCESS | 2566 | Number of tests: 6 14:31:02 INFO - PROCESS | 2566 | 14:31:02 INFO - PROCESS | 2566 | [#0] dojo.html Cycles:165 Average:5753.34 Median:5998.85 stddev:654.07 (10.9%) stddev-sans-first:627.38 14:31:02 INFO - PROCESS | 2566 | Values: 3310.9 3321.6 3335.2 3375.4 3390.5 5564.1 5641.6 5652.2 5740.6 5758.3 5745.9 5750.1 5848.9 5863.7 5911.9 5140.1 5142.2 5211.1 5212.7 5303.9 5282.3 5303.6 5312.6 5334.6 5357.1 5128.3 5154.1 5169.7 5200.6 5212.9 5167.4 5191.0 5208.9 5217.1 5249.1 4442.3 5194.3 5206.3 5245.7 5282.6 5661.9 5700.4 5713.2 5735.5 5864.6 6196.0 6198.6 6243.0 6261.4 6293.2 6177.6 6245.0 6246.5 6278.5 6278.8 5743.2 5804.1 5826.2 5976.2 5998.7 6269.9 6334.5 6334.6 6345.8 6350.7 6168.4 6186.4 6187.9 6192.2 6211.2 6125.0 6137.8 6155.2 6182.8 6237.0 6143.1 6197.9 6222.4 6227.5 6232.5 6209.9 6211.2 6233.6 6235.8 6238.8 4889.6 4939.1 4959.5 4963.0 5075.4 3853.5 4448.8 4528.8 4553.7 4562.7 5807.5 5829.2 5840.3 5854.8 5882.3 6147.3 6177.7 6192.3 6221.3 6247.8 5563.0 5707.5 5714.7 5753.4 5767.8 5453.8 5473.1 5475.3 5477.3 5518.6 6341.9 6354.1 6364.3 6382.8 6407.4 5100.6 6089.0 6156.0 6159.7 6265.8 6267.9 6316.5 6318.1 6323.3 6335.5 6200.4 6222.8 6245.5 6251.5 6252.8 6108.4 6226.4 6267.5 6293.3 6297.3 5998.9 6145.0 6154.4 6176.5 6176.9 6114.9 6143.9 6168.4 6188.4 6191.2 5571.0 5774.9 5852.8 5854.2 5923.7 5196.4 6146.3 6184.6 6212.5 6212.7 6069.6 6071.3 6073.7 6081.8 6093.5 14:31:02 INFO - PROCESS | 2566 | 14:31:02 INFO - PROCESS | 2566 | [#1] ext.html Cycles:180 Average:74137.41 Median:20264.28 stddev:162089.96 (799.9%) stddev-sans-first:162450.27 14:31:02 INFO - PROCESS | 2566 | Values: 458.0 472.8 486.4 505.1 511.6 31163.5 33366.5 35360.0 42646.4 43243.4 44541.3 44892.0 44962.8 45033.1 45119.1 9669.3 9868.4 9871.2 9874.0 9888.0 8674.9 8901.3 11832.2 12043.7 12072.6 12020.3 12052.4 12130.0 12141.4 12145.5 8722.0 11718.7 11964.1 12002.1 12035.5 11546.0 11939.7 11952.3 11959.0 11974.8 42108.6 42555.0 42561.4 42600.8 42691.0 3537.7 3553.3 3929.7 4245.1 4425.8 31728.8 32883.3 33520.8 33535.0 33615.5 3228.6 3328.9 3371.3 3438.5 3441.2 553742.0 554136.0 555920.0 556722.4 557374.2 65816.7 65988.7 66373.7 66439.7 66445.7 57275.7 68776.3 68803.0 68922.0 68938.3 17405.0 17610.6 17613.7 17620.6 17640.6 12136.0 12378.9 12388.7 13235.7 13309.7 16353.8 16438.1 17185.4 17283.7 17352.0 7897.6 7899.9 7909.3 7944.5 7966.4 931.9 982.6 1006.9 1019.7 1053.9 30734.0 31061.4 31119.8 31238.7 31986.5 1018.9 1077.1 1153.0 1159.3 1171.1 15846.9 16125.7 16158.4 16416.8 16751.6 719391.0 723684.0 723729.0 724208.0 724564.4 61643.4 62125.7 62152.7 62252.0 62421.1 1237.0 1237.2 1404.0 1411.9 1449.2 31251.8 31982.7 32032.8 32821.0 32833.3 52052.5 52804.5 52810.0 52819.0 52881.5 516306.0 518888.0 521905.0 522005.0 523899.0 27041.9 28207.6 28297.6 28303.0 28375.7 49679.0 50521.5 51121.5 51724.7 51748.0 34535.1 40962.0 41035.0 41144.4 42257.0 40972.0 41200.4 41312.6 41557.0 42659.8 39574.4 40125.6 40307.4 40356.8 40617.6 35051.6 35139.6 36479.5 36575.6 36598.8 24792.3 25454.7 26210.0 26269.5 27001.6 14:31:02 INFO - PROCESS | 2566 | 14:31:02 INFO - PROCESS | 2566 | [#2] jquery.html Cycles:180 Average:34496.21 Median:2276.45 stddev:100590.37 (4418.7%) stddev-sans-first:100839.89 14:31:02 INFO - PROCESS | 2566 | Values: 359.1 378.4 389.0 391.8 408.7 15564.2 15921.4 21498.0 21570.5 21899.2 21446.5 21942.0 21974.3 22154.7 22563.4 5973.8 6044.4 6072.1 6182.2 6183.4 4144.2 4380.9 4858.3 6177.7 6377.6 6669.0 6727.9 6735.4 6739.2 6752.0 6363.0 6666.4 6674.5 6681.5 6686.0 5171.3 5511.6 5792.6 5799.7 5799.9 13357.9 13598.7 13602.6 13626.9 23005.4 2329.7 2418.7 2451.1 2750.2 3073.7 9442.3 10431.5 10443.6 11292.6 15627.9 1785.4 1795.7 1807.2 1840.8 2034.0 86970.0 103489.0 115373.0 126507.4 139409.0 9600.4 11221.4 11494.3 11655.1 11676.1 14718.6 14886.7 14921.5 14932.6 14939.8 8650.2 8806.1 8919.3 8995.5 9007.2 8788.0 8961.4 8987.8 9095.6 9141.8 4574.7 4646.2 4646.6 4651.0 4702.7 1614.9 1616.7 1618.3 1707.6 1914.2 810.9 861.3 867.2 879.9 1013.0 21543.5 22438.8 22474.0 22524.3 22597.0 924.4 929.7 939.9 953.9 989.1 8011.5 11451.5 11733.4 11811.4 11813.0 589241.0 603685.0 607182.0 614289.0 615647.0 88518.0 92727.0 93804.5 118760.0 121636.4 853.4 910.8 940.4 972.1 972.9 18232.7 19672.4 19984.5 20105.0 20166.8 43247.8 58075.4 58605.5 59343.4 60005.7 76296.0 78591.0 80927.4 84679.0 84941.2 5543.1 7828.4 8235.7 8241.0 8271.1 11254.0 11588.5 13495.5 13818.9 13820.0 10220.4 11254.7 11299.4 11378.5 11798.5 11314.5 11353.8 11482.5 11491.3 11788.9 9436.6 9463.8 11365.4 11617.0 11840.5 7124.0 7427.1 7476.6 7719.8 8485.5 8229.4 10552.7 11543.4 11892.4 11901.4 14:31:02 INFO - PROCESS | 2566 | 14:31:02 INFO - PROCESS | 2566 | [#3] mootools.html Cycles:180 Average:5705.11 Median:4786.00 stddev:3200.61 (66.9%) stddev-sans-first:3194.51 14:31:02 INFO - PROCESS | 2566 | Values: 1570.1 1591.7 1815.5 1940.8 1942.8 8249.9 8534.9 8582.4 8777.3 8947.9 7822.1 8128.9 8450.9 8744.3 8763.3 2362.0 2397.3 2397.7 2402.7 2406.7 2372.5 2380.6 2421.3 2421.3 2424.3 2096.3 2175.6 2178.6 2179.8 2181.0 2310.6 2388.3 2394.3 2395.0 2396.7 2326.2 2350.0 2362.0 2373.9 2381.2 8724.8 8768.1 8770.0 8781.7 8825.5 5198.2 5322.6 5372.7 5377.5 5380.7 3180.3 3537.5 3614.4 3690.5 3698.9 967.2 1061.6 1100.8 1114.3 1118.7 11330.4 11533.3 11555.5 11563.9 11574.5 4659.3 4728.2 4774.2 4830.2 4831.1 10025.6 10175.0 10187.9 10206.0 10215.2 5222.8 5302.3 5315.0 5320.7 5329.6 4779.6 4792.4 4845.5 4860.1 4861.0 3276.9 3844.2 3879.6 3922.2 3971.7 1048.2 1252.8 1254.9 1265.5 1270.0 870.6 937.2 939.2 971.3 994.2 5914.1 5974.1 6080.0 6129.1 6184.2 436.3 438.3 450.4 457.0 458.6 3997.2 4082.0 4151.4 4161.4 4179.6 10089.4 10501.7 10661.3 10679.9 10686.6 10542.5 10698.7 10708.7 10718.0 10735.8 8020.4 8039.1 8251.6 8297.8 8345.0 5190.6 5990.6 5998.4 6006.5 6045.5 9793.9 10114.2 10127.5 10131.0 10159.7 9852.2 10147.4 10249.3 10278.2 10282.9 6439.6 7359.5 7515.5 7525.1 7539.0 8121.8 8147.7 8243.4 8245.1 8252.5 6138.5 7366.0 7463.7 7621.6 7753.5 7294.1 7429.6 7466.1 7487.7 7622.5 7023.1 7077.5 7129.1 7147.0 7156.4 4934.8 5112.5 5118.5 5155.3 5211.8 5115.7 5123.1 5131.7 5211.9 5336.5 14:31:02 INFO - PROCESS | 2566 | 14:31:02 INFO - PROCESS | 2566 | [#4] prototype.html Cycles:180 Average:4528.35 Median:5188.14 stddev:1400.88 (27.0%) stddev-sans-first:1368.53 14:31:02 INFO - PROCESS | 2566 | Values: 308.0 314.8 318.2 319.0 323.4 5040.9 5148.5 5321.6 5394.1 5434.6 5316.9 5377.0 5386.0 5407.9 5412.8 3567.9 3849.8 3850.4 4017.2 4076.6 3992.0 4053.7 4096.2 4116.0 4116.7 3453.5 4035.1 4047.0 4053.6 4092.4 3629.9 3867.8 4065.0 4072.6 4083.8 3484.6 3562.5 3565.2 3571.9 3573.4 4286.8 4290.1 4826.3 5150.2 5279.6 4476.6 4657.6 4696.8 4700.4 4747.4 4454.7 5521.4 5532.9 5569.3 5599.4 3319.4 3919.9 3962.0 3966.3 3967.8 5096.5 5387.6 5856.9 5883.8 5918.2 3269.9 3813.7 3853.8 3861.5 3903.0 3824.9 3922.5 3940.7 3942.0 3945.9 4176.0 4476.2 4576.7 4584.7 4602.1 5313.8 5603.9 5611.6 5620.6 5655.2 1298.3 1329.8 1330.7 1331.2 1331.8 742.4 762.4 799.2 816.6 821.1 3970.8 4366.5 5042.0 5212.0 5241.4 5048.8 5262.9 5562.9 5705.6 5728.3 4864.5 5191.4 5201.8 5205.4 5225.5 2527.4 2985.8 3006.5 3009.7 3009.9 5184.9 5854.6 5861.3 5887.0 5920.9 5538.4 5583.4 5645.6 5754.0 5790.7 5110.4 5657.7 5759.2 6025.7 6027.5 4408.0 4670.7 5417.6 5506.3 5587.2 5419.3 5724.3 5757.5 5766.7 5769.3 5928.4 5971.8 5977.6 5998.8 6055.8 3237.5 3400.7 3813.5 3840.2 3861.8 5747.4 5750.5 5754.9 5790.0 5886.3 4892.2 5552.7 5620.0 5632.0 5682.3 5242.1 5544.2 5571.5 5634.8 5658.7 5149.5 5172.7 5209.8 5427.9 5548.6 5286.3 5346.7 5471.8 5586.3 5599.8 4565.0 5446.4 5459.8 5460.0 5481.8 14:31:02 INFO - PROCESS | 2566 | 14:31:02 INFO - PROCESS | 2566 | [#5] yui.html Cycles:180 Average:24987.40 Median:3542.81 stddev:40232.79 (1135.6%) stddev-sans-first:40304.46 14:31:02 INFO - PROCESS | 2566 | Values: 737.7 744.4 786.7 841.7 853.6 12136.0 15885.2 15908.3 15960.5 15976.2 13985.4 14803.9 14812.6 14843.8 14872.3 718.7 888.7 893.3 905.8 906.1 735.8 886.5 918.1 925.8 927.5 967.2 967.3 969.0 970.3 972.9 745.4 775.2 957.9 960.2 960.8 572.1 573.3 574.9 695.2 719.8 14925.3 14938.8 14961.4 14964.6 14975.1 13854.4 13929.0 13933.2 14012.6 14334.4 12417.5 12496.9 12529.6 12657.5 12699.6 4430.9 4501.4 4521.4 4567.6 4741.4 111404.0 112464.0 112886.0 113090.0 114466.0 11075.3 11157.9 11170.2 11172.4 11581.7 21802.6 21832.8 21834.0 21851.6 21854.7 7924.2 7934.4 7973.4 8033.2 8136.2 4412.2 4451.6 4485.7 4607.6 4648.0 3486.6 3599.0 3599.8 3600.7 3602.1 641.0 652.0 658.9 666.7 669.9 520.9 531.7 586.7 650.5 655.8 7907.4 8255.6 8355.9 9046.5 9134.5 592.7 603.2 631.6 638.8 640.4 4179.9 4363.6 4370.8 4404.8 4447.6 155594.0 155838.0 156148.0 158504.0 162198.0 126595.0 127375.0 129076.0 132511.0 136614.0 111026.0 115915.0 116237.0 116359.4 116477.4 8451.9 8499.8 8543.9 8610.2 8670.7 51181.7 58914.7 61502.8 62922.7 65256.0 68701.0 72276.3 75748.2 79081.6 80653.0 13559.3 13650.3 13652.5 14163.3 14374.6 15000.8 15436.8 15601.5 15825.0 16116.7 14232.2 14473.2 14819.6 14863.9 15020.0 12654.6 14222.7 14280.5 14713.2 14716.9 13566.3 13691.2 13791.4 13855.4 14007.2 10156.3 11116.1 11163.3 11654.8 11839.7 11284.5 11366.3 11528.8 11618.8 11659.3 14:31:02 INFO - PROCESS | 2566 | -------- Summary: end -------- 14:31:02 INFO - PROCESS | 2566 | 14:31:03 INFO - TEST-INFO | 2566: exit 0 14:31:03 INFO - TEST-OK | dromaeo_css | took 1117239ms 14:31:03 INFO - TEST-START | kraken 14:31:03 INFO - operating with platform_type : mac_ 14:31:03 INFO - Initialising browser for kraken test... 14:31:03 INFO - TEST-INFO | started process 2570 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpVVX_rv/profile http://localhost:52615/getInfo.html) 14:31:05 INFO - PROCESS | 2570 | __metrics Screen width/height:1600/1200 14:31:05 INFO - PROCESS | 2570 | colorDepth:24 14:31:05 INFO - PROCESS | 2570 | Browser inner width/height: 1024/689 14:31:05 INFO - PROCESS | 2570 | __metrics 14:31:05 INFO - PROCESS | 2570 | 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" 14:31:05 INFO - PROCESS | 2570 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:31:06 INFO - TEST-INFO | 2570: exit 0 14:31:06 INFO - Browser initialized. 14:31:06 INFO - Running cycle 1/1 for kraken test... 14:31:06 INFO - TEST-INFO | started process 2571 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpVVX_rv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:31:17 INFO - PROCESS | 2571 | RSS: Main: 245006336 14:31:17 INFO - PROCESS | 2571 | 14:31:20 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52615/tests/kraken/driver.html?testName=audio-beat-detection) 14:31:21 INFO - PROCESS | 2571 | RSS: Main: 294658048 14:31:21 INFO - PROCESS | 2571 | 14:31:24 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52615/tests/kraken/driver.html?testName=audio-dft) 14:31:24 INFO - PROCESS | 2571 | RSS: Main: 304959488 14:31:24 INFO - PROCESS | 2571 | 14:31:28 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52615/tests/kraken/driver.html?testName=audio-fft) 14:31:28 INFO - PROCESS | 2571 | RSS: Main: 389357568 14:31:28 INFO - PROCESS | 2571 | 14:31:31 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52615/tests/kraken/driver.html?testName=audio-oscillator) 14:31:31 INFO - PROCESS | 2571 | RSS: Main: 290381824 14:31:31 INFO - PROCESS | 2571 | 14:31:33 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52615/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:31:34 INFO - PROCESS | 2571 | RSS: Main: 294891520 14:31:34 INFO - PROCESS | 2571 | 14:31:37 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52615/tests/kraken/driver.html?testName=imaging-darkroom) 14:31:37 INFO - PROCESS | 2571 | RSS: Main: 332169216 14:31:37 INFO - PROCESS | 2571 | 14:31:40 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52615/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:41 INFO - PROCESS | 2571 | RSS: Main: 334241792 14:31:41 INFO - PROCESS | 2571 | 14:31:44 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52615/tests/kraken/driver.html?testName=json-parse-financial) 14:31:45 INFO - PROCESS | 2571 | RSS: Main: 332881920 14:31:45 INFO - PROCESS | 2571 | 14:31:46 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52615/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:47 INFO - PROCESS | 2571 | RSS: Main: 312471552 14:31:47 INFO - PROCESS | 2571 | 14:31:49 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52615/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:49 INFO - PROCESS | 2571 | RSS: Main: 319524864 14:31:49 INFO - PROCESS | 2571 | 14:31:51 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52615/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:52 INFO - PROCESS | 2571 | RSS: Main: 322072576 14:31:52 INFO - PROCESS | 2571 | 14:31:55 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:56 INFO - PROCESS | 2571 | RSS: Main: 325910528 14:31:56 INFO - PROCESS | 2571 | 14:31:59 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:59 INFO - PROCESS | 2571 | RSS: Main: 328097792 14:31:59 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | Cycle 1(1): loaded http://localhost:52615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52615/tests/kraken/driver.html?testName=ai-astar) 14:32:01 INFO - PROCESS | 2571 | RSS: Main: 371593216 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | __start_tp_report 14:32:01 INFO - PROCESS | 2571 | _x_x_mozilla_page_load 14:32:01 INFO - PROCESS | 2571 | _x_x_mozilla_page_load_details 14:32:01 INFO - PROCESS | 2571 | |i|pagename|runs| 14:32:01 INFO - PROCESS | 2571 | |0;ai-astar;101;113;114;112;112;112;112;111;113;118 14:32:01 INFO - PROCESS | 2571 | |1;audio-beat-detection;148;109;108;175;112;107;129;106;141;106 14:32:01 INFO - PROCESS | 2571 | |2;audio-dft;185;185;184;183;183;183;183;183;183;186 14:32:01 INFO - PROCESS | 2571 | |3;audio-fft;78;77;57;110;58;71;79;83;113;62 14:32:01 INFO - PROCESS | 2571 | |4;audio-oscillator;86;83;94;95;105;97;102;68;67;94 14:32:01 INFO - PROCESS | 2571 | |5;imaging-gaussian-blur;88;86;88;84;87;84;89;86;88;88 14:32:01 INFO - PROCESS | 2571 | |6;imaging-darkroom;93;93;94;94;93;111;150;102;94;93 14:32:01 INFO - PROCESS | 2571 | |7;imaging-desaturate;87;86;89;86;85;86;85;86;85;84 14:32:01 INFO - PROCESS | 2571 | |8;json-parse-financial;55;54;53;55;54;56;55;55;53;52 14:32:01 INFO - PROCESS | 2571 | |9;json-stringify-tinderbox;65;71;70;74;73;73;70;71;70;71 14:32:01 INFO - PROCESS | 2571 | |10;stanford-crypto-aes;86;83;84;83;84;82;81;85;86;90 14:32:01 INFO - PROCESS | 2571 | |11;stanford-crypto-ccm;137;138;140;145;144;137;136;136;236;155 14:32:01 INFO - PROCESS | 2571 | |12;stanford-crypto-pbkdf2;162;170;162;165;168;165;162;163;166;164 14:32:01 INFO - PROCESS | 2571 | |13;stanford-crypto-sha256-iterative;68;67;67;67;66;65;66;63;65;66 14:32:01 INFO - PROCESS | 2571 | __end_tp_report 14:32:01 INFO - PROCESS | 2571 | __start_cc_report 14:32:01 INFO - PROCESS | 2571 | _x_x_mozilla_cycle_collect,2150 14:32:01 INFO - PROCESS | 2571 | __end_cc_report 14:32:01 INFO - PROCESS | 2571 | __startTimestamp1467754321764__endTimestamp 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | ------- Summary: start ------- 14:32:01 INFO - PROCESS | 2571 | Number of tests: 14 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.50 stddev:4.26 (3.8%) stddev-sans-first:2.06 14:32:01 INFO - PROCESS | 2571 | Values: 101.0 113.0 114.0 112.0 112.0 112.0 112.0 111.0 113.0 118.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:120.50 stddev:23.69 (19.7%) stddev-sans-first:23.50 14:32:01 INFO - PROCESS | 2571 | Values: 148.0 109.0 108.0 175.0 112.0 107.0 129.0 106.0 141.0 106.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#2] audio-dft Cycles:10 Average:183.80 Median:183.50 stddev:1.14 (0.6%) stddev-sans-first:1.12 14:32:01 INFO - PROCESS | 2571 | Values: 185.0 185.0 184.0 183.0 183.0 183.0 183.0 183.0 183.0 186.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#3] audio-fft Cycles:10 Average:78.80 Median:74.00 stddev:19.48 (26.3%) stddev-sans-first:20.66 14:32:01 INFO - PROCESS | 2571 | Values: 78.0 77.0 57.0 110.0 58.0 71.0 79.0 83.0 113.0 62.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:90.00 stddev:13.10 (14.6%) stddev-sans-first:13.85 14:32:01 INFO - PROCESS | 2571 | Values: 86.0 83.0 94.0 95.0 105.0 97.0 102.0 68.0 67.0 94.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#5] imaging-gaussian-blur Cycles:10 Average:86.80 Median:88.00 stddev:1.75 (2.0%) stddev-sans-first:1.80 14:32:01 INFO - PROCESS | 2571 | Values: 88.0 86.0 88.0 84.0 87.0 84.0 89.0 86.0 88.0 88.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#6] imaging-darkroom Cycles:10 Average:101.70 Median:93.00 stddev:17.95 (19.3%) stddev-sans-first:18.76 14:32:01 INFO - PROCESS | 2571 | Values: 93.0 93.0 94.0 94.0 93.0 111.0 150.0 102.0 94.0 93.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:1.37 (1.6%) stddev-sans-first:1.39 14:32:01 INFO - PROCESS | 2571 | Values: 87.0 86.0 89.0 86.0 85.0 86.0 85.0 86.0 85.0 84.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.23 (2.2%) stddev-sans-first:1.27 14:32:01 INFO - PROCESS | 2571 | Values: 55.0 54.0 53.0 55.0 54.0 56.0 55.0 55.0 53.0 52.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#9] json-stringify-tinderbox Cycles:10 Average:70.80 Median:71.00 stddev:2.49 (3.5%) stddev-sans-first:1.51 14:32:01 INFO - PROCESS | 2571 | Values: 65.0 71.0 70.0 74.0 73.0 73.0 70.0 71.0 70.0 71.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:2.55 (3.0%) stddev-sans-first:2.64 14:32:01 INFO - PROCESS | 2571 | Values: 86.0 83.0 84.0 83.0 84.0 82.0 81.0 85.0 86.0 90.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#11] stanford-crypto-ccm Cycles:10 Average:150.40 Median:142.00 stddev:30.65 (21.6%) stddev-sans-first:32.12 14:32:01 INFO - PROCESS | 2571 | Values: 137.0 138.0 140.0 145.0 144.0 137.0 136.0 136.0 236.0 155.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:165.00 stddev:2.71 (1.6%) stddev-sans-first:2.69 14:32:01 INFO - PROCESS | 2571 | Values: 162.0 170.0 162.0 165.0 168.0 165.0 162.0 163.0 166.0 164.0 14:32:01 INFO - PROCESS | 2571 | 14:32:01 INFO - PROCESS | 2571 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.41 (2.1%) stddev-sans-first:1.30 14:32:01 INFO - PROCESS | 2571 | Values: 68.0 67.0 67.0 67.0 66.0 65.0 66.0 63.0 65.0 66.0 14:32:01 INFO - PROCESS | 2571 | -------- Summary: end -------- 14:32:01 INFO - PROCESS | 2571 | 14:32:02 INFO - TEST-INFO | 2571: exit 0 14:32:02 INFO - TEST-OK | kraken | took 59574ms 14:32:02 INFO - SUITE-END | took 1176s 14:32:02 INFO - Completed test suite (00:19:37) 14:32:02 INFO - javascript benchmark 14:32:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3310.917227069323, 3321.5681961345026, 3335.24956884701, 3375.392429362717, 3390.5083762854388, 5564.081926482136, 5641.605087643867, 5652.208690783294, 5740.569457290704, 5758.337791154018, 5745.942540574593, 5750.079987202049, 5848.941510584893, 5863.736131874065, 5911.93585154673, 5140.100482415581, 5142.151544995071, 5211.140161873286, 5212.739363031852, 5303.946960530403, 5282.286891269668, 5303.628745987782, 5312.6281160318795, 5334.5999050071205, 5357.142857142858, 5128.256402821588, 5154.123798954187, 5169.715665638389, 5200.609954253408, 5212.895742085156, 5167.431582525919, 5191.039657663345, 5208.895822083575, 5217.060929032773, 5249.055170069386, 4442.311441726505, 5194.3247377840635, 5206.323177986876, 5245.737713114368, 5282.550983166436, 5661.8584535386535, 5700.40145784695, 5713.171590119409, 5735.4551317624755, 5864.618799778001, 6196.039613859859, 6198.597091189058, 6243.0, 6261.405166509175, 6293.244810622755, 6177.598456100339, 6245.0, 6246.500279977591, 6278.497720182374, 6278.843028924313, 5743.2246646703, 5804.100364443518, 5826.242588463558, 5976.223090998186, 5998.670073145975, 6269.905951410732, 6334.5249106317215, 6334.588251763621, 6345.841353966188, 6350.682465876687, 6168.383161683885, 6186.381361863778, 6187.938120618826, 6192.195014648067, 6211.16149319845, 6125.021800333839, 6137.846553836101, 6155.199824022938, 6182.752689892354, 6237.0, 6143.109249158847, 6197.876042479215, 6222.408871157233, 6227.501799856001, 6232.532560058014, 6209.875802483925, 6211.192544969125, 6233.625982441068, 6235.750569977241, 6238.75044998195, 4889.559939605452, 4939.135651261015, 4959.479254678206, 4962.975185124052, 5075.390953085654, 3853.460515527828, 4448.799804008828, 4528.841490547815, 4553.658475614276, 4562.68061235717, 5807.535397168301, 5829.213056237439, 5840.2991641003355, 5854.795082172103, 5882.264716910387, 6147.262328520516, 6177.722002509898, 6192.349803270592, 6221.253449586078, 6247.781327653601, 5562.97218513913, 5707.4577915098, 5714.657120572779, 5753.424657534297, 5767.798127065533, 5453.7818487260065, 5473.0969390050195, 5475.342958844964, 5477.342718873681, 5518.558515318765, 6341.8731625368155, 6354.078658594478, 6364.268109167412, 6382.840428989312, 6407.359264073555, 5100.6429549931145, 6088.969555152196, 6156.045812899008, 6159.692015399301, 6265.843353916189, 6267.905981410374, 6316.494680425463, 6318.115463835159, 6323.272823625158, 6335.461485773577, 6200.410960958701, 6222.751089956532, 6245.500359971101, 6251.531135164972, 6252.843678907881, 6108.433136212329, 6226.439620434183, 6267.5299352549655, 6293.307736148929, 6297.338779428277, 5998.850028749316, 6145.016797312409, 6154.353792851686, 6176.474999625082, 6176.876462470816, 6114.938850611437, 6143.877122457437, 6168.352323006199, 6188.44304012623, 6191.19514463117, 5571.0, 5774.942250577608, 5852.824415267549, 5854.151148083419, 5923.703814809156, 5196.376434827694, 6146.293176284785, 6184.628922264678, 6212.534059945432, 6212.720427580679, 6069.605475644069, 6071.332153463204, 6073.665948372882, 6081.756729730761, 6093.451589356979], "value": 5710.898894224043, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.96042982429884, 472.84159806464834, 486.36043602662517, 505.0958783777039, 511.6188439612489, 31163.53254701181, 33366.49950250748, 35360.0, 42646.36030459546, 43243.35134972978, 44541.331880021826, 44892.0, 44962.775186124105, 45033.09933801322, 45119.09761804762, 9669.323147379686, 9868.407895526256, 9871.210303175729, 9873.950630246838, 9888.011198880127, 8674.86987695185, 8901.287896968228, 11832.171747977645, 12043.698907527294, 12072.577459788909, 12020.278783272988, 12052.397380131002, 12130.0, 12141.392930353491, 12145.453454594564, 8722.0, 11718.707032324175, 11964.102692298069, 12002.099842511847, 12035.458404371824, 11546.018588419995, 11939.701507462296, 11952.342621155833, 11959.0, 11974.820377694254, 42108.578914210775, 42555.0, 42561.36157957633, 42600.78699606513, 42691.0, 3537.6816086552076, 3553.2919328657144, 3929.7445666031617, 4245.108527209259, 4425.7565833879125, 31728.841355793305, 32883.34233315344, 33520.83239583811, 33535.0, 33615.49576756351, 3228.564044452407, 3328.900132996014, 3371.3088816792497, 3438.4670376091744, 3441.20852203992, 553742.0, 554136.0, 555920.0, 556722.4327756711, 557374.2131289317, 65816.6709166451, 65988.67005664941, 66373.69449902252, 66439.66780166165, 66445.6677716618, 57275.71362143246, 68776.31223687799, 68803.0, 68922.0, 68938.31061689318, 17405.042722650123, 17610.559736006704, 17613.7357939631, 17620.647587048188, 17640.558986025197, 12135.968442682295, 12378.938105309417, 12388.690282743004, 13235.73528529424, 13309.667258318426, 16353.81803310152, 16438.095904725116, 17185.39851105205, 17283.654326913642, 17351.958882467094, 7897.565633890076, 7899.881501777478, 7909.327707144842, 7944.523328600302, 7966.362690984707, 931.8695382646434, 982.6216906491053, 1006.8892421833592, 1019.6686077024997, 1053.8893416191343, 30734.0, 31061.378772424425, 31119.844400778304, 31238.68761312403, 31986.520202196985, 1018.8624535687735, 1077.052194069214, 1152.9565743002597, 1159.263867444162, 1171.1275100050348, 15846.920765396098, 16125.677486450206, 16158.43445479426, 16416.75374869378, 16751.58121046959, 719391.0, 723684.0, 723729.0, 724208.0, 724564.3771781108, 61643.38356616466, 62125.68937155376, 62152.68923655353, 62252.0, 62421.06368404478, 1237.047473445442, 1237.189640785287, 1403.9929800350933, 1411.908225965309, 1449.173970836613, 31251.84374078115, 31982.68017319797, 32032.83983580067, 32821.0, 32833.343333132725, 52052.47947520476, 52804.47195528149, 52810.0, 52819.0, 52881.47118528919, 516306.0, 518888.0, 521905.0, 522005.0, 523899.0, 27041.86479067592, 28207.57688634631, 28297.57553636738, 28303.0, 28375.71624283731, 49679.00641987212, 50521.49478505168, 51121.48878511167, 51724.74137629438, 51748.0, 34535.13662158365, 40961.975950601474, 41035.0, 41144.38283425691, 42257.0, 40972.0, 41200.35198592023, 41312.58687413087, 41557.0, 42659.786701066296, 39574.40638390369, 40125.598744013354, 40307.395389069774, 40356.789296321156, 40617.59382406256, 35051.649483504836, 35139.64860351364, 36479.45280820737, 36575.634243658285, 36598.8170059148, 24792.25623231306, 25454.745452545238, 26210.0, 26269.474610508067, 27001.59497607577], "value": 21146.393078936995, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.1344858890075, 378.38323532641795, 389.0371330955884, 391.8138884030086, 408.6710198290377, 15564.221788910552, 15921.442749503754, 21497.99999999998, 21570.460738481506, 21899.233526826563, 21446.463838404048, 21942.0, 21974.340769776893, 22154.667679984774, 22563.435914102156, 5973.820785376435, 6044.395560443964, 6072.119542666311, 6182.196314479134, 6183.350748171445, 4144.233316836395, 4380.934285985697, 4858.344123543312, 6177.722002509875, 6377.585456945284, 6669.0, 6727.932720672779, 6735.427488663469, 6739.22498912624, 6751.966240168792, 6362.968185159068, 6666.433353164987, 6674.466042716571, 6681.465482761368, 6686.0, 5171.301874247004, 5511.559075273968, 5792.594518383715, 5799.652020878719, 5799.88400231993, 13357.866421335759, 13598.660033499144, 13602.591922242349, 13626.931865340708, 23005.424864378358, 2329.743728189898, 2418.6734790803366, 2451.080844683244, 2750.2024412920227, 3073.6926307369085, 9442.339036267464, 10431.478426078666, 10443.582256709722, 11292.604758833402, 15627.92186039074, 1785.4108144312477, 1795.721663142215, 1807.204829874851, 1840.8159184081485, 2033.9593208135755, 86970.0, 103489.0, 115373.0, 126507.36746316301, 139409.0, 9600.420557734962, 11221.382823944597, 11494.252873563191, 11655.125865560118, 11676.124290678234, 14718.63203419923, 14886.70226595462, 14921.477748278758, 14932.626684332761, 14939.775903361458, 8650.178233067974, 8806.12755170241, 8919.331050171264, 8995.505247211466, 9007.189352958265, 8788.0, 8961.417507861968, 8987.775305617412, 9095.590698418588, 9141.81716365669, 4574.656900732459, 4646.233371493666, 4646.581807637329, 4651.046535460223, 4702.694324868941, 1614.9180049366717, 1616.7009103315925, 1618.281287437117, 1707.581642497596, 1914.2389002118084, 810.8905297784842, 861.2636196052285, 867.2108381372921, 879.8680197970227, 1012.9949350253349, 21543.46141346479, 22438.775612243997, 22473.988670509538, 22524.324270271918, 22596.983135758932, 924.3806649544821, 929.7303781903172, 939.8637197606308, 953.880764904387, 989.1246247071393, 8011.479253848481, 11451.541938322374, 11733.35466549348, 11811.409429528489, 11812.99589534882, 589241.0, 603685.0, 607182.0, 614289.0, 615647.0, 88518.0, 92727.0, 93804.53097734468, 118760.0, 121636.39181804212, 853.3770347646253, 910.7841032221926, 940.4122423485321, 972.0910948263396, 972.8783902012249, 18232.726509102107, 19672.409827705193, 19984.50038749043, 20105.0, 20166.798332016493, 43247.783761080995, 58075.41924580869, 58605.5348616288, 59343.40656593379, 60005.69997149986, 76296.0, 78591.0, 80927.3814523718, 84679.0, 84941.15058849333, 5543.085390910454, 7828.412869034732, 8235.711750088718, 8240.958795205986, 8271.131531189138, 11254.0, 11588.536458541565, 13495.527656531975, 13818.86181138216, 13820.0, 10220.386776793119, 11254.705708843589, 11299.3785341807, 11378.487968041292, 11798.52805887755, 11314.490847911698, 11353.829692554784, 11482.483288252215, 11491.253068550517, 11788.882111178778, 9436.622535098793, 9463.763405914908, 11365.431728413381, 11616.954474097372, 11840.467178977138, 7123.964380178066, 7427.071616047994, 7476.626168691652, 7719.845603087794, 8485.533295668798, 8229.423940324119, 10552.683419497427, 11543.422828858691, 11892.405379731152, 11901.404929753304], "value": 9497.136816928798, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1570.1364249662684, 1591.7134915715171, 1815.52796272969, 1940.7865134835174, 1942.7571553555806, 8249.886265354175, 8534.91465085349, 8582.356323275755, 8777.253933415668, 8947.91052089479, 7822.10045844728, 8128.878066829002, 8450.87323690145, 8744.300455963523, 8763.255123314526, 2362.0197617988515, 2397.2927986244013, 2397.6883005209297, 2402.699662542182, 2406.6630671705975, 2372.4543355028354, 2380.5952987991996, 2421.32202983165, 2421.32202983165, 2424.272718184546, 2096.329174664108, 2175.575762726269, 2178.6078505868936, 2179.8365122615787, 2180.967285490719, 2310.630299152136, 2388.3432056184515, 2394.341556072077, 2394.964075538868, 2396.724376696667, 2326.209088909779, 2350.0364850411247, 2361.97638023621, 2373.8813059346962, 2381.190395265618, 8724.78188045304, 8768.079351668046, 8770.035296117421, 8781.692640757607, 8825.51459669718, 5198.246254293144, 5322.627416080876, 5372.7045012524295, 5377.51602355786, 5380.650257733274, 3180.3321302526497, 3537.5047493350953, 3614.36748569002, 3690.5017822593873, 3698.8890333289773, 967.1972263021676, 1061.5912873543664, 1100.818364969779, 1114.2701530497536, 1118.6867677050438, 11330.376829274386, 11533.308001519936, 11555.53777848885, 11563.884361156364, 11574.53701851925, 4659.254519276899, 4728.17256980034, 4774.212254977959, 4830.236963508294, 4831.106245344622, 10025.649102281384, 10175.033371829664, 10187.898121018843, 10206.0, 10215.23385746072, 5222.843314700565, 5302.28419163408, 5314.97342513285, 5320.733963301819, 5329.626926115212, 4779.641526885497, 4792.353032340659, 4845.53967373099, 4860.1008813369635, 4861.003494283664, 3276.8689252429635, 3844.1735026968777, 3879.631435013669, 3922.1763429679518, 3971.7418367806, 1048.219076787798, 1252.8371311729418, 1254.9372531373394, 1265.5380786013038, 1269.9809502857465, 870.5821205821242, 937.2033771294346, 939.2110627073155, 971.2569884038716, 994.1947022911465, 5914.083317085859, 5974.133750606138, 6080.027195648675, 6129.1419201311855, 6184.165137706442, 436.2844934307738, 438.27246770361046, 450.38747303666986, 456.99314510282375, 458.6262196309997, 3997.2446466358147, 4081.9591804082174, 4151.377293406013, 4161.4382058421725, 4179.6029377209115, 10089.394636321844, 10501.684949451528, 10661.253712240068, 10679.932006799258, 10686.625968091079, 10542.525586348633, 10698.732531686614, 10708.678739637824, 10718.035376816124, 10735.83896241557, 8020.398470114765, 8039.115697273295, 8251.587420628945, 8297.8340433191, 8344.998600168019, 5190.636655434083, 5990.64056156632, 5998.430149135826, 6006.459418652343, 6045.549068223682, 9793.85309220348, 10114.241431892784, 10127.544260508148, 10131.0, 10159.695209143738, 9852.162566181669, 10147.441890696082, 10249.33379330341, 10278.229132814919, 10282.948585257025, 6439.645819479973, 7359.521631093961, 7515.511491753018, 7525.134609519756, 7539.0, 8121.75634730959, 8147.714829980922, 8243.381746369167, 8245.051819040647, 8252.546109964009, 6138.5396095292135, 7365.963170184329, 7463.731165701953, 7621.618919054136, 7753.457257991887, 7294.088238970129, 7429.628518574158, 7466.104067511933, 7487.6630551626395, 7622.504537205064, 7023.122109736283, 7077.5399599025895, 7129.1445026595065, 7147.035150254649, 7156.391706704989, 4934.827281045146, 5112.514311140436, 5118.462561431145, 5155.32980712505, 5211.817586384458, 5115.667481613832, 5123.129068058364, 5131.743412829418, 5211.9478805212975, 5336.466353364633], "value": 4514.765746393783, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.98614062367193, 314.7875184250632, 318.1806847368028, 319.0333290130904, 323.43560486950275, 5040.949590504094, 5148.510891465314, 5321.574274058075, 5394.109971854639, 5434.592405569583, 5316.893662126765, 5377.0, 5385.973070134653, 5407.918416316733, 5412.753707211503, 3567.94648080279, 3849.7671350616715, 3850.403187505934, 4017.1521100293753, 4076.5719599442077, 3992.0, 4053.7433395647445, 4096.242195193884, 4116.0121570823085, 4116.650084742801, 3453.49924260982, 4035.1122752994293, 4046.9967366153796, 4053.61490658387, 4092.4475195848627, 3629.891103266906, 3867.845286188549, 4064.959350406488, 4072.552019277877, 4083.7743429830516, 3484.61669216386, 3562.4656301554714, 3565.180008598037, 3571.928561428783, 3573.4103872860946, 4286.828526858922, 4290.0561876387455, 4826.251930950708, 5150.150225212836, 5279.60402969775, 4476.597106260452, 4657.601335312317, 4696.765161741933, 4700.412448443944, 4747.382840230783, 4454.732716037048, 5521.4478552144865, 5532.889342213133, 5569.331680198402, 5599.356074051496, 3319.40250754864, 3919.862804801818, 3961.98019009906, 3966.2632783379377, 3967.8016099195215, 5096.490350964911, 5387.622866399353, 5856.89584520205, 5883.79406720767, 5918.2306300181135, 3269.869205231764, 3813.6567708905777, 3853.7687738735767, 3861.5366156061455, 3903.0047337929213, 3824.8661296854475, 3922.4508568800393, 3940.6650434712797, 3942.0, 3945.9013524662114, 4176.0395109125075, 4476.194285028726, 4576.679632425765, 4584.679072464962, 4602.148602508547, 5313.840584782462, 5603.943960560424, 5611.6352437091455, 5620.634658747168, 5655.208270842086, 1298.3183828490119, 1329.7672907241194, 1330.6872884872048, 1331.2145833958011, 1331.780256257726, 742.3615690506268, 762.4472257613186, 799.152897928198, 816.5794615772882, 821.1008945204991, 3970.84845394838, 4366.476022877211, 5042.033606893315, 5212.0, 5241.397239317451, 5048.7728052237735, 5262.92105618416, 5562.853047382584, 5705.5720820938595, 5728.283964504437, 4864.494785185632, 5191.377034755854, 5201.817936372285, 5205.427402985669, 5225.451327610546, 2527.4186937004224, 2985.8056777289257, 3006.4888968875343, 3009.660700988083, 3009.864556094981, 5184.896302074013, 5854.560907931922, 5861.296644402699, 5886.997631208029, 5920.904632642889, 5538.390777014606, 5583.357913839879, 5645.633033852787, 5754.0, 5790.668146326284, 5110.4123025852505, 5657.660540367591, 5759.183224942754, 6025.698715064317, 6027.48766354856, 4407.964128429752, 4670.743109129031, 5417.593680474059, 5506.256655351476, 5587.234319012115, 5419.268398766274, 5724.341700704473, 5757.5393968481585, 5766.682832444088, 5769.307683078057, 5928.407159284209, 5971.7611295547695, 5977.641341519523, 5998.770252098222, 6055.760168309933, 3237.482002879528, 3400.727941764603, 3813.485179500732, 3840.1551658635058, 3861.8262178201485, 5747.396523365153, 5750.511206547323, 5754.884902302014, 5789.9710501447225, 5886.264216972879, 4892.192788189909, 5552.722363881709, 5619.971900140473, 5631.971840140773, 5682.272509195692, 5242.082635538842, 5544.22380866687, 5571.526420254324, 5634.774609015593, 5658.717064146694, 5149.459306772885, 5172.7155006475, 5209.801745598609, 5427.887283107033, 5548.583856210719, 5286.312779338661, 5346.732663366894, 5471.841400535542, 5586.329640443173, 5599.80400685974, 4564.977175114103, 5446.373667028342, 5459.781608735606, 5459.962607104638, 5481.808136715196], "value": 4076.3721730120947, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.686483244621, 744.3896005275673, 786.6774622404812, 841.7011960753936, 853.5604163855613, 12136.0, 15885.205739713012, 15908.284127214274, 15960.521184364488, 15976.2011899405, 13985.440582376717, 14803.925980370082, 14812.555623331318, 14843.777343339858, 14872.256387180652, 718.6658203935169, 888.7111688701182, 893.2630579771682, 905.8460061789478, 906.1391677905983, 735.808689740666, 886.4902680958443, 918.1277786103228, 925.8055808280269, 927.4620719982394, 967.1585720423242, 967.318040781251, 968.9854652180223, 970.3207754571793, 972.8735264415651, 745.4148493432683, 775.1899265267753, 957.8802649668792, 960.2222200018008, 960.7982323711994, 572.0932322269208, 573.3292048303495, 574.8562859285179, 695.183159787253, 719.7696737044148, 14925.25373731309, 14938.775918361232, 14961.40154393823, 14964.551063468114, 14975.101493910292, 13854.376553055035, 13929.0, 13933.233672148028, 14012.579622611338, 14334.42662293507, 12417.503299867994, 12496.875031249752, 12529.561465348668, 12657.493700251978, 12699.55551555691, 4430.911381772379, 4501.369808226851, 4521.3896124023495, 4567.588916997486, 4741.407324084489, 111404.0, 112464.0, 112886.01810791781, 113090.0, 114466.0, 11075.280106793032, 11157.888421115847, 11170.162237832195, 11172.385518796382, 11581.710457238636, 21802.563948720937, 21832.78167218339, 21834.0, 21851.562968740534, 21854.672179917314, 7924.167962363984, 7934.404919631051, 7973.362131029504, 8033.1966803320365, 8136.227058429558, 4412.24991751403, 4451.59935605797, 4485.708428952173, 4607.608353289941, 4648.047150334173, 3486.633903440153, 3598.982005089958, 3599.8380072896784, 3600.657937495986, 3602.117481217066, 640.9647469389229, 651.9739210431625, 658.8616390557941, 666.7466362782112, 669.8827705151579, 520.898424807159, 531.6889619572594, 586.6949186423036, 650.4763665249519, 655.783591414832, 7907.446478746432, 8255.587220638945, 8355.874661880076, 9046.547672616343, 9134.497602631785, 592.7273454211111, 603.2278683285401, 631.643121636274, 638.7604648256904, 640.4236187431256, 4179.874603761892, 4363.585459381354, 4370.8033138508845, 4404.8458303959205, 4447.577480139382, 155594.0, 155838.0, 156148.0, 158504.0, 162198.0, 126595.0, 127375.0, 129076.0, 132511.0, 136614.0, 111026.0, 115915.0, 116237.0, 116359.41820290845, 116477.41761291139, 8451.8732219018, 8499.787505312417, 8543.871841922251, 8610.225079742853, 8670.696525621574, 51181.7440912793, 58914.705426472596, 61502.76994460175, 62922.685386572775, 65256.0, 68701.0, 72276.27723722695, 75748.24251757412, 79081.60459197668, 80653.0, 13559.254241016839, 13650.317484125953, 13652.522161724291, 14163.291835407983, 14374.568762937128, 15000.774988375402, 15436.768448473507, 15601.453949111727, 15825.0, 16116.67766644637, 14232.217228052143, 14473.203973781121, 14819.629509262355, 14863.925680371529, 15020.0, 12654.620361389174, 14222.715545689236, 14280.500182493979, 14713.190774507504, 14716.926415367854, 13566.321683915567, 13691.178529288274, 13791.379387927367, 13855.445782168601, 14007.159570425807, 10156.339837910513, 11116.110711142928, 11163.330200188015, 11654.825177622512, 11839.704007399883, 11284.526895416873, 11366.261193022427, 11528.769424611628, 11618.825717614412, 11659.300441973508], "value": 7895.045698544952, "unit": "score"}], "name": "dromaeo_css", "value": 7418.355778584961, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 114.0, 112.0, 112.0, 112.0, 112.0, 111.0, 113.0, 118.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 109.0, 108.0, 175.0, 112.0, 107.0, 129.0, 106.0, 141.0, 106.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 184.0, 183.0, 183.0, 183.0, 183.0, 183.0, 183.0, 186.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 57.0, 110.0, 58.0, 71.0, 79.0, 83.0, 113.0, 62.0], "value": 78.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 94.0, 95.0, 105.0, 97.0, 102.0, 68.0, 67.0, 94.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 84.0, 87.0, 84.0, 89.0, 86.0, 88.0, 88.0], "value": 86.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 93.0, 111.0, 150.0, 102.0, 94.0, 93.0], "value": 101.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 89.0, 86.0, 85.0, 86.0, 85.0, 86.0, 85.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 55.0, 54.0, 56.0, 55.0, 55.0, 53.0, 52.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 70.0, 74.0, 73.0, 73.0, 70.0, 71.0, 70.0, 71.0], "value": 70.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 84.0, 83.0, 84.0, 82.0, 81.0, 85.0, 86.0, 90.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 140.0, 145.0, 144.0, 137.0, 136.0, 136.0, 236.0, 155.0], "value": 150.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 170.0, 162.0, 165.0, 168.0, 165.0, 162.0, 163.0, 166.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 66.0, 65.0, 66.0, 63.0, 65.0, 66.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1452.5000000000002, "alertThreshold": 2.0}]} 14:32:03 INFO - Return code: 0 14:32:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:32:03 INFO - # TBPL SUCCESS # 14:32:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:32:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:32:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:32:03 INFO - 2016-07-05 14:32:03.111 screenresolution[2575:289716] starting screenresolution argv=screenresolution get 14:32:03 INFO - 2016-07-05 14:32:03.114 screenresolution[2575:289716] Display 0: 1600x1200x32@60 14:32:03 INFO - 2016-07-05 14:32:03.120 screenresolution[2576:289719] starting screenresolution argv=screenresolution list 14:32:03 INFO - Available Modes on Display 0 14:32:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:32:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:32:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:32:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:32:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:32:03 INFO - Intel Iris: 14:32:03 INFO - Chipset Model: Intel Iris 14:32:03 INFO - Type: GPU 14:32:03 INFO - Bus: Built-In 14:32:03 INFO - VRAM (Dynamic, Max): 1536 MB 14:32:03 INFO - Vendor: Intel (0x8086) 14:32:03 INFO - Device ID: 0x0a2e 14:32:03 INFO - Revision ID: 0x0009 14:32:03 INFO - Displays: 14:32:03 INFO - Display: 14:32:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:32:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:32:03 INFO - Display Serial Number: 1600x1200 60 14:32:03 INFO - Main Display: Yes 14:32:03 INFO - Mirror: Off 14:32:03 INFO - Online: Yes 14:32:03 INFO - Rotation: Supported 14:32:03 INFO - Return code: 0 14:32:03 INFO - Running post-action listener: _resource_record_post_action 14:32:03 INFO - ##### 14:32:03 INFO - ##### Finished run-tests step (success) 14:32:03 INFO - ##### 14:32:03 INFO - Running post-run listener: _resource_record_post_run 14:32:03 INFO - Total resource usage - Wall time: 1212s; CPU: 53.0%; Read bytes: 16384; Write bytes: 705203712; Read time: 1; Write time: 2053 14:32:03 INFO - TinderboxPrint: CPU usage
53.3% 14:32:03 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 1 14:32:03 INFO - TinderboxPrint: I/O write bytes / time
705,203,712 / 2,053 14:32:03 INFO - TinderboxPrint: CPU idle
2,264.3 (46.7%) 14:32:03 INFO - TinderboxPrint: CPU system
963.7 (19.9%) 14:32:03 INFO - TinderboxPrint: CPU user
1,621.6 (33.4%) 14:32:03 INFO - TinderboxPrint: Swap in / out
406,413,312 / 0 14:32:03 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 404734464; Write bytes: 401755648; Read time: 30850; Write time: 738 14:32:03 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 16384; Write bytes: 291569664; Read time: 1; Write time: 1248 14:32:03 INFO - Running post-run listener: _upload_blobber_files 14:32:03 INFO - Blob upload gear active. 14:32:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:32:03 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 14:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:32:04 INFO - (blobuploader) - INFO - Open directory for files ... 14:32:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:32:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:05 INFO - (blobuploader) - INFO - Done attempting. 14:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:32:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:05 INFO - (blobuploader) - INFO - Done attempting. 14:32:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:32:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:32:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:32:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:32:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:32:08 INFO - (blobuploader) - INFO - Done attempting. 14:32:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:32:08 INFO - Return code: 0 14:32:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:32:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:32:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7f8317e576b9d3a66a3f9ec969904ee7a380d0997360baa6fc66513f2798de7d964e13e6c2fbf844fb1f1efdc03c143accfda21c3c5cda54eeb7d8d201d3858", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8799fb1b179ef89ea958ebe3bd1db28d0afe777bcb18631640e2e2be44bf185066fddcf1b2ba403f364c64e80f4dbeb189afaad16f3ff7f5eaf4cf5c197c199e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c44e6dec9a1368381f49312ff6fde5c1b748d501016abd8f5679f913513476ddb575bb32a2a6363a8fd80d3d114935d1fd8b690644bc2c7412b355eca6da9196"} 14:32:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:32:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:32:08 INFO - Contents: 14:32:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7f8317e576b9d3a66a3f9ec969904ee7a380d0997360baa6fc66513f2798de7d964e13e6c2fbf844fb1f1efdc03c143accfda21c3c5cda54eeb7d8d201d3858", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8799fb1b179ef89ea958ebe3bd1db28d0afe777bcb18631640e2e2be44bf185066fddcf1b2ba403f364c64e80f4dbeb189afaad16f3ff7f5eaf4cf5c197c199e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c44e6dec9a1368381f49312ff6fde5c1b748d501016abd8f5679f913513476ddb575bb32a2a6363a8fd80d3d114935d1fd8b690644bc2c7412b355eca6da9196"} 14:32:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:32:08 INFO - Copying logs to upload dir... 14:32:08 INFO - mkdir: /builds/slave/test/build/upload/logs 14:32:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.934923 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-05 14:32:08.552358) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 14:32:08.556117) ========= 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.kfZjq39UZq/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.fGFSRJI64P/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7f8317e576b9d3a66a3f9ec969904ee7a380d0997360baa6fc66513f2798de7d964e13e6c2fbf844fb1f1efdc03c143accfda21c3c5cda54eeb7d8d201d3858", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8799fb1b179ef89ea958ebe3bd1db28d0afe777bcb18631640e2e2be44bf185066fddcf1b2ba403f364c64e80f4dbeb189afaad16f3ff7f5eaf4cf5c197c199e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c44e6dec9a1368381f49312ff6fde5c1b748d501016abd8f5679f913513476ddb575bb32a2a6363a8fd80d3d114935d1fd8b690644bc2c7412b355eca6da9196"} build_url:https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011098 build_url: 'https://queue.taskcluster.net/v1/task/GM6byGiDTc2rsrt76D1QGw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7f8317e576b9d3a66a3f9ec969904ee7a380d0997360baa6fc66513f2798de7d964e13e6c2fbf844fb1f1efdc03c143accfda21c3c5cda54eeb7d8d201d3858", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8799fb1b179ef89ea958ebe3bd1db28d0afe777bcb18631640e2e2be44bf185066fddcf1b2ba403f364c64e80f4dbeb189afaad16f3ff7f5eaf4cf5c197c199e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c44e6dec9a1368381f49312ff6fde5c1b748d501016abd8f5679f913513476ddb575bb32a2a6363a8fd80d3d114935d1fd8b690644bc2c7412b355eca6da9196"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 14:32:08.589034) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:32:08.589366) ========= 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.kfZjq39UZq/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.fGFSRJI64P/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005192 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 14:32:08.638514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 14:32:08.638839) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 14:32:08.639465) ========= ========= Total master_lag: 0.17 =========