builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0321 starttime: 1467521163.83 results: success (0) buildid: 20160702204822 builduid: bee97707d67843f5b0581e9d3d2b03b9 revision: c61101c15a280b078071fd130eba2dd5079d69c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 21:46:03.831579) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 21:46:03.831978) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 21:46:03.832278) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 21:46:04.021899) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 21:46:04.022183) ========= 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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-02 21:46:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-07-02 21:46:04 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.582684 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 21:46:04.651439) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 21:46:04.651777) ========= 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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020695 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 21:46:04.705894) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-02 21:46:04.706232) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev c61101c15a280b078071fd130eba2dd5079d69c2 --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 c61101c15a280b078071fd130eba2dd5079d69c2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.W1mDwB3fnx/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.8e2UzFoHqA/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-02 21:46:04,788 truncating revision to first 12 chars 2016-07-02 21:46:04,789 Setting DEBUG logging. 2016-07-02 21:46:04,789 attempt 1/10 2016-07-02 21:46:04,789 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/c61101c15a28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 21:46:06,201 unpacking tar archive at: autoland-c61101c15a28/testing/mozharness/ program finished with exit code 0 elapsedTime=1.956499 ========= master_lag: 1.67 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-02 21:46:08.335105) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 21:46:08.335392) ========= script_repo_revision: c61101c15a280b078071fd130eba2dd5079d69c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 21:46:08.335757) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 21:46:08.336041) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 21:46:08.463187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2016-07-02 21:46:08.463447) ========= /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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 21:46:09 INFO - MultiFileLogger online at 20160702 21:46:09 in /builds/slave/test 21:46:09 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 21:46:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:46:09 INFO - {'append_to_log': False, 21:46:09 INFO - 'base_work_dir': '/builds/slave/test', 21:46:09 INFO - 'blob_upload_branch': 'Autoland', 21:46:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:46:09 INFO - 'branch': 'Autoland', 21:46:09 INFO - 'buildbot_json_path': 'buildprops.json', 21:46:09 INFO - 'config_files': ('talos/mac_config.py',), 21:46:09 INFO - 'default_actions': ('clobber', 21:46:09 INFO - 'read-buildbot-config', 21:46:09 INFO - 'download-and-extract', 21:46:09 INFO - 'populate-webroot', 21:46:09 INFO - 'create-virtualenv', 21:46:09 INFO - 'install', 21:46:09 INFO - 'run-tests'), 21:46:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:46:09 INFO - 'download_minidump_stackwalk': True, 21:46:09 INFO - 'download_symbols': 'ondemand', 21:46:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:46:09 INFO - 'tooltool.py': '/tools/tooltool.py', 21:46:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:46:09 INFO - '/tools/misc-python/virtualenv.py')}, 21:46:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:46:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:46:09 INFO - 'installer_path': 'installer.exe', 21:46:09 INFO - 'log_level': 'info', 21:46:09 INFO - 'log_name': 'talos', 21:46:09 INFO - 'log_to_console': True, 21:46:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:46:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:46:09 INFO - 'opt_config_files': (), 21:46:09 INFO - 'pip_index': False, 21:46:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:46:09 INFO - 'cmd': ('bash', 21:46:09 INFO - '-c', 21:46:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:46:09 INFO - 'enabled': True, 21:46:09 INFO - 'halt_on_failure': False, 21:46:09 INFO - 'name': 'check_screen_resolution'},), 21:46:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:46:09 INFO - 'cmd': ('bash', 21:46:09 INFO - '-c', 21:46:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:46:09 INFO - 'enabled': True, 21:46:09 INFO - 'halt_on_failure': False, 21:46:09 INFO - 'name': 'check_screen_resolution'},), 21:46:09 INFO - 'run_cmd_checks_enabled': True, 21:46:09 INFO - 'sps_profile': False, 21:46:09 INFO - 'sps_profile_interval': 0, 21:46:09 INFO - 'suite': 'dromaeojs', 21:46:09 INFO - 'system_bits': '32', 21:46:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:46:09 INFO - 'title': 't-yosemite-r7-0321', 21:46:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:46:09 INFO - 'use_talos_json': True, 21:46:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:46:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:46:09 INFO - 'work_dir': 'build'} 21:46:09 INFO - ##### 21:46:09 INFO - ##### Running clobber step. 21:46:09 INFO - ##### 21:46:09 INFO - Running pre-action listener: _resource_record_pre_action 21:46:09 INFO - Running main action method: clobber 21:46:09 INFO - rmtree: /builds/slave/test/build 21:46:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:46:10 INFO - Running post-action listener: _resource_record_post_action 21:46:10 INFO - ##### 21:46:10 INFO - ##### Finished clobber step (success) 21:46:10 INFO - ##### 21:46:10 INFO - ##### 21:46:10 INFO - ##### Running read-buildbot-config step. 21:46:10 INFO - ##### 21:46:10 INFO - Running pre-action listener: _resource_record_pre_action 21:46:10 INFO - Running main action method: read_buildbot_config 21:46:10 INFO - Using buildbot properties: 21:46:10 INFO - { 21:46:10 INFO - "project": "", 21:46:10 INFO - "product": "firefox", 21:46:10 INFO - "script_repo_revision": "production", 21:46:10 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 21:46:10 INFO - "repository": "", 21:46:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 21:46:10 INFO - "buildid": "20160702204822", 21:46:10 INFO - "pgo_build": "False", 21:46:10 INFO - "basedir": "/builds/slave/test", 21:46:10 INFO - "buildnumber": 21, 21:46:10 INFO - "slavename": "t-yosemite-r7-0321", 21:46:10 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:46:10 INFO - "platform": "yosemite_r7", 21:46:10 INFO - "scheduler": "tests-autoland-macosx64-talos", 21:46:10 INFO - "branch": "autoland", 21:46:10 INFO - "repo_path": "integration/autoland", 21:46:10 INFO - "revision": "c61101c15a280b078071fd130eba2dd5079d69c2", 21:46:10 INFO - "stage_platform": "macosx64", 21:46:10 INFO - "builduid": "bee97707d67843f5b0581e9d3d2b03b9", 21:46:10 INFO - "slavebuilddir": "test" 21:46:10 INFO - } 21:46:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 21:46:10 INFO - Running post-action listener: _resource_record_post_action 21:46:10 INFO - ##### 21:46:10 INFO - ##### Finished read-buildbot-config step (success) 21:46:10 INFO - ##### 21:46:10 INFO - ##### 21:46:10 INFO - ##### Running download-and-extract step. 21:46:10 INFO - ##### 21:46:10 INFO - Running pre-action listener: _resource_record_pre_action 21:46:10 INFO - Running main action method: download_and_extract 21:46:10 INFO - mkdir: /builds/slave/test/build/tests 21:46: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')]} 21:46:10 INFO - https://queue.taskcluster.net/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:46:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 21:46:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 21:46:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/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 21:46:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/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 21:46:20 INFO - Downloaded 1199 bytes. 21:46:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 21:46:20 INFO - Using the following test package requirements: 21:46:20 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 21:46:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:20 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 21:46:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:20 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 21:46:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:20 INFO - u'jsshell-mac.zip'], 21:46:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:20 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 21:46:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 21:46:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:20 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 21:46:20 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:20 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 21:46:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:20 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 21:46:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 21:46:20 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 21:46:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:46: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')]} 21:46:20 INFO - https://queue.taskcluster.net/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:46:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 21:46:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 21:46:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/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 21:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/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 21:46:40 INFO - Downloaded 18791305 bytes. 21:46:40 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'] 21:46:40 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 21:46:43 INFO - Return code: 0 21:46:43 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 21:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:46:43 INFO - https://queue.taskcluster.net/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:46:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 21:46:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 21:46:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/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 21:46:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/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 21:47:10 INFO - Downloaded 18791305 bytes. 21:47:10 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'] 21:47:10 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 21:47:13 INFO - Return code: 0 21:47: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')]} 21:47:13 INFO - https://queue.taskcluster.net/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:47:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 21:47:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 21:47:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/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 21:47:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/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 21:47:15 INFO - Downloaded 14405327 bytes. 21:47:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:47:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 21:47:15 INFO - Return code: 0 21:47:15 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')]} 21:47:15 INFO - https://queue.taskcluster.net/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:47:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 21:47:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 21:47:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 21:47:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C_v1XczdTd2BzmKrsWhskA/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 21:47:23 INFO - Downloaded 112447212 bytes. 21:47:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 21:47:23 INFO - mkdir: /builds/slave/test/properties 21:47:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:47:23 INFO - Writing to file /builds/slave/test/properties/build_url 21:47:23 INFO - Contents: 21:47:23 INFO - build_url:https://queue.taskcluster.net/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 21:47:24 INFO - Running post-action listener: _resource_record_post_action 21:47:24 INFO - Running post-action listener: set_extra_try_arguments 21:47:24 INFO - ##### 21:47:24 INFO - ##### Finished download-and-extract step (success) 21:47:24 INFO - ##### 21:47:24 INFO - ##### 21:47:24 INFO - ##### Running populate-webroot step. 21:47:24 INFO - ##### 21:47:24 INFO - Running pre-action listener: _resource_record_pre_action 21:47:24 INFO - Running main action method: populate_webroot 21:47:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:47:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:47:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:47:24 INFO - '--tppagecycles', 21:47:24 INFO - '7'], 21:47:24 INFO - 'tests': ['tsvgm']}}, 21:47:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:47:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:47:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:47:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:47:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:47:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:47:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:24 INFO - 'talos_options': ['--disable-e10s'], 21:47:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:47:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:24 INFO - 'talos_options': ['--disable-e10s'], 21:47:24 INFO - 'tests': ['damp', 'tps']}, 21:47:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:24 INFO - 'tests': ['damp', 'tps']}, 21:47:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:47:24 INFO - 'tests': ['dromaeo_dom']}, 21:47:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:47:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:47:24 INFO - 'tests': ['basic_compositor_video']}, 21:47:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:47:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:47:24 INFO - 'tests': ['a11yr', 21:47:24 INFO - 'ts_paint', 21:47:24 INFO - 'tpaint', 21:47:24 INFO - 'sessionrestore', 21:47:24 INFO - 'sessionrestore_no_auto_restore', 21:47:24 INFO - 'tabpaint']}, 21:47:24 INFO - 'other-e10s': {'tests': ['a11yr', 21:47:24 INFO - 'ts_paint', 21:47:24 INFO - 'tpaint', 21:47:24 INFO - 'sessionrestore', 21:47:24 INFO - 'sessionrestore_no_auto_restore', 21:47:24 INFO - 'tabpaint']}, 21:47:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:47:24 INFO - 'ts_paint', 21:47:24 INFO - 'tpaint', 21:47:24 INFO - 'sessionrestore', 21:47:24 INFO - 'sessionrestore_no_auto_restore', 21:47:24 INFO - 'tabpaint']}, 21:47:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:47:24 INFO - 'ts_paint', 21:47:24 INFO - 'tpaint', 21:47:24 INFO - 'sessionrestore', 21:47:24 INFO - 'sessionrestore_no_auto_restore', 21:47:24 INFO - 'tabpaint']}, 21:47:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:47:24 INFO - 'tests': ['a11yr', 21:47:24 INFO - 'ts_paint', 21:47:24 INFO - 'tpaint', 21:47:24 INFO - 'sessionrestore', 21:47:24 INFO - 'sessionrestore_no_auto_restore', 21:47:24 INFO - 'tabpaint']}, 21:47:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:47:24 INFO - 'tests': ['a11yr', 21:47:24 INFO - 'ts_paint', 21:47:24 INFO - 'tpaint', 21:47:24 INFO - 'sessionrestore', 21:47:24 INFO - 'sessionrestore_no_auto_restore', 21:47:24 INFO - 'tabpaint']}, 21:47:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:47:24 INFO - 'tests': ['tsvgx', 21:47:24 INFO - 'tsvgr_opacity', 21:47:24 INFO - 'tart', 21:47:24 INFO - 'tscrollx', 21:47:24 INFO - 'cart']}, 21:47:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:47:24 INFO - 'tsvgr_opacity', 21:47:24 INFO - 'tart', 21:47:24 INFO - 'tscrollx', 21:47:24 INFO - 'cart']}, 21:47:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:24 INFO - 'talos_options': ['--disable-e10s'], 21:47:24 INFO - 'tests': ['tp5o']}, 21:47:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:24 INFO - 'tests': ['tp5o']}, 21:47:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:24 INFO - 'talos_options': ['--disable-e10s', 21:47:24 INFO - '--xperf_path', 21:47:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:24 INFO - 'tests': ['tp5n']}, 21:47:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:47:24 INFO - 'talos_options': ['--xperf_path', 21:47:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:47:24 INFO - 'tests': ['tp5n']}}, 21:47:24 INFO - 'talos.zip': {'path': '', 21:47:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:47:24 INFO - Running post-action listener: _resource_record_post_action 21:47:24 INFO - ##### 21:47:24 INFO - ##### Finished populate-webroot step (success) 21:47:24 INFO - ##### 21:47:24 INFO - ##### 21:47:24 INFO - ##### Running create-virtualenv step. 21:47:24 INFO - ##### 21:47:24 INFO - Running pre-action listener: _resource_record_pre_action 21:47:24 INFO - Running main action method: create_virtualenv 21:47:24 INFO - Creating virtualenv /builds/slave/test/build/venv 21:47:24 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 21:47:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:47:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:47:24 INFO - Using real prefix '/tools/python27' 21:47:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:47:25 INFO - Installing distribute.............................................................................................................................................................................................done. 21:47:28 INFO - Installing pip.................done. 21:47:28 INFO - Return code: 0 21:47:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c536618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ff1d71a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c405d30>, '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 0x10c16adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fdb20>, '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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:47:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W1mDwB3fnx/Render', 21:47:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:28 INFO - 'HOME': '/Users/cltbld', 21:47:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:28 INFO - 'LOGNAME': 'cltbld', 21:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:28 INFO - 'MOZ_NO_REMOTE': '1', 21:47:28 INFO - 'NO_EM_RESTART': '1', 21:47:28 INFO - 'PAGER': '/bin/cat', 21:47:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:28 INFO - 'PWD': '/builds/slave/test', 21:47:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:28 INFO - 'SHELL': '/bin/bash', 21:47:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8e2UzFoHqA/Listeners', 21:47:28 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 21:47:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:28 INFO - 'USER': 'cltbld', 21:47:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:28 INFO - 'XPC_FLAGS': '0x0', 21:47:28 INFO - 'XPC_SERVICE_NAME': '0', 21:47:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:28 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 21:47:28 INFO - Cleaning up... 21:47:28 INFO - Return code: 0 21:47:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c4a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c536618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ff1d71a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c405d30>, '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 0x10c16adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fdb20>, '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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:47:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:47:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:47:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W1mDwB3fnx/Render', 21:47:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:28 INFO - 'HOME': '/Users/cltbld', 21:47:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:28 INFO - 'LOGNAME': 'cltbld', 21:47:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:28 INFO - 'MOZ_NO_REMOTE': '1', 21:47:28 INFO - 'NO_EM_RESTART': '1', 21:47:28 INFO - 'PAGER': '/bin/cat', 21:47:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:28 INFO - 'PWD': '/builds/slave/test', 21:47:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:28 INFO - 'SHELL': '/bin/bash', 21:47:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8e2UzFoHqA/Listeners', 21:47:28 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 21:47:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:28 INFO - 'USER': 'cltbld', 21:47:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:28 INFO - 'XPC_FLAGS': '0x0', 21:47:28 INFO - 'XPC_SERVICE_NAME': '0', 21:47:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:29 INFO - Downloading/unpacking psutil>=3.1.1 21:47:29 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 21:47:29 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 21:47:29 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 21:47:29 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 21:47:29 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 21:47:29 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 21:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:47:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:32 INFO - Installing collected packages: psutil 21:47:32 INFO - Running setup.py install for psutil 21:47:32 INFO - building 'psutil._psutil_osx' extension 21:47:32 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 21:47:32 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 21:47:32 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 21:47:32 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 21:47:32 INFO - building 'psutil._psutil_posix' extension 21:47:32 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 21:47:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:47:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:47:33 INFO - ^ 21:47:33 INFO - 1 warning generated. 21:47:33 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 21:47:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:47:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:47:33 INFO - Successfully installed psutil 21:47:33 INFO - Cleaning up... 21:47:33 INFO - Return code: 0 21:47:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:47:33 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')]} 21:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:33 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')]} 21:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:33 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 0x10c4a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c536618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ff1d71a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c405d30>, '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 0x10c16adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fdb20>, '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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:47:33 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 21:47:33 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 21:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W1mDwB3fnx/Render', 21:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:33 INFO - 'HOME': '/Users/cltbld', 21:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:33 INFO - 'LOGNAME': 'cltbld', 21:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:33 INFO - 'MOZ_NO_REMOTE': '1', 21:47:33 INFO - 'NO_EM_RESTART': '1', 21:47:33 INFO - 'PAGER': '/bin/cat', 21:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:33 INFO - 'PWD': '/builds/slave/test', 21:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:33 INFO - 'SHELL': '/bin/bash', 21:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8e2UzFoHqA/Listeners', 21:47:33 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 21:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:33 INFO - 'USER': 'cltbld', 21:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:33 INFO - 'XPC_FLAGS': '0x0', 21:47:33 INFO - 'XPC_SERVICE_NAME': '0', 21:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:47:33 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 21:47:33 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 21:47:33 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 21:47:33 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 21:47:33 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 21:47:33 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 21:47:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:47:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:47:36 INFO - Installing collected packages: mozsystemmonitor 21:47:36 INFO - Running setup.py install for mozsystemmonitor 21:47:36 INFO - Successfully installed mozsystemmonitor 21:47:36 INFO - Cleaning up... 21:47:36 INFO - Return code: 0 21:47:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:47:36 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')]} 21:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:36 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')]} 21:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:36 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 0x10c4a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c536618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ff1d71a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c405d30>, '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 0x10c16adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fdb20>, '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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:47:36 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 21:47:36 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 21:47:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W1mDwB3fnx/Render', 21:47:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:36 INFO - 'HOME': '/Users/cltbld', 21:47:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:36 INFO - 'LOGNAME': 'cltbld', 21:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:36 INFO - 'MOZ_NO_REMOTE': '1', 21:47:36 INFO - 'NO_EM_RESTART': '1', 21:47:36 INFO - 'PAGER': '/bin/cat', 21:47:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:36 INFO - 'PWD': '/builds/slave/test', 21:47:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:36 INFO - 'SHELL': '/bin/bash', 21:47:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8e2UzFoHqA/Listeners', 21:47:36 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 21:47:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:36 INFO - 'USER': 'cltbld', 21:47:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:36 INFO - 'XPC_FLAGS': '0x0', 21:47:36 INFO - 'XPC_SERVICE_NAME': '0', 21:47:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:36 INFO - Downloading/unpacking jsonschema==2.5.1 21:47:36 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 21:47:36 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 21:47:36 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 21:47:36 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 21:47:36 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 21:47:36 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 21:47:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:47:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:47:39 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 21:47:39 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 21:47:39 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 21:47:39 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 21:47:39 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 21:47:39 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 21:47:39 INFO - Downloading functools32-3.2.3-2.tar.gz 21:47:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:47:39 INFO - warning: no files found matching '*.txt' 21:47:39 INFO - no previously-included directories found matching 'build' 21:47:39 INFO - no previously-included directories found matching 'dist' 21:47:39 INFO - no previously-included directories found matching '.git*' 21:47:39 INFO - Installing collected packages: jsonschema, functools32 21:47:39 INFO - Running setup.py install for functools32 21:47:39 INFO - warning: no files found matching '*.txt' 21:47:39 INFO - no previously-included directories found matching 'build' 21:47:39 INFO - no previously-included directories found matching 'dist' 21:47:39 INFO - no previously-included directories found matching '.git*' 21:47:39 INFO - Successfully installed jsonschema functools32 21:47:39 INFO - Cleaning up... 21:47:39 INFO - Return code: 0 21:47:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:39 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 0x10c4a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c536618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ff1d71a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c405d30>, '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 0x10c16adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fdb20>, '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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:47:39 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 21:47:39 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 21:47:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W1mDwB3fnx/Render', 21:47:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:39 INFO - 'HOME': '/Users/cltbld', 21:47:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:39 INFO - 'LOGNAME': 'cltbld', 21:47:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:39 INFO - 'MOZ_NO_REMOTE': '1', 21:47:39 INFO - 'NO_EM_RESTART': '1', 21:47:39 INFO - 'PAGER': '/bin/cat', 21:47:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:39 INFO - 'PWD': '/builds/slave/test', 21:47:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:39 INFO - 'SHELL': '/bin/bash', 21:47:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8e2UzFoHqA/Listeners', 21:47:39 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 21:47:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:39 INFO - 'USER': 'cltbld', 21:47:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:39 INFO - 'XPC_FLAGS': '0x0', 21:47:39 INFO - 'XPC_SERVICE_NAME': '0', 21:47:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:40 INFO - Downloading/unpacking blobuploader==1.2.4 21:47:40 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 21:47:40 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 21:47:40 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 21:47:40 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 21:47:40 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 21:47:40 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 21:47:42 INFO - Downloading blobuploader-1.2.4.tar.gz 21:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:47:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:47:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:47:43 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 21:47:43 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 21:47:43 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 21:47:43 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 21:47:43 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 21:47:43 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 21:47:43 INFO - Downloading docopt-0.6.1.tar.gz 21:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:47:43 INFO - Installing collected packages: blobuploader, requests, docopt 21:47:43 INFO - Running setup.py install for blobuploader 21:47:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:47:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:47:43 INFO - Running setup.py install for requests 21:47:44 INFO - Running setup.py install for docopt 21:47:44 INFO - Successfully installed blobuploader requests docopt 21:47:44 INFO - Cleaning up... 21:47:44 INFO - Return code: 0 21:47:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:47:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:44 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 0x10c4a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c536618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ff1d71a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c405d30>, '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 0x10c16adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fdb20>, '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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:47:44 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 21:47:44 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 21:47:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W1mDwB3fnx/Render', 21:47:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:44 INFO - 'HOME': '/Users/cltbld', 21:47:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:44 INFO - 'LOGNAME': 'cltbld', 21:47:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:44 INFO - 'MOZ_NO_REMOTE': '1', 21:47:44 INFO - 'NO_EM_RESTART': '1', 21:47:44 INFO - 'PAGER': '/bin/cat', 21:47:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:44 INFO - 'PWD': '/builds/slave/test', 21:47:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:44 INFO - 'SHELL': '/bin/bash', 21:47:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8e2UzFoHqA/Listeners', 21:47:44 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 21:47:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:44 INFO - 'USER': 'cltbld', 21:47:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:44 INFO - 'XPC_FLAGS': '0x0', 21:47:44 INFO - 'XPC_SERVICE_NAME': '0', 21:47:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:47:44 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-xJYRs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:47:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-0O2UOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:47:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-YpDm0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:47:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-1Dc0a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:47:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-ZGlXnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:47:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-dvAfHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:47:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-5BHGiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:47:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-DlKX_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:47:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-dLfS86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:47:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-qYezTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:47:45 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-U2c5lO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:47:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-b8RhVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:47:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-l2a28J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:47:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-UPiJG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-PRvK07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:47:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-chLV2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:47:46 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-SGxE1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:47:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:47:46 INFO - Running setup.py install for manifestparser 21:47:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:47:46 INFO - Running setup.py install for mozcrash 21:47:46 INFO - Running setup.py install for mozdebug 21:47:47 INFO - Running setup.py install for mozdevice 21:47:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:47:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:47:47 INFO - Running setup.py install for mozfile 21:47:47 INFO - Running setup.py install for mozhttpd 21:47:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:47:47 INFO - Running setup.py install for mozinfo 21:47:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:47:47 INFO - Running setup.py install for mozInstall 21:47:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:47:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:47:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:47:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:47:47 INFO - Running setup.py install for mozleak 21:47:47 INFO - Running setup.py install for mozlog 21:47:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:47:48 INFO - Running setup.py install for moznetwork 21:47:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:47:48 INFO - Running setup.py install for mozprocess 21:47:48 INFO - Running setup.py install for mozprofile 21:47:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:47:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:47:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:47:48 INFO - Running setup.py install for mozrunner 21:47:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:47:48 INFO - Running setup.py install for mozscreenshot 21:47:48 INFO - Running setup.py install for moztest 21:47:49 INFO - Running setup.py install for mozversion 21:47:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:47:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:47:49 INFO - Cleaning up... 21:47:49 INFO - Return code: 0 21:47:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47: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')]} 21:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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')]} 21:47:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:49 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 0x10c4a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c536618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ff1d71a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c405d30>, '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 0x10c16adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fdb20>, '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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:47:49 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 21:47:49 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 21:47:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W1mDwB3fnx/Render', 21:47:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:49 INFO - 'HOME': '/Users/cltbld', 21:47:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:49 INFO - 'LOGNAME': 'cltbld', 21:47:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:49 INFO - 'MOZ_NO_REMOTE': '1', 21:47:49 INFO - 'NO_EM_RESTART': '1', 21:47:49 INFO - 'PAGER': '/bin/cat', 21:47:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:49 INFO - 'PWD': '/builds/slave/test', 21:47:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:49 INFO - 'SHELL': '/bin/bash', 21:47:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8e2UzFoHqA/Listeners', 21:47:49 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 21:47:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:49 INFO - 'USER': 'cltbld', 21:47:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:49 INFO - 'XPC_FLAGS': '0x0', 21:47:49 INFO - 'XPC_SERVICE_NAME': '0', 21:47:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:47:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-w5Anco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:47:49 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)) 21:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:47:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-xHNClQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:47:49 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)) 21:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:47:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-35Dm3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:47:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:47:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-xxW1KC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:47:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:47:49 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-RO_1OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:47:50 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)) 21:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:47:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-TnYAn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:47:50 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)) 21:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:47:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-x8mQFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:47:50 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)) 21:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:47:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-fsXEsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:47:50 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)) 21:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:47:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-judTo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:47:50 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)) 21:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:47:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-z5o6CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:47:50 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)) 21:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:47:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-dhjGEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:47:50 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)) 21:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:47:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-WVZi3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:47:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-LGrjFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:47:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:47:50 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-0wekdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-thPDUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:47:51 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)) 21:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:47:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-uAq6v2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:47:51 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)) 21:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:47:51 INFO - Running setup.py (path:/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/pip-RNqrRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:47:51 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)) 21:47:51 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)) 21:47:51 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)) 21:47:51 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)) 21:47:51 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)) 21:47:51 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)) 21:47:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:47:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:47:53 INFO - Downloading blessings-1.6.tar.gz 21:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:47:53 INFO - Installing collected packages: blessings 21:47:53 INFO - Running setup.py install for blessings 21:47:54 INFO - Successfully installed blessings 21:47:54 INFO - Cleaning up... 21:47:54 INFO - Return code: 0 21:47:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:47:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:47:54 INFO - Reading from file tmpfile_stdout 21:47:54 INFO - Current package versions: 21:47:54 INFO - blessings == 1.6 21:47:54 INFO - blobuploader == 1.2.4 21:47:54 INFO - docopt == 0.6.1 21:47:54 INFO - functools32 == 3.2.3-2 21:47:54 INFO - jsonschema == 2.5.1 21:47:54 INFO - manifestparser == 1.1 21:47:54 INFO - mozInstall == 1.12 21:47:54 INFO - mozcrash == 0.17 21:47:54 INFO - mozdebug == 0.1 21:47:54 INFO - mozdevice == 0.48 21:47:54 INFO - mozfile == 1.2 21:47:54 INFO - mozhttpd == 0.7 21:47:54 INFO - mozinfo == 0.9 21:47:54 INFO - mozleak == 0.1 21:47:54 INFO - mozlog == 3.2 21:47:54 INFO - moznetwork == 0.27 21:47:54 INFO - mozprocess == 0.22 21:47:54 INFO - mozprofile == 0.28 21:47:54 INFO - mozrunner == 6.11 21:47:54 INFO - mozscreenshot == 0.1 21:47:54 INFO - mozsystemmonitor == 0.3 21:47:54 INFO - moztest == 0.7 21:47:54 INFO - mozversion == 1.4 21:47:54 INFO - psutil == 3.1.1 21:47:54 INFO - requests == 1.2.3 21:47:54 INFO - wsgiref == 0.1.2 21:47:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:47: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')]} 21:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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')]} 21:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:54 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 0x10c4a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c536618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ff1d71a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c405d30>, '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 0x10c16adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fdb20>, '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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:47:54 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 21:47:54 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 21:47:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W1mDwB3fnx/Render', 21:47:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:54 INFO - 'HOME': '/Users/cltbld', 21:47:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:54 INFO - 'LOGNAME': 'cltbld', 21:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:54 INFO - 'MOZ_NO_REMOTE': '1', 21:47:54 INFO - 'NO_EM_RESTART': '1', 21:47:54 INFO - 'PAGER': '/bin/cat', 21:47:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:54 INFO - 'PWD': '/builds/slave/test', 21:47:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:54 INFO - 'SHELL': '/bin/bash', 21:47:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8e2UzFoHqA/Listeners', 21:47:54 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 21:47:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:54 INFO - 'USER': 'cltbld', 21:47:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:54 INFO - 'XPC_FLAGS': '0x0', 21:47:54 INFO - 'XPC_SERVICE_NAME': '0', 21:47:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:47:54 INFO - Cleaning up... 21:47:54 INFO - Return code: 0 21:47:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:47: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')]} 21:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47: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')]} 21:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c4a1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c536618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ff1d71a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c405d30>, '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 0x10c16adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fdb20>, '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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:47:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W1mDwB3fnx/Render', 21:47:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:47:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:47:54 INFO - 'HOME': '/Users/cltbld', 21:47:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:47:54 INFO - 'LOGNAME': 'cltbld', 21:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:47:54 INFO - 'MOZ_NO_REMOTE': '1', 21:47:54 INFO - 'NO_EM_RESTART': '1', 21:47:54 INFO - 'PAGER': '/bin/cat', 21:47:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:47:54 INFO - 'PWD': '/builds/slave/test', 21:47:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:47:54 INFO - 'SHELL': '/bin/bash', 21:47:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8e2UzFoHqA/Listeners', 21:47:54 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 21:47:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:47:54 INFO - 'USER': 'cltbld', 21:47:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:47:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:47:54 INFO - 'XPC_FLAGS': '0x0', 21:47:54 INFO - 'XPC_SERVICE_NAME': '0', 21:47:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:47:54 INFO - Cleaning up... 21:47:54 INFO - Return code: 0 21:47:54 INFO - Running post-action listener: _resource_record_post_action 21:47:54 INFO - Running post-action listener: _start_resource_monitoring 21:47:55 INFO - Starting resource monitoring. 21:47:55 INFO - ##### 21:47:55 INFO - ##### Finished create-virtualenv step (success) 21:47:55 INFO - ##### 21:47:55 INFO - ##### 21:47:55 INFO - ##### Running install step. 21:47:55 INFO - ##### 21:47:55 INFO - Running pre-action listener: _resource_record_pre_action 21:47:55 INFO - Running main action method: install 21:47:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:47:55 INFO - Reading from file tmpfile_stdout 21:47:55 INFO - Detecting whether we're running mozinstall >=1.0... 21:47:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:47:55 INFO - Reading from file tmpfile_stdout 21:47:55 INFO - Output received: 21:47:55 INFO - Usage: mozinstall [options] installer 21:47:55 INFO - Options: 21:47:55 INFO - -h, --help show this help message and exit 21:47:55 INFO - -d DEST, --destination=DEST 21:47:55 INFO - Directory to install application into. [default: 21:47:55 INFO - "/builds/slave/test"] 21:47:55 INFO - --app=APP Application being installed. [default: firefox] 21:47:55 INFO - mkdir: /builds/slave/test/build/application 21:47:55 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'] 21:47:55 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 21:48:30 INFO - Reading from file tmpfile_stdout 21:48:30 INFO - Output received: 21:48:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:48:30 INFO - Running post-action listener: _resource_record_post_action 21:48:30 INFO - ##### 21:48:30 INFO - ##### Finished install step (success) 21:48:30 INFO - ##### 21:48:30 INFO - ##### 21:48:30 INFO - ##### Running run-tests step. 21:48:30 INFO - ##### 21:48:30 INFO - Running pre-action listener: _resource_record_pre_action 21:48:30 INFO - Running main action method: run_tests 21:48:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:48:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:48:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:48:30 INFO - 2016-07-02 21:48:30.367 screenresolution[1924:12625] starting screenresolution argv=screenresolution get 21:48:30 INFO - 2016-07-02 21:48:30.369 screenresolution[1924:12625] Display 0: 1600x1200x32@60 21:48:30 INFO - 2016-07-02 21:48:30.376 screenresolution[1925:12627] starting screenresolution argv=screenresolution list 21:48:30 INFO - Available Modes on Display 0 21:48:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:48:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:48:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:48:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:48:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:48:30 INFO - Intel Iris: 21:48:30 INFO - Chipset Model: Intel Iris 21:48:30 INFO - Type: GPU 21:48:30 INFO - Bus: Built-In 21:48:30 INFO - VRAM (Dynamic, Max): 1536 MB 21:48:30 INFO - Vendor: Intel (0x8086) 21:48:30 INFO - Device ID: 0x0a2e 21:48:30 INFO - Revision ID: 0x0009 21:48:30 INFO - Displays: 21:48:30 INFO - Display: 21:48:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:48:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:48:30 INFO - Display Serial Number: 1600x1200 60 21:48:30 INFO - Main Display: Yes 21:48:30 INFO - Mirror: Off 21:48:30 INFO - Online: Yes 21:48:30 INFO - Rotation: Supported 21:48:30 INFO - Return code: 0 21:48:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:48:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:48:30 INFO - Python 2.7.3 21:48:30 INFO - Return code: 0 21:48:30 INFO - grabbing minidump binary from tooltool 21:48:30 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')]} 21:48:30 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 0x10c405d30>, '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 0x10c16adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:48:30 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 21:48:30 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 21:48:30 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 21:48:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:48:30 INFO - Return code: 0 21:48:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:48:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:48:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:48:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:48:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:48:30 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/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:48:30 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/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0321 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:48:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.W1mDwB3fnx/Render', 21:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:48:30 INFO - 'HOME': '/Users/cltbld', 21:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:48:30 INFO - 'LOGNAME': 'cltbld', 21:48:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:48:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:48:30 INFO - 'MOZ_NO_REMOTE': '1', 21:48:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:48:30 INFO - 'NO_EM_RESTART': '1', 21:48:30 INFO - 'PAGER': '/bin/cat', 21:48:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:48:30 INFO - 'PWD': '/builds/slave/test', 21:48:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:48:30 INFO - 'SHELL': '/bin/bash', 21:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8e2UzFoHqA/Listeners', 21:48:30 INFO - 'TMPDIR': '/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/', 21:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:48:30 INFO - 'USER': 'cltbld', 21:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:48:30 INFO - 'XPC_FLAGS': '0x0', 21:48:30 INFO - 'XPC_SERVICE_NAME': '0', 21:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:48:30 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/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0321', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:48:30 INFO - mozversion application_buildid: 20160702204822 21:48:30 INFO - mozversion application_changeset: c61101c15a280b078071fd130eba2dd5079d69c2 21:48:30 INFO - mozversion application_display_name: Nightly 21:48:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:48:30 INFO - mozversion application_name: Firefox 21:48:30 INFO - mozversion application_remotingname: firefox 21:48:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:48:30 INFO - mozversion application_vendor: Mozilla 21:48:30 INFO - mozversion application_version: 50.0a1 21:48:30 INFO - mozversion platform_buildid: 20160702204822 21:48:30 INFO - mozversion platform_changeset: c61101c15a280b078071fd130eba2dd5079d69c2 21:48:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:48:30 INFO - mozversion platform_version: 50.0a1 21:48:30 INFO - using testdate: 1467521310 21:48:30 INFO - actual date: 1467521310 21:48:30 INFO - starting webserver on 'localhost:49780' 21:48:30 INFO - SUITE-START | Running 2 tests 21:48:30 INFO - TEST-START | dromaeo_css 21:48:30 INFO - operating with platform_type : mac_ 21:48:30 INFO - Initialising browser for dromaeo_css test... 21:48:30 INFO - TEST-INFO | started process 1935 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpuh5p7K/profile http://localhost:49780/getInfo.html) 21:48:33 INFO - PROCESS | 1935 | __metrics Screen width/height:1600/1200 21:48:33 INFO - PROCESS | 1935 | colorDepth:24 21:48:33 INFO - PROCESS | 1935 | Browser inner width/height: 1024/689 21:48:33 INFO - PROCESS | 1935 | __metrics 21:48:33 INFO - PROCESS | 1935 | 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" 21:48:33 INFO - PROCESS | 1935 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:48:34 INFO - TEST-INFO | 1935: exit 0 21:48:34 INFO - Browser initialized. 21:48:34 INFO - Running cycle 1/1 for dromaeo_css test... 21:48:34 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmpuh5p7K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:48:46 INFO - PROCESS | 1937 | RSS: Main: 244858880 21:48:46 INFO - PROCESS | 1937 | 21:49:37 INFO - PROCESS | 1937 | 1467521377190 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] 21:51:48 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49780/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49780/tests/dromaeo/cssquery-ext.html) 21:51:49 INFO - PROCESS | 1937 | RSS: Main: 369762304 21:51:49 INFO - PROCESS | 1937 | 21:54:52 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49780/tests/dromaeo/cssquery-ext.html (next: http://localhost:49780/tests/dromaeo/cssquery-jquery.html) 21:54:53 INFO - PROCESS | 1937 | RSS: Main: 380461056 21:54:53 INFO - PROCESS | 1937 | 21:57:55 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49780/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49780/tests/dromaeo/cssquery-mootools.html) 21:57:56 INFO - PROCESS | 1937 | RSS: Main: 369987584 21:57:56 INFO - PROCESS | 1937 | 22:00:58 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49780/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49780/tests/dromaeo/cssquery-prototype.html) 22:00:59 INFO - PROCESS | 1937 | RSS: Main: 373583872 22:00:59 INFO - PROCESS | 1937 | 22:04:02 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49780/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49780/tests/dromaeo/cssquery-yui.html) 22:04:03 INFO - PROCESS | 1937 | RSS: Main: 337760256 22:04:03 INFO - PROCESS | 1937 | 22:07:06 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49780/tests/dromaeo/cssquery-yui.html (next: http://localhost:49780/tests/dromaeo/cssquery-dojo.html) 22:07:06 INFO - PROCESS | 1937 | RSS: Main: 382824448 22:07:06 INFO - PROCESS | 1937 | 22:07:06 INFO - PROCESS | 1937 | __start_tp_report 22:07:06 INFO - PROCESS | 1937 | _x_x_mozilla_page_load 22:07:06 INFO - PROCESS | 1937 | _x_x_mozilla_page_load_details 22:07:06 INFO - PROCESS | 1937 | |i|pagename|runs| 22:07:06 INFO - PROCESS | 1937 | |0;dojo.html;2856.8714407851644;2919.3869287449647;3404.3021180657965;3449.9310013799723;3464.861405543777;5613.129964855454;5675.5459563234945;5713.200151978726;5756.510696590794;5792.160136780164;5717.3139223293265;5764.481196692286;5840.824775256739;5841.007028805103;5870.765169393219;5184.818531351403;5189;5256.605754568403;5265.7893684252585;5275.180488868415;5329.200619907026;5357.276767636377;5373.435789242132;5385.461453854622;5411.648242864201;5176.12005958986;5237.162054071368;5240.266362709186;5276.3668359796875;5297.523222909918;5278.498542638443;5286.471352864722;5290.629655924048;5302.443243459458;5303.920441193347;5214.817481388133;5247;5250.684958902478;5257.605679574009;5264.184051472028;5715.228444160027;5738.282714660668;5742.08126699726;5867.237259156325;5885.176075349455;6175.166352542395;6217.937820621826;6243.87512249757;6267.4672652824565;6276.340984196685;6176.752929882799;6255.593386429868;6277;6288.591241569284;6292.433680968735;5821.883562328772;5854.975379308647;5865.5600829937075;5904.5571582131515;5920.881582368328;6331.968340158362;6355.713992870332;6383;6388.137601423841;6388.616682999035;6082.787102451482;6086.3185110131435;6218.284897236786;6232.781852635136;6246.469050130699;6197.442230199304;6240.063990401385;6251.6561589112125;6304.936950630527;6309.495240380758;6229.906551401733;6230.408111229426;6239.688015599202;6252.218472690914;6282.120503129566;6103.115048318058;6195.256569211723;6250.656213908279;6263.217097862767;6265.530085243625;4932.53140951609;4946.925796113062;4953.8266160684925;4976.576990955737;5044.798208071636;4469.7318160910445;4474.7762611869275;4480.731156130642;4488.9102217956115;4511.639068874482;5860.941390586125;5873.236479257755;5875.324337701134;5907.084401917709;5945.7621695132575;6158.476529495043;6193.287771906288;6223;6244.781432649836;6250.4374606285655;5830.125481177857;5834.183214349994;5848.444397782204;5860.531157507389;5892.322382925932;5432.103702888979;5477;5497.39528651848;5515.393306736256;5536.169574563848;6258.906116408258;6297.433231009231;6316.431521163117;6343.9365606343345;6350.90473642905;6250.124982502544;6252.749890004349;6262.812115636538;6268.623882567061;6281.246250449975;6385.233771947396;6393.264774550986;6415.166028416276;6419.261784894797;6427.357264273535;6060.696965151813;6066.939330606814;6093.664848433379;6113.719560719409;6148.723307451086;6268.529860260407;6281.497480201664;6308.936910630835;6309.400606942333;6330.177076980147;6194.473469755121;6202.751889924352;6208.906866397098;6211.9068213975925;6216.595921265103;5683.119116536944;5911.881762364815;6036.094585812163;6134.5590473767;6180.196574445294;6042.456178943916;6065.4541091302;6070.878582428415;6081.956430749656;6085.111892360268;6195.690215489298;6198.535109866688;6207.596506227081;6209.285932117864;6230.626162430269;5832.912506312324;5852.736626851887;5915.08316210988;6011.248593925759;6016.819495415145 22:07:06 INFO - PROCESS | 1937 | |1;ext.html;471.5214057731402;484.7115966000231;509.4167178580528;522.3027258609758;535.7891165964918;29476.41047179055;39861.80069099654;40706.38940415896;40750.57372991946;40929.38605920914;42358.94102647436;42720.35919461211;42803.571964280345;42805.57194428055;42831.78584107083;8482.745517634481;9466.526673666342;9624.422534647909;9635.277354198428;9701.272404569685;8584.356173286997;9538;11286.604968826092;11292.491837867316;11864.288142711464;11714.355710435922;11748.706282342924;11779.646610601696;11786.410679465993;11789.351585662786;8542.316614670812;11188.944055279753;11498.310101393943;11730.829796487635;11798.94100529496;10613.893861061368;11056.502457389437;11655.825162622568;11726.94136529312;11749.941250293694;40251.59748402537;40519.59480405188;40534.39198412026;40535.594644053475;40565.79717101425;3475.3570589440783;3478.478228265755;3533.805640689761;3539.2605686253164;4314.245007123772;30870.845645771627;31939.520907186412;32291.031269061965;32394;32517.349653006808;3129.436701393748;3265.9346813063844;3299.307145499448;3379.493076038589;3408.1479630092476;489370;490145;490783;491917;494251;33105.83447082749;57336;57606;57939;57955.551111221714;33570.32859342799;35566.11084722903;35588.46617300742;35614.10964725903;35697;14779.92610036943;14924.701505970037;14932.62668433298;14951.252437378305;15012.174330411932;11461.426928653535;11658.358790266617;11671.708207294885;11856.347900865536;12699.682507937376;7439.962800185965;7606.923930760621;7650.693972241048;7661.578613176329;7868.134505204537;3007.75178301007;3139.5918530591334;3252.495863141217;3267.983660081732;3268.9509657354683;901.3555307954844;954.4034978138664;955.6846240740539;959.8560215967522;969.1907257440116;24689.62965555518;29891;29972.70027299699;30334.69665303363;31059.844700776805;1023.3859684189426;1033.6847261585137;1121.6130434999911;1145.3185354713933;1164.9825252621217;15385.076895386313;15763;15899.686144373487;15903.204839757966;16060.75908861368;675591;679993;680974;681280;682390;57266.42733572611;58167;58182.418175818544;58204.41795582075;58460;1256.8051951947464;1298.448159532195;1377.042955146204;1403.3193900958026;1424.5939907126626;30691.079267622008;31387.84306078455;31734.206644834063;31969.840150799097;32264.83867580647;48890.75554622347;48999.26501102558;49472.75263623659;49615.50384496109;49675;462676;538158;538311.308443471;538851;539129;24107.517849642558;25924.35189120287;26430.471390571696;26813.195604131906;26909;47671;47753.28370074382;48222.758886205345;48743.75628121837;48800.5119948796;31275.84362078175;38641.8407447777;39565.2086958265;39632.801835990635;40872.978175545846;31021.68978310188;39045.414318785806;39344.80327598458;39913.40129897996;40217.1956560873;38225.23549529049;38511.422328664536;38733.418998715606;38800.80599596984;39063.80468097755;33995.49006764851;34287.65712342845;35166.64833351736;35183.472247915786;35195.82402087973;24126.75873241245;24502.142425015038;25439.43847861264;25699.486010279317;26181.367076045157 22:07:06 INFO - PROCESS | 1937 | |2;jquery.html;353.0784652058126;370.7997681252124;381.8816166988233;382.56196654830205;397.7355058885841;15640.687186256268;17012.82987170128;20618.278360257395;21989;22059.448513787163;20953.895230523827;21306.14775408982;21536.13855445784;21836.563268734615;22102.668459973112;5380.192971054334;6031.125486804422;6268.717907694142;6271.749130034793;6310.021946598285;6216.098665693472;6260.342664020258;6301.432871041606;6304.779332723356;6309.968450157743;5982.940170598304;6256.593321434115;6259.280182778971;6277;6289.496840252792;5086.702890762832;6037.913175628385;6186.164867742842;6220.7822726204595;6232.626042437469;4670.252759558454;5309.62832601718;5329.786808527654;5341.0920143575295;5345.33183352081;26506.86746566274;26910.73089269102;27224.727752722614;27260.04589839366;27267.727322726914;2137.273327068804;2182.2907555044517;2261.1746712450004;2286.8399212054996;2290.7480177180496;15316.693666126726;15733.606659833482;15860.92069539645;16204.574168581703;16321.183940802912;1480.489231215229;1857.990710046441;1861.926975064906;1875.024987006749;1884.1144662008835;123405;127084;127908;128473;129301;11029.283096598696;11184.944075279735;11407;11482.311061336346;11501.884981150082;13968.790468142986;14063.43746250159;14068.296585170701;14091.647708807363;14095.154290742588;8737.650493980169;8758.956205219061;8778.990416102102;8822.294216462667;9001;8908.554572271361;8940.195382415613;8945.507997060224;9040;9048.004719480852;6229.221347331583;6541.771038013647;6761.797146085625;6893.138357705287;6905.75829845953;1817.7546031285872;1862.320253107606;1864.4313484387392;1867;1867.6451474220125;718.3929579505414;905.3210092430677;952.8189643967762;967.066780556766;977.506359288569;22711.545769084856;22827.657585136236;23060.76939230586;23355.88322058379;23638;803.9829615536352;920.2453987729997;938.3197182043101;950.2160717408166;1001.9398836069859;11430.314181149157;12103.576374826838;12189.573364932185;12307.56923507673;12312.445939932546;627424.8628756827;627654.7569174337;632453;638682;647967.8820876722;107504;109612;113574.43212784048;114151.42924285325;122567;978.1832170138015;999.8300288950895;1015.7562185075528;1020.0717347213999;1023.7184774187158;16498;20247.59504809866;20342.084606193053;20420.89789551043;20489.48776280605;49216.26175607297;49225.52323430303;51985.22022169746;52170.47829521656;53349.46650533445;53000;72914.27085729074;77035.61482192553;77608;78123.60938195273;7152.570845749272;7435.33082022599;7467.850642987001;7660.463767536219;7670.463067585439;11874.287542747463;13129.474821007434;13363.3986470611;13447.529336473177;13645.727085458037;11432.828507572227;11435.313881167156;11626.941865290619;11630.185886987829;11728.589499367481;10842.132629389473;11055.72360690989;11446.542138314375;11472.426378680866;11647.825282620937;9356.95321523388;11780.70548236301;11839.112066594867;11904.583339583072;11915.821262680893;6851.931480685129;7433.739819106521;7444.478886478111;7493.775186744407;7697.692092316244;9947.403155810674;11121.943415375526;11364.602238921598;11454;11457.770844583229 22:07:06 INFO - PROCESS | 1937 | |3;mootools.html;1352.8511863694991;1494.4395851555666;1674.8157702652707;1854.5641774183073;1911.4743445552463;8540.444871083382;8877.467351958887;9074;9076.36465447418;9076.95461522693;7849.2543208395255;8157.265846073852;8390.874136887951;8631.69789057383;8839.292856571476;2321.1759825262;2351.564960482316;2352;2352.200251914349;2354.176038386568;2075.9273425430115;2322.2336628912503;2328.604137296664;2359.127122964497;2361.8464799787957;2120.416885356524;2293.3578597992587;2354.6468029795496;2358.575456417844;2376.025829409942;2297.0467256088705;2317.6523521471745;2324.476992676651;2328.7671232876746;2334.9299521014395;1990.5222746540726;2297.7127859017623;2325.4418939454577;2327.150590034625;2335.5795956727784;7829.569373684445;8931.285497160212;9083.818323633557;9098.272138228926;9098.545072746336;5296.947030529684;5473.28847249855;5475.178723191553;5485.204645326406;5497.065498865202;3508.15804206991;3601.6398360164035;3661.8169091545315;3676.1544844685873;3677.9264414711556;1032.8812186598561;1054.641421916552;1061.9150467962622;1073.822819234833;1081.5457507846645;11947.880521194851;12055.939720301343;12059.457324420422;12068.698282542919;12134.5752898649;4149.294619914622;4701.21972052345;4746.667733258639;4847.636427267969;4919.754012299442;10051.849222261671;10107.241956853266;10111.241656875764;10118.443485608363;10135.7466063349;5435.347758269033;5443.292371991616;5459.481349271813;5472.288602481652;5483;4974.353334066548;4999.725015124203;5014.222795466709;5019.0463811875625;5043.344365232496;4023.959760402417;4062.756234625932;4101.610347017028;4108.116754897652;4123.752574845519;1064.4677661169414;1180.1915687753917;1220.2922305063041;1279.9040071994639;1281.0968267371481;792.8612492813735;894.789724414762;909.3180114913814;927.1655510040882;957.2533423929347;5935.792247271411;6031.849203769853;6079.08813677943;6087.482563982023;6105.938940610626;897.2463130970017;922.3543519536352;942.7124726958207;961.4183419031525;966.4536741214142;3919.2945269851703;4047.453593764863;4073.022474606073;4115.6006957634545;4133.441985332001;10781.946090269656;10789.298695584763;11072.948069933344;11157.944210278896;11190.440477976068;9070.591823367964;9976.351537150062;11089.445527723581;11125.054370378446;11130.721731956604;7528.360089392353;7618.971438855794;7857.803554911173;8279.172082791672;8476.788080298165;6013.158157857816;6013.428724271187;6068.848278793065;6162.322144564184;6285.905711414424;10181.930897255977;10342.431166285625;10372.377657340583;10381.013803688638;10392.532336045047;10432.269741118353;10566.524506397383;10593.993570610779;10607.94696026515;10643.680689579325;7458.142313633784;7502.624868756649;7574.697012119454;7602.885956710765;7695.576743279174;8351.123132071045;8382.287505561852;8456.492610443393;8461.196186362286;8472.19514146155;7489.850202995801;7715.614219288901;7719.189485103983;7744.6902123914415;7868.134505204309;7502.212267711811;7579.658915348712;7587.810304742205;7718.768436946901;7752.651130699245;7080.787576372717;7120.572765634079;7156.821079472847;7158.964205179149;7173.569585824867;4854.19905715553;5048.7475626219275;5075.923861142012;5134.589232861287;5155.7164355959285;5096.694198348111;5114.948850511596;5223.268742375994;5225.954809038283;5283.603729720209 22:07:06 INFO - PROCESS | 1937 | |4;prototype.html;302.57488229038205;305.3465583650987;311.3182131132819;313.68004635272035;316.23628936119275;4345.369921361401;5033.874153146173;5306.336707911506;5333.626646134772;5346.599005074625;4697.412823397075;4811.783469743861;5220.112580861253;5258.2638430619745;5320.654157479771;3831.425286207077;3863.4784304118866;3991.1219531702977;4052.1895620875944;4117.197146556423;3203.567518385023;3342.830009496681;3734.9813250933707;3973.1656352165937;4097.180563887219;4003.1993601279714;4043.8786836394806;4047.372657238118;4053.310937140693;4079.2861249281405;3345.6654334566592;3795.8481660733537;3824.808759562011;4031.2945234583976;4063.7358571692744;2859.7140285971445;3062.3569050499423;3406.3017081498233;3486.477028445728;3515.3496603128247;5099.770510327045;5123.487651234884;5128.153854613985;5135.6148288878485;5173.249394189221;4430.844920427802;4538.411555955422;4619.591024737454;4627.699199552018;4632.490426053131;5478.698671573062;5486.259354987065;5504.779808807642;5527.861803454905;5531.819203957741;3904.570497245301;3904.6876249899938;3905.199434116028;3907.909268541345;3909.960900390988;4459.9331010034875;5060.645754797166;5825;5836;5897.587168898179;3164.905052848418;3338.8163650999427;3678.020803149404;3808.4858544096746;3868.0716628009077;3909.4917660703927;3927.9803600981813;3938.1729836734607;3939.1333906540517;3940.9605903941165;4539.75031373271;4554.931676024862;4563.589276965089;4588.564086411786;4593.885152871138;5190.6107041972;5300.680109772097;5498.780048798083;5565.972170139124;5594.804181853616;1297.2151848131932;1318.0773458579033;1321.5308565459316;1328.9534866279635;1329.8736620021082;765.7090305683804;781.4686013510753;783.3498196496894;810.7973006748313;821.6138414944967;4979.278004689372;5084.669496482717;5150.759419652463;5283.233931079972;5294.602904782157;5722.141678748221;5722.74247658848;5726.856828579319;5736.713164341766;5738.885222295614;4648.907021859612;4775.235962246094;5013.674111182834;5225.242339860699;5239.3234165066815;2732.426190500017;2975.3751712140693;2992.2818523554192;2996.4007198560375;3017;4978.950210497921;5820.700823174907;5879.618289701916;5958.463738263577;5982.371850955587;5539.41836107211;5579.38626751057;5834.912476312858;5848;5868.882622347614;4702.9764851176205;4938.320970869921;5003.724050367133;5409.648372855751;5616.1529352393745;5401.86626282624;5668.404817494104;5692;5720.91186716837;5753.252077229933;4673.6728429009645;4941.579965702812;5503.174523821459;5641.774329026793;5656.632318899258;5233.790648374023;5865.912011319919;5941.346451890375;5951.345352011189;5953.642781433128;3505.596856361449;3511.455724362728;3805.5813860474773;3810.7523011004196;3814.5231846019246;4636.791344389578;4955.851324460272;4999.800007999639;5603.607747457639;5661.207430959586;4473.575010374009;4744.762761861824;5184.870378240575;5389.757460914347;5410.540104091197;4136.896577585584;4603.026414981239;5044.899102018013;5387;5548.500634942875;4686.507916668701;5371.683937435353;5391.649542779707;5394.352677678704;5426.375966763872;4708.411448568929;5243.8164664236565;5404.7297635118875;5508.20131080983;5540.695261760642;4528.003839155513;4705.658887217127;5105.566026887607;5472.671639701631;5492.725363731877 22:07:06 INFO - PROCESS | 1937 | |5;yui.html;707.5188871567339;710.7405796884138;777.0558771093124;783.1376319552037;816.1185919207256;14323.355449004794;15394.538163855088;15420.228988550583;15437.922810385933;15524.456644017448;13749.381277842496;14276.214808185545;14446.422143114263;14452.205128717917;14466.421343146261;840.1850205300848;855.9315254779634;859.1580251353677;859.1580251353677;859.4327743689166;648.8280605639509;691.8028361916855;803.4295650088444;841.2428814067327;858.3390789092426;894.9886628110227;896.0680891872478;898.2768871058828;898.4519443139679;900.1223806788395;891.7324802559239;892.205936716323;892.7723430525207;893.0622846011727;893.4237416866117;500.9173486374744;621.4779585148452;667.8430568816324;669.4744625469032;669.6584741781727;14862.628434289229;14885.92557037208;14893;14903.105813651217;14930.62673433162;13842.653933651638;14273.214973176471;14319.928400358036;14407.639809004753;14446.49437269701;12841.165324253894;12898.87101128986;12991.285479298635;13089.083764136514;13469.595912122651;4567.634589232854;4571.451425828888;4605.83879564217;4780.593649539794;4793.089313030548;104742.47628761883;105149.474252629;105725.47137264264;106416.40375394376;108024.4598777009;10537.157027437786;10834;10887.455627218607;10962.835557466644;11120.332780033224;20932.267370641955;21022.47443813917;21246.681299780517;21273.574528509344;21284;7820.608969551499;7889.960550197327;7938.455120214192;8008.839823203503;8028.397870159762;4392.407025051641;4429.667774916894;4440.400545926259;4525.818967241274;4594.104149690778;3455.222574920673;3635.4365073413665;3638.1632224588493;3639.636036396339;3641.344557979536;674.6559254780097;684.6679360510149;690.6753825701912;697.013725578301;697.4106879686758;568.7753337431774;646.2955378637214;648.4812150279757;669.0326364657531;718.4144921888644;8931.240844528158;9083.137101975302;9237.676681316121;9404.24766018717;9470.431774093577;622.7446746833867;653.6796969484918;657.4411750012451;669.6484345718537;678.7149397253165;4415.867523974286;4640.23436133041;4672.813087476531;4693.990791979672;4795.808167673324;134759.93580288911;139399.30300348433;145413.27293363467;151269;157528;107792;107842.46078769713;108373;109538;117862.82137178519;101727;117570;117811.41094294474;118639.81360186287;120530.39734801445;8834.204921557091;8953.731388058368;8979.10208979123;9101.590428430603;9147.679831205876;58576;63223.367766321746;65309.34690653033;65968.34031659622;68175.65912170407;92844;93361;94887;96372;97106;13111.14777539457;13146.34268286601;13276.385118952749;13288.136271142344;13416.329183540589;14820.851791481948;14912.701745965236;14917.713854644473;14971.850281497482;15162.393504259706;13615.727685446038;13705.451781928612;13795.655108622364;14035.859641403864;14522;13903.721925561229;13925.23411212393;14141.36363863608;14176.149431034171;14340.713185736018;11456.94271528637;13451.46194152262;13610.843078338452;13775.724485510033;14132.293385330899;11314.886851131383;11514.712132196428;11634.767304653691;11710.12174086964;11980.820287695866;11156.497957591766;11272.549098035986;11539.134564907497;11648.359340236368;11990.640280791591 22:07:06 INFO - PROCESS | 1937 | __end_tp_report 22:07:06 INFO - PROCESS | 1937 | __start_cc_report 22:07:06 INFO - PROCESS | 1937 | _x_x_mozilla_cycle_collect,1399 22:07:06 INFO - PROCESS | 1937 | __end_cc_report 22:07:06 INFO - PROCESS | 1937 | __startTimestamp1467522426475__endTimestamp 22:07:06 INFO - PROCESS | 1937 | 22:07:06 INFO - PROCESS | 1937 | ------- Summary: start ------- 22:07:06 INFO - PROCESS | 1937 | Number of tests: 6 22:07:06 INFO - PROCESS | 1937 | 22:07:06 INFO - PROCESS | 1937 | [#0] dojo.html Cycles:165 Average:5795.08 Median:6036.09 stddev:653.02 (10.8%) stddev-sans-first:612.99 22:07:06 INFO - PROCESS | 1937 | Values: 2856.9 2919.4 3404.3 3449.9 3464.9 5613.1 5675.5 5713.2 5756.5 5792.2 5717.3 5764.5 5840.8 5841.0 5870.8 5184.8 5189.0 5256.6 5265.8 5275.2 5329.2 5357.3 5373.4 5385.5 5411.6 5176.1 5237.2 5240.3 5276.4 5297.5 5278.5 5286.5 5290.6 5302.4 5303.9 5214.8 5247.0 5250.7 5257.6 5264.2 5715.2 5738.3 5742.1 5867.2 5885.2 6175.2 6217.9 6243.9 6267.5 6276.3 6176.8 6255.6 6277.0 6288.6 6292.4 5821.9 5855.0 5865.6 5904.6 5920.9 6332.0 6355.7 6383.0 6388.1 6388.6 6082.8 6086.3 6218.3 6232.8 6246.5 6197.4 6240.1 6251.7 6304.9 6309.5 6229.9 6230.4 6239.7 6252.2 6282.1 6103.1 6195.3 6250.7 6263.2 6265.5 4932.5 4946.9 4953.8 4976.6 5044.8 4469.7 4474.8 4480.7 4488.9 4511.6 5860.9 5873.2 5875.3 5907.1 5945.8 6158.5 6193.3 6223.0 6244.8 6250.4 5830.1 5834.2 5848.4 5860.5 5892.3 5432.1 5477.0 5497.4 5515.4 5536.2 6258.9 6297.4 6316.4 6343.9 6350.9 6250.1 6252.7 6262.8 6268.6 6281.2 6385.2 6393.3 6415.2 6419.3 6427.4 6060.7 6066.9 6093.7 6113.7 6148.7 6268.5 6281.5 6308.9 6309.4 6330.2 6194.5 6202.8 6208.9 6211.9 6216.6 5683.1 5911.9 6036.1 6134.6 6180.2 6042.5 6065.5 6070.9 6082.0 6085.1 6195.7 6198.5 6207.6 6209.3 6230.6 5832.9 5852.7 5915.1 6011.2 6016.8 22:07:06 INFO - PROCESS | 1937 | 22:07:06 INFO - PROCESS | 1937 | [#1] ext.html Cycles:180 Average:68654.05 Median:19552.69 stddev:152938.30 (782.2%) stddev-sans-first:153281.65 22:07:06 INFO - PROCESS | 1937 | Values: 471.5 484.7 509.4 522.3 535.8 29476.4 39861.8 40706.4 40750.6 40929.4 42358.9 42720.4 42803.6 42805.6 42831.8 8482.7 9466.5 9624.4 9635.3 9701.3 8584.4 9538.0 11286.6 11292.5 11864.3 11714.4 11748.7 11779.6 11786.4 11789.4 8542.3 11188.9 11498.3 11730.8 11798.9 10613.9 11056.5 11655.8 11726.9 11749.9 40251.6 40519.6 40534.4 40535.6 40565.8 3475.4 3478.5 3533.8 3539.3 4314.2 30870.8 31939.5 32291.0 32394.0 32517.3 3129.4 3265.9 3299.3 3379.5 3408.1 489370.0 490145.0 490783.0 491917.0 494251.0 33105.8 57336.0 57606.0 57939.0 57955.6 33570.3 35566.1 35588.5 35614.1 35697.0 14779.9 14924.7 14932.6 14951.3 15012.2 11461.4 11658.4 11671.7 11856.3 12699.7 7440.0 7606.9 7650.7 7661.6 7868.1 3007.8 3139.6 3252.5 3268.0 3269.0 901.4 954.4 955.7 959.9 969.2 24689.6 29891.0 29972.7 30334.7 31059.8 1023.4 1033.7 1121.6 1145.3 1165.0 15385.1 15763.0 15899.7 15903.2 16060.8 675591.0 679993.0 680974.0 681280.0 682390.0 57266.4 58167.0 58182.4 58204.4 58460.0 1256.8 1298.4 1377.0 1403.3 1424.6 30691.1 31387.8 31734.2 31969.8 32264.8 48890.8 48999.3 49472.8 49615.5 49675.0 462676.0 538158.0 538311.3 538851.0 539129.0 24107.5 25924.4 26430.5 26813.2 26909.0 47671.0 47753.3 48222.8 48743.8 48800.5 31275.8 38641.8 39565.2 39632.8 40873.0 31021.7 39045.4 39344.8 39913.4 40217.2 38225.2 38511.4 38733.4 38800.8 39063.8 33995.5 34287.7 35166.6 35183.5 35195.8 24126.8 24502.1 25439.4 25699.5 26181.4 22:07:06 INFO - PROCESS | 1937 | 22:07:06 INFO - PROCESS | 1937 | [#2] jquery.html Cycles:180 Average:36085.34 Median:23496.94 stddev:105382.51 (448.5%) stddev-sans-first:105643.98 22:07:06 INFO - PROCESS | 1937 | Values: 353.1 370.8 381.9 382.6 397.7 15640.7 17012.8 20618.3 21989.0 22059.4 20953.9 21306.1 21536.1 21836.6 22102.7 5380.2 6031.1 6268.7 6271.7 6310.0 6216.1 6260.3 6301.4 6304.8 6310.0 5982.9 6256.6 6259.3 6277.0 6289.5 5086.7 6037.9 6186.2 6220.8 6232.6 4670.3 5309.6 5329.8 5341.1 5345.3 26506.9 26910.7 27224.7 27260.0 27267.7 2137.3 2182.3 2261.2 2286.8 2290.7 15316.7 15733.6 15860.9 16204.6 16321.2 1480.5 1858.0 1861.9 1875.0 1884.1 123405.0 127084.0 127908.0 128473.0 129301.0 11029.3 11184.9 11407.0 11482.3 11501.9 13968.8 14063.4 14068.3 14091.6 14095.2 8737.7 8759.0 8779.0 8822.3 9001.0 8908.6 8940.2 8945.5 9040.0 9048.0 6229.2 6541.8 6761.8 6893.1 6905.8 1817.8 1862.3 1864.4 1867.0 1867.6 718.4 905.3 952.8 967.1 977.5 22711.5 22827.7 23060.8 23355.9 23638.0 804.0 920.2 938.3 950.2 1001.9 11430.3 12103.6 12189.6 12307.6 12312.4 627424.9 627654.8 632453.0 638682.0 647967.9 107504.0 109612.0 113574.4 114151.4 122567.0 978.2 999.8 1015.8 1020.1 1023.7 16498.0 20247.6 20342.1 20420.9 20489.5 49216.3 49225.5 51985.2 52170.5 53349.5 53000.0 72914.3 77035.6 77608.0 78123.6 7152.6 7435.3 7467.9 7660.5 7670.5 11874.3 13129.5 13363.4 13447.5 13645.7 11432.8 11435.3 11626.9 11630.2 11728.6 10842.1 11055.7 11446.5 11472.4 11647.8 9357.0 11780.7 11839.1 11904.6 11915.8 6851.9 7433.7 7444.5 7493.8 7697.7 9947.4 11121.9 11364.6 11454.0 11457.8 22:07:06 INFO - PROCESS | 1937 | 22:07:06 INFO - PROCESS | 1937 | [#3] mootools.html Cycles:180 Average:5808.07 Median:5006.97 stddev:3274.14 (65.4%) stddev-sans-first:3266.20 22:07:06 INFO - PROCESS | 1937 | Values: 1352.9 1494.4 1674.8 1854.6 1911.5 8540.4 8877.5 9074.0 9076.4 9077.0 7849.3 8157.3 8390.9 8631.7 8839.3 2321.2 2351.6 2352.0 2352.2 2354.2 2075.9 2322.2 2328.6 2359.1 2361.8 2120.4 2293.4 2354.6 2358.6 2376.0 2297.0 2317.7 2324.5 2328.8 2334.9 1990.5 2297.7 2325.4 2327.2 2335.6 7829.6 8931.3 9083.8 9098.3 9098.5 5296.9 5473.3 5475.2 5485.2 5497.1 3508.2 3601.6 3661.8 3676.2 3677.9 1032.9 1054.6 1061.9 1073.8 1081.5 11947.9 12055.9 12059.5 12068.7 12134.6 4149.3 4701.2 4746.7 4847.6 4919.8 10051.8 10107.2 10111.2 10118.4 10135.7 5435.3 5443.3 5459.5 5472.3 5483.0 4974.4 4999.7 5014.2 5019.0 5043.3 4024.0 4062.8 4101.6 4108.1 4123.8 1064.5 1180.2 1220.3 1279.9 1281.1 792.9 894.8 909.3 927.2 957.3 5935.8 6031.8 6079.1 6087.5 6105.9 897.2 922.4 942.7 961.4 966.5 3919.3 4047.5 4073.0 4115.6 4133.4 10781.9 10789.3 11072.9 11157.9 11190.4 9070.6 9976.4 11089.4 11125.1 11130.7 7528.4 7619.0 7857.8 8279.2 8476.8 6013.2 6013.4 6068.8 6162.3 6285.9 10181.9 10342.4 10372.4 10381.0 10392.5 10432.3 10566.5 10594.0 10607.9 10643.7 7458.1 7502.6 7574.7 7602.9 7695.6 8351.1 8382.3 8456.5 8461.2 8472.2 7489.9 7715.6 7719.2 7744.7 7868.1 7502.2 7579.7 7587.8 7718.8 7752.7 7080.8 7120.6 7156.8 7159.0 7173.6 4854.2 5048.7 5075.9 5134.6 5155.7 5096.7 5114.9 5223.3 5226.0 5283.6 22:07:06 INFO - PROCESS | 1937 | 22:07:06 INFO - PROCESS | 1937 | [#4] prototype.html Cycles:180 Average:4442.17 Median:4979.11 stddev:1367.16 (27.5%) stddev-sans-first:1335.22 22:07:06 INFO - PROCESS | 1937 | Values: 302.6 305.3 311.3 313.7 316.2 4345.4 5033.9 5306.3 5333.6 5346.6 4697.4 4811.8 5220.1 5258.3 5320.7 3831.4 3863.5 3991.1 4052.2 4117.2 3203.6 3342.8 3735.0 3973.2 4097.2 4003.2 4043.9 4047.4 4053.3 4079.3 3345.7 3795.8 3824.8 4031.3 4063.7 2859.7 3062.4 3406.3 3486.5 3515.3 5099.8 5123.5 5128.2 5135.6 5173.2 4430.8 4538.4 4619.6 4627.7 4632.5 5478.7 5486.3 5504.8 5527.9 5531.8 3904.6 3904.7 3905.2 3907.9 3910.0 4459.9 5060.6 5825.0 5836.0 5897.6 3164.9 3338.8 3678.0 3808.5 3868.1 3909.5 3928.0 3938.2 3939.1 3941.0 4539.8 4554.9 4563.6 4588.6 4593.9 5190.6 5300.7 5498.8 5566.0 5594.8 1297.2 1318.1 1321.5 1329.0 1329.9 765.7 781.5 783.3 810.8 821.6 4979.3 5084.7 5150.8 5283.2 5294.6 5722.1 5722.7 5726.9 5736.7 5738.9 4648.9 4775.2 5013.7 5225.2 5239.3 2732.4 2975.4 2992.3 2996.4 3017.0 4979.0 5820.7 5879.6 5958.5 5982.4 5539.4 5579.4 5834.9 5848.0 5868.9 4703.0 4938.3 5003.7 5409.6 5616.2 5401.9 5668.4 5692.0 5720.9 5753.3 4673.7 4941.6 5503.2 5641.8 5656.6 5233.8 5865.9 5941.3 5951.3 5953.6 3505.6 3511.5 3805.6 3810.8 3814.5 4636.8 4955.9 4999.8 5603.6 5661.2 4473.6 4744.8 5184.9 5389.8 5410.5 4136.9 4603.0 5044.9 5387.0 5548.5 4686.5 5371.7 5391.6 5394.4 5426.4 4708.4 5243.8 5404.7 5508.2 5540.7 4528.0 4705.7 5105.6 5472.7 5492.7 22:07:06 INFO - PROCESS | 1937 | 22:07:06 INFO - PROCESS | 1937 | [#5] yui.html Cycles:180 Average:24531.61 Median:3545.33 stddev:38354.92 (1081.8%) stddev-sans-first:38420.80 22:07:06 INFO - PROCESS | 1937 | Values: 707.5 710.7 777.1 783.1 816.1 14323.4 15394.5 15420.2 15437.9 15524.5 13749.4 14276.2 14446.4 14452.2 14466.4 840.2 855.9 859.2 859.2 859.4 648.8 691.8 803.4 841.2 858.3 895.0 896.1 898.3 898.5 900.1 891.7 892.2 892.8 893.1 893.4 500.9 621.5 667.8 669.5 669.7 14862.6 14885.9 14893.0 14903.1 14930.6 13842.7 14273.2 14319.9 14407.6 14446.5 12841.2 12898.9 12991.3 13089.1 13469.6 4567.6 4571.5 4605.8 4780.6 4793.1 104742.5 105149.5 105725.5 106416.4 108024.5 10537.2 10834.0 10887.5 10962.8 11120.3 20932.3 21022.5 21246.7 21273.6 21284.0 7820.6 7890.0 7938.5 8008.8 8028.4 4392.4 4429.7 4440.4 4525.8 4594.1 3455.2 3635.4 3638.2 3639.6 3641.3 674.7 684.7 690.7 697.0 697.4 568.8 646.3 648.5 669.0 718.4 8931.2 9083.1 9237.7 9404.2 9470.4 622.7 653.7 657.4 669.6 678.7 4415.9 4640.2 4672.8 4694.0 4795.8 134759.9 139399.3 145413.3 151269.0 157528.0 107792.0 107842.5 108373.0 109538.0 117862.8 101727.0 117570.0 117811.4 118639.8 120530.4 8834.2 8953.7 8979.1 9101.6 9147.7 58576.0 63223.4 65309.3 65968.3 68175.7 92844.0 93361.0 94887.0 96372.0 97106.0 13111.1 13146.3 13276.4 13288.1 13416.3 14820.9 14912.7 14917.7 14971.9 15162.4 13615.7 13705.5 13795.7 14035.9 14522.0 13903.7 13925.2 14141.4 14176.1 14340.7 11456.9 13451.5 13610.8 13775.7 14132.3 11314.9 11514.7 11634.8 11710.1 11980.8 11156.5 11272.5 11539.1 11648.4 11990.6 22:07:06 INFO - PROCESS | 1937 | -------- Summary: end -------- 22:07:06 INFO - PROCESS | 1937 | 22:07:07 INFO - TEST-INFO | 1937: exit 0 22:07:07 INFO - TEST-OK | dromaeo_css | took 1116101ms 22:07:07 INFO - TEST-START | kraken 22:07:07 INFO - operating with platform_type : mac_ 22:07:07 INFO - Initialising browser for kraken test... 22:07:07 INFO - TEST-INFO | started process 1942 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmptTisJL/profile http://localhost:49780/getInfo.html) 22:07:09 INFO - PROCESS | 1942 | __metrics Screen width/height:1600/1200 22:07:09 INFO - PROCESS | 1942 | colorDepth:24 22:07:09 INFO - PROCESS | 1942 | Browser inner width/height: 1024/689 22:07:09 INFO - PROCESS | 1942 | __metrics 22:07:09 INFO - PROCESS | 1942 | 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" 22:07:09 INFO - PROCESS | 1942 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:07:10 INFO - TEST-INFO | 1942: exit 0 22:07:10 INFO - Browser initialized. 22:07:10 INFO - Running cycle 1/1 for kraken test... 22:07:10 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/tmptTisJL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:07:22 INFO - PROCESS | 1943 | RSS: Main: 244858880 22:07:22 INFO - PROCESS | 1943 | 22:07:24 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49780/tests/kraken/driver.html?testName=audio-beat-detection) 22:07:25 INFO - PROCESS | 1943 | RSS: Main: 294805504 22:07:25 INFO - PROCESS | 1943 | 22:07:28 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49780/tests/kraken/driver.html?testName=audio-dft) 22:07:29 INFO - PROCESS | 1943 | RSS: Main: 304771072 22:07:29 INFO - PROCESS | 1943 | 22:07:32 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49780/tests/kraken/driver.html?testName=audio-fft) 22:07:33 INFO - PROCESS | 1943 | RSS: Main: 388747264 22:07:33 INFO - PROCESS | 1943 | 22:07:35 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49780/tests/kraken/driver.html?testName=audio-oscillator) 22:07:35 INFO - PROCESS | 1943 | RSS: Main: 290566144 22:07:35 INFO - PROCESS | 1943 | 22:07:37 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49780/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:07:38 INFO - PROCESS | 1943 | RSS: Main: 294146048 22:07:38 INFO - PROCESS | 1943 | 22:07:41 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49780/tests/kraken/driver.html?testName=imaging-darkroom) 22:07:41 INFO - PROCESS | 1943 | RSS: Main: 331296768 22:07:41 INFO - PROCESS | 1943 | 22:07:44 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49780/tests/kraken/driver.html?testName=imaging-desaturate) 22:07:45 INFO - PROCESS | 1943 | RSS: Main: 333651968 22:07:45 INFO - PROCESS | 1943 | 22:07:48 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49780/tests/kraken/driver.html?testName=json-parse-financial) 22:07:48 INFO - PROCESS | 1943 | RSS: Main: 331300864 22:07:48 INFO - PROCESS | 1943 | 22:07:50 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49780/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:07:50 INFO - PROCESS | 1943 | RSS: Main: 312090624 22:07:50 INFO - PROCESS | 1943 | 22:07:52 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:07:53 INFO - PROCESS | 1943 | RSS: Main: 318427136 22:07:53 INFO - PROCESS | 1943 | 22:07:55 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:07:56 INFO - PROCESS | 1943 | RSS: Main: 316919808 22:07:56 INFO - PROCESS | 1943 | 22:07:59 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:07:59 INFO - PROCESS | 1943 | RSS: Main: 326225920 22:07:59 INFO - PROCESS | 1943 | 22:08:02 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:08:03 INFO - PROCESS | 1943 | RSS: Main: 328216576 22:08:03 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49780/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49780/tests/kraken/driver.html?testName=ai-astar) 22:08:05 INFO - PROCESS | 1943 | RSS: Main: 371646464 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | __start_tp_report 22:08:05 INFO - PROCESS | 1943 | _x_x_mozilla_page_load 22:08:05 INFO - PROCESS | 1943 | _x_x_mozilla_page_load_details 22:08:05 INFO - PROCESS | 1943 | |i|pagename|runs| 22:08:05 INFO - PROCESS | 1943 | |0;ai-astar;100;111;112;110;111;111;112;112;112;113 22:08:05 INFO - PROCESS | 1943 | |1;audio-beat-detection;145;107;109;174;107;98;158;137;179;106 22:08:05 INFO - PROCESS | 1943 | |2;audio-dft;181;183;186;185;181;184;179;180;180;181 22:08:05 INFO - PROCESS | 1943 | |3;audio-fft;79;74;58;108;58;57;60;67;97;56 22:08:05 INFO - PROCESS | 1943 | |4;audio-oscillator;84;87;92;70;73;69;97;70;68;102 22:08:05 INFO - PROCESS | 1943 | |5;imaging-gaussian-blur;87;85;87;83;87;84;88;85;88;84 22:08:05 INFO - PROCESS | 1943 | |6;imaging-darkroom;117;150;94;95;94;94;94;95;94;94 22:08:05 INFO - PROCESS | 1943 | |7;imaging-desaturate;86;86;86;85;83;85;86;85;83;85 22:08:05 INFO - PROCESS | 1943 | |8;json-parse-financial;56;56;57;54;54;54;55;54;54;56 22:08:05 INFO - PROCESS | 1943 | |9;json-stringify-tinderbox;65;76;64;76;70;69;69;70;69;70 22:08:05 INFO - PROCESS | 1943 | |10;stanford-crypto-aes;83;82;81;82;85;81;83;86;83;83 22:08:05 INFO - PROCESS | 1943 | |11;stanford-crypto-ccm;134;136;138;135;134;132;153;148;240;163 22:08:05 INFO - PROCESS | 1943 | |12;stanford-crypto-pbkdf2;162;161;157;217;175;163;161;163;161;161 22:08:05 INFO - PROCESS | 1943 | |13;stanford-crypto-sha256-iterative;67;66;69;67;66;64;66;63;65;66 22:08:05 INFO - PROCESS | 1943 | __end_tp_report 22:08:05 INFO - PROCESS | 1943 | __start_cc_report 22:08:05 INFO - PROCESS | 1943 | _x_x_mozilla_cycle_collect,2089 22:08:05 INFO - PROCESS | 1943 | __end_cc_report 22:08:05 INFO - PROCESS | 1943 | __startTimestamp1467522485337__endTimestamp 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | ------- Summary: start ------- 22:08:05 INFO - PROCESS | 1943 | Number of tests: 14 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#0] ai-astar Cycles:10 Average:110.40 Median:112.00 stddev:3.75 (3.3%) stddev-sans-first:0.88 22:08:05 INFO - PROCESS | 1943 | Values: 100.0 111.0 112.0 110.0 111.0 111.0 112.0 112.0 112.0 113.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:151.50 stddev:30.65 (20.2%) stddev-sans-first:32.14 22:08:05 INFO - PROCESS | 1943 | Values: 145.0 107.0 109.0 174.0 107.0 98.0 158.0 137.0 179.0 106.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#2] audio-dft Cycles:10 Average:182.00 Median:182.00 stddev:2.36 (1.3%) stddev-sans-first:2.47 22:08:05 INFO - PROCESS | 1943 | Values: 181.0 183.0 186.0 185.0 181.0 184.0 179.0 180.0 180.0 181.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#3] audio-fft Cycles:10 Average:71.40 Median:63.50 stddev:18.30 (28.8%) stddev-sans-first:19.20 22:08:05 INFO - PROCESS | 1943 | Values: 79.0 74.0 58.0 108.0 58.0 57.0 60.0 67.0 97.0 56.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#4] audio-oscillator Cycles:10 Average:81.20 Median:78.50 stddev:12.83 (16.3%) stddev-sans-first:13.57 22:08:05 INFO - PROCESS | 1943 | Values: 84.0 87.0 92.0 70.0 73.0 69.0 97.0 70.0 68.0 102.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:1.81 (2.1%) stddev-sans-first:1.87 22:08:05 INFO - PROCESS | 1943 | Values: 87.0 85.0 87.0 83.0 87.0 84.0 88.0 85.0 88.0 84.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#6] imaging-darkroom Cycles:10 Average:102.10 Median:94.00 stddev:18.29 (19.5%) stddev-sans-first:18.59 22:08:05 INFO - PROCESS | 1943 | Values: 117.0 150.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.50 stddev:1.15 (1.4%) stddev-sans-first:1.17 22:08:05 INFO - PROCESS | 1943 | Values: 86.0 86.0 86.0 85.0 83.0 85.0 86.0 85.0 83.0 85.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:1.15 (2.1%) stddev-sans-first:1.17 22:08:05 INFO - PROCESS | 1943 | Values: 56.0 56.0 57.0 54.0 54.0 54.0 55.0 54.0 54.0 56.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.00 stddev:3.88 (5.5%) stddev-sans-first:3.71 22:08:05 INFO - PROCESS | 1943 | Values: 65.0 76.0 64.0 76.0 70.0 69.0 69.0 70.0 69.0 70.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.60 (1.9%) stddev-sans-first:1.69 22:08:05 INFO - PROCESS | 1943 | Values: 83.0 82.0 81.0 82.0 85.0 81.0 83.0 86.0 83.0 83.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:143.00 stddev:32.77 (22.9%) stddev-sans-first:34.16 22:08:05 INFO - PROCESS | 1943 | Values: 134.0 136.0 138.0 135.0 134.0 132.0 153.0 148.0 240.0 163.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:162.50 stddev:17.80 (11.0%) stddev-sans-first:18.75 22:08:05 INFO - PROCESS | 1943 | Values: 162.0 161.0 157.0 217.0 175.0 163.0 161.0 163.0 161.0 161.0 22:08:05 INFO - PROCESS | 1943 | 22:08:05 INFO - PROCESS | 1943 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.66 (2.5%) stddev-sans-first:1.72 22:08:05 INFO - PROCESS | 1943 | Values: 67.0 66.0 69.0 67.0 66.0 64.0 66.0 63.0 65.0 66.0 22:08:05 INFO - PROCESS | 1943 | -------- Summary: end -------- 22:08:05 INFO - PROCESS | 1943 | 22:08:06 INFO - TEST-INFO | 1943: exit 0 22:08:06 INFO - TEST-OK | kraken | took 59121ms 22:08:06 INFO - SUITE-END | took 1175s 22:08:06 INFO - Completed test suite (00:19:35) 22:08:06 INFO - javascript benchmark 22:08:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2856.8714407851644, 2919.3869287449647, 3404.3021180657965, 3449.9310013799723, 3464.861405543777, 5613.129964855454, 5675.5459563234945, 5713.200151978726, 5756.510696590794, 5792.160136780164, 5717.3139223293265, 5764.481196692286, 5840.824775256739, 5841.007028805103, 5870.765169393219, 5184.818531351403, 5189.0, 5256.605754568403, 5265.7893684252585, 5275.180488868415, 5329.200619907026, 5357.276767636377, 5373.435789242132, 5385.461453854622, 5411.648242864201, 5176.12005958986, 5237.162054071368, 5240.266362709186, 5276.3668359796875, 5297.523222909918, 5278.498542638443, 5286.471352864722, 5290.629655924048, 5302.443243459458, 5303.920441193347, 5214.817481388133, 5247.0, 5250.684958902478, 5257.605679574009, 5264.184051472028, 5715.228444160027, 5738.282714660668, 5742.08126699726, 5867.237259156325, 5885.176075349455, 6175.166352542395, 6217.937820621826, 6243.87512249757, 6267.4672652824565, 6276.340984196685, 6176.752929882799, 6255.593386429868, 6277.0, 6288.591241569284, 6292.433680968735, 5821.883562328772, 5854.975379308647, 5865.5600829937075, 5904.5571582131515, 5920.881582368328, 6331.968340158362, 6355.713992870332, 6383.0, 6388.137601423841, 6388.616682999035, 6082.787102451482, 6086.3185110131435, 6218.284897236786, 6232.781852635136, 6246.469050130699, 6197.442230199304, 6240.063990401385, 6251.6561589112125, 6304.936950630527, 6309.495240380758, 6229.906551401733, 6230.408111229426, 6239.688015599202, 6252.218472690914, 6282.120503129566, 6103.115048318058, 6195.256569211723, 6250.656213908279, 6263.217097862767, 6265.530085243625, 4932.53140951609, 4946.925796113062, 4953.8266160684925, 4976.576990955737, 5044.798208071636, 4469.7318160910445, 4474.7762611869275, 4480.731156130642, 4488.9102217956115, 4511.639068874482, 5860.941390586125, 5873.236479257755, 5875.324337701134, 5907.084401917709, 5945.7621695132575, 6158.476529495043, 6193.287771906288, 6223.0, 6244.781432649836, 6250.4374606285655, 5830.125481177857, 5834.183214349994, 5848.444397782204, 5860.531157507389, 5892.322382925932, 5432.103702888979, 5477.0, 5497.39528651848, 5515.393306736256, 5536.169574563848, 6258.906116408258, 6297.433231009231, 6316.431521163117, 6343.9365606343345, 6350.90473642905, 6250.124982502544, 6252.749890004349, 6262.812115636538, 6268.623882567061, 6281.246250449975, 6385.233771947396, 6393.264774550986, 6415.166028416276, 6419.261784894797, 6427.357264273535, 6060.696965151813, 6066.939330606814, 6093.664848433379, 6113.719560719409, 6148.723307451086, 6268.529860260407, 6281.497480201664, 6308.936910630835, 6309.400606942333, 6330.177076980147, 6194.473469755121, 6202.751889924352, 6208.906866397098, 6211.9068213975925, 6216.595921265103, 5683.119116536944, 5911.881762364815, 6036.094585812163, 6134.5590473767, 6180.196574445294, 6042.456178943916, 6065.4541091302, 6070.878582428415, 6081.956430749656, 6085.111892360268, 6195.690215489298, 6198.535109866688, 6207.596506227081, 6209.285932117864, 6230.626162430269, 5832.912506312324, 5852.736626851887, 5915.08316210988, 6011.248593925759, 6016.819495415145], "value": 5750.4635898148035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.5214057731402, 484.7115966000231, 509.4167178580528, 522.3027258609758, 535.7891165964918, 29476.41047179055, 39861.80069099654, 40706.38940415896, 40750.57372991946, 40929.38605920914, 42358.94102647436, 42720.35919461211, 42803.571964280345, 42805.57194428055, 42831.78584107083, 8482.745517634481, 9466.526673666342, 9624.422534647909, 9635.277354198428, 9701.272404569685, 8584.356173286997, 9538.0, 11286.604968826092, 11292.491837867316, 11864.288142711464, 11714.355710435922, 11748.706282342924, 11779.646610601696, 11786.410679465993, 11789.351585662786, 8542.316614670812, 11188.944055279753, 11498.310101393943, 11730.829796487635, 11798.94100529496, 10613.893861061368, 11056.502457389437, 11655.825162622568, 11726.94136529312, 11749.941250293694, 40251.59748402537, 40519.59480405188, 40534.39198412026, 40535.594644053475, 40565.79717101425, 3475.3570589440783, 3478.478228265755, 3533.805640689761, 3539.2605686253164, 4314.245007123772, 30870.845645771627, 31939.520907186412, 32291.031269061965, 32394.0, 32517.349653006808, 3129.436701393748, 3265.9346813063844, 3299.307145499448, 3379.493076038589, 3408.1479630092476, 489370.0, 490145.0, 490783.0, 491917.0, 494251.0, 33105.83447082749, 57336.0, 57606.0, 57939.0, 57955.551111221714, 33570.32859342799, 35566.11084722903, 35588.46617300742, 35614.10964725903, 35697.0, 14779.92610036943, 14924.701505970037, 14932.62668433298, 14951.252437378305, 15012.174330411932, 11461.426928653535, 11658.358790266617, 11671.708207294885, 11856.347900865536, 12699.682507937376, 7439.962800185965, 7606.923930760621, 7650.693972241048, 7661.578613176329, 7868.134505204537, 3007.75178301007, 3139.5918530591334, 3252.495863141217, 3267.983660081732, 3268.9509657354683, 901.3555307954844, 954.4034978138664, 955.6846240740539, 959.8560215967522, 969.1907257440116, 24689.62965555518, 29891.0, 29972.70027299699, 30334.69665303363, 31059.844700776805, 1023.3859684189426, 1033.6847261585137, 1121.6130434999911, 1145.3185354713933, 1164.9825252621217, 15385.076895386313, 15763.0, 15899.686144373487, 15903.204839757966, 16060.75908861368, 675591.0, 679993.0, 680974.0, 681280.0, 682390.0, 57266.42733572611, 58167.0, 58182.418175818544, 58204.41795582075, 58460.0, 1256.8051951947464, 1298.448159532195, 1377.042955146204, 1403.3193900958026, 1424.5939907126626, 30691.079267622008, 31387.84306078455, 31734.206644834063, 31969.840150799097, 32264.83867580647, 48890.75554622347, 48999.26501102558, 49472.75263623659, 49615.50384496109, 49675.0, 462676.0, 538158.0, 538311.308443471, 538851.0, 539129.0, 24107.517849642558, 25924.35189120287, 26430.471390571696, 26813.195604131906, 26909.0, 47671.0, 47753.28370074382, 48222.758886205345, 48743.75628121837, 48800.5119948796, 31275.84362078175, 38641.8407447777, 39565.2086958265, 39632.801835990635, 40872.978175545846, 31021.68978310188, 39045.414318785806, 39344.80327598458, 39913.40129897996, 40217.1956560873, 38225.23549529049, 38511.422328664536, 38733.418998715606, 38800.80599596984, 39063.80468097755, 33995.49006764851, 34287.65712342845, 35166.64833351736, 35183.472247915786, 35195.82402087973, 24126.75873241245, 24502.142425015038, 25439.43847861264, 25699.486010279317, 26181.367076045157], "value": 18929.543117977413, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.0784652058126, 370.7997681252124, 381.8816166988233, 382.56196654830205, 397.7355058885841, 15640.687186256268, 17012.82987170128, 20618.278360257395, 21989.0, 22059.448513787163, 20953.895230523827, 21306.14775408982, 21536.13855445784, 21836.563268734615, 22102.668459973112, 5380.192971054334, 6031.125486804422, 6268.717907694142, 6271.749130034793, 6310.021946598285, 6216.098665693472, 6260.342664020258, 6301.432871041606, 6304.779332723356, 6309.968450157743, 5982.940170598304, 6256.593321434115, 6259.280182778971, 6277.0, 6289.496840252792, 5086.702890762832, 6037.913175628385, 6186.164867742842, 6220.7822726204595, 6232.626042437469, 4670.252759558454, 5309.62832601718, 5329.786808527654, 5341.0920143575295, 5345.33183352081, 26506.86746566274, 26910.73089269102, 27224.727752722614, 27260.04589839366, 27267.727322726914, 2137.273327068804, 2182.2907555044517, 2261.1746712450004, 2286.8399212054996, 2290.7480177180496, 15316.693666126726, 15733.606659833482, 15860.92069539645, 16204.574168581703, 16321.183940802912, 1480.489231215229, 1857.990710046441, 1861.926975064906, 1875.024987006749, 1884.1144662008835, 123405.0, 127084.0, 127908.0, 128473.0, 129301.0, 11029.283096598696, 11184.944075279735, 11407.0, 11482.311061336346, 11501.884981150082, 13968.790468142986, 14063.43746250159, 14068.296585170701, 14091.647708807363, 14095.154290742588, 8737.650493980169, 8758.956205219061, 8778.990416102102, 8822.294216462667, 9001.0, 8908.554572271361, 8940.195382415613, 8945.507997060224, 9040.0, 9048.004719480852, 6229.221347331583, 6541.771038013647, 6761.797146085625, 6893.138357705287, 6905.75829845953, 1817.7546031285872, 1862.320253107606, 1864.4313484387392, 1867.0, 1867.6451474220125, 718.3929579505414, 905.3210092430677, 952.8189643967762, 967.066780556766, 977.506359288569, 22711.545769084856, 22827.657585136236, 23060.76939230586, 23355.88322058379, 23638.0, 803.9829615536352, 920.2453987729997, 938.3197182043101, 950.2160717408166, 1001.9398836069859, 11430.314181149157, 12103.576374826838, 12189.573364932185, 12307.56923507673, 12312.445939932546, 627424.8628756827, 627654.7569174337, 632453.0, 638682.0, 647967.8820876722, 107504.0, 109612.0, 113574.43212784048, 114151.42924285325, 122567.0, 978.1832170138015, 999.8300288950895, 1015.7562185075528, 1020.0717347213999, 1023.7184774187158, 16498.0, 20247.59504809866, 20342.084606193053, 20420.89789551043, 20489.48776280605, 49216.26175607297, 49225.52323430303, 51985.22022169746, 52170.47829521656, 53349.46650533445, 53000.0, 72914.27085729074, 77035.61482192553, 77608.0, 78123.60938195273, 7152.570845749272, 7435.33082022599, 7467.850642987001, 7660.463767536219, 7670.463067585439, 11874.287542747463, 13129.474821007434, 13363.3986470611, 13447.529336473177, 13645.727085458037, 11432.828507572227, 11435.313881167156, 11626.941865290619, 11630.185886987829, 11728.589499367481, 10842.132629389473, 11055.72360690989, 11446.542138314375, 11472.426378680866, 11647.825282620937, 9356.95321523388, 11780.70548236301, 11839.112066594867, 11904.583339583072, 11915.821262680893, 6851.931480685129, 7433.739819106521, 7444.478886478111, 7493.775186744407, 7697.692092316244, 9947.403155810674, 11121.943415375526, 11364.602238921598, 11454.0, 11457.770844583229], "value": 9846.242183156584, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.8511863694991, 1494.4395851555666, 1674.8157702652707, 1854.5641774183073, 1911.4743445552463, 8540.444871083382, 8877.467351958887, 9074.0, 9076.36465447418, 9076.95461522693, 7849.2543208395255, 8157.265846073852, 8390.874136887951, 8631.69789057383, 8839.292856571476, 2321.1759825262, 2351.564960482316, 2352.0, 2352.200251914349, 2354.176038386568, 2075.9273425430115, 2322.2336628912503, 2328.604137296664, 2359.127122964497, 2361.8464799787957, 2120.416885356524, 2293.3578597992587, 2354.6468029795496, 2358.575456417844, 2376.025829409942, 2297.0467256088705, 2317.6523521471745, 2324.476992676651, 2328.7671232876746, 2334.9299521014395, 1990.5222746540726, 2297.7127859017623, 2325.4418939454577, 2327.150590034625, 2335.5795956727784, 7829.569373684445, 8931.285497160212, 9083.818323633557, 9098.272138228926, 9098.545072746336, 5296.947030529684, 5473.28847249855, 5475.178723191553, 5485.204645326406, 5497.065498865202, 3508.15804206991, 3601.6398360164035, 3661.8169091545315, 3676.1544844685873, 3677.9264414711556, 1032.8812186598561, 1054.641421916552, 1061.9150467962622, 1073.822819234833, 1081.5457507846645, 11947.880521194851, 12055.939720301343, 12059.457324420422, 12068.698282542919, 12134.5752898649, 4149.294619914622, 4701.21972052345, 4746.667733258639, 4847.636427267969, 4919.754012299442, 10051.849222261671, 10107.241956853266, 10111.241656875764, 10118.443485608363, 10135.7466063349, 5435.347758269033, 5443.292371991616, 5459.481349271813, 5472.288602481652, 5483.0, 4974.353334066548, 4999.725015124203, 5014.222795466709, 5019.0463811875625, 5043.344365232496, 4023.959760402417, 4062.756234625932, 4101.610347017028, 4108.116754897652, 4123.752574845519, 1064.4677661169414, 1180.1915687753917, 1220.2922305063041, 1279.9040071994639, 1281.0968267371481, 792.8612492813735, 894.789724414762, 909.3180114913814, 927.1655510040882, 957.2533423929347, 5935.792247271411, 6031.849203769853, 6079.08813677943, 6087.482563982023, 6105.938940610626, 897.2463130970017, 922.3543519536352, 942.7124726958207, 961.4183419031525, 966.4536741214142, 3919.2945269851703, 4047.453593764863, 4073.022474606073, 4115.6006957634545, 4133.441985332001, 10781.946090269656, 10789.298695584763, 11072.948069933344, 11157.944210278896, 11190.440477976068, 9070.591823367964, 9976.351537150062, 11089.445527723581, 11125.054370378446, 11130.721731956604, 7528.360089392353, 7618.971438855794, 7857.803554911173, 8279.172082791672, 8476.788080298165, 6013.158157857816, 6013.428724271187, 6068.848278793065, 6162.322144564184, 6285.905711414424, 10181.930897255977, 10342.431166285625, 10372.377657340583, 10381.013803688638, 10392.532336045047, 10432.269741118353, 10566.524506397383, 10593.993570610779, 10607.94696026515, 10643.680689579325, 7458.142313633784, 7502.624868756649, 7574.697012119454, 7602.885956710765, 7695.576743279174, 8351.123132071045, 8382.287505561852, 8456.492610443393, 8461.196186362286, 8472.19514146155, 7489.850202995801, 7715.614219288901, 7719.189485103983, 7744.6902123914415, 7868.134505204309, 7502.212267711811, 7579.658915348712, 7587.810304742205, 7718.768436946901, 7752.651130699245, 7080.787576372717, 7120.572765634079, 7156.821079472847, 7158.964205179149, 7173.569585824867, 4854.19905715553, 5048.7475626219275, 5075.923861142012, 5134.589232861287, 5155.7164355959285, 5096.694198348111, 5114.948850511596, 5223.268742375994, 5225.954809038283, 5283.603729720209], "value": 4642.335723291639, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.57488229038205, 305.3465583650987, 311.3182131132819, 313.68004635272035, 316.23628936119275, 4345.369921361401, 5033.874153146173, 5306.336707911506, 5333.626646134772, 5346.599005074625, 4697.412823397075, 4811.783469743861, 5220.112580861253, 5258.2638430619745, 5320.654157479771, 3831.425286207077, 3863.4784304118866, 3991.1219531702977, 4052.1895620875944, 4117.197146556423, 3203.567518385023, 3342.830009496681, 3734.9813250933707, 3973.1656352165937, 4097.180563887219, 4003.1993601279714, 4043.8786836394806, 4047.372657238118, 4053.310937140693, 4079.2861249281405, 3345.6654334566592, 3795.8481660733537, 3824.808759562011, 4031.2945234583976, 4063.7358571692744, 2859.7140285971445, 3062.3569050499423, 3406.3017081498233, 3486.477028445728, 3515.3496603128247, 5099.770510327045, 5123.487651234884, 5128.153854613985, 5135.6148288878485, 5173.249394189221, 4430.844920427802, 4538.411555955422, 4619.591024737454, 4627.699199552018, 4632.490426053131, 5478.698671573062, 5486.259354987065, 5504.779808807642, 5527.861803454905, 5531.819203957741, 3904.570497245301, 3904.6876249899938, 3905.199434116028, 3907.909268541345, 3909.960900390988, 4459.9331010034875, 5060.645754797166, 5825.0, 5836.0, 5897.587168898179, 3164.905052848418, 3338.8163650999427, 3678.020803149404, 3808.4858544096746, 3868.0716628009077, 3909.4917660703927, 3927.9803600981813, 3938.1729836734607, 3939.1333906540517, 3940.9605903941165, 4539.75031373271, 4554.931676024862, 4563.589276965089, 4588.564086411786, 4593.885152871138, 5190.6107041972, 5300.680109772097, 5498.780048798083, 5565.972170139124, 5594.804181853616, 1297.2151848131932, 1318.0773458579033, 1321.5308565459316, 1328.9534866279635, 1329.8736620021082, 765.7090305683804, 781.4686013510753, 783.3498196496894, 810.7973006748313, 821.6138414944967, 4979.278004689372, 5084.669496482717, 5150.759419652463, 5283.233931079972, 5294.602904782157, 5722.141678748221, 5722.74247658848, 5726.856828579319, 5736.713164341766, 5738.885222295614, 4648.907021859612, 4775.235962246094, 5013.674111182834, 5225.242339860699, 5239.3234165066815, 2732.426190500017, 2975.3751712140693, 2992.2818523554192, 2996.4007198560375, 3017.0, 4978.950210497921, 5820.700823174907, 5879.618289701916, 5958.463738263577, 5982.371850955587, 5539.41836107211, 5579.38626751057, 5834.912476312858, 5848.0, 5868.882622347614, 4702.9764851176205, 4938.320970869921, 5003.724050367133, 5409.648372855751, 5616.1529352393745, 5401.86626282624, 5668.404817494104, 5692.0, 5720.91186716837, 5753.252077229933, 4673.6728429009645, 4941.579965702812, 5503.174523821459, 5641.774329026793, 5656.632318899258, 5233.790648374023, 5865.912011319919, 5941.346451890375, 5951.345352011189, 5953.642781433128, 3505.596856361449, 3511.455724362728, 3805.5813860474773, 3810.7523011004196, 3814.5231846019246, 4636.791344389578, 4955.851324460272, 4999.800007999639, 5603.607747457639, 5661.207430959586, 4473.575010374009, 4744.762761861824, 5184.870378240575, 5389.757460914347, 5410.540104091197, 4136.896577585584, 4603.026414981239, 5044.899102018013, 5387.0, 5548.500634942875, 4686.507916668701, 5371.683937435353, 5391.649542779707, 5394.352677678704, 5426.375966763872, 4708.411448568929, 5243.8164664236565, 5404.7297635118875, 5508.20131080983, 5540.695261760642, 4528.003839155513, 4705.658887217127, 5105.566026887607, 5472.671639701631, 5492.725363731877], "value": 4004.3063355813347, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.5188871567339, 710.7405796884138, 777.0558771093124, 783.1376319552037, 816.1185919207256, 14323.355449004794, 15394.538163855088, 15420.228988550583, 15437.922810385933, 15524.456644017448, 13749.381277842496, 14276.214808185545, 14446.422143114263, 14452.205128717917, 14466.421343146261, 840.1850205300848, 855.9315254779634, 859.1580251353677, 859.1580251353677, 859.4327743689166, 648.8280605639509, 691.8028361916855, 803.4295650088444, 841.2428814067327, 858.3390789092426, 894.9886628110227, 896.0680891872478, 898.2768871058828, 898.4519443139679, 900.1223806788395, 891.7324802559239, 892.205936716323, 892.7723430525207, 893.0622846011727, 893.4237416866117, 500.9173486374744, 621.4779585148452, 667.8430568816324, 669.4744625469032, 669.6584741781727, 14862.628434289229, 14885.92557037208, 14893.0, 14903.105813651217, 14930.62673433162, 13842.653933651638, 14273.214973176471, 14319.928400358036, 14407.639809004753, 14446.49437269701, 12841.165324253894, 12898.87101128986, 12991.285479298635, 13089.083764136514, 13469.595912122651, 4567.634589232854, 4571.451425828888, 4605.83879564217, 4780.593649539794, 4793.089313030548, 104742.47628761883, 105149.474252629, 105725.47137264264, 106416.40375394376, 108024.4598777009, 10537.157027437786, 10834.0, 10887.455627218607, 10962.835557466644, 11120.332780033224, 20932.267370641955, 21022.47443813917, 21246.681299780517, 21273.574528509344, 21284.0, 7820.608969551499, 7889.960550197327, 7938.455120214192, 8008.839823203503, 8028.397870159762, 4392.407025051641, 4429.667774916894, 4440.400545926259, 4525.818967241274, 4594.104149690778, 3455.222574920673, 3635.4365073413665, 3638.1632224588493, 3639.636036396339, 3641.344557979536, 674.6559254780097, 684.6679360510149, 690.6753825701912, 697.013725578301, 697.4106879686758, 568.7753337431774, 646.2955378637214, 648.4812150279757, 669.0326364657531, 718.4144921888644, 8931.240844528158, 9083.137101975302, 9237.676681316121, 9404.24766018717, 9470.431774093577, 622.7446746833867, 653.6796969484918, 657.4411750012451, 669.6484345718537, 678.7149397253165, 4415.867523974286, 4640.23436133041, 4672.813087476531, 4693.990791979672, 4795.808167673324, 134759.93580288911, 139399.30300348433, 145413.27293363467, 151269.0, 157528.0, 107792.0, 107842.46078769713, 108373.0, 109538.0, 117862.82137178519, 101727.0, 117570.0, 117811.41094294474, 118639.81360186287, 120530.39734801445, 8834.204921557091, 8953.731388058368, 8979.10208979123, 9101.590428430603, 9147.679831205876, 58576.0, 63223.367766321746, 65309.34690653033, 65968.34031659622, 68175.65912170407, 92844.0, 93361.0, 94887.0, 96372.0, 97106.0, 13111.14777539457, 13146.34268286601, 13276.385118952749, 13288.136271142344, 13416.329183540589, 14820.851791481948, 14912.701745965236, 14917.713854644473, 14971.850281497482, 15162.393504259706, 13615.727685446038, 13705.451781928612, 13795.655108622364, 14035.859641403864, 14522.0, 13903.721925561229, 13925.23411212393, 14141.36363863608, 14176.149431034171, 14340.713185736018, 11456.94271528637, 13451.46194152262, 13610.843078338452, 13775.724485510033, 14132.293385330899, 11314.886851131383, 11514.712132196428, 11634.767304653691, 11710.12174086964, 11980.820287695866, 11156.497957591766, 11272.549098035986, 11539.134564907497, 11648.359340236368, 11990.640280791591], "value": 7889.258742228744, "unit": "score"}], "name": "dromaeo_css", "value": 7346.431107570151, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 112.0, 110.0, 111.0, 111.0, 112.0, 112.0, 112.0, 113.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 107.0, 109.0, 174.0, 107.0, 98.0, 158.0, 137.0, 179.0, 106.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 186.0, 185.0, 181.0, 184.0, 179.0, 180.0, 180.0, 181.0], "value": 182.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 58.0, 108.0, 58.0, 57.0, 60.0, 67.0, 97.0, 56.0], "value": 71.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 92.0, 70.0, 73.0, 69.0, 97.0, 70.0, 68.0, 102.0], "value": 81.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 83.0, 87.0, 84.0, 88.0, 85.0, 88.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 150.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 102.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 85.0, 83.0, 85.0, 86.0, 85.0, 83.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 56.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 64.0, 76.0, 70.0, 69.0, 69.0, 70.0, 69.0, 70.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 81.0, 82.0, 85.0, 81.0, 83.0, 86.0, 83.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 138.0, 135.0, 134.0, 132.0, 153.0, 148.0, 240.0, 163.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 157.0, 217.0, 175.0, 163.0, 161.0, 163.0, 161.0, 161.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 67.0, 66.0, 64.0, 66.0, 63.0, 65.0, 66.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1442.8999999999999, "alertThreshold": 2.0}]} 22:08:06 INFO - Return code: 0 22:08:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:08:06 INFO - # TBPL SUCCESS # 22:08:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:08:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:08:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:08:06 INFO - 2016-07-02 22:08:06.683 screenresolution[1947:14515] starting screenresolution argv=screenresolution get 22:08:06 INFO - 2016-07-02 22:08:06.686 screenresolution[1947:14515] Display 0: 1600x1200x32@60 22:08:06 INFO - 2016-07-02 22:08:06.692 screenresolution[1948:14518] starting screenresolution argv=screenresolution list 22:08:06 INFO - Available Modes on Display 0 22:08:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:08:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:08:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:08:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:08:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:08:06 INFO - Intel Iris: 22:08:06 INFO - Chipset Model: Intel Iris 22:08:06 INFO - Type: GPU 22:08:06 INFO - Bus: Built-In 22:08:06 INFO - VRAM (Dynamic, Max): 1536 MB 22:08:06 INFO - Vendor: Intel (0x8086) 22:08:06 INFO - Device ID: 0x0a2e 22:08:06 INFO - Revision ID: 0x0009 22:08:06 INFO - Displays: 22:08:06 INFO - Display: 22:08:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:08:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:08:06 INFO - Display Serial Number: 1600x1200 60 22:08:06 INFO - Main Display: Yes 22:08:06 INFO - Mirror: Off 22:08:06 INFO - Online: Yes 22:08:06 INFO - Rotation: Supported 22:08:06 INFO - Return code: 0 22:08:06 INFO - Running post-action listener: _resource_record_post_action 22:08:06 INFO - ##### 22:08:06 INFO - ##### Finished run-tests step (success) 22:08:06 INFO - ##### 22:08:06 INFO - Running post-run listener: _resource_record_post_run 22:08:06 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 1236992; Write bytes: 708620288; Read time: 13; Write time: 2018 22:08:06 INFO - TinderboxPrint: CPU usage
53.3% 22:08:06 INFO - TinderboxPrint: I/O read bytes / time
1,236,992 / 13 22:08:06 INFO - TinderboxPrint: I/O write bytes / time
708,620,288 / 2,018 22:08:06 INFO - TinderboxPrint: CPU idle
2,262.7 (46.7%) 22:08:06 INFO - TinderboxPrint: CPU system
963.0 (19.9%) 22:08:06 INFO - TinderboxPrint: CPU user
1,619.9 (33.4%) 22:08:06 INFO - TinderboxPrint: Swap in / out
407,826,432 / 0 22:08:06 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 402504192; Write bytes: 397727744; Read time: 30688; Write time: 869 22:08:06 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 1196032; Write bytes: 297056256; Read time: 12; Write time: 1107 22:08:07 INFO - Running post-run listener: _upload_blobber_files 22:08:07 INFO - Blob upload gear active. 22:08:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:08:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:08:07 INFO - (blobuploader) - INFO - Open directory for files ... 22:08:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:08:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:08:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:08 INFO - (blobuploader) - INFO - Done attempting. 22:08:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:08:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:08:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:09 INFO - (blobuploader) - INFO - Done attempting. 22:08:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:08:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:08:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:08:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:08:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:08:12 INFO - (blobuploader) - INFO - Done attempting. 22:08:12 INFO - (blobuploader) - INFO - Iteration through files over. 22:08:12 INFO - Return code: 0 22:08:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:08:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:08:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f961c7e1acd683588363b9d51b8eaba0bcc02dc36d35ee35582eee728db5179bb7c83555e72e8292787de2ea7024fb6b0af9fb38b4b7f120857076916709f72d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/57b16595b05e7f64a2475fef08f5d08db994b0fdc74a1aa30082d624aa100a5fac06974621cc5fcd54ca8a08eb71e47294fbf15e1df9e965f965f63c83a557ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1281d3fa4fa349d205ab48c9586c6a8bb62121c089698513b7d74ac1715109a9239510a8ed6d745b3f546fe9cd319fc986c869029c15b0dad8e1365931dff883"} 22:08:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:08:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:08:12 INFO - Contents: 22:08:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f961c7e1acd683588363b9d51b8eaba0bcc02dc36d35ee35582eee728db5179bb7c83555e72e8292787de2ea7024fb6b0af9fb38b4b7f120857076916709f72d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/57b16595b05e7f64a2475fef08f5d08db994b0fdc74a1aa30082d624aa100a5fac06974621cc5fcd54ca8a08eb71e47294fbf15e1df9e965f965f63c83a557ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1281d3fa4fa349d205ab48c9586c6a8bb62121c089698513b7d74ac1715109a9239510a8ed6d745b3f546fe9cd319fc986c869029c15b0dad8e1365931dff883"} 22:08:12 INFO - Running post-run listener: copy_logs_to_upload_dir 22:08:12 INFO - Copying logs to upload dir... 22:08:12 INFO - mkdir: /builds/slave/test/build/upload/logs 22:08:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1323.393308 ========= master_lag: 0.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2016-07-02 22:08:12.307917) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 22:08:12.311595) ========= 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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f961c7e1acd683588363b9d51b8eaba0bcc02dc36d35ee35582eee728db5179bb7c83555e72e8292787de2ea7024fb6b0af9fb38b4b7f120857076916709f72d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/57b16595b05e7f64a2475fef08f5d08db994b0fdc74a1aa30082d624aa100a5fac06974621cc5fcd54ca8a08eb71e47294fbf15e1df9e965f965f63c83a557ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1281d3fa4fa349d205ab48c9586c6a8bb62121c089698513b7d74ac1715109a9239510a8ed6d745b3f546fe9cd319fc986c869029c15b0dad8e1365931dff883"} build_url:https://queue.taskcluster.net/v1/task/C_v1XczdTd2BzmKrsWhskA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011012 build_url: 'https://queue.taskcluster.net/v1/task/C_v1XczdTd2BzmKrsWhskA/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/f961c7e1acd683588363b9d51b8eaba0bcc02dc36d35ee35582eee728db5179bb7c83555e72e8292787de2ea7024fb6b0af9fb38b4b7f120857076916709f72d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/57b16595b05e7f64a2475fef08f5d08db994b0fdc74a1aa30082d624aa100a5fac06974621cc5fcd54ca8a08eb71e47294fbf15e1df9e965f965f63c83a557ca", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1281d3fa4fa349d205ab48c9586c6a8bb62121c089698513b7d74ac1715109a9239510a8ed6d745b3f546fe9cd319fc986c869029c15b0dad8e1365931dff883"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 22:08:12.345528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 22:08:12.346032) ========= 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.W1mDwB3fnx/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.8e2UzFoHqA/Listeners TMPDIR=/var/folders/f_/784x9wv55zl7jxv09s004psc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005206 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 22:08:12.394909) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 22:08:12.395230) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 22:08:12.395573) ========= ========= Total master_lag: 2.27 =========