builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0380 starttime: 1468631505.02 results: success (0) buildid: 20160715162252 builduid: b8e6c53a7d354be580f7e9bfb458d68b revision: 53ee209a0557b5c11e821c980c5a460fd09c1730 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 18:11:45.018857) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 18:11:45.019346) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 18:11:45.019652) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 18:11:45.043720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:11:45.044036) ========= 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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners TMPDIR=/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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-15 18:11:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2016-07-15 18:11:45 (19.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.099590 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:11:45.170200) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:11:45.170984) ========= 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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners TMPDIR=/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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.025728 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:11:45.223454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 18:11:45.224238) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 53ee209a0557b5c11e821c980c5a460fd09c1730 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 53ee209a0557b5c11e821c980c5a460fd09c1730 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RYmPAqZX6d/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.mZDy2wO4oK/Listeners TMPDIR=/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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-15 18:11:45,307 truncating revision to first 12 chars 2016-07-15 18:11:45,307 Setting DEBUG logging. 2016-07-15 18:11:45,307 attempt 1/10 2016-07-15 18:11:45,307 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/53ee209a0557?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 18:11:46,298 unpacking tar archive at: autoland-53ee209a0557/testing/mozharness/ program finished with exit code 0 elapsedTime=1.253119 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 18:11:46.500803) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 18:11:46.501181) ========= script_repo_revision: 53ee209a0557b5c11e821c980c5a460fd09c1730 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 18:11:46.501619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 18:11:46.501940) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 18:11:46.520063) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-15 18:11:46.520383) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RYmPAqZX6d/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.mZDy2wO4oK/Listeners TMPDIR=/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 18:11:46 INFO - MultiFileLogger online at 20160715 18:11:46 in /builds/slave/test 18:11:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 18:11:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:11:46 INFO - {'append_to_log': False, 18:11:46 INFO - 'base_work_dir': '/builds/slave/test', 18:11:46 INFO - 'blob_upload_branch': 'Autoland', 18:11:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:11:46 INFO - 'branch': 'Autoland', 18:11:46 INFO - 'buildbot_json_path': 'buildprops.json', 18:11:46 INFO - 'config_files': ('talos/mac_config.py',), 18:11:46 INFO - 'default_actions': ('clobber', 18:11:46 INFO - 'read-buildbot-config', 18:11:46 INFO - 'download-and-extract', 18:11:46 INFO - 'populate-webroot', 18:11:46 INFO - 'create-virtualenv', 18:11:46 INFO - 'install', 18:11:46 INFO - 'run-tests'), 18:11:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:11:46 INFO - 'download_minidump_stackwalk': True, 18:11:46 INFO - 'download_symbols': 'ondemand', 18:11:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:11:46 INFO - 'tooltool.py': '/tools/tooltool.py', 18:11:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:11:46 INFO - '/tools/misc-python/virtualenv.py')}, 18:11:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:11:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:11:46 INFO - 'installer_path': 'installer.exe', 18:11:46 INFO - 'log_level': 'info', 18:11:46 INFO - 'log_name': 'talos', 18:11:46 INFO - 'log_to_console': True, 18:11:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:11:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:11:46 INFO - 'opt_config_files': (), 18:11:46 INFO - 'pip_index': False, 18:11:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:11:46 INFO - 'cmd': ('bash', 18:11:46 INFO - '-c', 18:11:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:11:46 INFO - 'enabled': True, 18:11:46 INFO - 'halt_on_failure': False, 18:11:46 INFO - 'name': 'check_screen_resolution'},), 18:11:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:11:46 INFO - 'cmd': ('bash', 18:11:46 INFO - '-c', 18:11:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:11:46 INFO - 'enabled': True, 18:11:46 INFO - 'halt_on_failure': False, 18:11:46 INFO - 'name': 'check_screen_resolution'},), 18:11:46 INFO - 'run_cmd_checks_enabled': True, 18:11:46 INFO - 'sps_profile': False, 18:11:46 INFO - 'sps_profile_interval': 0, 18:11:46 INFO - 'suite': 'dromaeojs', 18:11:46 INFO - 'system_bits': '32', 18:11:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:11:46 INFO - 'title': 't-yosemite-r7-0380', 18:11:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:11:46 INFO - 'use_talos_json': True, 18:11:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:11:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:11:46 INFO - 'work_dir': 'build'} 18:11:46 INFO - ##### 18:11:46 INFO - ##### Running clobber step. 18:11:46 INFO - ##### 18:11:46 INFO - Running pre-action listener: _resource_record_pre_action 18:11:46 INFO - Running main action method: clobber 18:11:46 INFO - rmtree: /builds/slave/test/build 18:11:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:11:48 INFO - Running post-action listener: _resource_record_post_action 18:11:48 INFO - ##### 18:11:48 INFO - ##### Finished clobber step (success) 18:11:48 INFO - ##### 18:11:48 INFO - ##### 18:11:48 INFO - ##### Running read-buildbot-config step. 18:11:48 INFO - ##### 18:11:48 INFO - Running pre-action listener: _resource_record_pre_action 18:11:48 INFO - Running main action method: read_buildbot_config 18:11:48 INFO - Using buildbot properties: 18:11:48 INFO - { 18:11:48 INFO - "project": "", 18:11:48 INFO - "product": "firefox", 18:11:48 INFO - "script_repo_revision": "production", 18:11:48 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 18:11:48 INFO - "repository": "", 18:11:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 18:11:48 INFO - "buildid": "20160715162252", 18:11:48 INFO - "pgo_build": "False", 18:11:48 INFO - "basedir": "/builds/slave/test", 18:11:48 INFO - "buildnumber": 23, 18:11:48 INFO - "slavename": "t-yosemite-r7-0380", 18:11:48 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:11:48 INFO - "platform": "yosemite_r7", 18:11:48 INFO - "scheduler": "tests-autoland-macosx64-talos", 18:11:48 INFO - "branch": "autoland", 18:11:48 INFO - "repo_path": "integration/autoland", 18:11:48 INFO - "revision": "53ee209a0557b5c11e821c980c5a460fd09c1730", 18:11:48 INFO - "stage_platform": "macosx64", 18:11:48 INFO - "builduid": "b8e6c53a7d354be580f7e9bfb458d68b", 18:11:48 INFO - "slavebuilddir": "test" 18:11:48 INFO - } 18:11:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 18:11:48 INFO - Running post-action listener: _resource_record_post_action 18:11:48 INFO - ##### 18:11:48 INFO - ##### Finished read-buildbot-config step (success) 18:11:48 INFO - ##### 18:11:48 INFO - ##### 18:11:48 INFO - ##### Running download-and-extract step. 18:11:48 INFO - ##### 18:11:48 INFO - Running pre-action listener: _resource_record_pre_action 18:11:48 INFO - Running main action method: download_and_extract 18:11:48 INFO - mkdir: /builds/slave/test/build/tests 18:11:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:48 INFO - https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:11:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 18:11:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 18:11:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/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 18:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/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 18:11:49 INFO - Downloaded 1199 bytes. 18:11:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 18:11:49 INFO - Using the following test package requirements: 18:11:49 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 18:11:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:11:49 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 18:11:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:11:49 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 18:11:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:11:49 INFO - u'jsshell-mac.zip'], 18:11:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:11:49 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 18:11:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 18:11:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:11:49 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 18:11:49 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:11:49 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 18:11:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:11:49 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 18:11:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 18:11:49 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 18:11:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18: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')]} 18:11:49 INFO - https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:11:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:11:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:11:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/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 18:11:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/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 18:11:51 INFO - Downloaded 18829169 bytes. 18:11:51 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'] 18:11:51 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 18:11:54 INFO - Return code: 0 18:11:54 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 18:11:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:11:54 INFO - https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:11:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:11:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 18:11:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/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 18:11:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/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 18:11:56 INFO - Downloaded 18829169 bytes. 18:11:56 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'] 18:11:56 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 18:11:59 INFO - Return code: 0 18:11:59 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')]} 18:11:59 INFO - https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:11:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:11:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 18:11:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/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 18:11:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/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 18:12:01 INFO - Downloaded 14403317 bytes. 18:12:01 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'] 18:12:01 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 18:12:01 INFO - Return code: 0 18:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:12:01 INFO - https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:12:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:12:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:12:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 18:12:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fbj5WbOnSX6YX4dSJP790g/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 18:12:04 INFO - Downloaded 112749699 bytes. 18:12:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:12:04 INFO - mkdir: /builds/slave/test/properties 18:12:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:12:04 INFO - Writing to file /builds/slave/test/properties/build_url 18:12:04 INFO - Contents: 18:12:04 INFO - build_url:https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 18:12:05 INFO - Running post-action listener: _resource_record_post_action 18:12:05 INFO - Running post-action listener: set_extra_try_arguments 18:12:05 INFO - ##### 18:12:05 INFO - ##### Finished download-and-extract step (success) 18:12:05 INFO - ##### 18:12:05 INFO - ##### 18:12:05 INFO - ##### Running populate-webroot step. 18:12:05 INFO - ##### 18:12:05 INFO - Running pre-action listener: _resource_record_pre_action 18:12:05 INFO - Running main action method: populate_webroot 18:12:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:12:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:12:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:12:05 INFO - '--tppagecycles', 18:12:05 INFO - '7'], 18:12:05 INFO - 'tests': ['tsvgm']}}, 18:12:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:12:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:12:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:12:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:12:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:05 INFO - 'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:12:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:05 INFO - 'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['damp', 'tps']}, 18:12:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:05 INFO - 'tests': ['damp', 'tps']}, 18:12:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['dromaeo_dom']}, 18:12:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:12:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['basic_compositor_video']}, 18:12:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:12:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['a11yr', 18:12:05 INFO - 'ts_paint', 18:12:05 INFO - 'tpaint', 18:12:05 INFO - 'sessionrestore', 18:12:05 INFO - 'sessionrestore_no_auto_restore', 18:12:05 INFO - 'tabpaint']}, 18:12:05 INFO - 'other-e10s': {'tests': ['a11yr', 18:12:05 INFO - 'ts_paint', 18:12:05 INFO - 'tpaint', 18:12:05 INFO - 'sessionrestore', 18:12:05 INFO - 'sessionrestore_no_auto_restore', 18:12:05 INFO - 'tabpaint']}, 18:12:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:12:05 INFO - 'ts_paint', 18:12:05 INFO - 'tpaint', 18:12:05 INFO - 'sessionrestore', 18:12:05 INFO - 'sessionrestore_no_auto_restore', 18:12:05 INFO - 'tabpaint']}, 18:12:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:12:05 INFO - 'ts_paint', 18:12:05 INFO - 'tpaint', 18:12:05 INFO - 'sessionrestore', 18:12:05 INFO - 'sessionrestore_no_auto_restore', 18:12:05 INFO - 'tabpaint']}, 18:12:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['a11yr', 18:12:05 INFO - 'ts_paint', 18:12:05 INFO - 'tpaint', 18:12:05 INFO - 'sessionrestore', 18:12:05 INFO - 'sessionrestore_no_auto_restore', 18:12:05 INFO - 'tabpaint']}, 18:12:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['a11yr', 18:12:05 INFO - 'ts_paint', 18:12:05 INFO - 'tpaint', 18:12:05 INFO - 'sessionrestore', 18:12:05 INFO - 'sessionrestore_no_auto_restore', 18:12:05 INFO - 'tabpaint']}, 18:12:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['tsvgx', 18:12:05 INFO - 'tsvgr_opacity', 18:12:05 INFO - 'tart', 18:12:05 INFO - 'tscrollx', 18:12:05 INFO - 'cart']}, 18:12:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:12:05 INFO - 'tsvgr_opacity', 18:12:05 INFO - 'tart', 18:12:05 INFO - 'tscrollx', 18:12:05 INFO - 'cart']}, 18:12:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:05 INFO - 'talos_options': ['--disable-e10s'], 18:12:05 INFO - 'tests': ['tp5o']}, 18:12:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:05 INFO - 'tests': ['tp5o']}, 18:12:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:05 INFO - 'talos_options': ['--disable-e10s', 18:12:05 INFO - '--xperf_path', 18:12:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:05 INFO - 'tests': ['tp5n']}, 18:12:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:12:05 INFO - 'talos_options': ['--xperf_path', 18:12:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:12:05 INFO - 'tests': ['tp5n']}}, 18:12:05 INFO - 'talos.zip': {'path': '', 18:12:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:12:05 INFO - Running post-action listener: _resource_record_post_action 18:12:05 INFO - ##### 18:12:05 INFO - ##### Finished populate-webroot step (success) 18:12:05 INFO - ##### 18:12:05 INFO - ##### 18:12:05 INFO - ##### Running create-virtualenv step. 18:12:05 INFO - ##### 18:12:05 INFO - Running pre-action listener: _resource_record_pre_action 18:12:05 INFO - Running main action method: create_virtualenv 18:12:05 INFO - Creating virtualenv /builds/slave/test/build/venv 18:12:05 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 18:12:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:12:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:12:05 INFO - Using real prefix '/tools/python27' 18:12:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:12:06 INFO - Installing distribute.............................................................................................................................................................................................done. 18:12:09 INFO - Installing pip.................done. 18:12:09 INFO - Return code: 0 18:12:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:09 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 0x10b4b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b2578f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b41cd30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b414b20>, '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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 18:12:09 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 18:12:09 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 18:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RYmPAqZX6d/Render', 18:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:09 INFO - 'HOME': '/Users/cltbld', 18:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:09 INFO - 'LOGNAME': 'cltbld', 18:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:09 INFO - 'MOZ_NO_REMOTE': '1', 18:12:09 INFO - 'NO_EM_RESTART': '1', 18:12:09 INFO - 'PAGER': '/bin/cat', 18:12:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:09 INFO - 'PWD': '/builds/slave/test', 18:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:09 INFO - 'SHELL': '/bin/bash', 18:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mZDy2wO4oK/Listeners', 18:12:09 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 18:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:09 INFO - 'USER': 'cltbld', 18:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:09 INFO - 'XPC_FLAGS': '0x0', 18:12:09 INFO - 'XPC_SERVICE_NAME': '0', 18:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:09 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 18:12:09 INFO - Cleaning up... 18:12:09 INFO - Return code: 0 18:12:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:09 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 0x10b4b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b2578f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b41cd30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b414b20>, '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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 18:12:09 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 18:12:09 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 18:12:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RYmPAqZX6d/Render', 18:12:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:09 INFO - 'HOME': '/Users/cltbld', 18:12:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:09 INFO - 'LOGNAME': 'cltbld', 18:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:09 INFO - 'MOZ_NO_REMOTE': '1', 18:12:09 INFO - 'NO_EM_RESTART': '1', 18:12:09 INFO - 'PAGER': '/bin/cat', 18:12:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:09 INFO - 'PWD': '/builds/slave/test', 18:12:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:09 INFO - 'SHELL': '/bin/bash', 18:12:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mZDy2wO4oK/Listeners', 18:12:09 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 18:12:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:09 INFO - 'USER': 'cltbld', 18:12:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:09 INFO - 'XPC_FLAGS': '0x0', 18:12:09 INFO - 'XPC_SERVICE_NAME': '0', 18:12:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:09 INFO - Downloading/unpacking psutil>=3.1.1 18:12:09 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 18:12:09 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 18:12:09 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 18:12:09 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 18:12:09 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 18:12:09 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 18:12:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:12:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:12 INFO - Installing collected packages: psutil 18:12:12 INFO - Running setup.py install for psutil 18:12:12 INFO - building 'psutil._psutil_osx' extension 18:12:12 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 18:12:13 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 18:12:13 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 18:12:13 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 18:12:13 INFO - building 'psutil._psutil_posix' extension 18:12:13 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 18:12:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:12:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:12:13 INFO - ^ 18:12:13 INFO - 1 warning generated. 18:12:13 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 18:12:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:12:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:12:13 INFO - Successfully installed psutil 18:12:13 INFO - Cleaning up... 18:12:13 INFO - Return code: 0 18:12:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:12:13 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')]} 18:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:13 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')]} 18:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:13 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 0x10b4b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b2578f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b41cd30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b414b20>, '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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 18:12:13 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 18:12:13 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 18:12:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RYmPAqZX6d/Render', 18:12:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:13 INFO - 'HOME': '/Users/cltbld', 18:12:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:13 INFO - 'LOGNAME': 'cltbld', 18:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:13 INFO - 'MOZ_NO_REMOTE': '1', 18:12:13 INFO - 'NO_EM_RESTART': '1', 18:12:13 INFO - 'PAGER': '/bin/cat', 18:12:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:13 INFO - 'PWD': '/builds/slave/test', 18:12:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:13 INFO - 'SHELL': '/bin/bash', 18:12:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mZDy2wO4oK/Listeners', 18:12:13 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 18:12:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:13 INFO - 'USER': 'cltbld', 18:12:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:13 INFO - 'XPC_FLAGS': '0x0', 18:12:13 INFO - 'XPC_SERVICE_NAME': '0', 18:12:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:12:13 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 18:12:13 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 18:12:13 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 18:12:13 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 18:12:13 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 18:12:13 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 18:12:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:12:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:12:16 INFO - Installing collected packages: mozsystemmonitor 18:12:16 INFO - Running setup.py install for mozsystemmonitor 18:12:16 INFO - Successfully installed mozsystemmonitor 18:12:16 INFO - Cleaning up... 18:12:16 INFO - Return code: 0 18:12:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:16 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 0x10b4b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b2578f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b41cd30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b414b20>, '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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 18:12:16 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 18:12:16 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 18:12:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RYmPAqZX6d/Render', 18:12:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:16 INFO - 'HOME': '/Users/cltbld', 18:12:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:16 INFO - 'LOGNAME': 'cltbld', 18:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:16 INFO - 'MOZ_NO_REMOTE': '1', 18:12:16 INFO - 'NO_EM_RESTART': '1', 18:12:16 INFO - 'PAGER': '/bin/cat', 18:12:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:16 INFO - 'PWD': '/builds/slave/test', 18:12:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:16 INFO - 'SHELL': '/bin/bash', 18:12:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mZDy2wO4oK/Listeners', 18:12:16 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 18:12:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:16 INFO - 'USER': 'cltbld', 18:12:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:16 INFO - 'XPC_FLAGS': '0x0', 18:12:16 INFO - 'XPC_SERVICE_NAME': '0', 18:12:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:17 INFO - Downloading/unpacking jsonschema==2.5.1 18:12:17 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 18:12:17 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 18:12:17 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 18:12:17 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 18:12:17 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 18:12:17 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 18:12:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:12:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:19 INFO - Downloading functools32-3.2.3-2.tar.gz 18:12:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:12:19 INFO - warning: no files found matching '*.txt' 18:12:19 INFO - no previously-included directories found matching 'build' 18:12:19 INFO - no previously-included directories found matching 'dist' 18:12:19 INFO - no previously-included directories found matching '.git*' 18:12:19 INFO - Installing collected packages: jsonschema, functools32 18:12:19 INFO - Running setup.py install for functools32 18:12:20 INFO - warning: no files found matching '*.txt' 18:12:20 INFO - no previously-included directories found matching 'build' 18:12:20 INFO - no previously-included directories found matching 'dist' 18:12:20 INFO - no previously-included directories found matching '.git*' 18:12:20 INFO - Successfully installed jsonschema functools32 18:12:20 INFO - Cleaning up... 18:12:20 INFO - Return code: 0 18:12:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:12:20 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')]} 18:12:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:20 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')]} 18:12:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:20 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 0x10b4b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b2578f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b41cd30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b414b20>, '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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 18:12:20 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 18:12:20 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 18:12:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RYmPAqZX6d/Render', 18:12:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:20 INFO - 'HOME': '/Users/cltbld', 18:12:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:20 INFO - 'LOGNAME': 'cltbld', 18:12:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:20 INFO - 'MOZ_NO_REMOTE': '1', 18:12:20 INFO - 'NO_EM_RESTART': '1', 18:12:20 INFO - 'PAGER': '/bin/cat', 18:12:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:20 INFO - 'PWD': '/builds/slave/test', 18:12:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:20 INFO - 'SHELL': '/bin/bash', 18:12:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mZDy2wO4oK/Listeners', 18:12:20 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 18:12:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:20 INFO - 'USER': 'cltbld', 18:12:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:20 INFO - 'XPC_FLAGS': '0x0', 18:12:20 INFO - 'XPC_SERVICE_NAME': '0', 18:12:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:20 INFO - Downloading/unpacking blobuploader==1.2.4 18:12:20 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 18:12:20 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 18:12:20 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 18:12:20 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 18:12:20 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 18:12:20 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 18:12:22 INFO - Downloading blobuploader-1.2.4.tar.gz 18:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:12:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:12:22 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 18:12:22 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 18:12:22 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 18:12:22 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 18:12:22 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 18:12:22 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 18:12:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:12:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:12:23 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 18:12:23 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 18:12:23 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 18:12:23 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 18:12:23 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 18:12:23 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 18:12:24 INFO - Downloading docopt-0.6.1.tar.gz 18:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:12:24 INFO - Installing collected packages: blobuploader, requests, docopt 18:12:24 INFO - Running setup.py install for blobuploader 18:12:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:12:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:12:24 INFO - Running setup.py install for requests 18:12:24 INFO - Running setup.py install for docopt 18:12:24 INFO - Successfully installed blobuploader requests docopt 18:12:24 INFO - Cleaning up... 18:12:25 INFO - Return code: 0 18:12:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18: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')]} 18:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18: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')]} 18:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:25 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 0x10b4b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b2578f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b41cd30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b414b20>, '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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 18:12:25 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 18:12:25 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 18:12:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RYmPAqZX6d/Render', 18:12:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:25 INFO - 'HOME': '/Users/cltbld', 18:12:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:25 INFO - 'LOGNAME': 'cltbld', 18:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:25 INFO - 'MOZ_NO_REMOTE': '1', 18:12:25 INFO - 'NO_EM_RESTART': '1', 18:12:25 INFO - 'PAGER': '/bin/cat', 18:12:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:25 INFO - 'PWD': '/builds/slave/test', 18:12:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:25 INFO - 'SHELL': '/bin/bash', 18:12:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mZDy2wO4oK/Listeners', 18:12:25 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 18:12:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:25 INFO - 'USER': 'cltbld', 18:12:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:25 INFO - 'XPC_FLAGS': '0x0', 18:12:25 INFO - 'XPC_SERVICE_NAME': '0', 18:12:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:25 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-qq6iz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:25 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-lfF7jA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:25 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-3GJJ3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:25 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-LzBNQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:25 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-FlI64o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:25 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-DYOCUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:25 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-rcf47F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:26 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-twrZZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:26 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-dvhhiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:26 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-dCWnPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:26 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-_w_xMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:26 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-Ybzb5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:26 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-644KiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:26 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-X6kUq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:26 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-verQJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:26 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-3U_Hbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:26 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-VQeYLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:12:27 INFO - Running setup.py install for manifestparser 18:12:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:12:27 INFO - Running setup.py install for mozcrash 18:12:27 INFO - Running setup.py install for mozdebug 18:12:27 INFO - Running setup.py install for mozdevice 18:12:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:12:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:12:27 INFO - Running setup.py install for mozfile 18:12:27 INFO - Running setup.py install for mozhttpd 18:12:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:12:27 INFO - Running setup.py install for mozinfo 18:12:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:12:28 INFO - Running setup.py install for mozInstall 18:12:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:12:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:12:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:12:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:12:28 INFO - Running setup.py install for mozleak 18:12:28 INFO - Running setup.py install for mozlog 18:12:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:12:28 INFO - Running setup.py install for moznetwork 18:12:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:12:28 INFO - Running setup.py install for mozprocess 18:12:28 INFO - Running setup.py install for mozprofile 18:12:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:12:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:12:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:12:29 INFO - Running setup.py install for mozrunner 18:12:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:12:29 INFO - Running setup.py install for mozscreenshot 18:12:29 INFO - Running setup.py install for moztest 18:12:29 INFO - Running setup.py install for mozversion 18:12:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:12:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:12:29 INFO - Cleaning up... 18:12:29 INFO - Return code: 0 18:12:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:29 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 0x10b4b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b2578f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b41cd30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b414b20>, '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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 18:12:29 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 18:12:29 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 18:12:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RYmPAqZX6d/Render', 18:12:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:29 INFO - 'HOME': '/Users/cltbld', 18:12:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:29 INFO - 'LOGNAME': 'cltbld', 18:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:29 INFO - 'MOZ_NO_REMOTE': '1', 18:12:29 INFO - 'NO_EM_RESTART': '1', 18:12:29 INFO - 'PAGER': '/bin/cat', 18:12:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:29 INFO - 'PWD': '/builds/slave/test', 18:12:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:29 INFO - 'SHELL': '/bin/bash', 18:12:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mZDy2wO4oK/Listeners', 18:12:29 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 18:12:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:29 INFO - 'USER': 'cltbld', 18:12:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:29 INFO - 'XPC_FLAGS': '0x0', 18:12:29 INFO - 'XPC_SERVICE_NAME': '0', 18:12:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:12:29 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-5tjhce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:12:30 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)) 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:12:30 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-k1yfyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:12:30 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)) 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:12:30 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-9im_Ad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:12:30 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)) 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:12:30 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-vMMeJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:12:30 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)) 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:12:30 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-EGLIrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:12:30 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)) 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:12:30 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-9DsydB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:12:30 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)) 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:12:30 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-XnArBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:12:30 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)) 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:12:30 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-_K0h9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:12:30 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)) 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:12:30 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-tJxio4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:12:30 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)) 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:12:30 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-qSLj6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:12:30 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)) 18:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:12:30 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-ABTHpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:12:31 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)) 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:12:31 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-bihn5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:12:31 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-rm7wyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:12:31 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)) 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:12:31 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-gwIBLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:12:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:31 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-nje9Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:12:31 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)) 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:12:31 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-PB789Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:12:31 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)) 18:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:12:31 INFO - Running setup.py (path:/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/pip-BeNtm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:12:31 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)) 18:12:31 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)) 18:12:31 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)) 18:12:31 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)) 18:12:31 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)) 18:12:31 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)) 18:12:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:12:34 INFO - Downloading blessings-1.6.tar.gz 18:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:12:34 INFO - Installing collected packages: blessings 18:12:34 INFO - Running setup.py install for blessings 18:12:34 INFO - Successfully installed blessings 18:12:34 INFO - Cleaning up... 18:12:34 INFO - Return code: 0 18:12:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:12:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:34 INFO - Reading from file tmpfile_stdout 18:12:34 INFO - Current package versions: 18:12:34 INFO - blessings == 1.6 18:12:34 INFO - blobuploader == 1.2.4 18:12:34 INFO - docopt == 0.6.1 18:12:34 INFO - functools32 == 3.2.3-2 18:12:34 INFO - jsonschema == 2.5.1 18:12:34 INFO - manifestparser == 1.1 18:12:34 INFO - mozInstall == 1.12 18:12:34 INFO - mozcrash == 0.17 18:12:34 INFO - mozdebug == 0.1 18:12:34 INFO - mozdevice == 0.48 18:12:34 INFO - mozfile == 1.2 18:12:34 INFO - mozhttpd == 0.7 18:12:34 INFO - mozinfo == 0.9 18:12:34 INFO - mozleak == 0.1 18:12:34 INFO - mozlog == 3.2 18:12:34 INFO - moznetwork == 0.27 18:12:34 INFO - mozprocess == 0.23 18:12:34 INFO - mozprofile == 0.28 18:12:34 INFO - mozrunner == 6.12 18:12:34 INFO - mozscreenshot == 0.1 18:12:34 INFO - mozsystemmonitor == 0.3 18:12:34 INFO - moztest == 0.7 18:12:34 INFO - mozversion == 1.4 18:12:34 INFO - psutil == 3.1.1 18:12:34 INFO - requests == 1.2.3 18:12:34 INFO - wsgiref == 0.1.2 18:12:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:12: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')]} 18:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12: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')]} 18:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:34 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 0x10b4b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b2578f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b41cd30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b414b20>, '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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 18:12:34 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 18:12:34 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 18:12:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RYmPAqZX6d/Render', 18:12:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:34 INFO - 'HOME': '/Users/cltbld', 18:12:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:34 INFO - 'LOGNAME': 'cltbld', 18:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:34 INFO - 'MOZ_NO_REMOTE': '1', 18:12:34 INFO - 'NO_EM_RESTART': '1', 18:12:34 INFO - 'PAGER': '/bin/cat', 18:12:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:34 INFO - 'PWD': '/builds/slave/test', 18:12:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:34 INFO - 'SHELL': '/bin/bash', 18:12:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mZDy2wO4oK/Listeners', 18:12:34 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 18:12:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:34 INFO - 'USER': 'cltbld', 18:12:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:34 INFO - 'XPC_FLAGS': '0x0', 18:12:34 INFO - 'XPC_SERVICE_NAME': '0', 18:12:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:35 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)) 18:12:35 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)) 18:12:35 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)) 18:12:35 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)) 18:12:35 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)) 18:12:35 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)) 18:12:35 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)) 18:12:35 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)) 18:12:35 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)) 18:12:35 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)) 18:12:35 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)) 18:12:35 INFO - Cleaning up... 18:12:35 INFO - Return code: 0 18:12:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:12:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b54d618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff4b2578f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b41cd30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b414b20>, '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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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 18:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:12:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RYmPAqZX6d/Render', 18:12:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:12:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:12:35 INFO - 'HOME': '/Users/cltbld', 18:12:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:12:35 INFO - 'LOGNAME': 'cltbld', 18:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:12:35 INFO - 'MOZ_NO_REMOTE': '1', 18:12:35 INFO - 'NO_EM_RESTART': '1', 18:12:35 INFO - 'PAGER': '/bin/cat', 18:12:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:12:35 INFO - 'PWD': '/builds/slave/test', 18:12:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:12:35 INFO - 'SHELL': '/bin/bash', 18:12:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mZDy2wO4oK/Listeners', 18:12:35 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 18:12:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:12:35 INFO - 'USER': 'cltbld', 18:12:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:12:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:12:35 INFO - 'XPC_FLAGS': '0x0', 18:12:35 INFO - 'XPC_SERVICE_NAME': '0', 18:12:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:12:35 INFO - Cleaning up... 18:12:35 INFO - Return code: 0 18:12:35 INFO - Running post-action listener: _resource_record_post_action 18:12:35 INFO - Running post-action listener: _start_resource_monitoring 18:12:35 INFO - Starting resource monitoring. 18:12:35 INFO - ##### 18:12:35 INFO - ##### Finished create-virtualenv step (success) 18:12:35 INFO - ##### 18:12:35 INFO - ##### 18:12:35 INFO - ##### Running install step. 18:12:35 INFO - ##### 18:12:35 INFO - Running pre-action listener: _resource_record_pre_action 18:12:35 INFO - Running main action method: install 18:12:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:12:35 INFO - Reading from file tmpfile_stdout 18:12:35 INFO - Detecting whether we're running mozinstall >=1.0... 18:12:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:12:35 INFO - Reading from file tmpfile_stdout 18:12:35 INFO - Output received: 18:12:35 INFO - Usage: mozinstall [options] installer 18:12:35 INFO - Options: 18:12:35 INFO - -h, --help show this help message and exit 18:12:35 INFO - -d DEST, --destination=DEST 18:12:35 INFO - Directory to install application into. [default: 18:12:35 INFO - "/builds/slave/test"] 18:12:35 INFO - --app=APP Application being installed. [default: firefox] 18:12:35 INFO - mkdir: /builds/slave/test/build/application 18:12:35 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'] 18:12:35 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 18:13:09 INFO - Reading from file tmpfile_stdout 18:13:09 INFO - Output received: 18:13:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:13:09 INFO - Running post-action listener: _resource_record_post_action 18:13:09 INFO - ##### 18:13:09 INFO - ##### Finished install step (success) 18:13:09 INFO - ##### 18:13:09 INFO - ##### 18:13:09 INFO - ##### Running run-tests step. 18:13:09 INFO - ##### 18:13:09 INFO - Running pre-action listener: _resource_record_pre_action 18:13:09 INFO - Running main action method: run_tests 18:13:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:13:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:13:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:13:09 INFO - 2016-07-15 18:13:09.946 screenresolution[1654:7506] starting screenresolution argv=screenresolution get 18:13:09 INFO - 2016-07-15 18:13:09.949 screenresolution[1654:7506] Display 0: 1600x1200x32@60 18:13:09 INFO - 2016-07-15 18:13:09.955 screenresolution[1655:7508] starting screenresolution argv=screenresolution list 18:13:09 INFO - Available Modes on Display 0 18:13:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:13:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:13:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:13:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:13:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:13:10 INFO - Intel Iris: 18:13:10 INFO - Chipset Model: Intel Iris 18:13:10 INFO - Type: GPU 18:13:10 INFO - Bus: Built-In 18:13:10 INFO - VRAM (Dynamic, Max): 1536 MB 18:13:10 INFO - Vendor: Intel (0x8086) 18:13:10 INFO - Device ID: 0x0a2e 18:13:10 INFO - Revision ID: 0x0009 18:13:10 INFO - Displays: 18:13:10 INFO - Display: 18:13:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:13:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:13:10 INFO - Display Serial Number: 1600x1200 60 18:13:10 INFO - Main Display: Yes 18:13:10 INFO - Mirror: Off 18:13:10 INFO - Online: Yes 18:13:10 INFO - Rotation: Supported 18:13:10 INFO - Return code: 0 18:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:13:10 INFO - Python 2.7.3 18:13:10 INFO - Return code: 0 18:13:10 INFO - grabbing minidump binary from tooltool 18:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 18:13:10 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 0x10b41cd30>, '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 0x10b181db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b414b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:13:10 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 18:13:10 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 18:13:10 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 18:13:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:13:10 INFO - Return code: 0 18:13:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:13:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:13:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:13:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:13:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0380', '--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 18:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0380 --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 18:13:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RYmPAqZX6d/Render', 18:13:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:13:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:13:10 INFO - 'HOME': '/Users/cltbld', 18:13:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:13:10 INFO - 'LOGNAME': 'cltbld', 18:13:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:13:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:13:10 INFO - 'MOZ_NO_REMOTE': '1', 18:13:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:13:10 INFO - 'NO_EM_RESTART': '1', 18:13:10 INFO - 'PAGER': '/bin/cat', 18:13:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:13:10 INFO - 'PWD': '/builds/slave/test', 18:13:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:13:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:13:10 INFO - 'SHELL': '/bin/bash', 18:13:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mZDy2wO4oK/Listeners', 18:13:10 INFO - 'TMPDIR': '/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/', 18:13:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:13:10 INFO - 'USER': 'cltbld', 18:13:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:13:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:13:10 INFO - 'XPC_FLAGS': '0x0', 18:13:10 INFO - 'XPC_SERVICE_NAME': '0', 18:13:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:13:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0380', '--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 18:13:10 INFO - mozversion application_buildid: 20160715162252 18:13:10 INFO - mozversion application_changeset: 53ee209a0557b5c11e821c980c5a460fd09c1730 18:13:10 INFO - mozversion application_display_name: Nightly 18:13:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:13:10 INFO - mozversion application_name: Firefox 18:13:10 INFO - mozversion application_remotingname: firefox 18:13:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:13:10 INFO - mozversion application_vendor: Mozilla 18:13:10 INFO - mozversion application_version: 50.0a1 18:13:10 INFO - mozversion platform_buildid: 20160715162252 18:13:10 INFO - mozversion platform_changeset: 53ee209a0557b5c11e821c980c5a460fd09c1730 18:13:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:13:10 INFO - mozversion platform_version: 50.0a1 18:13:10 INFO - using testdate: 1468631590 18:13:10 INFO - actual date: 1468631590 18:13:10 INFO - starting webserver on 'localhost:49279' 18:13:10 INFO - SUITE-START | Running 2 tests 18:13:10 INFO - TEST-START | dromaeo_css 18:13:10 INFO - operating with platform_type : mac_ 18:13:10 INFO - Initialising browser for dromaeo_css test... 18:13:10 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/tmp2LFUPg/profile http://localhost:49279/getInfo.html) 18:13:12 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 18:13:12 INFO - PROCESS | 1665 | colorDepth:24 18:13:12 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 18:13:12 INFO - PROCESS | 1665 | __metrics 18:13:12 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:13:12 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:13:13 INFO - TEST-INFO | 1665: exit 0 18:13:13 INFO - Browser initialized. 18:13:13 INFO - Running cycle 1/1 for dromaeo_css test... 18:13:13 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/tmp2LFUPg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:13:25 INFO - PROCESS | 1668 | RSS: Main: 243765248 18:13:25 INFO - PROCESS | 1668 | 18:14:16 INFO - PROCESS | 1668 | 1468631656933 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] 18:16:27 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 18:16:28 INFO - PROCESS | 1668 | RSS: Main: 386154496 18:16:28 INFO - PROCESS | 1668 | 18:19:32 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 18:19:32 INFO - PROCESS | 1668 | RSS: Main: 383647744 18:19:32 INFO - PROCESS | 1668 | 18:22:34 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 18:22:35 INFO - PROCESS | 1668 | RSS: Main: 374022144 18:22:35 INFO - PROCESS | 1668 | 18:25:37 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 18:25:38 INFO - PROCESS | 1668 | RSS: Main: 371937280 18:25:38 INFO - PROCESS | 1668 | 18:28:41 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 18:28:42 INFO - PROCESS | 1668 | RSS: Main: 347406336 18:28:42 INFO - PROCESS | 1668 | 18:31:45 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 18:31:45 INFO - PROCESS | 1668 | RSS: Main: 388763648 18:31:45 INFO - PROCESS | 1668 | 18:31:45 INFO - PROCESS | 1668 | __start_tp_report 18:31:45 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 18:31:45 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 18:31:45 INFO - PROCESS | 1668 | |i|pagename|runs| 18:31:45 INFO - PROCESS | 1668 | |0;dojo.html;3329.3008468221674;3345.983270083649;3347.514610381493;3375.426177549816;3404.0468668772737;5577.69322687252;5622.8313150605545;5647.43525647435;5704.54363650908;5710.371859095496;5621.578381621384;5680.744366503507;5684.459976302255;5692.260006199199;5698.886022279562;5154.974225128878;5161.354830646169;5184.351956005499;5213.765380557884;5268.604854635899;5266.210068489719;5312.521873031426;5340.91988620171;5351.0903146465;5353.812616558421;5254.15933450646;5264.341957255343;5283.207518872162;5326.866828329304;5343.332083489564;559.2619454117088;5251.921221181686;5304.443033481468;5324.653897496689;5339.5461385782255;5088.643794934356;5140.434552199255;5173.32746742921;5207.297014902978;5213.2701421800975;5696.202531645573;5701.857453563653;5704.344000439961;5776.046952252873;5784.36371999084;6032.185654936615;6265.4361107500545;6280.717367718464;6282;6290.685465726695;6143.481172719208;6177;6186.443220110212;6195.597286176384;6250.1874756281395;5878.441548052928;5883.0881213411985;5886.293644762656;5886.852828679317;5901.7934372297195;6229;6252.406021427957;6281.309056003836;6287.717052732638;6289.905651415233;5981.312149102821;6042.848928776816;6123.203983482119;6166.105914642441;6179.104029915637;6260.217472815898;6279.0895320178315;6280.9685951569945;6284.905726414107;6315.36846315374;5199.2201169824075;6099.115628233882;6188.938110618927;6219.751209951642;6260.499160067184;6034.909476357858;6114.388561143939;6130.601510901777;6263.561550691408;6265.122882796412;4934.8766280843265;4942.9011419771405;4943.8022479101155;4946.406431228275;4958.975205124024;4430.778461076933;4464.129494748558;4490.101979604092;4501.887452813706;4503.639708823286;5754.683492407874;5773.278340207474;5775.711214439261;5798.043322851767;5800.53595712342;6235.376462353728;6280.623162610258;6287.465565426898;6300;6318.968405157945;5583.888322233533;5642.520385767174;5646.632968857011;5778.0272064922365;5823.155642431823;5428.70142142186;5429.647072940246;5432.864178395572;5441.428649991773;5468.125099983983;6180.907286390708;6228.439440450381;6248.375162483715;6251.968740156452;6252.5935814171935;6129.724162412613;6167.290761562478;6265.968670156803;6274.215723034621;6288.182536270256;6222.564420490522;6267.46726528232;6285.905711414241;6299.370062993664;6304.5586808922935;5363.651362661414;6105.429421494235;6131.110988906495;6137.22377000893;6142.170806941184;6182.443580077815;6212.782552610637;6216.564840461125;6237.906431403442;6240.937590624036;4543.227651299221;5768.711564421846;6077.908831367445;6083.178770866053;6094.7257373417415;5796.04365279741;5858.033424484912;5864.061750120131;5867.061270196748;5882.382349853204;5753.108268218432;5766.308043034863;5907.763689452374;5971.373005834324;6016.398360164124;6124.908126378019;6141.385861413823;6147.508199344131;6147.784827531015;6154.230721159855;5921;5928.762849486145;5930.495907847881;5943.524518038633;5960.970195148997 18:31:45 INFO - PROCESS | 1668 | |1;ext.html;510.5226613116735;514.4341224652883;518.2537146509027;528.1364968276869;551.0989532114991;23886.76113238867;40043.599564004355;41707.58292417075;41734.7913260434;44091.55908440915;42803.78598107013;42996.57003429965;43077.353839692354;43169.35245971313;43171.78414107925;8601.95699021507;9558.42649441034;9734.41593504392;9738.853917191213;9740.025997400238;8644.005939316996;11664.41677916105;11774.646760597196;11801.7639647207;12114.091443141755;11855.585054523093;11935.403229838517;11939.223950443236;11940.522379104825;11949.64151075469;8592.355573331963;11730.35483048432;11734.237274577124;11841.526338946474;11842.467088981017;11739.941300293529;11834.644960651194;11836.585719499863;11846.822297665542;11851.229670071418;40403;40634.18731625351;40755.592444075475;40760.79619601883;40795.184096317906;3521.366154092262;3743.9625603743884;3816.8282427290837;3882.9805850970565;4259.744415335059;31444.842775785975;32383.514247286308;32617.836910815295;32758.836205819058;33105.84129555478;3245.415825151472;3392.1010932103013;3396.184915620258;3420.025292791567;3435.209901722618;510048;510269;511422;512677;514641;59277.814443710886;59461.70269148713;59801.401985980454;59969.700151499834;60040;56349.591260218;59539.702301488214;62980.685096575144;63055;63079;16459.83540164583;16771.664566708598;16775.328986840635;16783.58041048959;16797.496075117768;11821.763564728657;12083.75832483363;12084.939575302244;12274.202176858476;13001.869981300066;13396.464141434428;14727.337269822883;16053.117078560557;16484.670306594042;16845.663086738197;5962.791302304398;6615.702293396808;6711.8589839727365;6721.4958878084335;6737.629430381376;890.6081324217324;967.1778987860263;980.7352014955922;1062.9946850265699;1115.6374178392055;30623.540646890313;30673.926412575453;30859.015354763324;31149.377012459623;31473.8426307867;912.539167720297;1144.8511693479795;1148.5635458525708;1181.2262967756133;1193.3317342288346;15811.68376632461;15858.444954426539;15930.60173495672;15999.920000400156;16150.919245403698;668015;675717;679183;679282;679413;60228;60453.69773151106;60480.79038419207;60524;60539.48651283665;1173.3312012153162;1187.5487314820487;1416.900816942804;1426.322496814005;1458.0741229319246;31225.063248102593;31640.683593164693;31810.681893180772;32637.347253055283;32796.508052378755;49057.52827415183;49601;49610.75194624004;49630;49687;442274;443989;449047;449935;451434;38848.02879928024;39326.01684957899;40006.39990400204;40222.1955560893;40273.798631006655;46911.530884690714;47384.7630761844;47634;47639.04721905612;48627;39112;39787.80636580907;39801;40537.391939120345;40658.1868362637;39547.2090558193;39784.00539986524;39983.60016399799;40407;40702.778916632546;38202.617973819906;38635;38901.6109838898;38954.80522597369;39066.63266785649;29688;32458.02625921226;34614.13464663403;35360.11599709925;35402.82298588491;24109.879450603337;24886;24932.750672493043;25549.23352299434;26091.347716307246 18:31:45 INFO - PROCESS | 1668 | |2;jquery.html;361.1440885102308;383.43251987059153;391.57709673552586;391.762983395046;418.4873529925839;15091.84908150918;20149.29477468289;20307.187712491483;20642.38072857813;21304.680429793567;20008.599828003433;20522.794772052275;21377.465563360925;21390.679139812913;21416.57166856662;5783.508401785833;5796.797112101088;5847.093700476412;5914.1128830675525;5919.408059194089;5627.240322556464;5751.7699292028265;5769.884602307951;5798.304203495565;5801.854953626151;5652.943470565283;5715.0855863061915;5730.312362516483;5735.2544169257935;5752.367239603661;5558.888822223533;5671.7731290748325;5708;5718.42815718429;5722.971385143069;4295.334223195409;4964.354633897607;5019.623528235397;5055.090083784954;5096.235564665293;25663;25784.710764461703;25789.742102579108;26031.088911888182;26040.479190416274;2253.2339004738305;2348.377679914824;2477.938051548708;2589.8705064746687;2899.855007249629;12332.568360107352;15073.623159420993;15218.46735364268;15463.690726185414;15697.450589229436;1571.8506741859505;1805.629845881591;1834.871558990871;1847.131848031423;1848.8890666559914;112561;113419;114441.85558144479;114818.42590787075;115200.42399787948;9437.764055898657;10007.149392301735;10351.534180961875;10668;10898.836517452244;12881.935590321988;13575.456981720818;13605.523806666719;13643.454261829615;13649.317534123255;6942.375186233162;8322.126176751475;8522.914770852336;8587.22714955657;8695.826083478421;8689.261328367473;8692.174243446989;8747.475151490931;8770;8869.73390798277;6409.455196308366;6500.902486462707;6527.902081468782;6556.475481961432;6614.966925165343;1791.4177892185091;1827.86140215945;1829.3962992212537;1847.3072597775833;1867.561123136089;827.6523859978823;906.4334790755778;936.8313703533294;992.7964767222702;1048.4286064095086;18283.134936486367;22098.0055897485;22165.113395464;22200.77799221987;22213.77786222117;951.4861974533675;972.9708108756748;973.4062222044547;974.5322245322285;1004.0762498501397;9593;11494.770104597861;11724.941375293069;11782.705432364088;11837.408129593487;605130;617569;620454;627031;627888;99627;112603;121945;123029.15456268164;127068;900.3337530227584;1024.830902901013;1036.264252380803;1053.5996321397972;1060.6393826099008;15938.177494929827;18628.254869805056;19240.05578856303;19336.709949351054;19755.012249387186;28871.42257154803;39799;47888.521114788404;48537.27194092162;52729.736351317995;70300.94548581878;72002.63998680182;72092;74399.62800185964;76013;7701.4608977371045;7777.259602504459;7826.256505631955;7914.24814642608;8056.838863222585;12560.434780435085;12650.746985060432;12840.935795320964;12850.42173102194;12969.221846689228;11091.556337746722;11243.943780281374;11309;11357.318560886373;11427.542898283975;11021.393823339793;11061.557537698402;11099.334039957628;11171.273867198606;11342.716432089264;10600.946995265283;11079.833802492807;11255.549778009115;11330.263532870336;11406.372649504025;6557.573757705733;7682.884756728766;7727.304542591194;7764.92235077642;7962;10950.945245273722;11028.062614677843;11092.556297748;11129.610463633733;11302.095832333229 18:31:45 INFO - PROCESS | 1668 | |3;mootools.html;1519.0809560216069;1564.6479542103027;1722.8535574476168;1871.157978909491;1880.5768702042042;8440.113788052258;8724.8691269631;8938;8939.776505587355;8960.462372257669;6971.546849454782;7790.45466817323;8017.398695097876;8670.653173873054;8710.172533609313;2329.0683726509405;2352.494213744045;2356.1988923765916;2357.2456813819585;2364.125273648752;2376.1089591403224;2381.940451488718;2415.0581273303424;2416.827838498327;2416.9516609667885;2093.288281984125;2162.805347518723;2334.6498025296173;2402.039184326266;2406.566817972773;2366.8579885206855;2374.81001519878;2385.1294277588727;2388.5581167483897;2389.1637926725593;2369.845960012594;2373.7744914233294;2374.9881250593635;2376.251480783548;2378.131981826638;8957;9022.188003079755;9025.864612030824;9033.819323613556;9040.141186587263;5174.7412629368755;5319.9202011969855;5353.625246232766;5364.275822763916;5382.946170538284;3488.598811136701;3553.200529880782;3671.5777685566236;3673.173535954389;3677.9080522987138;985.6845809341014;1009.2531526670284;1068.8289873620183;1093.5461783359897;1099.3239157917903;11811.346411502396;11830.704232394173;11833.230839995458;11837.993770529516;11860.584879529175;4579.885502862455;4665.766711664403;4797.352357431702;4808.422989241313;4810.182269014276;10015.799684006279;10018.899811001942;10022.3485473444;10032.498375081217;10045.246606504395;5343.465653434625;5360.785568577291;5361.597880159004;5367.704776237344;5381.165919282517;4710.9764451177525;4916.016796640686;4918.409790825124;4920.065187614342;4925.630577706686;3796.2027974125745;3833.4824798652385;3888;3924.411338299221;3944.15200731844;1088.7876864011441;1110.2838669058413;1199.9880001200052;1312.4750099959901;1314.2204238036484;790.0992868130336;927.9257659387233;931.6785708930408;950.0499500499501;959.2278216036018;5865.648061116347;5949.10763385487;5971.462568368781;6112.51099912006;6129.96935015331;965.4062751407834;969.9078587534173;974.6101559376165;1006.7080546641538;1016.2124353625999;3594.892153235407;3756.436534519844;3941;4042.939355909664;4109.157622687342;10249.795004100026;10643.201759867887;10678.946605266923;10687.73280667974;10690.465476726133;9742.902570974342;10273.126784223276;10477;10624.415657138778;10674.946625266979;6977.89533157003;7974.5215287082965;8253.711120110767;8304.294134998592;8306.501609903426;5975.073863551156;6044.788432404845;6228.4705800007505;6249.531285153541;6286.214223222098;9731.756706082404;9807.411555306704;10130.594776208869;10132.138768204784;10192.643257485952;9966;10129.898701012895;10134.898651013396;10135.087842094246;10331;7307.378872795872;7468.066491688539;7584.165741768291;7588.430867684835;7592.81017974555;8268.214519620868;8313.750587482386;8351.41540092212;8355.248027677539;8358;6287.30839607652;7361.2638736125955;7395.556266624019;7643.273888980538;7708.49894756839;7343.522671026366;7460.992765976741;7476.514026588255;7594.012778338781;7607.581583012766;6942.062821519232;6961.6171110587375;6990.545614535039;7024;7027.789166325018;4916.827911023097;5089.923651145162;5096.949030509796;5108.770105345343;5154.948450515447;5038.496150384932;5080.872978175576;5149.845504634867;5169.405518365285;5228.63399562027 18:31:45 INFO - PROCESS | 1668 | |4;prototype.html;303.91034644779785;304.3957743878401;312.82794463045326;319.2848020434228;320.45042751680865;5405.351377824867;5426.728663566821;5467.20725494804;5483.340579818785;5552.888942221153;4394.824207031715;5069.771860266288;5188.429272779991;5341.65279256848;5346.492083252095;3408.5739282589675;3923.8822835314986;4093.6520395766397;4109.260333140033;4117.2177286315655;3395.7283417326553;4057.2494088593558;4111.301078816593;4120.690948178899;4149.46057012588;3468.06948128832;3872.7676339419586;4107.630313271805;4108;4140.523839758421;3187.4581321175456;3418.982905085471;4044.69664775143;4080.1839632073406;4156.334986402177;2965.8665360058635;3521.67569404192;3538.2039041215776;3546.2552863898613;3551.0057183988524;4523.977380113111;4541.863744087683;5214.556762675177;5217.217417387385;5307.920381194285;4198.097409057037;4324.897151226417;4686.976565117153;4723.481006650033;4778.593819525345;4880.341153944208;5637.587915601028;5642.689652069134;5666.603337766358;5695.515881150107;3885.1258466845015;3903.3949737790404;3930.2728995135703;3941.605839416064;3951.920961580752;4668.789904454274;5784.219130417382;5888.852778680524;5890.793822216245;5936.436038576328;3911.765294082364;3938.5667576566557;3949.6050394960275;3963.6829053675638;3963.8612648557737;3600.71194304455;4022.27599032177;4031.3549832026733;4038.697097717683;4039.434479172918;3997.520297564311;4454.732716037048;4466.285394336891;4472.926497640543;4488.438945131858;4503.707259028152;4752.388184979441;5612.915806262909;5674.375818659944;5696.240481282333;1203.0375699440588;1347.45428101619;1373.7183877305129;1385.279654579613;1394.5914626227584;870.6517393042834;897.9595918183697;928.6656803550717;941.152962333905;951.4338968313981;4377.365282034088;4586.981728039652;5223.425423203445;5273.235380869753;5300.31095957523;5068.426759134801;5338.252644629755;5729.541636669056;5730.822287530795;5757.309122905278;4472.865814025585;4683.695559788671;4700.929486057712;4818.325434439182;5204.34945631796;2993.670696223414;3002.9849850751043;3014.1861697341596;3015.5826761422095;3052.526858336961;5584.190292407659;5621.606487545914;5924.19312109802;5932.288125424977;5944.851378715567;4918.827841025547;4992.8002879885125;5124.897502049938;5847.795327163614;5960.900331827425;5449.092817513918;5886.676232807151;5894.850504151821;5900.380460051719;5911.852203694856;5474.890502190014;5726.856828579319;5736.598438109292;5812.9709351452975;5855.945929732689;4905.8037678492465;5593.580481463988;5620.297462817148;5633.521150702236;5654;4778.522147785194;5259.89480210386;5743.62666426681;5835.912461312999;6035.275766907824;3650.1969566695284;3830.885073447801;3919.2951066286255;3947.585503522089;3974.9863784734707;5699.145128230799;5716.885662286814;5726.656400615976;5742.19609254713;5745.683987380734;5633.267675202197;5637.998510528703;5642.548596112383;5646.689432081275;5690.544756419559;4893.681910675795;5344.99562664001;5678.68767217807;5697.259356283656;5720.19917211599;4440.866773996785;5321.920171197357;5431.456854314695;5492.505674489315;5590.980870329976;5229.450907654794;5718.513926316144;5734.455226753452;5738.081906894877;5815.6510609361885;5465.96503140383;5585.385607583244;5588.552915766648;5589.10574308125;5632.577556683347 18:31:45 INFO - PROCESS | 1668 | |5;yui.html;676.6616691654173;743.5873090434808;807.7172989453692;833.9262701702183;887.3699673232007;15098.849011509881;16288;16317.918410407947;16337.428190013352;16358.345666173354;15448.304826282816;16139.677206455865;16260.18699065048;16287.185640717977;16741.414050508203;712.6187489693016;735.2977906099688;880.7798050487394;898.5776684958092;902.9367944243905;876.2770714160811;905.316486053029;906.5875026862794;906.7053207707488;907.0068275238636;954.1651055326589;958.7698952251479;960.1358777100595;961.8749562556858;965.4931161140387;734.5482528245144;921.6543796076471;950.7718147644584;951.5432592355673;951.6241084771511;707.253847191213;708.9826099547166;709.8828693265605;710.4884483172108;713.2261496276494;15334.539963801104;15390.384384624602;15408.614784630361;15413.922930385388;15424.845751542565;13706.794398084037;13923.025388222828;13930.233837138954;14027.298635068206;14183.149011059266;13231.007674424456;13253.867461325457;13342.599722008259;13610.251436171007;13933.30333483332;4602.539746025404;4634.281686338623;4645.187092258875;4758.333833263346;4810.2063159578975;111701.99999999919;114566.42716786363;115102;116007;117116.41441792737;10955.397453140155;11008.559657613767;11080.944595277133;11094.889051109547;11152.163587730953;21473.570528589342;21476.570468590853;21482.89258553697;21514.56970860574;21565.67651485229;6726.899096513556;7709.845803084019;7959.721409750631;8015.559144247006;8160.877586836202;4058.2492238935893;4114;4188.057687020396;4192.727472714325;4207.495100587949;3458.2046129390383;3565.3047655707405;3568.1258091767163;3569.1434055826417;3577.338192434408;623.7598524567983;651.9348065193537;652.3085529338916;652.8041587523724;660.1220376898713;527.3987654074358;578.2684903596953;607.750822162911;640.9839754006094;657.2999755260632;9065.68270110543;9101.838052657724;9228.538573071319;9249.30630202724;9269.582868770787;620.7082671144555;630.4893036640336;632.2286810091681;643.4337782751243;653.3335997282745;4228.3446065859225;4399.5820397062225;4439.200943830077;4512.796924138422;4513.768036675003;146244;149631;150783;151003.24498377438;152561.47438525694;100330;123622;124879;127795.08307375397;127823;94432;112222.43888780667;115518.42240788742;116495.01029938231;117109.41445292889;8354.540500272544;8596.28074385138;8601.13988601135;8618.482891026559;8826.646934122564;60542;61844.17726897685;61878.690606546676;63694.726105478556;64312.03531946931;67026.66486667536;69418.65290673514;79932.00169995797;90566;92975;13384.128378985584;13435.596932092052;13949.302534873419;14115.505957291856;14294.71410571762;13214.86785132175;14966.850331496982;15287.541373758804;15502.457413990456;15905;14071.718565628835;14174.858251417354;14196.432142714175;14414.85585144135;14722.091555049477;13865.445382185004;14066.929665351608;14208.218547979961;14412.207328597027;14839.183844888636;13691.041627086008;14068.788968165281;14122.858771412566;14354.856451435351;14423.278836058365;11403.133122864852;11518.151980056931;11693.590724324607;11734.295942243492;11843.46704398287;11120.944395278295;11491.697352879766;11632.243904146204;11653.184277100521;11671.76656466883 18:31:45 INFO - PROCESS | 1668 | __end_tp_report 18:31:45 INFO - PROCESS | 1668 | __start_cc_report 18:31:45 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1418 18:31:45 INFO - PROCESS | 1668 | __end_cc_report 18:31:45 INFO - PROCESS | 1668 | __startTimestamp1468632705817__endTimestamp 18:31:45 INFO - PROCESS | 1668 | 18:31:45 INFO - PROCESS | 1668 | ------- Summary: start ------- 18:31:45 INFO - PROCESS | 1668 | Number of tests: 6 18:31:45 INFO - PROCESS | 1668 | 18:31:45 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5695.54 Median:5883.09 stddev:743.13 (12.6%) stddev-sans-first:721.85 18:31:45 INFO - PROCESS | 1668 | Values: 3329.3 3346.0 3347.5 3375.4 3404.0 5577.7 5622.8 5647.4 5704.5 5710.4 5621.6 5680.7 5684.5 5692.3 5698.9 5155.0 5161.4 5184.4 5213.8 5268.6 5266.2 5312.5 5340.9 5351.1 5353.8 5254.2 5264.3 5283.2 5326.9 5343.3 559.3 5251.9 5304.4 5324.7 5339.5 5088.6 5140.4 5173.3 5207.3 5213.3 5696.2 5701.9 5704.3 5776.0 5784.4 6032.2 6265.4 6280.7 6282.0 6290.7 6143.5 6177.0 6186.4 6195.6 6250.2 5878.4 5883.1 5886.3 5886.9 5901.8 6229.0 6252.4 6281.3 6287.7 6289.9 5981.3 6042.8 6123.2 6166.1 6179.1 6260.2 6279.1 6281.0 6284.9 6315.4 5199.2 6099.1 6188.9 6219.8 6260.5 6034.9 6114.4 6130.6 6263.6 6265.1 4934.9 4942.9 4943.8 4946.4 4959.0 4430.8 4464.1 4490.1 4501.9 4503.6 5754.7 5773.3 5775.7 5798.0 5800.5 6235.4 6280.6 6287.5 6300.0 6319.0 5583.9 5642.5 5646.6 5778.0 5823.2 5428.7 5429.6 5432.9 5441.4 5468.1 6180.9 6228.4 6248.4 6252.0 6252.6 6129.7 6167.3 6266.0 6274.2 6288.2 6222.6 6267.5 6285.9 6299.4 6304.6 5363.7 6105.4 6131.1 6137.2 6142.2 6182.4 6212.8 6216.6 6237.9 6240.9 4543.2 5768.7 6077.9 6083.2 6094.7 5796.0 5858.0 5864.1 5867.1 5882.4 5753.1 5766.3 5907.8 5971.4 6016.4 6124.9 6141.4 6147.5 6147.8 6154.2 5921.0 5928.8 5930.5 5943.5 5961.0 18:31:45 INFO - PROCESS | 1668 | 18:31:45 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:68948.30 Median:39219.01 stddev:147774.09 (376.8%) stddev-sans-first:148099.30 18:31:45 INFO - PROCESS | 1668 | Values: 510.5 514.4 518.3 528.1 551.1 23886.8 40043.6 41707.6 41734.8 44091.6 42803.8 42996.6 43077.4 43169.4 43171.8 8602.0 9558.4 9734.4 9738.9 9740.0 8644.0 11664.4 11774.6 11801.8 12114.1 11855.6 11935.4 11939.2 11940.5 11949.6 8592.4 11730.4 11734.2 11841.5 11842.5 11739.9 11834.6 11836.6 11846.8 11851.2 40403.0 40634.2 40755.6 40760.8 40795.2 3521.4 3744.0 3816.8 3883.0 4259.7 31444.8 32383.5 32617.8 32758.8 33105.8 3245.4 3392.1 3396.2 3420.0 3435.2 510048.0 510269.0 511422.0 512677.0 514641.0 59277.8 59461.7 59801.4 59969.7 60040.0 56349.6 59539.7 62980.7 63055.0 63079.0 16459.8 16771.7 16775.3 16783.6 16797.5 11821.8 12083.8 12084.9 12274.2 13001.9 13396.5 14727.3 16053.1 16484.7 16845.7 5962.8 6615.7 6711.9 6721.5 6737.6 890.6 967.2 980.7 1063.0 1115.6 30623.5 30673.9 30859.0 31149.4 31473.8 912.5 1144.9 1148.6 1181.2 1193.3 15811.7 15858.4 15930.6 15999.9 16150.9 668015.0 675717.0 679183.0 679282.0 679413.0 60228.0 60453.7 60480.8 60524.0 60539.5 1173.3 1187.5 1416.9 1426.3 1458.1 31225.1 31640.7 31810.7 32637.3 32796.5 49057.5 49601.0 49610.8 49630.0 49687.0 442274.0 443989.0 449047.0 449935.0 451434.0 38848.0 39326.0 40006.4 40222.2 40273.8 46911.5 47384.8 47634.0 47639.0 48627.0 39112.0 39787.8 39801.0 40537.4 40658.2 39547.2 39784.0 39983.6 40407.0 40702.8 38202.6 38635.0 38901.6 38954.8 39066.6 29688.0 32458.0 34614.1 35360.1 35402.8 24109.9 24886.0 24932.8 25549.2 26091.3 18:31:45 INFO - PROCESS | 1668 | 18:31:45 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:34911.04 Median:14070.47 stddev:102789.84 (730.5%) stddev-sans-first:103045.46 18:31:45 INFO - PROCESS | 1668 | Values: 361.1 383.4 391.6 391.8 418.5 15091.8 20149.3 20307.2 20642.4 21304.7 20008.6 20522.8 21377.5 21390.7 21416.6 5783.5 5796.8 5847.1 5914.1 5919.4 5627.2 5751.8 5769.9 5798.3 5801.9 5652.9 5715.1 5730.3 5735.3 5752.4 5558.9 5671.8 5708.0 5718.4 5723.0 4295.3 4964.4 5019.6 5055.1 5096.2 25663.0 25784.7 25789.7 26031.1 26040.5 2253.2 2348.4 2477.9 2589.9 2899.9 12332.6 15073.6 15218.5 15463.7 15697.5 1571.9 1805.6 1834.9 1847.1 1848.9 112561.0 113419.0 114441.9 114818.4 115200.4 9437.8 10007.1 10351.5 10668.0 10898.8 12881.9 13575.5 13605.5 13643.5 13649.3 6942.4 8322.1 8522.9 8587.2 8695.8 8689.3 8692.2 8747.5 8770.0 8869.7 6409.5 6500.9 6527.9 6556.5 6615.0 1791.4 1827.9 1829.4 1847.3 1867.6 827.7 906.4 936.8 992.8 1048.4 18283.1 22098.0 22165.1 22200.8 22213.8 951.5 973.0 973.4 974.5 1004.1 9593.0 11494.8 11724.9 11782.7 11837.4 605130.0 617569.0 620454.0 627031.0 627888.0 99627.0 112603.0 121945.0 123029.2 127068.0 900.3 1024.8 1036.3 1053.6 1060.6 15938.2 18628.3 19240.1 19336.7 19755.0 28871.4 39799.0 47888.5 48537.3 52729.7 70300.9 72002.6 72092.0 74399.6 76013.0 7701.5 7777.3 7826.3 7914.2 8056.8 12560.4 12650.7 12840.9 12850.4 12969.2 11091.6 11243.9 11309.0 11357.3 11427.5 11021.4 11061.6 11099.3 11171.3 11342.7 10600.9 11079.8 11255.5 11330.3 11406.4 6557.6 7682.9 7727.3 7764.9 7962.0 10950.9 11028.1 11092.6 11129.6 11302.1 18:31:45 INFO - PROCESS | 1668 | 18:31:45 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5723.86 Median:4919.24 stddev:3183.39 (64.7%) stddev-sans-first:3176.64 18:31:45 INFO - PROCESS | 1668 | Values: 1519.1 1564.6 1722.9 1871.2 1880.6 8440.1 8724.9 8938.0 8939.8 8960.5 6971.5 7790.5 8017.4 8670.7 8710.2 2329.1 2352.5 2356.2 2357.2 2364.1 2376.1 2381.9 2415.1 2416.8 2417.0 2093.3 2162.8 2334.6 2402.0 2406.6 2366.9 2374.8 2385.1 2388.6 2389.2 2369.8 2373.8 2375.0 2376.3 2378.1 8957.0 9022.2 9025.9 9033.8 9040.1 5174.7 5319.9 5353.6 5364.3 5382.9 3488.6 3553.2 3671.6 3673.2 3677.9 985.7 1009.3 1068.8 1093.5 1099.3 11811.3 11830.7 11833.2 11838.0 11860.6 4579.9 4665.8 4797.4 4808.4 4810.2 10015.8 10018.9 10022.3 10032.5 10045.2 5343.5 5360.8 5361.6 5367.7 5381.2 4711.0 4916.0 4918.4 4920.1 4925.6 3796.2 3833.5 3888.0 3924.4 3944.2 1088.8 1110.3 1200.0 1312.5 1314.2 790.1 927.9 931.7 950.0 959.2 5865.6 5949.1 5971.5 6112.5 6130.0 965.4 969.9 974.6 1006.7 1016.2 3594.9 3756.4 3941.0 4042.9 4109.2 10249.8 10643.2 10678.9 10687.7 10690.5 9742.9 10273.1 10477.0 10624.4 10674.9 6977.9 7974.5 8253.7 8304.3 8306.5 5975.1 6044.8 6228.5 6249.5 6286.2 9731.8 9807.4 10130.6 10132.1 10192.6 9966.0 10129.9 10134.9 10135.1 10331.0 7307.4 7468.1 7584.2 7588.4 7592.8 8268.2 8313.8 8351.4 8355.2 8358.0 6287.3 7361.3 7395.6 7643.3 7708.5 7343.5 7461.0 7476.5 7594.0 7607.6 6942.1 6961.6 6990.5 7024.0 7027.8 4916.8 5089.9 5096.9 5108.8 5154.9 5038.5 5080.9 5149.8 5169.4 5228.6 18:31:45 INFO - PROCESS | 1668 | 18:31:45 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:4538.61 Median:5097.33 stddev:1390.23 (27.3%) stddev-sans-first:1357.31 18:31:45 INFO - PROCESS | 1668 | Values: 303.9 304.4 312.8 319.3 320.5 5405.4 5426.7 5467.2 5483.3 5552.9 4394.8 5069.8 5188.4 5341.7 5346.5 3408.6 3923.9 4093.7 4109.3 4117.2 3395.7 4057.2 4111.3 4120.7 4149.5 3468.1 3872.8 4107.6 4108.0 4140.5 3187.5 3419.0 4044.7 4080.2 4156.3 2965.9 3521.7 3538.2 3546.3 3551.0 4524.0 4541.9 5214.6 5217.2 5307.9 4198.1 4324.9 4687.0 4723.5 4778.6 4880.3 5637.6 5642.7 5666.6 5695.5 3885.1 3903.4 3930.3 3941.6 3951.9 4668.8 5784.2 5888.9 5890.8 5936.4 3911.8 3938.6 3949.6 3963.7 3963.9 3600.7 4022.3 4031.4 4038.7 4039.4 3997.5 4454.7 4466.3 4472.9 4488.4 4503.7 4752.4 5612.9 5674.4 5696.2 1203.0 1347.5 1373.7 1385.3 1394.6 870.7 898.0 928.7 941.2 951.4 4377.4 4587.0 5223.4 5273.2 5300.3 5068.4 5338.3 5729.5 5730.8 5757.3 4472.9 4683.7 4700.9 4818.3 5204.3 2993.7 3003.0 3014.2 3015.6 3052.5 5584.2 5621.6 5924.2 5932.3 5944.9 4918.8 4992.8 5124.9 5847.8 5960.9 5449.1 5886.7 5894.9 5900.4 5911.9 5474.9 5726.9 5736.6 5813.0 5855.9 4905.8 5593.6 5620.3 5633.5 5654.0 4778.5 5259.9 5743.6 5835.9 6035.3 3650.2 3830.9 3919.3 3947.6 3975.0 5699.1 5716.9 5726.7 5742.2 5745.7 5633.3 5638.0 5642.5 5646.7 5690.5 4893.7 5345.0 5678.7 5697.3 5720.2 4440.9 5321.9 5431.5 5492.5 5591.0 5229.5 5718.5 5734.5 5738.1 5815.7 5466.0 5585.4 5588.6 5589.1 5632.6 18:31:45 INFO - PROCESS | 1668 | 18:31:45 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:24751.02 Median:3566.72 stddev:39031.18 (1094.3%) stddev-sans-first:39098.82 18:31:45 INFO - PROCESS | 1668 | Values: 676.7 743.6 807.7 833.9 887.4 15098.8 16288.0 16317.9 16337.4 16358.3 15448.3 16139.7 16260.2 16287.2 16741.4 712.6 735.3 880.8 898.6 902.9 876.3 905.3 906.6 906.7 907.0 954.2 958.8 960.1 961.9 965.5 734.5 921.7 950.8 951.5 951.6 707.3 709.0 709.9 710.5 713.2 15334.5 15390.4 15408.6 15413.9 15424.8 13706.8 13923.0 13930.2 14027.3 14183.1 13231.0 13253.9 13342.6 13610.3 13933.3 4602.5 4634.3 4645.2 4758.3 4810.2 111702.0 114566.4 115102.0 116007.0 117116.4 10955.4 11008.6 11080.9 11094.9 11152.2 21473.6 21476.6 21482.9 21514.6 21565.7 6726.9 7709.8 7959.7 8015.6 8160.9 4058.2 4114.0 4188.1 4192.7 4207.5 3458.2 3565.3 3568.1 3569.1 3577.3 623.8 651.9 652.3 652.8 660.1 527.4 578.3 607.8 641.0 657.3 9065.7 9101.8 9228.5 9249.3 9269.6 620.7 630.5 632.2 643.4 653.3 4228.3 4399.6 4439.2 4512.8 4513.8 146244.0 149631.0 150783.0 151003.2 152561.5 100330.0 123622.0 124879.0 127795.1 127823.0 94432.0 112222.4 115518.4 116495.0 117109.4 8354.5 8596.3 8601.1 8618.5 8826.6 60542.0 61844.2 61878.7 63694.7 64312.0 67026.7 69418.7 79932.0 90566.0 92975.0 13384.1 13435.6 13949.3 14115.5 14294.7 13214.9 14966.9 15287.5 15502.5 15905.0 14071.7 14174.9 14196.4 14414.9 14722.1 13865.4 14066.9 14208.2 14412.2 14839.2 13691.0 14068.8 14122.9 14354.9 14423.3 11403.1 11518.2 11693.6 11734.3 11843.5 11120.9 11491.7 11632.2 11653.2 11671.8 18:31:45 INFO - PROCESS | 1668 | -------- Summary: end -------- 18:31:45 INFO - PROCESS | 1668 | 18:31:46 INFO - TEST-INFO | 1668: exit 0 18:31:46 INFO - TEST-OK | dromaeo_css | took 1115889ms 18:31:46 INFO - TEST-START | kraken 18:31:46 INFO - operating with platform_type : mac_ 18:31:46 INFO - Initialising browser for kraken test... 18:31:46 INFO - TEST-INFO | started process 1789 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/tmpaNGjgz/profile http://localhost:49279/getInfo.html) 18:31:48 INFO - PROCESS | 1789 | __metrics Screen width/height:1600/1200 18:31:48 INFO - PROCESS | 1789 | colorDepth:24 18:31:48 INFO - PROCESS | 1789 | Browser inner width/height: 1024/689 18:31:48 INFO - PROCESS | 1789 | __metrics 18:31:48 INFO - PROCESS | 1789 | 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" 18:31:48 INFO - PROCESS | 1789 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:31:49 INFO - TEST-INFO | 1789: exit 0 18:31:49 INFO - Browser initialized. 18:31:49 INFO - Running cycle 1/1 for kraken test... 18:31:49 INFO - TEST-INFO | started process 1790 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/tmpaNGjgz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:32:01 INFO - PROCESS | 1790 | RSS: Main: 243851264 18:32:01 INFO - PROCESS | 1790 | 18:32:04 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 18:32:05 INFO - PROCESS | 1790 | RSS: Main: 294400000 18:32:05 INFO - PROCESS | 1790 | 18:32:08 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 18:32:08 INFO - PROCESS | 1790 | RSS: Main: 304648192 18:32:08 INFO - PROCESS | 1790 | 18:32:12 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 18:32:12 INFO - PROCESS | 1790 | RSS: Main: 390795264 18:32:12 INFO - PROCESS | 1790 | 18:32:14 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 18:32:15 INFO - PROCESS | 1790 | RSS: Main: 294846464 18:32:15 INFO - PROCESS | 1790 | 18:32:17 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:32:18 INFO - PROCESS | 1790 | RSS: Main: 298811392 18:32:18 INFO - PROCESS | 1790 | 18:32:20 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 18:32:21 INFO - PROCESS | 1790 | RSS: Main: 336211968 18:32:21 INFO - PROCESS | 1790 | 18:32:24 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 18:32:25 INFO - PROCESS | 1790 | RSS: Main: 337682432 18:32:25 INFO - PROCESS | 1790 | 18:32:28 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 18:32:28 INFO - PROCESS | 1790 | RSS: Main: 334524416 18:32:28 INFO - PROCESS | 1790 | 18:32:30 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:32:30 INFO - PROCESS | 1790 | RSS: Main: 312942592 18:32:30 INFO - PROCESS | 1790 | 18:32:32 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:32:33 INFO - PROCESS | 1790 | RSS: Main: 320036864 18:32:33 INFO - PROCESS | 1790 | 18:32:35 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:32:36 INFO - PROCESS | 1790 | RSS: Main: 317444096 18:32:36 INFO - PROCESS | 1790 | 18:32:39 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:32:39 INFO - PROCESS | 1790 | RSS: Main: 326717440 18:32:39 INFO - PROCESS | 1790 | 18:32:42 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:32:43 INFO - PROCESS | 1790 | RSS: Main: 328912896 18:32:43 INFO - PROCESS | 1790 | 18:32:44 INFO - PROCESS | 1790 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 18:32:45 INFO - PROCESS | 1790 | RSS: Main: 372539392 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | __start_tp_report 18:32:45 INFO - PROCESS | 1790 | _x_x_mozilla_page_load 18:32:45 INFO - PROCESS | 1790 | _x_x_mozilla_page_load_details 18:32:45 INFO - PROCESS | 1790 | |i|pagename|runs| 18:32:45 INFO - PROCESS | 1790 | |0;ai-astar;99;113;117;134;113;112;112;112;112;112 18:32:45 INFO - PROCESS | 1790 | |1;audio-beat-detection;143;130;136;197;104;110;154;139;179;104 18:32:45 INFO - PROCESS | 1790 | |2;audio-dft;183;188;186;183;183;185;181;184;183;231 18:32:45 INFO - PROCESS | 1790 | |3;audio-fft;81;71;59;88;60;58;59;67;82;56 18:32:45 INFO - PROCESS | 1790 | |4;audio-oscillator;85;88;92;72;75;69;97;70;68;103 18:32:45 INFO - PROCESS | 1790 | |5;imaging-gaussian-blur;87;83;86;84;86;84;88;84;87;81 18:32:45 INFO - PROCESS | 1790 | |6;imaging-darkroom;132;93;93;93;93;93;93;93;92;92 18:32:45 INFO - PROCESS | 1790 | |7;imaging-desaturate;83;84;86;119;131;104;85;85;85;84 18:32:45 INFO - PROCESS | 1790 | |8;json-parse-financial;56;54;53;54;55;56;54;53;54;55 18:32:45 INFO - PROCESS | 1790 | |9;json-stringify-tinderbox;68;76;70;81;73;73;71;73;71;72 18:32:45 INFO - PROCESS | 1790 | |10;stanford-crypto-aes;83;82;83;83;85;84;83;82;84;84 18:32:45 INFO - PROCESS | 1790 | |11;stanford-crypto-ccm;137;138;132;134;133;135;134;138;225;135 18:32:45 INFO - PROCESS | 1790 | |12;stanford-crypto-pbkdf2;172;175;172;176;172;175;173;171;171;171 18:32:45 INFO - PROCESS | 1790 | |13;stanford-crypto-sha256-iterative;69;69;68;68;68;67;71;65;86;69 18:32:45 INFO - PROCESS | 1790 | __end_tp_report 18:32:45 INFO - PROCESS | 1790 | __start_cc_report 18:32:45 INFO - PROCESS | 1790 | _x_x_mozilla_cycle_collect,2055 18:32:45 INFO - PROCESS | 1790 | __end_cc_report 18:32:45 INFO - PROCESS | 1790 | __startTimestamp1468632765211__endTimestamp 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | ------- Summary: start ------- 18:32:45 INFO - PROCESS | 1790 | Number of tests: 14 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.00 stddev:8.53 (7.5%) stddev-sans-first:7.22 18:32:45 INFO - PROCESS | 1790 | Values: 99.0 113.0 117.0 134.0 113.0 112.0 112.0 112.0 112.0 112.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:141.00 stddev:30.88 (21.9%) stddev-sans-first:32.73 18:32:45 INFO - PROCESS | 1790 | Values: 143.0 130.0 136.0 197.0 104.0 110.0 154.0 139.0 179.0 104.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#2] audio-dft Cycles:10 Average:188.70 Median:184.50 stddev:14.99 (8.1%) stddev-sans-first:15.76 18:32:45 INFO - PROCESS | 1790 | Values: 183.0 188.0 186.0 183.0 183.0 185.0 181.0 184.0 183.0 231.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#3] audio-fft Cycles:10 Average:68.10 Median:69.00 stddev:11.76 (17.0%) stddev-sans-first:11.51 18:32:45 INFO - PROCESS | 1790 | Values: 81.0 71.0 59.0 88.0 60.0 58.0 59.0 67.0 82.0 56.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#4] audio-oscillator Cycles:10 Average:81.90 Median:80.00 stddev:12.78 (16.0%) stddev-sans-first:13.50 18:32:45 INFO - PROCESS | 1790 | Values: 85.0 88.0 92.0 72.0 75.0 69.0 97.0 70.0 68.0 103.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#5] imaging-gaussian-blur Cycles:10 Average:85.00 Median:86.00 stddev:2.16 (2.5%) stddev-sans-first:2.17 18:32:45 INFO - PROCESS | 1790 | Values: 87.0 83.0 86.0 84.0 86.0 84.0 88.0 84.0 87.0 81.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#6] imaging-darkroom Cycles:10 Average:96.70 Median:93.00 stddev:12.41 (13.3%) stddev-sans-first:0.44 18:32:45 INFO - PROCESS | 1790 | Values: 132.0 93.0 93.0 93.0 93.0 93.0 93.0 93.0 92.0 92.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:84.50 stddev:17.38 (20.6%) stddev-sans-first:17.92 18:32:45 INFO - PROCESS | 1790 | Values: 83.0 84.0 86.0 119.0 131.0 104.0 85.0 85.0 85.0 84.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:1.07 (2.0%) stddev-sans-first:0.97 18:32:45 INFO - PROCESS | 1790 | Values: 56.0 54.0 53.0 54.0 55.0 56.0 54.0 53.0 54.0 55.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:73.00 stddev:3.58 (4.9%) stddev-sans-first:3.35 18:32:45 INFO - PROCESS | 1790 | Values: 68.0 76.0 70.0 81.0 73.0 73.0 71.0 73.0 71.0 72.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:0.95 (1.1%) stddev-sans-first:1.00 18:32:45 INFO - PROCESS | 1790 | Values: 83.0 82.0 83.0 83.0 85.0 84.0 83.0 82.0 84.0 84.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:136.00 stddev:28.50 (21.0%) stddev-sans-first:30.11 18:32:45 INFO - PROCESS | 1790 | Values: 137.0 138.0 132.0 134.0 133.0 135.0 134.0 138.0 225.0 135.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:172.50 stddev:1.87 (1.1%) stddev-sans-first:1.96 18:32:45 INFO - PROCESS | 1790 | Values: 172.0 175.0 172.0 176.0 172.0 175.0 173.0 171.0 171.0 171.0 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - PROCESS | 1790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:69.00 stddev:5.83 (8.5%) stddev-sans-first:6.17 18:32:45 INFO - PROCESS | 1790 | Values: 69.0 69.0 68.0 68.0 68.0 67.0 71.0 65.0 86.0 69.0 18:32:45 INFO - PROCESS | 1790 | -------- Summary: end -------- 18:32:45 INFO - PROCESS | 1790 | 18:32:45 INFO - TEST-INFO | 1790: exit 0 18:32:46 INFO - TEST-OK | kraken | took 59605ms 18:32:46 INFO - SUITE-END | took 1175s 18:32:46 INFO - Completed test suite (00:19:35) 18:32:46 INFO - javascript benchmark 18:32:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3329.3008468221674, 3345.983270083649, 3347.514610381493, 3375.426177549816, 3404.0468668772737, 5577.69322687252, 5622.8313150605545, 5647.43525647435, 5704.54363650908, 5710.371859095496, 5621.578381621384, 5680.744366503507, 5684.459976302255, 5692.260006199199, 5698.886022279562, 5154.974225128878, 5161.354830646169, 5184.351956005499, 5213.765380557884, 5268.604854635899, 5266.210068489719, 5312.521873031426, 5340.91988620171, 5351.0903146465, 5353.812616558421, 5254.15933450646, 5264.341957255343, 5283.207518872162, 5326.866828329304, 5343.332083489564, 559.2619454117088, 5251.921221181686, 5304.443033481468, 5324.653897496689, 5339.5461385782255, 5088.643794934356, 5140.434552199255, 5173.32746742921, 5207.297014902978, 5213.2701421800975, 5696.202531645573, 5701.857453563653, 5704.344000439961, 5776.046952252873, 5784.36371999084, 6032.185654936615, 6265.4361107500545, 6280.717367718464, 6282.0, 6290.685465726695, 6143.481172719208, 6177.0, 6186.443220110212, 6195.597286176384, 6250.1874756281395, 5878.441548052928, 5883.0881213411985, 5886.293644762656, 5886.852828679317, 5901.7934372297195, 6229.0, 6252.406021427957, 6281.309056003836, 6287.717052732638, 6289.905651415233, 5981.312149102821, 6042.848928776816, 6123.203983482119, 6166.105914642441, 6179.104029915637, 6260.217472815898, 6279.0895320178315, 6280.9685951569945, 6284.905726414107, 6315.36846315374, 5199.2201169824075, 6099.115628233882, 6188.938110618927, 6219.751209951642, 6260.499160067184, 6034.909476357858, 6114.388561143939, 6130.601510901777, 6263.561550691408, 6265.122882796412, 4934.8766280843265, 4942.9011419771405, 4943.8022479101155, 4946.406431228275, 4958.975205124024, 4430.778461076933, 4464.129494748558, 4490.101979604092, 4501.887452813706, 4503.639708823286, 5754.683492407874, 5773.278340207474, 5775.711214439261, 5798.043322851767, 5800.53595712342, 6235.376462353728, 6280.623162610258, 6287.465565426898, 6300.0, 6318.968405157945, 5583.888322233533, 5642.520385767174, 5646.632968857011, 5778.0272064922365, 5823.155642431823, 5428.70142142186, 5429.647072940246, 5432.864178395572, 5441.428649991773, 5468.125099983983, 6180.907286390708, 6228.439440450381, 6248.375162483715, 6251.968740156452, 6252.5935814171935, 6129.724162412613, 6167.290761562478, 6265.968670156803, 6274.215723034621, 6288.182536270256, 6222.564420490522, 6267.46726528232, 6285.905711414241, 6299.370062993664, 6304.5586808922935, 5363.651362661414, 6105.429421494235, 6131.110988906495, 6137.22377000893, 6142.170806941184, 6182.443580077815, 6212.782552610637, 6216.564840461125, 6237.906431403442, 6240.937590624036, 4543.227651299221, 5768.711564421846, 6077.908831367445, 6083.178770866053, 6094.7257373417415, 5796.04365279741, 5858.033424484912, 5864.061750120131, 5867.061270196748, 5882.382349853204, 5753.108268218432, 5766.308043034863, 5907.763689452374, 5971.373005834324, 6016.398360164124, 6124.908126378019, 6141.385861413823, 6147.508199344131, 6147.784827531015, 6154.230721159855, 5921.0, 5928.762849486145, 5930.495907847881, 5943.524518038633, 5960.970195148997], "value": 5651.803394042715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.5226613116735, 514.4341224652883, 518.2537146509027, 528.1364968276869, 551.0989532114991, 23886.76113238867, 40043.599564004355, 41707.58292417075, 41734.7913260434, 44091.55908440915, 42803.78598107013, 42996.57003429965, 43077.353839692354, 43169.35245971313, 43171.78414107925, 8601.95699021507, 9558.42649441034, 9734.41593504392, 9738.853917191213, 9740.025997400238, 8644.005939316996, 11664.41677916105, 11774.646760597196, 11801.7639647207, 12114.091443141755, 11855.585054523093, 11935.403229838517, 11939.223950443236, 11940.522379104825, 11949.64151075469, 8592.355573331963, 11730.35483048432, 11734.237274577124, 11841.526338946474, 11842.467088981017, 11739.941300293529, 11834.644960651194, 11836.585719499863, 11846.822297665542, 11851.229670071418, 40403.0, 40634.18731625351, 40755.592444075475, 40760.79619601883, 40795.184096317906, 3521.366154092262, 3743.9625603743884, 3816.8282427290837, 3882.9805850970565, 4259.744415335059, 31444.842775785975, 32383.514247286308, 32617.836910815295, 32758.836205819058, 33105.84129555478, 3245.415825151472, 3392.1010932103013, 3396.184915620258, 3420.025292791567, 3435.209901722618, 510048.0, 510269.0, 511422.0, 512677.0, 514641.0, 59277.814443710886, 59461.70269148713, 59801.401985980454, 59969.700151499834, 60040.0, 56349.591260218, 59539.702301488214, 62980.685096575144, 63055.0, 63079.0, 16459.83540164583, 16771.664566708598, 16775.328986840635, 16783.58041048959, 16797.496075117768, 11821.763564728657, 12083.75832483363, 12084.939575302244, 12274.202176858476, 13001.869981300066, 13396.464141434428, 14727.337269822883, 16053.117078560557, 16484.670306594042, 16845.663086738197, 5962.791302304398, 6615.702293396808, 6711.8589839727365, 6721.4958878084335, 6737.629430381376, 890.6081324217324, 967.1778987860263, 980.7352014955922, 1062.9946850265699, 1115.6374178392055, 30623.540646890313, 30673.926412575453, 30859.015354763324, 31149.377012459623, 31473.8426307867, 912.539167720297, 1144.8511693479795, 1148.5635458525708, 1181.2262967756133, 1193.3317342288346, 15811.68376632461, 15858.444954426539, 15930.60173495672, 15999.920000400156, 16150.919245403698, 668015.0, 675717.0, 679183.0, 679282.0, 679413.0, 60228.0, 60453.69773151106, 60480.79038419207, 60524.0, 60539.48651283665, 1173.3312012153162, 1187.5487314820487, 1416.900816942804, 1426.322496814005, 1458.0741229319246, 31225.063248102593, 31640.683593164693, 31810.681893180772, 32637.347253055283, 32796.508052378755, 49057.52827415183, 49601.0, 49610.75194624004, 49630.0, 49687.0, 442274.0, 443989.0, 449047.0, 449935.0, 451434.0, 38848.02879928024, 39326.01684957899, 40006.39990400204, 40222.1955560893, 40273.798631006655, 46911.530884690714, 47384.7630761844, 47634.0, 47639.04721905612, 48627.0, 39112.0, 39787.80636580907, 39801.0, 40537.391939120345, 40658.1868362637, 39547.2090558193, 39784.00539986524, 39983.60016399799, 40407.0, 40702.778916632546, 38202.617973819906, 38635.0, 38901.6109838898, 38954.80522597369, 39066.63266785649, 29688.0, 32458.02625921226, 34614.13464663403, 35360.11599709925, 35402.82298588491, 24109.879450603337, 24886.0, 24932.750672493043, 25549.23352299434, 26091.347716307246], "value": 20612.31070998505, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.1440885102308, 383.43251987059153, 391.57709673552586, 391.762983395046, 418.4873529925839, 15091.84908150918, 20149.29477468289, 20307.187712491483, 20642.38072857813, 21304.680429793567, 20008.599828003433, 20522.794772052275, 21377.465563360925, 21390.679139812913, 21416.57166856662, 5783.508401785833, 5796.797112101088, 5847.093700476412, 5914.1128830675525, 5919.408059194089, 5627.240322556464, 5751.7699292028265, 5769.884602307951, 5798.304203495565, 5801.854953626151, 5652.943470565283, 5715.0855863061915, 5730.312362516483, 5735.2544169257935, 5752.367239603661, 5558.888822223533, 5671.7731290748325, 5708.0, 5718.42815718429, 5722.971385143069, 4295.334223195409, 4964.354633897607, 5019.623528235397, 5055.090083784954, 5096.235564665293, 25663.0, 25784.710764461703, 25789.742102579108, 26031.088911888182, 26040.479190416274, 2253.2339004738305, 2348.377679914824, 2477.938051548708, 2589.8705064746687, 2899.855007249629, 12332.568360107352, 15073.623159420993, 15218.46735364268, 15463.690726185414, 15697.450589229436, 1571.8506741859505, 1805.629845881591, 1834.871558990871, 1847.131848031423, 1848.8890666559914, 112561.0, 113419.0, 114441.85558144479, 114818.42590787075, 115200.42399787948, 9437.764055898657, 10007.149392301735, 10351.534180961875, 10668.0, 10898.836517452244, 12881.935590321988, 13575.456981720818, 13605.523806666719, 13643.454261829615, 13649.317534123255, 6942.375186233162, 8322.126176751475, 8522.914770852336, 8587.22714955657, 8695.826083478421, 8689.261328367473, 8692.174243446989, 8747.475151490931, 8770.0, 8869.73390798277, 6409.455196308366, 6500.902486462707, 6527.902081468782, 6556.475481961432, 6614.966925165343, 1791.4177892185091, 1827.86140215945, 1829.3962992212537, 1847.3072597775833, 1867.561123136089, 827.6523859978823, 906.4334790755778, 936.8313703533294, 992.7964767222702, 1048.4286064095086, 18283.134936486367, 22098.0055897485, 22165.113395464, 22200.77799221987, 22213.77786222117, 951.4861974533675, 972.9708108756748, 973.4062222044547, 974.5322245322285, 1004.0762498501397, 9593.0, 11494.770104597861, 11724.941375293069, 11782.705432364088, 11837.408129593487, 605130.0, 617569.0, 620454.0, 627031.0, 627888.0, 99627.0, 112603.0, 121945.0, 123029.15456268164, 127068.0, 900.3337530227584, 1024.830902901013, 1036.264252380803, 1053.5996321397972, 1060.6393826099008, 15938.177494929827, 18628.254869805056, 19240.05578856303, 19336.709949351054, 19755.012249387186, 28871.42257154803, 39799.0, 47888.521114788404, 48537.27194092162, 52729.736351317995, 70300.94548581878, 72002.63998680182, 72092.0, 74399.62800185964, 76013.0, 7701.4608977371045, 7777.259602504459, 7826.256505631955, 7914.24814642608, 8056.838863222585, 12560.434780435085, 12650.746985060432, 12840.935795320964, 12850.42173102194, 12969.221846689228, 11091.556337746722, 11243.943780281374, 11309.0, 11357.318560886373, 11427.542898283975, 11021.393823339793, 11061.557537698402, 11099.334039957628, 11171.273867198606, 11342.716432089264, 10600.946995265283, 11079.833802492807, 11255.549778009115, 11330.263532870336, 11406.372649504025, 6557.573757705733, 7682.884756728766, 7727.304542591194, 7764.92235077642, 7962.0, 10950.945245273722, 11028.062614677843, 11092.556297748, 11129.610463633733, 11302.095832333229], "value": 9593.05571153379, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1519.0809560216069, 1564.6479542103027, 1722.8535574476168, 1871.157978909491, 1880.5768702042042, 8440.113788052258, 8724.8691269631, 8938.0, 8939.776505587355, 8960.462372257669, 6971.546849454782, 7790.45466817323, 8017.398695097876, 8670.653173873054, 8710.172533609313, 2329.0683726509405, 2352.494213744045, 2356.1988923765916, 2357.2456813819585, 2364.125273648752, 2376.1089591403224, 2381.940451488718, 2415.0581273303424, 2416.827838498327, 2416.9516609667885, 2093.288281984125, 2162.805347518723, 2334.6498025296173, 2402.039184326266, 2406.566817972773, 2366.8579885206855, 2374.81001519878, 2385.1294277588727, 2388.5581167483897, 2389.1637926725593, 2369.845960012594, 2373.7744914233294, 2374.9881250593635, 2376.251480783548, 2378.131981826638, 8957.0, 9022.188003079755, 9025.864612030824, 9033.819323613556, 9040.141186587263, 5174.7412629368755, 5319.9202011969855, 5353.625246232766, 5364.275822763916, 5382.946170538284, 3488.598811136701, 3553.200529880782, 3671.5777685566236, 3673.173535954389, 3677.9080522987138, 985.6845809341014, 1009.2531526670284, 1068.8289873620183, 1093.5461783359897, 1099.3239157917903, 11811.346411502396, 11830.704232394173, 11833.230839995458, 11837.993770529516, 11860.584879529175, 4579.885502862455, 4665.766711664403, 4797.352357431702, 4808.422989241313, 4810.182269014276, 10015.799684006279, 10018.899811001942, 10022.3485473444, 10032.498375081217, 10045.246606504395, 5343.465653434625, 5360.785568577291, 5361.597880159004, 5367.704776237344, 5381.165919282517, 4710.9764451177525, 4916.016796640686, 4918.409790825124, 4920.065187614342, 4925.630577706686, 3796.2027974125745, 3833.4824798652385, 3888.0, 3924.411338299221, 3944.15200731844, 1088.7876864011441, 1110.2838669058413, 1199.9880001200052, 1312.4750099959901, 1314.2204238036484, 790.0992868130336, 927.9257659387233, 931.6785708930408, 950.0499500499501, 959.2278216036018, 5865.648061116347, 5949.10763385487, 5971.462568368781, 6112.51099912006, 6129.96935015331, 965.4062751407834, 969.9078587534173, 974.6101559376165, 1006.7080546641538, 1016.2124353625999, 3594.892153235407, 3756.436534519844, 3941.0, 4042.939355909664, 4109.157622687342, 10249.795004100026, 10643.201759867887, 10678.946605266923, 10687.73280667974, 10690.465476726133, 9742.902570974342, 10273.126784223276, 10477.0, 10624.415657138778, 10674.946625266979, 6977.89533157003, 7974.5215287082965, 8253.711120110767, 8304.294134998592, 8306.501609903426, 5975.073863551156, 6044.788432404845, 6228.4705800007505, 6249.531285153541, 6286.214223222098, 9731.756706082404, 9807.411555306704, 10130.594776208869, 10132.138768204784, 10192.643257485952, 9966.0, 10129.898701012895, 10134.898651013396, 10135.087842094246, 10331.0, 7307.378872795872, 7468.066491688539, 7584.165741768291, 7588.430867684835, 7592.81017974555, 8268.214519620868, 8313.750587482386, 8351.41540092212, 8355.248027677539, 8358.0, 6287.30839607652, 7361.2638736125955, 7395.556266624019, 7643.273888980538, 7708.49894756839, 7343.522671026366, 7460.992765976741, 7476.514026588255, 7594.012778338781, 7607.581583012766, 6942.062821519232, 6961.6171110587375, 6990.545614535039, 7024.0, 7027.789166325018, 4916.827911023097, 5089.923651145162, 5096.949030509796, 5108.770105345343, 5154.948450515447, 5038.496150384932, 5080.872978175576, 5149.845504634867, 5169.405518365285, 5228.63399562027], "value": 4610.642358516179, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.91034644779785, 304.3957743878401, 312.82794463045326, 319.2848020434228, 320.45042751680865, 5405.351377824867, 5426.728663566821, 5467.20725494804, 5483.340579818785, 5552.888942221153, 4394.824207031715, 5069.771860266288, 5188.429272779991, 5341.65279256848, 5346.492083252095, 3408.5739282589675, 3923.8822835314986, 4093.6520395766397, 4109.260333140033, 4117.2177286315655, 3395.7283417326553, 4057.2494088593558, 4111.301078816593, 4120.690948178899, 4149.46057012588, 3468.06948128832, 3872.7676339419586, 4107.630313271805, 4108.0, 4140.523839758421, 3187.4581321175456, 3418.982905085471, 4044.69664775143, 4080.1839632073406, 4156.334986402177, 2965.8665360058635, 3521.67569404192, 3538.2039041215776, 3546.2552863898613, 3551.0057183988524, 4523.977380113111, 4541.863744087683, 5214.556762675177, 5217.217417387385, 5307.920381194285, 4198.097409057037, 4324.897151226417, 4686.976565117153, 4723.481006650033, 4778.593819525345, 4880.341153944208, 5637.587915601028, 5642.689652069134, 5666.603337766358, 5695.515881150107, 3885.1258466845015, 3903.3949737790404, 3930.2728995135703, 3941.605839416064, 3951.920961580752, 4668.789904454274, 5784.219130417382, 5888.852778680524, 5890.793822216245, 5936.436038576328, 3911.765294082364, 3938.5667576566557, 3949.6050394960275, 3963.6829053675638, 3963.8612648557737, 3600.71194304455, 4022.27599032177, 4031.3549832026733, 4038.697097717683, 4039.434479172918, 3997.520297564311, 4454.732716037048, 4466.285394336891, 4472.926497640543, 4488.438945131858, 4503.707259028152, 4752.388184979441, 5612.915806262909, 5674.375818659944, 5696.240481282333, 1203.0375699440588, 1347.45428101619, 1373.7183877305129, 1385.279654579613, 1394.5914626227584, 870.6517393042834, 897.9595918183697, 928.6656803550717, 941.152962333905, 951.4338968313981, 4377.365282034088, 4586.981728039652, 5223.425423203445, 5273.235380869753, 5300.31095957523, 5068.426759134801, 5338.252644629755, 5729.541636669056, 5730.822287530795, 5757.309122905278, 4472.865814025585, 4683.695559788671, 4700.929486057712, 4818.325434439182, 5204.34945631796, 2993.670696223414, 3002.9849850751043, 3014.1861697341596, 3015.5826761422095, 3052.526858336961, 5584.190292407659, 5621.606487545914, 5924.19312109802, 5932.288125424977, 5944.851378715567, 4918.827841025547, 4992.8002879885125, 5124.897502049938, 5847.795327163614, 5960.900331827425, 5449.092817513918, 5886.676232807151, 5894.850504151821, 5900.380460051719, 5911.852203694856, 5474.890502190014, 5726.856828579319, 5736.598438109292, 5812.9709351452975, 5855.945929732689, 4905.8037678492465, 5593.580481463988, 5620.297462817148, 5633.521150702236, 5654.0, 4778.522147785194, 5259.89480210386, 5743.62666426681, 5835.912461312999, 6035.275766907824, 3650.1969566695284, 3830.885073447801, 3919.2951066286255, 3947.585503522089, 3974.9863784734707, 5699.145128230799, 5716.885662286814, 5726.656400615976, 5742.19609254713, 5745.683987380734, 5633.267675202197, 5637.998510528703, 5642.548596112383, 5646.689432081275, 5690.544756419559, 4893.681910675795, 5344.99562664001, 5678.68767217807, 5697.259356283656, 5720.19917211599, 4440.866773996785, 5321.920171197357, 5431.456854314695, 5492.505674489315, 5590.980870329976, 5229.450907654794, 5718.513926316144, 5734.455226753452, 5738.081906894877, 5815.6510609361885, 5465.96503140383, 5585.385607583244, 5588.552915766648, 5589.10574308125, 5632.577556683347], "value": 4101.418588726687, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.6616691654173, 743.5873090434808, 807.7172989453692, 833.9262701702183, 887.3699673232007, 15098.849011509881, 16288.0, 16317.918410407947, 16337.428190013352, 16358.345666173354, 15448.304826282816, 16139.677206455865, 16260.18699065048, 16287.185640717977, 16741.414050508203, 712.6187489693016, 735.2977906099688, 880.7798050487394, 898.5776684958092, 902.9367944243905, 876.2770714160811, 905.316486053029, 906.5875026862794, 906.7053207707488, 907.0068275238636, 954.1651055326589, 958.7698952251479, 960.1358777100595, 961.8749562556858, 965.4931161140387, 734.5482528245144, 921.6543796076471, 950.7718147644584, 951.5432592355673, 951.6241084771511, 707.253847191213, 708.9826099547166, 709.8828693265605, 710.4884483172108, 713.2261496276494, 15334.539963801104, 15390.384384624602, 15408.614784630361, 15413.922930385388, 15424.845751542565, 13706.794398084037, 13923.025388222828, 13930.233837138954, 14027.298635068206, 14183.149011059266, 13231.007674424456, 13253.867461325457, 13342.599722008259, 13610.251436171007, 13933.30333483332, 4602.539746025404, 4634.281686338623, 4645.187092258875, 4758.333833263346, 4810.2063159578975, 111701.99999999919, 114566.42716786363, 115102.0, 116007.0, 117116.41441792737, 10955.397453140155, 11008.559657613767, 11080.944595277133, 11094.889051109547, 11152.163587730953, 21473.570528589342, 21476.570468590853, 21482.89258553697, 21514.56970860574, 21565.67651485229, 6726.899096513556, 7709.845803084019, 7959.721409750631, 8015.559144247006, 8160.877586836202, 4058.2492238935893, 4114.0, 4188.057687020396, 4192.727472714325, 4207.495100587949, 3458.2046129390383, 3565.3047655707405, 3568.1258091767163, 3569.1434055826417, 3577.338192434408, 623.7598524567983, 651.9348065193537, 652.3085529338916, 652.8041587523724, 660.1220376898713, 527.3987654074358, 578.2684903596953, 607.750822162911, 640.9839754006094, 657.2999755260632, 9065.68270110543, 9101.838052657724, 9228.538573071319, 9249.30630202724, 9269.582868770787, 620.7082671144555, 630.4893036640336, 632.2286810091681, 643.4337782751243, 653.3335997282745, 4228.3446065859225, 4399.5820397062225, 4439.200943830077, 4512.796924138422, 4513.768036675003, 146244.0, 149631.0, 150783.0, 151003.24498377438, 152561.47438525694, 100330.0, 123622.0, 124879.0, 127795.08307375397, 127823.0, 94432.0, 112222.43888780667, 115518.42240788742, 116495.01029938231, 117109.41445292889, 8354.540500272544, 8596.28074385138, 8601.13988601135, 8618.482891026559, 8826.646934122564, 60542.0, 61844.17726897685, 61878.690606546676, 63694.726105478556, 64312.03531946931, 67026.66486667536, 69418.65290673514, 79932.00169995797, 90566.0, 92975.0, 13384.128378985584, 13435.596932092052, 13949.302534873419, 14115.505957291856, 14294.71410571762, 13214.86785132175, 14966.850331496982, 15287.541373758804, 15502.457413990456, 15905.0, 14071.718565628835, 14174.858251417354, 14196.432142714175, 14414.85585144135, 14722.091555049477, 13865.445382185004, 14066.929665351608, 14208.218547979961, 14412.207328597027, 14839.183844888636, 13691.041627086008, 14068.788968165281, 14122.858771412566, 14354.856451435351, 14423.278836058365, 11403.133122864852, 11518.151980056931, 11693.590724324607, 11734.295942243492, 11843.46704398287, 11120.944395278295, 11491.697352879766, 11632.243904146204, 11653.184277100521, 11671.76656466883], "value": 7967.193777511755, "unit": "score"}], "name": "dromaeo_css", "value": 7431.100220606117, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 113.0, 117.0, 134.0, 113.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 130.0, 136.0, 197.0, 104.0, 110.0, 154.0, 139.0, 179.0, 104.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 188.0, 186.0, 183.0, 183.0, 185.0, 181.0, 184.0, 183.0, 231.0], "value": 188.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 71.0, 59.0, 88.0, 60.0, 58.0, 59.0, 67.0, 82.0, 56.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 92.0, 72.0, 75.0, 69.0, 97.0, 70.0, 68.0, 103.0], "value": 81.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 86.0, 84.0, 86.0, 84.0, 88.0, 84.0, 87.0, 81.0], "value": 85.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0, 92.0], "value": 96.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 86.0, 119.0, 131.0, 104.0, 85.0, 85.0, 85.0, 84.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 54.0, 55.0, 56.0, 54.0, 53.0, 54.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 70.0, 81.0, 73.0, 73.0, 71.0, 73.0, 71.0, 72.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 83.0, 85.0, 84.0, 83.0, 82.0, 84.0, 84.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 132.0, 134.0, 133.0, 135.0, 134.0, 138.0, 225.0, 135.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 172.0, 176.0, 172.0, 175.0, 173.0, 171.0, 171.0, 171.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 71.0, 65.0, 86.0, 69.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1465.6, "alertThreshold": 2.0}]} 18:32:46 INFO - Return code: 0 18:32:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:32:46 INFO - # TBPL SUCCESS # 18:32:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:32:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:32:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:32:46 INFO - 2016-07-15 18:32:46.508 screenresolution[1800:9846] starting screenresolution argv=screenresolution get 18:32:46 INFO - 2016-07-15 18:32:46.510 screenresolution[1800:9846] Display 0: 1600x1200x32@60 18:32:46 INFO - 2016-07-15 18:32:46.516 screenresolution[1801:9849] starting screenresolution argv=screenresolution list 18:32:46 INFO - Available Modes on Display 0 18:32:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:32:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:32:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:32:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:32:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:32:46 INFO - Intel Iris: 18:32:46 INFO - Chipset Model: Intel Iris 18:32:46 INFO - Type: GPU 18:32:46 INFO - Bus: Built-In 18:32:46 INFO - VRAM (Dynamic, Max): 1536 MB 18:32:46 INFO - Vendor: Intel (0x8086) 18:32:46 INFO - Device ID: 0x0a2e 18:32:46 INFO - Revision ID: 0x0009 18:32:46 INFO - Displays: 18:32:46 INFO - Display: 18:32:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:32:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:32:46 INFO - Display Serial Number: 1600x1200 60 18:32:46 INFO - Main Display: Yes 18:32:46 INFO - Mirror: Off 18:32:46 INFO - Online: Yes 18:32:46 INFO - Rotation: Supported 18:32:46 INFO - Return code: 0 18:32:46 INFO - Running post-action listener: _resource_record_post_action 18:32:46 INFO - ##### 18:32:46 INFO - ##### Finished run-tests step (success) 18:32:46 INFO - ##### 18:32:46 INFO - Running post-run listener: _resource_record_post_run 18:32:46 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 37012992; Write bytes: 707588608; Read time: 239; Write time: 2022 18:32:46 INFO - TinderboxPrint: CPU usage
53.5% 18:32:46 INFO - TinderboxPrint: I/O read bytes / time
37,012,992 / 239 18:32:46 INFO - TinderboxPrint: I/O write bytes / time
707,588,608 / 2,022 18:32:46 INFO - TinderboxPrint: CPU idle
2,252.7 (46.5%) 18:32:46 INFO - TinderboxPrint: CPU system
965.2 (19.9%) 18:32:46 INFO - TinderboxPrint: CPU user
1,623.7 (33.5%) 18:32:46 INFO - TinderboxPrint: Swap in / out
443,813,888 / 0 18:32:46 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 398987776; Write bytes: 394545152; Read time: 29626; Write time: 843 18:32:46 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 35005952; Write bytes: 295397888; Read time: 221; Write time: 1135 18:32:47 INFO - Running post-run listener: _upload_blobber_files 18:32:47 INFO - Blob upload gear active. 18:32:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:32:47 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 18:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:32:47 INFO - (blobuploader) - INFO - Open directory for files ... 18:32:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:32:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:32:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:48 INFO - (blobuploader) - INFO - Done attempting. 18:32:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:32:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:32:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:49 INFO - (blobuploader) - INFO - Done attempting. 18:32:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:32:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:32:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:32:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:32:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:32:52 INFO - (blobuploader) - INFO - Done attempting. 18:32:52 INFO - (blobuploader) - INFO - Iteration through files over. 18:32:52 INFO - Return code: 0 18:32:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:32:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:32:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19ed7be957ae7454479b4dfdeba4e3f4dd241bc8f65d837047a9c569995f580327696d0955ed4547786a23d17ce1017f5edc3fa95aeaea0180ab9fe71868f9b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5102b598e272f5138b74df9c32fe5bc7d8b3fc28ef30cffee12fa0deb2c76ee4d2491f030ffa2cb80d388ac2135de5dba89d51c9e9451d4b3d7be0d92098d70d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/792c5cb1e979cccb9143297084c973169392bf3a82f93c8f5c90f609d0a6bc155b0d90338920b7222adf820c42fdf672dc432b1cd8f919901e38640bb6333f8b"} 18:32:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:32:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:32:52 INFO - Contents: 18:32:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19ed7be957ae7454479b4dfdeba4e3f4dd241bc8f65d837047a9c569995f580327696d0955ed4547786a23d17ce1017f5edc3fa95aeaea0180ab9fe71868f9b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5102b598e272f5138b74df9c32fe5bc7d8b3fc28ef30cffee12fa0deb2c76ee4d2491f030ffa2cb80d388ac2135de5dba89d51c9e9451d4b3d7be0d92098d70d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/792c5cb1e979cccb9143297084c973169392bf3a82f93c8f5c90f609d0a6bc155b0d90338920b7222adf820c42fdf672dc432b1cd8f919901e38640bb6333f8b"} 18:32:52 INFO - Running post-run listener: copy_logs_to_upload_dir 18:32:52 INFO - Copying logs to upload dir... 18:32:52 INFO - mkdir: /builds/slave/test/build/upload/logs 18:32:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.198023 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-15 18:32:52.766095) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 18:32:52.769297) ========= 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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners TMPDIR=/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19ed7be957ae7454479b4dfdeba4e3f4dd241bc8f65d837047a9c569995f580327696d0955ed4547786a23d17ce1017f5edc3fa95aeaea0180ab9fe71868f9b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5102b598e272f5138b74df9c32fe5bc7d8b3fc28ef30cffee12fa0deb2c76ee4d2491f030ffa2cb80d388ac2135de5dba89d51c9e9451d4b3d7be0d92098d70d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/792c5cb1e979cccb9143297084c973169392bf3a82f93c8f5c90f609d0a6bc155b0d90338920b7222adf820c42fdf672dc432b1cd8f919901e38640bb6333f8b"} build_url:https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/fbj5WbOnSX6YX4dSJP790g/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/19ed7be957ae7454479b4dfdeba4e3f4dd241bc8f65d837047a9c569995f580327696d0955ed4547786a23d17ce1017f5edc3fa95aeaea0180ab9fe71868f9b2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5102b598e272f5138b74df9c32fe5bc7d8b3fc28ef30cffee12fa0deb2c76ee4d2491f030ffa2cb80d388ac2135de5dba89d51c9e9451d4b3d7be0d92098d70d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/792c5cb1e979cccb9143297084c973169392bf3a82f93c8f5c90f609d0a6bc155b0d90338920b7222adf820c42fdf672dc432b1cd8f919901e38640bb6333f8b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 18:32:52.804427) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:32:52.805048) ========= 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.RYmPAqZX6d/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.mZDy2wO4oK/Listeners TMPDIR=/var/folders/40/__rckyn52mngk9ww2dj8d78400000w/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.005218 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 18:32:52.857061) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 18:32:52.857722) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 18:32:52.858340) ========= ========= Total master_lag: 0.20 =========