builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0163 starttime: 1467234290.75 results: success (0) buildid: 20160629120130 builduid: 4510152dfc4e45be8a562c26817cd09f revision: 5ecfdfb4a997766e51465fadc7453097a830b372 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:50.754607) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:50.755069) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:50.755370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:50.780474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:50.780868) ========= 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.F9jtjT38II/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.VnV4lhGFQq/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-06-29 14:04:50-- 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% 16.8M=0.001s 2016-06-29 14:04:50 (16.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113784 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:50.920763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:50.921082) ========= 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.F9jtjT38II/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.VnV4lhGFQq/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.027509 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:50.970311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:50.970671) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5ecfdfb4a997766e51465fadc7453097a830b372 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5ecfdfb4a997766e51465fadc7453097a830b372 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F9jtjT38II/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.VnV4lhGFQq/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-06-29 14:04:51,044 truncating revision to first 12 chars 2016-06-29 14:04:51,045 Setting DEBUG logging. 2016-06-29 14:04:51,045 attempt 1/10 2016-06-29 14:04:51,045 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5ecfdfb4a997?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 14:04:51,698 unpacking tar archive at: fx-team-5ecfdfb4a997/testing/mozharness/ program finished with exit code 0 elapsedTime=0.901964 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:51.895386) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:51.895808) ========= script_repo_revision: 5ecfdfb4a997766e51465fadc7453097a830b372 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:51.896273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:51.896552) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 14:04:51.915565) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-06-29 14:04:51.916226) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F9jtjT38II/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.VnV4lhGFQq/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:04:52 INFO - MultiFileLogger online at 20160629 14:04:52 in /builds/slave/test 14:04:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:04:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:04:52 INFO - {'append_to_log': False, 14:04:52 INFO - 'base_work_dir': '/builds/slave/test', 14:04:52 INFO - 'blob_upload_branch': 'Fx-Team', 14:04:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:04:52 INFO - 'branch': 'Fx-Team', 14:04:52 INFO - 'buildbot_json_path': 'buildprops.json', 14:04:52 INFO - 'config_files': ('talos/mac_config.py',), 14:04:52 INFO - 'default_actions': ('clobber', 14:04:52 INFO - 'read-buildbot-config', 14:04:52 INFO - 'download-and-extract', 14:04:52 INFO - 'populate-webroot', 14:04:52 INFO - 'create-virtualenv', 14:04:52 INFO - 'install', 14:04:52 INFO - 'run-tests'), 14:04:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:04:52 INFO - 'download_minidump_stackwalk': True, 14:04:52 INFO - 'download_symbols': 'ondemand', 14:04:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:04:52 INFO - 'tooltool.py': '/tools/tooltool.py', 14:04:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:04:52 INFO - '/tools/misc-python/virtualenv.py')}, 14:04:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:04:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:04:52 INFO - 'installer_path': 'installer.exe', 14:04:52 INFO - 'log_level': 'info', 14:04:52 INFO - 'log_name': 'talos', 14:04:52 INFO - 'log_to_console': True, 14:04:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:04:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:04:52 INFO - 'opt_config_files': (), 14:04:52 INFO - 'pip_index': False, 14:04:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:04:52 INFO - 'cmd': ('bash', 14:04:52 INFO - '-c', 14:04:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:04:52 INFO - 'enabled': True, 14:04:52 INFO - 'halt_on_failure': False, 14:04:52 INFO - 'name': 'check_screen_resolution'},), 14:04:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:04:52 INFO - 'cmd': ('bash', 14:04:52 INFO - '-c', 14:04:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:04:52 INFO - 'enabled': True, 14:04:52 INFO - 'halt_on_failure': False, 14:04:52 INFO - 'name': 'check_screen_resolution'},), 14:04:52 INFO - 'run_cmd_checks_enabled': True, 14:04:52 INFO - 'sps_profile': False, 14:04:52 INFO - 'sps_profile_interval': 0, 14:04:52 INFO - 'suite': 'dromaeojs', 14:04:52 INFO - 'system_bits': '32', 14:04:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:04:52 INFO - 'title': 't-yosemite-r7-0163', 14:04:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:04:52 INFO - 'use_talos_json': True, 14:04:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:04:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:04:52 INFO - 'work_dir': 'build'} 14:04:52 INFO - ##### 14:04:52 INFO - ##### Running clobber step. 14:04:52 INFO - ##### 14:04:52 INFO - Running pre-action listener: _resource_record_pre_action 14:04:52 INFO - Running main action method: clobber 14:04:52 INFO - rmtree: /builds/slave/test/build 14:04:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:04:54 INFO - Running post-action listener: _resource_record_post_action 14:04:54 INFO - ##### 14:04:54 INFO - ##### Finished clobber step (success) 14:04:54 INFO - ##### 14:04:54 INFO - ##### 14:04:54 INFO - ##### Running read-buildbot-config step. 14:04:54 INFO - ##### 14:04:54 INFO - Running pre-action listener: _resource_record_pre_action 14:04:54 INFO - Running main action method: read_buildbot_config 14:04:54 INFO - Using buildbot properties: 14:04:54 INFO - { 14:04:54 INFO - "project": "", 14:04:54 INFO - "product": "firefox", 14:04:54 INFO - "script_repo_revision": "production", 14:04:54 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:04:54 INFO - "repository": "", 14:04:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:04:54 INFO - "buildid": "20160629120130", 14:04:54 INFO - "pgo_build": "False", 14:04:54 INFO - "basedir": "/builds/slave/test", 14:04:54 INFO - "buildnumber": 70, 14:04:54 INFO - "slavename": "t-yosemite-r7-0163", 14:04:54 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 14:04:54 INFO - "platform": "yosemite_r7", 14:04:54 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:04:54 INFO - "branch": "fx-team", 14:04:54 INFO - "repo_path": "integration/fx-team", 14:04:54 INFO - "revision": "5ecfdfb4a997766e51465fadc7453097a830b372", 14:04:54 INFO - "stage_platform": "macosx64", 14:04:54 INFO - "builduid": "4510152dfc4e45be8a562c26817cd09f", 14:04:54 INFO - "slavebuilddir": "test" 14:04:54 INFO - } 14:04:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 14:04:54 INFO - Running post-action listener: _resource_record_post_action 14:04:54 INFO - ##### 14:04:54 INFO - ##### Finished read-buildbot-config step (success) 14:04:54 INFO - ##### 14:04:54 INFO - ##### 14:04:54 INFO - ##### Running download-and-extract step. 14:04:54 INFO - ##### 14:04:54 INFO - Running pre-action listener: _resource_record_pre_action 14:04:54 INFO - Running main action method: download_and_extract 14:04:54 INFO - mkdir: /builds/slave/test/build/tests 14:04: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')]} 14:04:54 INFO - https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:04:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 14:04:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 14:04:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 14:04:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 14:04:55 INFO - Downloaded 1199 bytes. 14:04:55 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 14:04:55 INFO - Using the following test package requirements: 14:04:55 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 14:04:55 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:04:55 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 14:04:55 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:04:55 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 14:04:55 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:04:55 INFO - u'jsshell-mac.zip'], 14:04:55 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:04:55 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 14:04:55 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 14:04:55 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:04:55 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 14:04:55 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:04:55 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 14:04:55 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:04:55 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 14:04:55 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:04:55 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 14:04:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:04:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:04:55 INFO - https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:04:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:04:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:04:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:04:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:04:57 INFO - Downloaded 18788540 bytes. 14:04:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:04:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:05:00 INFO - Return code: 0 14:05:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:00 INFO - https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:05:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:05:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:05:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:05:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:05:01 INFO - Downloaded 18788540 bytes. 14:05:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:05:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:05:05 INFO - Return code: 0 14:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:05 INFO - https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:05:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:05:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:05:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:05:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:05:06 INFO - Downloaded 14405245 bytes. 14:05:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:05:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:05:06 INFO - Return code: 0 14:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:06 INFO - https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:05:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:05:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:05:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 14:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 14:05:11 INFO - Downloaded 112467879 bytes. 14:05:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:05:11 INFO - mkdir: /builds/slave/test/properties 14:05:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:05:11 INFO - Writing to file /builds/slave/test/properties/build_url 14:05:11 INFO - Contents: 14:05:11 INFO - build_url:https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:05:13 INFO - Running post-action listener: _resource_record_post_action 14:05:13 INFO - Running post-action listener: set_extra_try_arguments 14:05:13 INFO - ##### 14:05:13 INFO - ##### Finished download-and-extract step (success) 14:05:13 INFO - ##### 14:05:13 INFO - ##### 14:05:13 INFO - ##### Running populate-webroot step. 14:05:13 INFO - ##### 14:05:13 INFO - Running pre-action listener: _resource_record_pre_action 14:05:13 INFO - Running main action method: populate_webroot 14:05:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:05:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:05:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:05:13 INFO - '--tppagecycles', 14:05:13 INFO - '7'], 14:05:13 INFO - 'tests': ['tsvgm']}}, 14:05:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:05:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:05:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:05:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:05:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:05:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:05:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:13 INFO - 'talos_options': ['--disable-e10s'], 14:05:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:05:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:13 INFO - 'talos_options': ['--disable-e10s'], 14:05:13 INFO - 'tests': ['damp', 'tps']}, 14:05:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:13 INFO - 'tests': ['damp', 'tps']}, 14:05:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:05:13 INFO - 'tests': ['dromaeo_dom']}, 14:05:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:05:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:05:13 INFO - 'tests': ['basic_compositor_video']}, 14:05:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:05:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:05:13 INFO - 'tests': ['a11yr', 14:05:13 INFO - 'ts_paint', 14:05:13 INFO - 'tpaint', 14:05:13 INFO - 'sessionrestore', 14:05:13 INFO - 'sessionrestore_no_auto_restore', 14:05:13 INFO - 'tabpaint']}, 14:05:13 INFO - 'other-e10s': {'tests': ['a11yr', 14:05:13 INFO - 'ts_paint', 14:05:13 INFO - 'tpaint', 14:05:13 INFO - 'sessionrestore', 14:05:13 INFO - 'sessionrestore_no_auto_restore', 14:05:13 INFO - 'tabpaint']}, 14:05:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:05:13 INFO - 'ts_paint', 14:05:13 INFO - 'tpaint', 14:05:13 INFO - 'sessionrestore', 14:05:13 INFO - 'sessionrestore_no_auto_restore', 14:05:13 INFO - 'tabpaint']}, 14:05:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:05:13 INFO - 'ts_paint', 14:05:13 INFO - 'tpaint', 14:05:13 INFO - 'sessionrestore', 14:05:13 INFO - 'sessionrestore_no_auto_restore', 14:05:13 INFO - 'tabpaint']}, 14:05:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:05:13 INFO - 'tests': ['a11yr', 14:05:13 INFO - 'ts_paint', 14:05:13 INFO - 'tpaint', 14:05:13 INFO - 'sessionrestore', 14:05:13 INFO - 'sessionrestore_no_auto_restore', 14:05:13 INFO - 'tabpaint']}, 14:05:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:05:13 INFO - 'tests': ['a11yr', 14:05:13 INFO - 'ts_paint', 14:05:13 INFO - 'tpaint', 14:05:13 INFO - 'sessionrestore', 14:05:13 INFO - 'sessionrestore_no_auto_restore', 14:05:13 INFO - 'tabpaint']}, 14:05:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:05:13 INFO - 'tests': ['tsvgx', 14:05:13 INFO - 'tsvgr_opacity', 14:05:13 INFO - 'tart', 14:05:13 INFO - 'tscrollx', 14:05:13 INFO - 'cart']}, 14:05:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:05:13 INFO - 'tsvgr_opacity', 14:05:13 INFO - 'tart', 14:05:13 INFO - 'tscrollx', 14:05:13 INFO - 'cart']}, 14:05:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:13 INFO - 'talos_options': ['--disable-e10s'], 14:05:13 INFO - 'tests': ['tp5o']}, 14:05:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:13 INFO - 'tests': ['tp5o']}, 14:05:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:13 INFO - 'talos_options': ['--disable-e10s', 14:05:13 INFO - '--xperf_path', 14:05:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:13 INFO - 'tests': ['tp5n']}, 14:05:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:05:13 INFO - 'talos_options': ['--xperf_path', 14:05:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:05:13 INFO - 'tests': ['tp5n']}}, 14:05:13 INFO - 'talos.zip': {'path': '', 14:05:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:05:13 INFO - Running post-action listener: _resource_record_post_action 14:05:13 INFO - ##### 14:05:13 INFO - ##### Finished populate-webroot step (success) 14:05:13 INFO - ##### 14:05:13 INFO - ##### 14:05:13 INFO - ##### Running create-virtualenv step. 14:05:13 INFO - ##### 14:05:13 INFO - Running pre-action listener: _resource_record_pre_action 14:05:13 INFO - Running main action method: create_virtualenv 14:05:13 INFO - Creating virtualenv /builds/slave/test/build/venv 14:05:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:05:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:05:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:05:13 INFO - Using real prefix '/tools/python27' 14:05:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:05:13 INFO - Installing distribute.............................................................................................................................................................................................done. 14:05:16 INFO - Installing pip.................done. 14:05:16 INFO - Return code: 0 14:05:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512cb1830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c951d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c949b20>, '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.F9jtjT38II/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.VnV4lhGFQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:05:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F9jtjT38II/Render', 14:05:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:16 INFO - 'HOME': '/Users/cltbld', 14:05:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:16 INFO - 'LOGNAME': 'cltbld', 14:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:16 INFO - 'MOZ_NO_REMOTE': '1', 14:05:16 INFO - 'NO_EM_RESTART': '1', 14:05:16 INFO - 'PAGER': '/bin/cat', 14:05:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:16 INFO - 'PWD': '/builds/slave/test', 14:05:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:16 INFO - 'SHELL': '/bin/bash', 14:05:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VnV4lhGFQq/Listeners', 14:05:16 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:05:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:16 INFO - 'USER': 'cltbld', 14:05:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:16 INFO - 'XPC_FLAGS': '0x0', 14:05:16 INFO - 'XPC_SERVICE_NAME': '0', 14:05:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:05:17 INFO - Cleaning up... 14:05:17 INFO - Return code: 0 14:05:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:17 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 0x10c9eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512cb1830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c951d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c949b20>, '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.F9jtjT38II/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.VnV4lhGFQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:05:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F9jtjT38II/Render', 14:05:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:17 INFO - 'HOME': '/Users/cltbld', 14:05:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:17 INFO - 'LOGNAME': 'cltbld', 14:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:17 INFO - 'MOZ_NO_REMOTE': '1', 14:05:17 INFO - 'NO_EM_RESTART': '1', 14:05:17 INFO - 'PAGER': '/bin/cat', 14:05:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:17 INFO - 'PWD': '/builds/slave/test', 14:05:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:17 INFO - 'SHELL': '/bin/bash', 14:05:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VnV4lhGFQq/Listeners', 14:05:17 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:05:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:17 INFO - 'USER': 'cltbld', 14:05:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:17 INFO - 'XPC_FLAGS': '0x0', 14:05:17 INFO - 'XPC_SERVICE_NAME': '0', 14:05:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:17 INFO - Downloading/unpacking psutil>=3.1.1 14:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:05:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:20 INFO - Installing collected packages: psutil 14:05:20 INFO - Running setup.py install for psutil 14:05:20 INFO - building 'psutil._psutil_osx' extension 14:05:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:05:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:05:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:05:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:05:21 INFO - building 'psutil._psutil_posix' extension 14:05:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:05:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:05:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:05:21 INFO - ^ 14:05:21 INFO - 1 warning generated. 14:05:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:05:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:05:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:05:21 INFO - Successfully installed psutil 14:05:21 INFO - Cleaning up... 14:05:21 INFO - Return code: 0 14:05:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:21 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 0x10c9eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512cb1830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c951d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c949b20>, '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.F9jtjT38II/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.VnV4lhGFQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:05:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F9jtjT38II/Render', 14:05:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:21 INFO - 'HOME': '/Users/cltbld', 14:05:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:21 INFO - 'LOGNAME': 'cltbld', 14:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:21 INFO - 'MOZ_NO_REMOTE': '1', 14:05:21 INFO - 'NO_EM_RESTART': '1', 14:05:21 INFO - 'PAGER': '/bin/cat', 14:05:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:21 INFO - 'PWD': '/builds/slave/test', 14:05:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:21 INFO - 'SHELL': '/bin/bash', 14:05:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VnV4lhGFQq/Listeners', 14:05:21 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:05:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:21 INFO - 'USER': 'cltbld', 14:05:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:21 INFO - 'XPC_FLAGS': '0x0', 14:05:21 INFO - 'XPC_SERVICE_NAME': '0', 14:05:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:05:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:05:25 INFO - Installing collected packages: mozsystemmonitor 14:05:25 INFO - Running setup.py install for mozsystemmonitor 14:05:25 INFO - Successfully installed mozsystemmonitor 14:05:25 INFO - Cleaning up... 14:05:25 INFO - Return code: 0 14:05:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:25 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 0x10c9eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512cb1830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c951d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c949b20>, '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.F9jtjT38II/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.VnV4lhGFQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:05:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:05:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:05:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F9jtjT38II/Render', 14:05:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:25 INFO - 'HOME': '/Users/cltbld', 14:05:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:25 INFO - 'LOGNAME': 'cltbld', 14:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:25 INFO - 'MOZ_NO_REMOTE': '1', 14:05:25 INFO - 'NO_EM_RESTART': '1', 14:05:25 INFO - 'PAGER': '/bin/cat', 14:05:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:25 INFO - 'PWD': '/builds/slave/test', 14:05:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:25 INFO - 'SHELL': '/bin/bash', 14:05:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VnV4lhGFQq/Listeners', 14:05:25 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:05:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:25 INFO - 'USER': 'cltbld', 14:05:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:25 INFO - 'XPC_FLAGS': '0x0', 14:05:25 INFO - 'XPC_SERVICE_NAME': '0', 14:05:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:25 INFO - Downloading/unpacking jsonschema==2.5.1 14:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:05:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:28 INFO - Downloading functools32-3.2.3-2.tar.gz 14:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:05:28 INFO - warning: no files found matching '*.txt' 14:05:28 INFO - no previously-included directories found matching 'build' 14:05:28 INFO - no previously-included directories found matching 'dist' 14:05:28 INFO - no previously-included directories found matching '.git*' 14:05:28 INFO - Installing collected packages: jsonschema, functools32 14:05:28 INFO - Running setup.py install for functools32 14:05:28 INFO - warning: no files found matching '*.txt' 14:05:28 INFO - no previously-included directories found matching 'build' 14:05:28 INFO - no previously-included directories found matching 'dist' 14:05:28 INFO - no previously-included directories found matching '.git*' 14:05:28 INFO - Successfully installed jsonschema functools32 14:05:28 INFO - Cleaning up... 14:05:29 INFO - Return code: 0 14:05:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:29 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 0x10c9eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512cb1830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c951d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c949b20>, '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.F9jtjT38II/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.VnV4lhGFQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:05:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:05:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F9jtjT38II/Render', 14:05:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:29 INFO - 'HOME': '/Users/cltbld', 14:05:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:29 INFO - 'LOGNAME': 'cltbld', 14:05:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:29 INFO - 'MOZ_NO_REMOTE': '1', 14:05:29 INFO - 'NO_EM_RESTART': '1', 14:05:29 INFO - 'PAGER': '/bin/cat', 14:05:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:29 INFO - 'PWD': '/builds/slave/test', 14:05:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:29 INFO - 'SHELL': '/bin/bash', 14:05:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VnV4lhGFQq/Listeners', 14:05:29 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:05:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:29 INFO - 'USER': 'cltbld', 14:05:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:29 INFO - 'XPC_FLAGS': '0x0', 14:05:29 INFO - 'XPC_SERVICE_NAME': '0', 14:05:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:29 INFO - Downloading/unpacking blobuploader==1.2.4 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:31 INFO - Downloading blobuploader-1.2.4.tar.gz 14:05:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:05:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:05:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:05:32 INFO - Downloading docopt-0.6.1.tar.gz 14:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:05:33 INFO - Installing collected packages: blobuploader, requests, docopt 14:05:33 INFO - Running setup.py install for blobuploader 14:05:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:05:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:05:33 INFO - Running setup.py install for requests 14:05:33 INFO - Running setup.py install for docopt 14:05:33 INFO - Successfully installed blobuploader requests docopt 14:05:33 INFO - Cleaning up... 14:05:33 INFO - Return code: 0 14:05:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:33 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 0x10c9eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512cb1830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c951d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c949b20>, '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.F9jtjT38II/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.VnV4lhGFQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:05:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F9jtjT38II/Render', 14:05:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:33 INFO - 'HOME': '/Users/cltbld', 14:05:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:33 INFO - 'LOGNAME': 'cltbld', 14:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:33 INFO - 'MOZ_NO_REMOTE': '1', 14:05:33 INFO - 'NO_EM_RESTART': '1', 14:05:33 INFO - 'PAGER': '/bin/cat', 14:05:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:33 INFO - 'PWD': '/builds/slave/test', 14:05:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:33 INFO - 'SHELL': '/bin/bash', 14:05:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VnV4lhGFQq/Listeners', 14:05:33 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:05:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:33 INFO - 'USER': 'cltbld', 14:05:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:33 INFO - 'XPC_FLAGS': '0x0', 14:05:33 INFO - 'XPC_SERVICE_NAME': '0', 14:05:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:05:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-iMRhEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:05:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-UkaSUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:05:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-XYxnNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:05:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-0e0PZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:05:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-RRiptv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:05:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3oZreG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:05:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-TD_yG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:05:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-NobceL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:05:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-97tIB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:05:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-vieSql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:05:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-E2na6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:05:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-dBhnon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:05:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-R41kAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:05:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-EMrUmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ihO0Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:05:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-L_F8D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:05:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-zt4UsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:05:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:05:35 INFO - Running setup.py install for manifestparser 14:05:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:05:36 INFO - Running setup.py install for mozcrash 14:05:36 INFO - Running setup.py install for mozdebug 14:05:36 INFO - Running setup.py install for mozdevice 14:05:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:05:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:05:36 INFO - Running setup.py install for mozfile 14:05:36 INFO - Running setup.py install for mozhttpd 14:05:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:05:36 INFO - Running setup.py install for mozinfo 14:05:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:05:37 INFO - Running setup.py install for mozInstall 14:05:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:05:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:05:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:05:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:05:37 INFO - Running setup.py install for mozleak 14:05:37 INFO - Running setup.py install for mozlog 14:05:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:05:37 INFO - Running setup.py install for moznetwork 14:05:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:05:37 INFO - Running setup.py install for mozprocess 14:05:37 INFO - Running setup.py install for mozprofile 14:05:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:05:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:05:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:05:37 INFO - Running setup.py install for mozrunner 14:05:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:05:38 INFO - Running setup.py install for mozscreenshot 14:05:38 INFO - Running setup.py install for moztest 14:05:38 INFO - Running setup.py install for mozversion 14:05:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:05:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:05:38 INFO - Cleaning up... 14:05:38 INFO - Return code: 0 14:05:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:38 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 0x10c9eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512cb1830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c951d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c949b20>, '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.F9jtjT38II/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.VnV4lhGFQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:05:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F9jtjT38II/Render', 14:05:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:38 INFO - 'HOME': '/Users/cltbld', 14:05:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:38 INFO - 'LOGNAME': 'cltbld', 14:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:38 INFO - 'MOZ_NO_REMOTE': '1', 14:05:38 INFO - 'NO_EM_RESTART': '1', 14:05:38 INFO - 'PAGER': '/bin/cat', 14:05:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:38 INFO - 'PWD': '/builds/slave/test', 14:05:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:38 INFO - 'SHELL': '/bin/bash', 14:05:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VnV4lhGFQq/Listeners', 14:05:38 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:05:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:38 INFO - 'USER': 'cltbld', 14:05:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:38 INFO - 'XPC_FLAGS': '0x0', 14:05:38 INFO - 'XPC_SERVICE_NAME': '0', 14:05:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:05:38 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-_JPxV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:05:38 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-bV7JqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:05:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-khc2go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:05:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ePhorT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:05:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-tiqIIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:05:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-3eCl9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:05:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ycoWHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:05:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-VCfje8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:05:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-F3N7ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:05:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-dy7mDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:05:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:05:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-SV8yWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:05:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-SJFk7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:05:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-pOmg6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:05:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-yFZQIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-AMJVNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:05:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-WGyN4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:05:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:05:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-NDJGjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:05:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:05:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05: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 14:05:43 INFO - Downloading blessings-1.6.tar.gz 14:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:05:43 INFO - Installing collected packages: blessings 14:05:43 INFO - Running setup.py install for blessings 14:05:43 INFO - Successfully installed blessings 14:05:43 INFO - Cleaning up... 14:05:43 INFO - Return code: 0 14:05:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:05:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:05:43 INFO - Reading from file tmpfile_stdout 14:05:43 INFO - Current package versions: 14:05:43 INFO - blessings == 1.6 14:05:43 INFO - blobuploader == 1.2.4 14:05:43 INFO - docopt == 0.6.1 14:05:43 INFO - functools32 == 3.2.3-2 14:05:43 INFO - jsonschema == 2.5.1 14:05:43 INFO - manifestparser == 1.1 14:05:43 INFO - mozInstall == 1.12 14:05:43 INFO - mozcrash == 0.17 14:05:43 INFO - mozdebug == 0.1 14:05:43 INFO - mozdevice == 0.48 14:05:43 INFO - mozfile == 1.2 14:05:43 INFO - mozhttpd == 0.7 14:05:43 INFO - mozinfo == 0.9 14:05:43 INFO - mozleak == 0.1 14:05:43 INFO - mozlog == 3.2 14:05:43 INFO - moznetwork == 0.27 14:05:43 INFO - mozprocess == 0.22 14:05:43 INFO - mozprofile == 0.28 14:05:43 INFO - mozrunner == 6.11 14:05:43 INFO - mozscreenshot == 0.1 14:05:43 INFO - mozsystemmonitor == 0.3 14:05:43 INFO - moztest == 0.7 14:05:43 INFO - mozversion == 1.4 14:05:43 INFO - psutil == 3.1.1 14:05:43 INFO - requests == 1.2.3 14:05:43 INFO - wsgiref == 0.1.2 14:05:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:05: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')]} 14:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05: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')]} 14:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:43 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 0x10c9eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512cb1830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c951d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c949b20>, '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.F9jtjT38II/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.VnV4lhGFQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:05:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:05:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:05:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F9jtjT38II/Render', 14:05:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:43 INFO - 'HOME': '/Users/cltbld', 14:05:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:43 INFO - 'LOGNAME': 'cltbld', 14:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:43 INFO - 'MOZ_NO_REMOTE': '1', 14:05:43 INFO - 'NO_EM_RESTART': '1', 14:05:43 INFO - 'PAGER': '/bin/cat', 14:05:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:43 INFO - 'PWD': '/builds/slave/test', 14:05:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:43 INFO - 'SHELL': '/bin/bash', 14:05:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VnV4lhGFQq/Listeners', 14:05:43 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:05:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:43 INFO - 'USER': 'cltbld', 14:05:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:43 INFO - 'XPC_FLAGS': '0x0', 14:05:43 INFO - 'XPC_SERVICE_NAME': '0', 14:05:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:05:43 INFO - Cleaning up... 14:05:44 INFO - Return code: 0 14:05:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:05:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:05:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:05:44 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 0x10c9eda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ca82618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa512cb1830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c951d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c949b20>, '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.F9jtjT38II/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.VnV4lhGFQq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:05:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:05:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F9jtjT38II/Render', 14:05:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:05:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:05:44 INFO - 'HOME': '/Users/cltbld', 14:05:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:05:44 INFO - 'LOGNAME': 'cltbld', 14:05:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:05:44 INFO - 'MOZ_NO_REMOTE': '1', 14:05:44 INFO - 'NO_EM_RESTART': '1', 14:05:44 INFO - 'PAGER': '/bin/cat', 14:05:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:05:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:05:44 INFO - 'PWD': '/builds/slave/test', 14:05:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:05:44 INFO - 'SHELL': '/bin/bash', 14:05:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VnV4lhGFQq/Listeners', 14:05:44 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:05:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:05:44 INFO - 'USER': 'cltbld', 14:05:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:05:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:05:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:05:44 INFO - 'XPC_FLAGS': '0x0', 14:05:44 INFO - 'XPC_SERVICE_NAME': '0', 14:05:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:05:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:05:44 INFO - Cleaning up... 14:05:44 INFO - Return code: 0 14:05:44 INFO - Running post-action listener: _resource_record_post_action 14:05:44 INFO - Running post-action listener: _start_resource_monitoring 14:05:44 INFO - Starting resource monitoring. 14:05:44 INFO - ##### 14:05:44 INFO - ##### Finished create-virtualenv step (success) 14:05:44 INFO - ##### 14:05:44 INFO - ##### 14:05:44 INFO - ##### Running install step. 14:05:44 INFO - ##### 14:05:44 INFO - Running pre-action listener: _resource_record_pre_action 14:05:44 INFO - Running main action method: install 14:05:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:05:44 INFO - Reading from file tmpfile_stdout 14:05:44 INFO - Detecting whether we're running mozinstall >=1.0... 14:05:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:05:44 INFO - Reading from file tmpfile_stdout 14:05:44 INFO - Output received: 14:05:44 INFO - Usage: mozinstall [options] installer 14:05:44 INFO - Options: 14:05:44 INFO - -h, --help show this help message and exit 14:05:44 INFO - -d DEST, --destination=DEST 14:05:44 INFO - Directory to install application into. [default: 14:05:44 INFO - "/builds/slave/test"] 14:05:44 INFO - --app=APP Application being installed. [default: firefox] 14:05:44 INFO - mkdir: /builds/slave/test/build/application 14:05:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:05:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:06:19 INFO - Reading from file tmpfile_stdout 14:06:19 INFO - Output received: 14:06:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:06:19 INFO - Running post-action listener: _resource_record_post_action 14:06:19 INFO - ##### 14:06:19 INFO - ##### Finished install step (success) 14:06:19 INFO - ##### 14:06:19 INFO - ##### 14:06:19 INFO - ##### Running run-tests step. 14:06:19 INFO - ##### 14:06:19 INFO - Running pre-action listener: _resource_record_pre_action 14:06:19 INFO - Running main action method: run_tests 14:06:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:06:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:06:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:06:19 INFO - 2016-06-29 14:06:19.196 screenresolution[1635:7514] starting screenresolution argv=screenresolution get 14:06:19 INFO - 2016-06-29 14:06:19.198 screenresolution[1635:7514] Display 0: 1600x1200x32@60 14:06:19 INFO - 2016-06-29 14:06:19.204 screenresolution[1636:7516] starting screenresolution argv=screenresolution list 14:06:19 INFO - Available Modes on Display 0 14:06:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:06:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:06:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:06:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:06:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:06:19 INFO - Intel Iris: 14:06:19 INFO - Chipset Model: Intel Iris 14:06:19 INFO - Type: GPU 14:06:19 INFO - Bus: Built-In 14:06:19 INFO - VRAM (Dynamic, Max): 1536 MB 14:06:19 INFO - Vendor: Intel (0x8086) 14:06:19 INFO - Device ID: 0x0a2e 14:06:19 INFO - Revision ID: 0x0009 14:06:19 INFO - Displays: 14:06:19 INFO - Display: 14:06:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:06:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:06:19 INFO - Display Serial Number: 1600x1200 60 14:06:19 INFO - Main Display: Yes 14:06:19 INFO - Mirror: Off 14:06:19 INFO - Online: Yes 14:06:19 INFO - Rotation: Supported 14:06:19 INFO - Return code: 0 14:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:06:19 INFO - Python 2.7.3 14:06:19 INFO - Return code: 0 14:06:19 INFO - grabbing minidump binary from tooltool 14:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:06:19 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 0x10c951d30>, '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 0x10c6b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c949b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:06:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:06:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:06:19 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:06:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:06:19 INFO - Return code: 0 14:06:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:06:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:06:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:06:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:06:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F9jtjT38II/Render', 14:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:19 INFO - 'HOME': '/Users/cltbld', 14:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:19 INFO - 'LOGNAME': 'cltbld', 14:06:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:06:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:19 INFO - 'MOZ_NO_REMOTE': '1', 14:06:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:06:19 INFO - 'NO_EM_RESTART': '1', 14:06:19 INFO - 'PAGER': '/bin/cat', 14:06:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:19 INFO - 'PWD': '/builds/slave/test', 14:06:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:19 INFO - 'SHELL': '/bin/bash', 14:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VnV4lhGFQq/Listeners', 14:06:19 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 14:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:19 INFO - 'USER': 'cltbld', 14:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:19 INFO - 'XPC_FLAGS': '0x0', 14:06:19 INFO - 'XPC_SERVICE_NAME': '0', 14:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:06:19 INFO - mozversion application_buildid: 20160629120130 14:06:19 INFO - mozversion application_changeset: 5ecfdfb4a997766e51465fadc7453097a830b372 14:06:19 INFO - mozversion application_display_name: Nightly 14:06:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:06:19 INFO - mozversion application_name: Firefox 14:06:19 INFO - mozversion application_remotingname: firefox 14:06:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:06:19 INFO - mozversion application_vendor: Mozilla 14:06:19 INFO - mozversion application_version: 50.0a1 14:06:19 INFO - mozversion platform_buildid: 20160629120130 14:06:19 INFO - mozversion platform_changeset: 5ecfdfb4a997766e51465fadc7453097a830b372 14:06:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:06:19 INFO - mozversion platform_version: 50.0a1 14:06:19 INFO - using testdate: 1467234379 14:06:19 INFO - actual date: 1467234379 14:06:19 INFO - starting webserver on 'localhost:49273' 14:06:19 INFO - SUITE-START | Running 2 tests 14:06:19 INFO - TEST-START | dromaeo_css 14:06:19 INFO - operating with platform_type : mac_ 14:06:19 INFO - Initialising browser for dromaeo_css test... 14:06:19 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpPMtDwg/profile http://localhost:49273/getInfo.html) 14:06:22 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 14:06:22 INFO - PROCESS | 1646 | colorDepth:24 14:06:22 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 14:06:22 INFO - PROCESS | 1646 | __metrics 14:06:22 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:06:22 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:06:22 INFO - TEST-INFO | 1646: exit 0 14:06:22 INFO - Browser initialized. 14:06:22 INFO - Running cycle 1/1 for dromaeo_css test... 14:06:22 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpPMtDwg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:06:35 INFO - PROCESS | 1649 | RSS: Main: 243531776 14:06:35 INFO - PROCESS | 1649 | 14:07:25 INFO - PROCESS | 1649 | 1467234445902 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:09:37 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 14:09:39 INFO - PROCESS | 1649 | RSS: Main: 367484928 14:09:39 INFO - PROCESS | 1649 | 14:12:42 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 14:12:43 INFO - PROCESS | 1649 | RSS: Main: 375758848 14:12:43 INFO - PROCESS | 1649 | 14:15:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 14:15:45 INFO - PROCESS | 1649 | RSS: Main: 374452224 14:15:45 INFO - PROCESS | 1649 | 14:18:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 14:18:48 INFO - PROCESS | 1649 | RSS: Main: 373182464 14:18:48 INFO - PROCESS | 1649 | 14:21:52 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 14:21:52 INFO - PROCESS | 1649 | RSS: Main: 340496384 14:21:52 INFO - PROCESS | 1649 | 14:24:55 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 14:24:56 INFO - PROCESS | 1649 | RSS: Main: 395173888 14:24:56 INFO - PROCESS | 1649 | 14:24:56 INFO - PROCESS | 1649 | __start_tp_report 14:24:56 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 14:24:56 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 14:24:56 INFO - PROCESS | 1649 | |i|pagename|runs| 14:24:56 INFO - PROCESS | 1649 | |0;dojo.html;2904.970950290498;3349.346877358915;3366.579177602798;3385.949210761839;3402.302527981764;5568.415316391771;5614.887702245953;5649.661020338783;5734.885302293957;5749.367569567349;5671.574631902614;5707.885842283152;5728.942710572904;5740.684262365568;5750.683712395827;5134.486551344864;5166.896662066756;5183.196604526285;5192.688438693672;5251.369835619731;5279.604029697769;5300.814471493499;5303.7082960437165;5307;5307.442718514559;5186.7925282988635;5195.40252870919;5208.531232189102;5218.321618189649;5304.443033481487;5293.206019097147;5300.443453437372;5309.920351194735;5319.228711836762;5360.785568577291;5075.873103172414;5087.3386459759995;5113.079645663779;5213.087709650834;5213.687178769286;5627.5779316551425;5655.4910058094965;5702.885942281173;5715.428457154293;5723.255976723;6292.056191571255;6307.369263073701;6317.589356691847;6326.177596912372;6332.366763323676;5084.542391184811;6177.81466556004;6188.9690551546955;6331.778387756406;6377.58545694533;5778.7399567019165;5807.622504537191;5825.155352473867;5839.678817665069;5853.122031695195;6305.085762564402;6306.8423289417215;6314.0844577536;6316.968415157987;6340.778072767431;6019.759209631653;6082.482988945901;6117.877642447126;6123.510119190454;6140.201773769381;6207.162033125561;6266.780662676784;6292.874142517124;6320.115183874262;6321.273053598803;6178.1350610913605;6227.408396202353;6245.687715614292;6253.312135665074;6281.214848143982;6070.180525628984;6129.111278864629;6134.355892631299;6286.685665716695;6313.494920406357;4910.950890491049;4957.801687932514;4963.950360496421;4967.279744437036;4970.105381031377;3792.3173828710546;4468.4637843458995;4504.256797628354;4506.256467682796;4522.389477420572;5681.318241811009;5722.37053924068;5768.567357448208;5804.796832110856;5819.098039803837;6287.622742635456;6352.460040896483;6353.841153971188;6367.968160159262;6375.808725738235;5736.13957906309;5744.167095771089;5744.253247077853;5746.683932383759;5819.301683797887;5304.522592966651;5353.197020446886;5356.758945847446;5414.648047876875;5435.918461223085;6206.317305096526;6235.3452887446165;6281.905771413432;6285.340039295899;6308.526860485482;5259.947400525945;6307.96846015767;6329.5569310149685;6336.873262534816;6364.713587888648;6275.090111933835;6315.3053164152825;6324.430801227912;6325.778597749057;6326.588771729823;5039.218921067094;6080.7567697291615;6132.355508992456;6136.110264011782;6190.907136392868;6060.39396060408;6179.196704428576;6203.2245969253845;6218;6227.688615569294;5361.839144825662;6050.788222412194;6112.938870611237;6113.938860611515;6134.38656134383;6084.330723620486;6093.207882975362;6130.417610327012;6139.109829074849;6144.846378840565;5787.768489260382;5851.239338885917;5904.114382842608;5945.435183657545;5953.583249172516;6095.588784116743;6099.110546378738;6116.908246376219;6117.035835319846;6143.723532440961;5934.139549765174;5966.910496342472;5968.850778730392;5980.850478737892;6013 14:24:56 INFO - PROCESS | 1649 | |1;ext.html;483.5575448464655;491.2925387442083;521.7156649625955;528.532248959671;530.0988319856243;29344;30287.545686814687;41185.58814411851;41715.16569668605;41806.790966045126;42894;43270.35094473577;43361.56638433615;43381.34927976083;43474.6957591272;9663.903360966387;9841.606335746561;9854.852177217312;9865.60537578496;9890.802183956317;8798.6920457784;9032.412893161956;11843.348615826126;12091.697707557294;12136.817947730748;12040.698982525462;12062.396880156;12093.153479256456;12121.818172727417;12130.332831694253;8715.041345451995;10157.492125393737;11829.763404731857;12085.758284834254;12088.939555302255;11040.282381645167;11266.746650669817;11692.883071169264;12038.518459261619;12047.759044819055;34082.48876266858;40011;40136.799316003235;40246.59753402458;40517;3392.2028323343993;3402.132456223672;3455.94816077759;3587.461880717887;3720.311742327678;31458.685413146035;31548.842255788804;32200.19499512531;32536.837315813507;32601.021969340956;3267.950980735291;3280.212748940261;3289.4243507386113;3307.140143562667;3336.48190073516;522016;524403.3779831114;525970;525972;525976;33390.83304583462;57820.71089644525;59003;59116;59119.40880591139;35690.572377104625;35698;35710.107247318505;35713.821430892676;35745.28509429797;14598.927005365118;14774.926125369304;14810.777838332433;14821.333040013225;14832.961692681409;11327.433628318551;11568.537258509565;12364.938175309066;12510.937445312715;12603.243805371707;7096.57420554758;7305.853882922312;7635.580043097571;7948.682052717826;7975.960120199362;3212.1969507623094;3279.737620990315;3282.8686852526107;3288.9506657400157;3312.0560640217423;889.8131392407538;969.2149359019216;983.8229118758692;1040.953157107917;1049.380865289483;29918.401631967237;29972.100836974925;30528.08415747531;30603.387932241232;30756.231094222378;1108.3349990005931;1120.9383483908464;1189.3458597771191;1190.089581470176;1225.3015781004742;15435.845641543665;15549.922250388676;15666.921665391601;15859.048457092611;16029.038257704575;561103;589155;618574;647970;648554;56985.715071424376;58859.70570147122;58904;58905.70547147322;59035;1232.8582213045615;1277.0485987939044;1363.3728484896662;1385;1402.9929850350886;29857.10428687143;30768.692313076583;30898.227544311572;31375.372492549566;31706.365872681956;54714.63213419697;55276;55829.441705584046;55866;55972;598365;603682;606806;607863;608634;35995;36766.264674705824;39939.0045746576;41690.58309416867;43307.56692433036;46641.76679116583;47006.76496617495;48040.75979620079;48059;48171.5182848167;36288.45567316545;36816.26367472689;39423;40054.59945400509;40202.798986004884;38184.80907595444;38643;38750;39087.6091239084;39468.013299667735;37553.81223093867;37982.43026354662;38121.856344309715;38441.615583843806;38517.2296554073;28376.723047463325;30446.412054975575;34016.319673605896;34140;34263.486047709805;22882.984625138637;24525.89633466534;24718.382040449134;25041.87479062593;25310.367240819127 14:24:56 INFO - PROCESS | 1649 | |2;jquery.html;352.7231123567996;372.45621392766566;381.8186361478298;384.41760732490263;402.43056075652953;15424.614384640376;15846.920765396171;21055;21201.363959081213;21242;20873.478163045933;21441.67837482439;21456.356309310708;21533;21908.904554772278;5564.415736347686;5873.0896711009755;5884.411558844125;6136.171616831715;6141.815745527641;6021.367756385582;6066.423689749467;6132.41742034506;6133.2026836511195;6134.7546098156245;5767.711614419283;5943.435373639497;5980.521558275327;5983.611065280765;6071.666058366788;5693.800716974927;5920.940790592082;5983.1025346197985;5986.042233242661;5998.4001599839885;5136.794528218904;5168.8966220675375;5171.612129090333;5181.663191892552;5187.636865419422;24933.252002439956;25861.35346616331;25893.09374171895;26295.816688249073;26355;2010.2260629657542;2159.6544552871464;2186.693862859201;2462.3967128053564;2507.185164821422;12756.425960831784;14702.191379474125;15506.689866202612;15548.61128471786;15993.760093598605;1724.611962308483;1777;1806.4580625812205;1811.2483319422424;1814.7005744052215;68452;89989;116149.99999999916;126403;129395.35302323522;11067.612633557786;11073.224874258885;11197.552097915992;11223.438828058564;11374.94312528432;13745.725085498234;13825.032247742764;13851.584452466443;13851.722965540634;13866.376013079234;8530.87203691945;8668.956655216683;8720.30237580992;8795.252403545643;8824.691135810215;8784.429012114193;8799.956000219958;8821.073787252375;8898.59956301968;8921.286297096347;5689.7724091036725;6540.6729663516635;6694.397504224643;6697.497687673444;6715.664216789141;1702.9659406812043;1713.1321948824248;1783.554111472132;1834.3029648733395;1847.2844917970563;773.4122067228834;848.4781859156574;909.1317791509093;974.2063492063492;994.194702291132;21179.894100529706;21980.900954952187;22904.427389315402;22955.42611434694;23241;766.0271455251799;867.5748883047388;937.2642475656577;945.7304668169538;992.3400938376044;11473.541058357572;11489.885101148882;11839.11206659504;12022.75954480923;12042.578509752117;605561;609322;613870;620868;626892;124949.37525312498;125061;128189.359053206;130224;144711;962.3840741925173;973.1193270090579;1014.8782146142363;1037.123630532199;1039.1634734039171;18970.43088707341;19592.412227632623;19685;19777.505562361057;19852.20591176337;57689.71155144365;58941;59694.806103878545;60005.39994599998;60237.096443554256;83514.5824270899;86210.56894715487;87279;88306.00767697023;89089;8047.436679432383;8110.256294896625;8146.14465481116;8398.916010839814;8457.281131103926;9124.45253284805;12344.4444999977;13137.737245255232;13181.736365272833;13340.932725381752;11008.944955275172;11080.224384293022;11300.94349528247;11310.717232069264;11358.148138889452;10981.505832237728;10993.505292261707;11059.778804423706;11216.439178040902;11384.829227561759;11419.543218271509;11428.828567571327;11464.828027579426;11519.424028798694;11683.941580292045;8135.552544610104;8160.30637395828;8183.590820458834;8226.095129535626;8229.670813167646;10435.32170408921;11118.555257789598;11258.986691197832;11266.549338026387;11271.211015229183 14:24:56 INFO - PROCESS | 1649 | |3;mootools.html;1379.3034517568626;1521.2089713349062;1522.840101789312;1731.6623258464597;1898.5538398476365;7869.213078692135;8673.436226645264;8880.911190888097;8894.110588941103;9023.95488022559;8637.481751094923;8803.20771130598;8811.074837142103;8815.382923195379;8888.866666999984;2083.3020937985793;2376.90492380305;2409.1567951217107;2411.1078900806724;2418.2019933422016;2334.078039174525;2371.4427109629223;2373.821963352747;2378.203301893868;2391.9714522755207;2324.0239099578216;2336.2523992322463;2340.8127349811975;2390.462146017141;2395.101836811196;2335.7313908900355;2367.9052837886466;2370.952580948371;2379.452725873042;2383.380321116505;2327.837051406402;2350.21267875262;2355.5171189906027;2361.8464799787957;2368.3723813189517;8774;8842.69050583233;8965.327600429928;8989.146031127033;8996.59515321812;5242.659227150223;5455.154451060052;5461.890762184774;5465.480779325958;5470.343558772933;3582.5700915889997;3612.223371975038;3658.1037645776687;3683.5027271318295;3684.889453316405;1068.1454836131063;1079.098952374768;1080.481368942904;1086.0497065068066;1099;11360.659180224524;11441.828372574419;11449.542018319256;11465;11479.540818367255;4372.23485889968;4390.429244198298;4594.218982772936;4601;4625.121226966866;9017.594208260643;9044.276457883354;9058.818823623491;9086.545672716338;9090.045545217657;5242.1088414969545;5252.107141785906;5254.395744489432;5256.737163141827;5258.2375555544995;4064.878053658395;4431.778411079433;4589.609883159968;4911.16510193268;4958.231474121517;3225.6935591118804;3753.3619284721663;3801.8784458584782;3885.106425522146;3936.645701886844;996.5266498413196;1151.2229245259584;1156.647222597116;1159.8434211381355;1165.2542372881362;633.7528363938068;775.7355510517932;890.4523717913437;928.8699582058517;963.0225321298888;5798.6810725410505;5912.615679980788;5956;6057.121717350959;6062.514998800086;492.48781267481417;645.5448908519483;992.2805965674828;1022.6471867205802;1054.298891237334;3905.1603905160528;3923.156521347924;4003.2193722223888;4006.579309172553;4009.7794621296107;10592.947035264775;10791.946040269748;11163.386013769159;11176.441177941071;11176.832347514794;9340.953295233481;11069.446527673585;11102.944485277521;11106.55573777056;11120.999999999838;7808.6095695216145;8216.83566328682;8221.424500284922;8338.916610833814;8340.833183336299;5856.94143058564;6021.096835474714;6041.2750469943885;6106.3588323227195;6239.688015599111;8129.146439623991;9106.317026223192;9907.653232136841;10487.685369438928;10489.370637761758;9779.119879210904;10533.57865685364;10547.156227501628;10583.576656933636;10638.946805265925;6984.2317345093015;7455.515391499535;7593.506422082547;7724.652390642322;7745.573993430416;8121.35029197651;8471.61877715492;8496.872546911925;8592.914070859211;8593.52735599548;6186.659733714689;7413.147488038729;7446.218147094477;7547.547147171187;7784.92215077842;7377.77866664001;7465.141508726566;7532.736354227576;7541.283578060075;7674.693012279669;6939.965300173467;6941.826454338682;7015.859682806417;7018.2630823762765;7018.6490675465;4870.878228044327;5066.138756411493;5068.26510156018;5072.75264102056;5099.954509325506;5024.698518088926;5072.644914856072;5090.974545127251;5112.079825631422;5240.7641656126325 14:24:56 INFO - PROCESS | 1649 | |4;prototype.html;298.2082570774594;302.190130450393;306.6917747663598;316.0896617740906;318.1124662192483;5468.53915737918;5483.808066717661;5485.506304432601;5511.917321240179;5516.420775818541;5056.713136461302;5234.345706786652;5284.709340986245;5295.973520132394;5496.670199788015;3999.7800670795395;4041.6564592009713;4046.858359957395;4073.8593193905754;4074.2684359147393;3640.4903313536124;3963.06867886048;4133.739209541089;4134.441850350195;4148.211839750437;3278.344331133783;3566.518519999806;4050.6354428101463;4068.5117785865737;4089.672826173914;3117.610298712661;3564.679178873901;3890.260850438436;3939.625735555118;4021.8994525136814;3001.9399612007855;3289.473684210539;3362.747793915466;3405.2848901730667;3504.632013638582;5184.7407629618365;5202.635815492917;5213.817516386908;5258.447862974409;5301.310829592128;4616.44602647681;4631.513691062423;4647.047355292157;4648.953510464919;4662.347271382009;4934.7285899275885;5338.119210330291;5624.943750562483;5652.689102099383;5685.2091591148655;3665.321915445651;3840.1551658635335;3849.2493963677093;3855.2867719471988;3863.1694185749916;5955.970220148914;5974.522038236974;5986.970065149646;6005.789797357115;6014.96992515039;3374.2239284964594;3672.5225720656144;3905.33609286422;3924.3328634132267;3933.252681990413;3977.423273625308;3996.500437445319;4008.378701301303;4016.638502534786;4018.0868870068966;3966.8214930328204;4657.534246575316;4669.649776266793;4693.389859318335;4707.741074240881;5261.500157485033;5289.894202116013;5734.541236701054;5789.88420231593;5805.8548536286935;1158.916413153704;1269.676232560691;1319.2678063674753;1360.3266383140408;1366.0232933452628;874.6370256343673;903.1735961595067;907.3421769217397;909.3452714045876;913.9954300228457;5236.847893463432;5290.376092376734;5301.628885977944;5314.2825718528275;5330.92003619946;5483.217954164833;5822;5859.062549991981;5862.237909071793;5869.53043756507;4325.826966921288;4877.487863774323;5174.327337446108;5261;5277.472252774769;3051.206686261588;3053.8931137410086;3060.2808340040074;3060.6939306069216;3061.785675002773;5041;5550.195221692832;5561.1082237236415;5922.466977971917;5926.170336152942;5374.731263436891;5872.324682661463;5887.823365298962;5906.586538942232;5919.615225010447;5590.049691552527;5889.440503152194;5915.438033386821;5922.3417443115995;5941.257342832059;4985.551300382983;5339.79854532727;5919.852003699942;5946.43508866657;5965.791197308247;5282.418933917343;5520.067976208295;5850;5858.004139296415;5888.705564721832;5093.71984540839;5900.793472228452;6085.847853803691;6102.877942441038;6140.723667434887;3909.9218015638958;3910.338106304866;3920.862769803043;3929.155231625214;3968.7023473239046;5220.738963051908;5455.918161227505;5972.8805423892145;5985.760569577343;5989.610675306091;4955.45489996093;5260.526552610283;5437.619366644455;5670.314295707823;5794.159846822272;5723.627964182315;5726.513246374105;5735.655860648374;5738.5696072795545;5800.7099645018425;4579.38178345919;5307.57539396855;5473.507384335429;5537.5569954402745;5565.3599836019375;5156.539593251735;5319.627626066293;5453.536449401845;5490.599897026233;5720.683123335056;4968.751562421937;5496.532794712494;5563.221149039218;5611.466910643482;5615 14:24:56 INFO - PROCESS | 1649 | |5;yui.html;605.9002909718861;707.8796604577221;780.5628847845207;816.6447595296042;826.0706704956923;13553.322333883303;14929.402823887045;15894.443694470696;16344.673106537863;16346.18269086547;14888.106713597192;15069.547913562583;15070.924645376785;15106.471273505429;15238.695226095471;676.736072931557;694.4305669351135;826.8966379202585;869.9043105258417;877.0965905117707;824.9711260105897;862.168007872403;863.8704194370832;873.7640836974014;878.3587980774039;895.1093661806511;901.8016036471998;904.2043002158092;905.108468158863;905.6513242401656;709.5139829217003;859.8796168536347;899.1413200393608;899.3569597737617;912.8037471943497;676.7563677076249;677.5054210426367;678.0304165043985;678.35217367414;678.9864202715918;15075.54773356801;15164.924175379163;15170.089794612248;15190.924045379812;15193.392264309414;11951.511181902464;13973.441062357493;14201.431942722278;14262.714745705132;14348.497802576963;12809.807852882213;13120.343982800821;13225.140365876186;13241.801372979413;13478.824739501777;4634.050019745944;4662.230731929228;4795.136875362434;4849.054434385296;4854.320395144682;101499.9850001498;108242.45878770635;119386.40306798411;120907.395463023;121681;11253.606123785628;11303.039241664386;11420.600278990196;11537.19239653233;11707.356095414834;22723;22726.20458283952;22731.09075636989;22741;22763.203287885175;6884.690188941509;8004.919950800534;8079.5960201989665;8080.73787988597;8198.508089514648;4381.101874115799;4437.844675436344;4439.42287502629;4442.311441726538;4593.356930029799;3796.962030379661;4071.9796401017807;4074;4081.795910204478;4084.571120032413;723.5224751663982;723.6200994477941;737.0676094740159;739.5562662402623;747.8429529798694;571.8313097636208;586.4751047812184;594.2245369792377;672.2269390201308;681.7511608262948;9420.387674801254;9428.340016198938;9658.420494770337;9762.260021883987;9793.461359625146;522.743855510797;627.9340669229756;645.8353119954381;661.9404253617198;672.6098862659645;4462.977685111554;4691.702360792867;4701.600363969101;4766.785494652749;4791;161880;163076;167271;170567;174252;123842.38078809548;131925;136947.31526342503;145338;145580;124112;125324;126117.73882261243;126521;127215;7771.533707977539;8663.830382898228;8903.543287477503;9125.680601178927;9227.031161727922;68411.3158868405;68776.98843850134;68918.65540672264;69368.61262774817;69598;96761.51619241858;103047.96952030384;104179;106151.46924265329;107957.46021270158;11639.47622357013;11857.241961001315;11975;11995.64013079609;12278.877211228131;13400.597982060553;13488.258145802076;13610.183388996691;13699.726005479635;14038.227897465737;12195.085368597212;12498.125131240726;12502.312372819582;12826.230426174086;12910.354482276036;10811.837822432828;12300.507979680713;12434.937825310815;12444.875551244733;12955.417006234931;12096.516139354679;12273.263604183778;12529.498820047096;12685.93657031709;12686.936565317113;10242.83530951237;10546.314489558154;10620.415877126832;10722.946385268024;10821.837672434762;10446.100179158715;10544.367337959748;10620.52207650642;10630.787384252426;10653.786924261316 14:24:56 INFO - PROCESS | 1649 | __end_tp_report 14:24:56 INFO - PROCESS | 1649 | __start_cc_report 14:24:56 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1205 14:24:56 INFO - PROCESS | 1649 | __end_cc_report 14:24:56 INFO - PROCESS | 1649 | __startTimestamp1467235496165__endTimestamp 14:24:56 INFO - PROCESS | 1649 | 14:24:56 INFO - PROCESS | 1649 | ------- Summary: start ------- 14:24:56 INFO - PROCESS | 1649 | Number of tests: 6 14:24:56 INFO - PROCESS | 1649 | 14:24:56 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5733.11 Median:5934.14 stddev:659.07 (11.1%) stddev-sans-first:622.63 14:24:56 INFO - PROCESS | 1649 | Values: 2905.0 3349.3 3366.6 3385.9 3402.3 5568.4 5614.9 5649.7 5734.9 5749.4 5671.6 5707.9 5728.9 5740.7 5750.7 5134.5 5166.9 5183.2 5192.7 5251.4 5279.6 5300.8 5303.7 5307.0 5307.4 5186.8 5195.4 5208.5 5218.3 5304.4 5293.2 5300.4 5309.9 5319.2 5360.8 5075.9 5087.3 5113.1 5213.1 5213.7 5627.6 5655.5 5702.9 5715.4 5723.3 6292.1 6307.4 6317.6 6326.2 6332.4 5084.5 6177.8 6189.0 6331.8 6377.6 5778.7 5807.6 5825.2 5839.7 5853.1 6305.1 6306.8 6314.1 6317.0 6340.8 6019.8 6082.5 6117.9 6123.5 6140.2 6207.2 6266.8 6292.9 6320.1 6321.3 6178.1 6227.4 6245.7 6253.3 6281.2 6070.2 6129.1 6134.4 6286.7 6313.5 4911.0 4957.8 4964.0 4967.3 4970.1 3792.3 4468.5 4504.3 4506.3 4522.4 5681.3 5722.4 5768.6 5804.8 5819.1 6287.6 6352.5 6353.8 6368.0 6375.8 5736.1 5744.2 5744.3 5746.7 5819.3 5304.5 5353.2 5356.8 5414.6 5435.9 6206.3 6235.3 6281.9 6285.3 6308.5 5259.9 6308.0 6329.6 6336.9 6364.7 6275.1 6315.3 6324.4 6325.8 6326.6 5039.2 6080.8 6132.4 6136.1 6190.9 6060.4 6179.2 6203.2 6218.0 6227.7 5361.8 6050.8 6112.9 6113.9 6134.4 6084.3 6093.2 6130.4 6139.1 6144.8 5787.8 5851.2 5904.1 5945.4 5953.6 6095.6 6099.1 6116.9 6117.0 6143.7 5934.1 5966.9 5968.9 5980.9 6013.0 14:24:56 INFO - PROCESS | 1649 | 14:24:56 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:70495.93 Median:19666.37 stddev:155840.33 (792.4%) stddev-sans-first:156188.85 14:24:56 INFO - PROCESS | 1649 | Values: 483.6 491.3 521.7 528.5 530.1 29344.0 30287.5 41185.6 41715.2 41806.8 42894.0 43270.4 43361.6 43381.3 43474.7 9663.9 9841.6 9854.9 9865.6 9890.8 8798.7 9032.4 11843.3 12091.7 12136.8 12040.7 12062.4 12093.2 12121.8 12130.3 8715.0 10157.5 11829.8 12085.8 12088.9 11040.3 11266.7 11692.9 12038.5 12047.8 34082.5 40011.0 40136.8 40246.6 40517.0 3392.2 3402.1 3455.9 3587.5 3720.3 31458.7 31548.8 32200.2 32536.8 32601.0 3268.0 3280.2 3289.4 3307.1 3336.5 522016.0 524403.4 525970.0 525972.0 525976.0 33390.8 57820.7 59003.0 59116.0 59119.4 35690.6 35698.0 35710.1 35713.8 35745.3 14598.9 14774.9 14810.8 14821.3 14833.0 11327.4 11568.5 12364.9 12510.9 12603.2 7096.6 7305.9 7635.6 7948.7 7976.0 3212.2 3279.7 3282.9 3289.0 3312.1 889.8 969.2 983.8 1041.0 1049.4 29918.4 29972.1 30528.1 30603.4 30756.2 1108.3 1120.9 1189.3 1190.1 1225.3 15435.8 15549.9 15666.9 15859.0 16029.0 561103.0 589155.0 618574.0 647970.0 648554.0 56985.7 58859.7 58904.0 58905.7 59035.0 1232.9 1277.0 1363.4 1385.0 1403.0 29857.1 30768.7 30898.2 31375.4 31706.4 54714.6 55276.0 55829.4 55866.0 55972.0 598365.0 603682.0 606806.0 607863.0 608634.0 35995.0 36766.3 39939.0 41690.6 43307.6 46641.8 47006.8 48040.8 48059.0 48171.5 36288.5 36816.3 39423.0 40054.6 40202.8 38184.8 38643.0 38750.0 39087.6 39468.0 37553.8 37982.4 38121.9 38441.6 38517.2 28376.7 30446.4 34016.3 34140.0 34263.5 22883.0 24525.9 24718.4 25041.9 25310.4 14:24:56 INFO - PROCESS | 1649 | 14:24:56 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:35939.68 Median:14184.27 stddev:102534.56 (722.9%) stddev-sans-first:102787.38 14:24:56 INFO - PROCESS | 1649 | Values: 352.7 372.5 381.8 384.4 402.4 15424.6 15846.9 21055.0 21201.4 21242.0 20873.5 21441.7 21456.4 21533.0 21908.9 5564.4 5873.1 5884.4 6136.2 6141.8 6021.4 6066.4 6132.4 6133.2 6134.8 5767.7 5943.4 5980.5 5983.6 6071.7 5693.8 5920.9 5983.1 5986.0 5998.4 5136.8 5168.9 5171.6 5181.7 5187.6 24933.3 25861.4 25893.1 26295.8 26355.0 2010.2 2159.7 2186.7 2462.4 2507.2 12756.4 14702.2 15506.7 15548.6 15993.8 1724.6 1777.0 1806.5 1811.2 1814.7 68452.0 89989.0 116150.0 126403.0 129395.4 11067.6 11073.2 11197.6 11223.4 11374.9 13745.7 13825.0 13851.6 13851.7 13866.4 8530.9 8669.0 8720.3 8795.3 8824.7 8784.4 8800.0 8821.1 8898.6 8921.3 5689.8 6540.7 6694.4 6697.5 6715.7 1703.0 1713.1 1783.6 1834.3 1847.3 773.4 848.5 909.1 974.2 994.2 21179.9 21980.9 22904.4 22955.4 23241.0 766.0 867.6 937.3 945.7 992.3 11473.5 11489.9 11839.1 12022.8 12042.6 605561.0 609322.0 613870.0 620868.0 626892.0 124949.4 125061.0 128189.4 130224.0 144711.0 962.4 973.1 1014.9 1037.1 1039.2 18970.4 19592.4 19685.0 19777.5 19852.2 57689.7 58941.0 59694.8 60005.4 60237.1 83514.6 86210.6 87279.0 88306.0 89089.0 8047.4 8110.3 8146.1 8398.9 8457.3 9124.5 12344.4 13137.7 13181.7 13340.9 11008.9 11080.2 11300.9 11310.7 11358.1 10981.5 10993.5 11059.8 11216.4 11384.8 11419.5 11428.8 11464.8 11519.4 11683.9 8135.6 8160.3 8183.6 8226.1 8229.7 10435.3 11118.6 11259.0 11266.5 11271.2 14:24:56 INFO - PROCESS | 1649 | 14:24:56 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5697.71 Median:5070.46 stddev:3206.03 (63.2%) stddev-sans-first:3198.60 14:24:56 INFO - PROCESS | 1649 | Values: 1379.3 1521.2 1522.8 1731.7 1898.6 7869.2 8673.4 8880.9 8894.1 9024.0 8637.5 8803.2 8811.1 8815.4 8888.9 2083.3 2376.9 2409.2 2411.1 2418.2 2334.1 2371.4 2373.8 2378.2 2392.0 2324.0 2336.3 2340.8 2390.5 2395.1 2335.7 2367.9 2371.0 2379.5 2383.4 2327.8 2350.2 2355.5 2361.8 2368.4 8774.0 8842.7 8965.3 8989.1 8996.6 5242.7 5455.2 5461.9 5465.5 5470.3 3582.6 3612.2 3658.1 3683.5 3684.9 1068.1 1079.1 1080.5 1086.0 1099.0 11360.7 11441.8 11449.5 11465.0 11479.5 4372.2 4390.4 4594.2 4601.0 4625.1 9017.6 9044.3 9058.8 9086.5 9090.0 5242.1 5252.1 5254.4 5256.7 5258.2 4064.9 4431.8 4589.6 4911.2 4958.2 3225.7 3753.4 3801.9 3885.1 3936.6 996.5 1151.2 1156.6 1159.8 1165.3 633.8 775.7 890.5 928.9 963.0 5798.7 5912.6 5956.0 6057.1 6062.5 492.5 645.5 992.3 1022.6 1054.3 3905.2 3923.2 4003.2 4006.6 4009.8 10592.9 10791.9 11163.4 11176.4 11176.8 9341.0 11069.4 11102.9 11106.6 11121.0 7808.6 8216.8 8221.4 8338.9 8340.8 5856.9 6021.1 6041.3 6106.4 6239.7 8129.1 9106.3 9907.7 10487.7 10489.4 9779.1 10533.6 10547.2 10583.6 10638.9 6984.2 7455.5 7593.5 7724.7 7745.6 8121.4 8471.6 8496.9 8592.9 8593.5 6186.7 7413.1 7446.2 7547.5 7784.9 7377.8 7465.1 7532.7 7541.3 7674.7 6940.0 6941.8 7015.9 7018.3 7018.6 4870.9 5066.1 5068.3 5072.8 5100.0 5024.7 5072.6 5091.0 5112.1 5240.8 14:24:56 INFO - PROCESS | 1649 | 14:24:56 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4602.37 Median:5261.25 stddev:1430.03 (27.2%) stddev-sans-first:1397.07 14:24:56 INFO - PROCESS | 1649 | Values: 298.2 302.2 306.7 316.1 318.1 5468.5 5483.8 5485.5 5511.9 5516.4 5056.7 5234.3 5284.7 5296.0 5496.7 3999.8 4041.7 4046.9 4073.9 4074.3 3640.5 3963.1 4133.7 4134.4 4148.2 3278.3 3566.5 4050.6 4068.5 4089.7 3117.6 3564.7 3890.3 3939.6 4021.9 3001.9 3289.5 3362.7 3405.3 3504.6 5184.7 5202.6 5213.8 5258.4 5301.3 4616.4 4631.5 4647.0 4649.0 4662.3 4934.7 5338.1 5624.9 5652.7 5685.2 3665.3 3840.2 3849.2 3855.3 3863.2 5956.0 5974.5 5987.0 6005.8 6015.0 3374.2 3672.5 3905.3 3924.3 3933.3 3977.4 3996.5 4008.4 4016.6 4018.1 3966.8 4657.5 4669.6 4693.4 4707.7 5261.5 5289.9 5734.5 5789.9 5805.9 1158.9 1269.7 1319.3 1360.3 1366.0 874.6 903.2 907.3 909.3 914.0 5236.8 5290.4 5301.6 5314.3 5330.9 5483.2 5822.0 5859.1 5862.2 5869.5 4325.8 4877.5 5174.3 5261.0 5277.5 3051.2 3053.9 3060.3 3060.7 3061.8 5041.0 5550.2 5561.1 5922.5 5926.2 5374.7 5872.3 5887.8 5906.6 5919.6 5590.0 5889.4 5915.4 5922.3 5941.3 4985.6 5339.8 5919.9 5946.4 5965.8 5282.4 5520.1 5850.0 5858.0 5888.7 5093.7 5900.8 6085.8 6102.9 6140.7 3909.9 3910.3 3920.9 3929.2 3968.7 5220.7 5455.9 5972.9 5985.8 5989.6 4955.5 5260.5 5437.6 5670.3 5794.2 5723.6 5726.5 5735.7 5738.6 5800.7 4579.4 5307.6 5473.5 5537.6 5565.4 5156.5 5319.6 5453.5 5490.6 5720.7 4968.8 5496.5 5563.2 5611.5 5615.0 14:24:56 INFO - PROCESS | 1649 | 14:24:56 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:26629.39 Median:22728.65 stddev:43843.49 (192.9%) stddev-sans-first:43922.94 14:24:56 INFO - PROCESS | 1649 | Values: 605.9 707.9 780.6 816.6 826.1 13553.3 14929.4 15894.4 16344.7 16346.2 14888.1 15069.5 15070.9 15106.5 15238.7 676.7 694.4 826.9 869.9 877.1 825.0 862.2 863.9 873.8 878.4 895.1 901.8 904.2 905.1 905.7 709.5 859.9 899.1 899.4 912.8 676.8 677.5 678.0 678.4 679.0 15075.5 15164.9 15170.1 15190.9 15193.4 11951.5 13973.4 14201.4 14262.7 14348.5 12809.8 13120.3 13225.1 13241.8 13478.8 4634.1 4662.2 4795.1 4849.1 4854.3 101500.0 108242.5 119386.4 120907.4 121681.0 11253.6 11303.0 11420.6 11537.2 11707.4 22723.0 22726.2 22731.1 22741.0 22763.2 6884.7 8004.9 8079.6 8080.7 8198.5 4381.1 4437.8 4439.4 4442.3 4593.4 3797.0 4072.0 4074.0 4081.8 4084.6 723.5 723.6 737.1 739.6 747.8 571.8 586.5 594.2 672.2 681.8 9420.4 9428.3 9658.4 9762.3 9793.5 522.7 627.9 645.8 661.9 672.6 4463.0 4691.7 4701.6 4766.8 4791.0 161880.0 163076.0 167271.0 170567.0 174252.0 123842.4 131925.0 136947.3 145338.0 145580.0 124112.0 125324.0 126117.7 126521.0 127215.0 7771.5 8663.8 8903.5 9125.7 9227.0 68411.3 68777.0 68918.7 69368.6 69598.0 96761.5 103048.0 104179.0 106151.5 107957.5 11639.5 11857.2 11975.0 11995.6 12278.9 13400.6 13488.3 13610.2 13699.7 14038.2 12195.1 12498.1 12502.3 12826.2 12910.4 10811.8 12300.5 12434.9 12444.9 12955.4 12096.5 12273.3 12529.5 12685.9 12686.9 10242.8 10546.3 10620.4 10722.9 10821.8 10446.1 10544.4 10620.5 10630.8 10653.8 14:24:56 INFO - PROCESS | 1649 | -------- Summary: end -------- 14:24:56 INFO - PROCESS | 1649 | 14:24:56 INFO - TEST-INFO | 1649: exit 0 14:24:56 INFO - TEST-OK | dromaeo_css | took 1116976ms 14:24:56 INFO - TEST-START | kraken 14:24:56 INFO - operating with platform_type : mac_ 14:24:56 INFO - Initialising browser for kraken test... 14:24:56 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpEiWHpM/profile http://localhost:49273/getInfo.html) 14:24:59 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 14:24:59 INFO - PROCESS | 1657 | colorDepth:24 14:24:59 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 14:24:59 INFO - PROCESS | 1657 | __metrics 14:24:59 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:24:59 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:24:59 INFO - TEST-INFO | 1657: exit 0 14:24:59 INFO - Browser initialized. 14:24:59 INFO - Running cycle 1/1 for kraken test... 14:24:59 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpEiWHpM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:11 INFO - PROCESS | 1658 | RSS: Main: 243838976 14:25:11 INFO - PROCESS | 1658 | 14:25:14 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 14:25:15 INFO - PROCESS | 1658 | RSS: Main: 294227968 14:25:15 INFO - PROCESS | 1658 | 14:25:18 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 14:25:18 INFO - PROCESS | 1658 | RSS: Main: 304820224 14:25:18 INFO - PROCESS | 1658 | 14:25:22 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 14:25:22 INFO - PROCESS | 1658 | RSS: Main: 387850240 14:25:22 INFO - PROCESS | 1658 | 14:25:24 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 14:25:25 INFO - PROCESS | 1658 | RSS: Main: 290033664 14:25:25 INFO - PROCESS | 1658 | 14:25:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:25:28 INFO - PROCESS | 1658 | RSS: Main: 294055936 14:25:28 INFO - PROCESS | 1658 | 14:25:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 14:25:31 INFO - PROCESS | 1658 | RSS: Main: 331976704 14:25:31 INFO - PROCESS | 1658 | 14:25:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 14:25:35 INFO - PROCESS | 1658 | RSS: Main: 332615680 14:25:35 INFO - PROCESS | 1658 | 14:25:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 14:25:38 INFO - PROCESS | 1658 | RSS: Main: 332005376 14:25:38 INFO - PROCESS | 1658 | 14:25:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:25:40 INFO - PROCESS | 1658 | RSS: Main: 311808000 14:25:40 INFO - PROCESS | 1658 | 14:25:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:25:43 INFO - PROCESS | 1658 | RSS: Main: 319639552 14:25:43 INFO - PROCESS | 1658 | 14:25:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:25:46 INFO - PROCESS | 1658 | RSS: Main: 315985920 14:25:46 INFO - PROCESS | 1658 | 14:25:49 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:25:49 INFO - PROCESS | 1658 | RSS: Main: 326148096 14:25:49 INFO - PROCESS | 1658 | 14:25:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:25:53 INFO - PROCESS | 1658 | RSS: Main: 328454144 14:25:53 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 14:25:55 INFO - PROCESS | 1658 | RSS: Main: 372334592 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | __start_tp_report 14:25:55 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 14:25:55 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 14:25:55 INFO - PROCESS | 1658 | |i|pagename|runs| 14:25:55 INFO - PROCESS | 1658 | |0;ai-astar;102;156;164;114;113;112;113;111;113;112 14:25:55 INFO - PROCESS | 1658 | |1;audio-beat-detection;143;110;108;159;109;107;130;108;160;138 14:25:55 INFO - PROCESS | 1658 | |2;audio-dft;183;185;183;184;184;184;185;183;184;184 14:25:55 INFO - PROCESS | 1658 | |3;audio-fft;78;73;57;89;59;57;64;62;96;57 14:25:55 INFO - PROCESS | 1658 | |4;audio-oscillator;79;89;93;70;71;69;95;70;69;99 14:25:55 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;118;128;90;87;130;70;123;72;118;102 14:25:55 INFO - PROCESS | 1658 | |6;imaging-darkroom;94;95;93;94;93;94;94;100;138;92 14:25:55 INFO - PROCESS | 1658 | |7;imaging-desaturate;85;84;84;85;84;85;83;87;86;87 14:25:55 INFO - PROCESS | 1658 | |8;json-parse-financial;55;53;53;54;54;52;52;55;53;54 14:25:55 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;64;67;76;80;73;70;70;69;69;69 14:25:55 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;83;83;82;80;83;78;85;85;84;80 14:25:55 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;154;110;142;143;148;143;143;141;236;153 14:25:55 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;166;163;171;222;200;165;163;163;163;165 14:25:55 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;67;66;67;66;65;64;66;66;65;73 14:25:55 INFO - PROCESS | 1658 | __end_tp_report 14:25:55 INFO - PROCESS | 1658 | __start_cc_report 14:25:55 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2017 14:25:55 INFO - PROCESS | 1658 | __end_cc_report 14:25:55 INFO - PROCESS | 1658 | __startTimestamp1467235555429__endTimestamp 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | ------- Summary: start ------- 14:25:55 INFO - PROCESS | 1658 | Number of tests: 14 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:121.00 Median:113.00 stddev:20.92 (18.5%) stddev-sans-first:21.03 14:25:55 INFO - PROCESS | 1658 | Values: 102.0 156.0 164.0 114.0 113.0 112.0 113.0 111.0 113.0 112.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:134.00 stddev:21.69 (16.2%) stddev-sans-first:22.24 14:25:55 INFO - PROCESS | 1658 | Values: 143.0 110.0 108.0 159.0 109.0 107.0 130.0 108.0 160.0 138.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:0.74 (0.4%) stddev-sans-first:0.71 14:25:55 INFO - PROCESS | 1658 | Values: 183.0 185.0 183.0 184.0 184.0 184.0 185.0 183.0 184.0 184.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:69.20 Median:68.50 stddev:14.27 (20.8%) stddev-sans-first:14.77 14:25:55 INFO - PROCESS | 1658 | Values: 78.0 73.0 57.0 89.0 59.0 57.0 64.0 62.0 96.0 57.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:80.40 Median:84.00 stddev:12.29 (14.6%) stddev-sans-first:13.02 14:25:55 INFO - PROCESS | 1658 | Values: 79.0 89.0 93.0 70.0 71.0 69.0 95.0 70.0 69.0 99.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:103.80 Median:100.00 stddev:22.79 (22.8%) stddev-sans-first:23.58 14:25:55 INFO - PROCESS | 1658 | Values: 118.0 128.0 90.0 87.0 130.0 70.0 123.0 72.0 118.0 102.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:98.70 Median:94.00 stddev:13.98 (14.9%) stddev-sans-first:14.72 14:25:55 INFO - PROCESS | 1658 | Values: 94.0 95.0 93.0 94.0 93.0 94.0 94.0 100.0 138.0 92.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.33 (1.6%) stddev-sans-first:1.41 14:25:55 INFO - PROCESS | 1658 | Values: 85.0 84.0 84.0 85.0 84.0 85.0 83.0 87.0 86.0 87.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:54.00 stddev:1.08 (2.0%) stddev-sans-first:1.00 14:25:55 INFO - PROCESS | 1658 | Values: 55.0 53.0 53.0 54.0 54.0 52.0 52.0 55.0 53.0 54.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:70.00 stddev:4.57 (6.5%) stddev-sans-first:4.16 14:25:55 INFO - PROCESS | 1658 | Values: 64.0 67.0 76.0 80.0 73.0 70.0 70.0 69.0 69.0 69.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:83.00 stddev:2.31 (2.8%) stddev-sans-first:2.44 14:25:55 INFO - PROCESS | 1658 | Values: 83.0 83.0 82.0 80.0 83.0 78.0 85.0 85.0 84.0 80.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:151.30 Median:145.50 stddev:32.15 (22.1%) stddev-sans-first:34.08 14:25:55 INFO - PROCESS | 1658 | Values: 154.0 110.0 142.0 143.0 148.0 143.0 143.0 141.0 236.0 153.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.10 Median:165.50 stddev:20.27 (12.2%) stddev-sans-first:21.29 14:25:55 INFO - PROCESS | 1658 | Values: 166.0 163.0 171.0 222.0 200.0 165.0 163.0 163.0 163.0 165.0 14:25:55 INFO - PROCESS | 1658 | 14:25:55 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:2.46 (3.7%) stddev-sans-first:2.60 14:25:55 INFO - PROCESS | 1658 | Values: 67.0 66.0 67.0 66.0 65.0 64.0 66.0 66.0 65.0 73.0 14:25:55 INFO - PROCESS | 1658 | -------- Summary: end -------- 14:25:55 INFO - PROCESS | 1658 | 14:25:56 INFO - TEST-INFO | 1658: exit 0 14:25:56 INFO - TEST-OK | kraken | took 59545ms 14:25:56 INFO - SUITE-END | took 1176s 14:25:56 INFO - Completed test suite (00:19:36) 14:25:56 INFO - javascript benchmark 14:25:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2904.970950290498, 3349.346877358915, 3366.579177602798, 3385.949210761839, 3402.302527981764, 5568.415316391771, 5614.887702245953, 5649.661020338783, 5734.885302293957, 5749.367569567349, 5671.574631902614, 5707.885842283152, 5728.942710572904, 5740.684262365568, 5750.683712395827, 5134.486551344864, 5166.896662066756, 5183.196604526285, 5192.688438693672, 5251.369835619731, 5279.604029697769, 5300.814471493499, 5303.7082960437165, 5307.0, 5307.442718514559, 5186.7925282988635, 5195.40252870919, 5208.531232189102, 5218.321618189649, 5304.443033481487, 5293.206019097147, 5300.443453437372, 5309.920351194735, 5319.228711836762, 5360.785568577291, 5075.873103172414, 5087.3386459759995, 5113.079645663779, 5213.087709650834, 5213.687178769286, 5627.5779316551425, 5655.4910058094965, 5702.885942281173, 5715.428457154293, 5723.255976723, 6292.056191571255, 6307.369263073701, 6317.589356691847, 6326.177596912372, 6332.366763323676, 5084.542391184811, 6177.81466556004, 6188.9690551546955, 6331.778387756406, 6377.58545694533, 5778.7399567019165, 5807.622504537191, 5825.155352473867, 5839.678817665069, 5853.122031695195, 6305.085762564402, 6306.8423289417215, 6314.0844577536, 6316.968415157987, 6340.778072767431, 6019.759209631653, 6082.482988945901, 6117.877642447126, 6123.510119190454, 6140.201773769381, 6207.162033125561, 6266.780662676784, 6292.874142517124, 6320.115183874262, 6321.273053598803, 6178.1350610913605, 6227.408396202353, 6245.687715614292, 6253.312135665074, 6281.214848143982, 6070.180525628984, 6129.111278864629, 6134.355892631299, 6286.685665716695, 6313.494920406357, 4910.950890491049, 4957.801687932514, 4963.950360496421, 4967.279744437036, 4970.105381031377, 3792.3173828710546, 4468.4637843458995, 4504.256797628354, 4506.256467682796, 4522.389477420572, 5681.318241811009, 5722.37053924068, 5768.567357448208, 5804.796832110856, 5819.098039803837, 6287.622742635456, 6352.460040896483, 6353.841153971188, 6367.968160159262, 6375.808725738235, 5736.13957906309, 5744.167095771089, 5744.253247077853, 5746.683932383759, 5819.301683797887, 5304.522592966651, 5353.197020446886, 5356.758945847446, 5414.648047876875, 5435.918461223085, 6206.317305096526, 6235.3452887446165, 6281.905771413432, 6285.340039295899, 6308.526860485482, 5259.947400525945, 6307.96846015767, 6329.5569310149685, 6336.873262534816, 6364.713587888648, 6275.090111933835, 6315.3053164152825, 6324.430801227912, 6325.778597749057, 6326.588771729823, 5039.218921067094, 6080.7567697291615, 6132.355508992456, 6136.110264011782, 6190.907136392868, 6060.39396060408, 6179.196704428576, 6203.2245969253845, 6218.0, 6227.688615569294, 5361.839144825662, 6050.788222412194, 6112.938870611237, 6113.938860611515, 6134.38656134383, 6084.330723620486, 6093.207882975362, 6130.417610327012, 6139.109829074849, 6144.846378840565, 5787.768489260382, 5851.239338885917, 5904.114382842608, 5945.435183657545, 5953.583249172516, 6095.588784116743, 6099.110546378738, 6116.908246376219, 6117.035835319846, 6143.723532440961, 5934.139549765174, 5966.910496342472, 5968.850778730392, 5980.850478737892, 6013.0], "value": 5690.274323257354, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.5575448464655, 491.2925387442083, 521.7156649625955, 528.532248959671, 530.0988319856243, 29344.0, 30287.545686814687, 41185.58814411851, 41715.16569668605, 41806.790966045126, 42894.0, 43270.35094473577, 43361.56638433615, 43381.34927976083, 43474.6957591272, 9663.903360966387, 9841.606335746561, 9854.852177217312, 9865.60537578496, 9890.802183956317, 8798.6920457784, 9032.412893161956, 11843.348615826126, 12091.697707557294, 12136.817947730748, 12040.698982525462, 12062.396880156, 12093.153479256456, 12121.818172727417, 12130.332831694253, 8715.041345451995, 10157.492125393737, 11829.763404731857, 12085.758284834254, 12088.939555302255, 11040.282381645167, 11266.746650669817, 11692.883071169264, 12038.518459261619, 12047.759044819055, 34082.48876266858, 40011.0, 40136.799316003235, 40246.59753402458, 40517.0, 3392.2028323343993, 3402.132456223672, 3455.94816077759, 3587.461880717887, 3720.311742327678, 31458.685413146035, 31548.842255788804, 32200.19499512531, 32536.837315813507, 32601.021969340956, 3267.950980735291, 3280.212748940261, 3289.4243507386113, 3307.140143562667, 3336.48190073516, 522016.0, 524403.3779831114, 525970.0, 525972.0, 525976.0, 33390.83304583462, 57820.71089644525, 59003.0, 59116.0, 59119.40880591139, 35690.572377104625, 35698.0, 35710.107247318505, 35713.821430892676, 35745.28509429797, 14598.927005365118, 14774.926125369304, 14810.777838332433, 14821.333040013225, 14832.961692681409, 11327.433628318551, 11568.537258509565, 12364.938175309066, 12510.937445312715, 12603.243805371707, 7096.57420554758, 7305.853882922312, 7635.580043097571, 7948.682052717826, 7975.960120199362, 3212.1969507623094, 3279.737620990315, 3282.8686852526107, 3288.9506657400157, 3312.0560640217423, 889.8131392407538, 969.2149359019216, 983.8229118758692, 1040.953157107917, 1049.380865289483, 29918.401631967237, 29972.100836974925, 30528.08415747531, 30603.387932241232, 30756.231094222378, 1108.3349990005931, 1120.9383483908464, 1189.3458597771191, 1190.089581470176, 1225.3015781004742, 15435.845641543665, 15549.922250388676, 15666.921665391601, 15859.048457092611, 16029.038257704575, 561103.0, 589155.0, 618574.0, 647970.0, 648554.0, 56985.715071424376, 58859.70570147122, 58904.0, 58905.70547147322, 59035.0, 1232.8582213045615, 1277.0485987939044, 1363.3728484896662, 1385.0, 1402.9929850350886, 29857.10428687143, 30768.692313076583, 30898.227544311572, 31375.372492549566, 31706.365872681956, 54714.63213419697, 55276.0, 55829.441705584046, 55866.0, 55972.0, 598365.0, 603682.0, 606806.0, 607863.0, 608634.0, 35995.0, 36766.264674705824, 39939.0045746576, 41690.58309416867, 43307.56692433036, 46641.76679116583, 47006.76496617495, 48040.75979620079, 48059.0, 48171.5182848167, 36288.45567316545, 36816.26367472689, 39423.0, 40054.59945400509, 40202.798986004884, 38184.80907595444, 38643.0, 38750.0, 39087.6091239084, 39468.013299667735, 37553.81223093867, 37982.43026354662, 38121.856344309715, 38441.615583843806, 38517.2296554073, 28376.723047463325, 30446.412054975575, 34016.319673605896, 34140.0, 34263.486047709805, 22882.984625138637, 24525.89633466534, 24718.382040449134, 25041.87479062593, 25310.367240819127], "value": 19325.519591910233, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.7231123567996, 372.45621392766566, 381.8186361478298, 384.41760732490263, 402.43056075652953, 15424.614384640376, 15846.920765396171, 21055.0, 21201.363959081213, 21242.0, 20873.478163045933, 21441.67837482439, 21456.356309310708, 21533.0, 21908.904554772278, 5564.415736347686, 5873.0896711009755, 5884.411558844125, 6136.171616831715, 6141.815745527641, 6021.367756385582, 6066.423689749467, 6132.41742034506, 6133.2026836511195, 6134.7546098156245, 5767.711614419283, 5943.435373639497, 5980.521558275327, 5983.611065280765, 6071.666058366788, 5693.800716974927, 5920.940790592082, 5983.1025346197985, 5986.042233242661, 5998.4001599839885, 5136.794528218904, 5168.8966220675375, 5171.612129090333, 5181.663191892552, 5187.636865419422, 24933.252002439956, 25861.35346616331, 25893.09374171895, 26295.816688249073, 26355.0, 2010.2260629657542, 2159.6544552871464, 2186.693862859201, 2462.3967128053564, 2507.185164821422, 12756.425960831784, 14702.191379474125, 15506.689866202612, 15548.61128471786, 15993.760093598605, 1724.611962308483, 1777.0, 1806.4580625812205, 1811.2483319422424, 1814.7005744052215, 68452.0, 89989.0, 116149.99999999916, 126403.0, 129395.35302323522, 11067.612633557786, 11073.224874258885, 11197.552097915992, 11223.438828058564, 11374.94312528432, 13745.725085498234, 13825.032247742764, 13851.584452466443, 13851.722965540634, 13866.376013079234, 8530.87203691945, 8668.956655216683, 8720.30237580992, 8795.252403545643, 8824.691135810215, 8784.429012114193, 8799.956000219958, 8821.073787252375, 8898.59956301968, 8921.286297096347, 5689.7724091036725, 6540.6729663516635, 6694.397504224643, 6697.497687673444, 6715.664216789141, 1702.9659406812043, 1713.1321948824248, 1783.554111472132, 1834.3029648733395, 1847.2844917970563, 773.4122067228834, 848.4781859156574, 909.1317791509093, 974.2063492063492, 994.194702291132, 21179.894100529706, 21980.900954952187, 22904.427389315402, 22955.42611434694, 23241.0, 766.0271455251799, 867.5748883047388, 937.2642475656577, 945.7304668169538, 992.3400938376044, 11473.541058357572, 11489.885101148882, 11839.11206659504, 12022.75954480923, 12042.578509752117, 605561.0, 609322.0, 613870.0, 620868.0, 626892.0, 124949.37525312498, 125061.0, 128189.359053206, 130224.0, 144711.0, 962.3840741925173, 973.1193270090579, 1014.8782146142363, 1037.123630532199, 1039.1634734039171, 18970.43088707341, 19592.412227632623, 19685.0, 19777.505562361057, 19852.20591176337, 57689.71155144365, 58941.0, 59694.806103878545, 60005.39994599998, 60237.096443554256, 83514.5824270899, 86210.56894715487, 87279.0, 88306.00767697023, 89089.0, 8047.436679432383, 8110.256294896625, 8146.14465481116, 8398.916010839814, 8457.281131103926, 9124.45253284805, 12344.4444999977, 13137.737245255232, 13181.736365272833, 13340.932725381752, 11008.944955275172, 11080.224384293022, 11300.94349528247, 11310.717232069264, 11358.148138889452, 10981.505832237728, 10993.505292261707, 11059.778804423706, 11216.439178040902, 11384.829227561759, 11419.543218271509, 11428.828567571327, 11464.828027579426, 11519.424028798694, 11683.941580292045, 8135.552544610104, 8160.30637395828, 8183.590820458834, 8226.095129535626, 8229.670813167646, 10435.32170408921, 11118.555257789598, 11258.986691197832, 11266.549338026387, 11271.211015229183], "value": 9823.958668023466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.3034517568626, 1521.2089713349062, 1522.840101789312, 1731.6623258464597, 1898.5538398476365, 7869.213078692135, 8673.436226645264, 8880.911190888097, 8894.110588941103, 9023.95488022559, 8637.481751094923, 8803.20771130598, 8811.074837142103, 8815.382923195379, 8888.866666999984, 2083.3020937985793, 2376.90492380305, 2409.1567951217107, 2411.1078900806724, 2418.2019933422016, 2334.078039174525, 2371.4427109629223, 2373.821963352747, 2378.203301893868, 2391.9714522755207, 2324.0239099578216, 2336.2523992322463, 2340.8127349811975, 2390.462146017141, 2395.101836811196, 2335.7313908900355, 2367.9052837886466, 2370.952580948371, 2379.452725873042, 2383.380321116505, 2327.837051406402, 2350.21267875262, 2355.5171189906027, 2361.8464799787957, 2368.3723813189517, 8774.0, 8842.69050583233, 8965.327600429928, 8989.146031127033, 8996.59515321812, 5242.659227150223, 5455.154451060052, 5461.890762184774, 5465.480779325958, 5470.343558772933, 3582.5700915889997, 3612.223371975038, 3658.1037645776687, 3683.5027271318295, 3684.889453316405, 1068.1454836131063, 1079.098952374768, 1080.481368942904, 1086.0497065068066, 1099.0, 11360.659180224524, 11441.828372574419, 11449.542018319256, 11465.0, 11479.540818367255, 4372.23485889968, 4390.429244198298, 4594.218982772936, 4601.0, 4625.121226966866, 9017.594208260643, 9044.276457883354, 9058.818823623491, 9086.545672716338, 9090.045545217657, 5242.1088414969545, 5252.107141785906, 5254.395744489432, 5256.737163141827, 5258.2375555544995, 4064.878053658395, 4431.778411079433, 4589.609883159968, 4911.16510193268, 4958.231474121517, 3225.6935591118804, 3753.3619284721663, 3801.8784458584782, 3885.106425522146, 3936.645701886844, 996.5266498413196, 1151.2229245259584, 1156.647222597116, 1159.8434211381355, 1165.2542372881362, 633.7528363938068, 775.7355510517932, 890.4523717913437, 928.8699582058517, 963.0225321298888, 5798.6810725410505, 5912.615679980788, 5956.0, 6057.121717350959, 6062.514998800086, 492.48781267481417, 645.5448908519483, 992.2805965674828, 1022.6471867205802, 1054.298891237334, 3905.1603905160528, 3923.156521347924, 4003.2193722223888, 4006.579309172553, 4009.7794621296107, 10592.947035264775, 10791.946040269748, 11163.386013769159, 11176.441177941071, 11176.832347514794, 9340.953295233481, 11069.446527673585, 11102.944485277521, 11106.55573777056, 11120.999999999838, 7808.6095695216145, 8216.83566328682, 8221.424500284922, 8338.916610833814, 8340.833183336299, 5856.94143058564, 6021.096835474714, 6041.2750469943885, 6106.3588323227195, 6239.688015599111, 8129.146439623991, 9106.317026223192, 9907.653232136841, 10487.685369438928, 10489.370637761758, 9779.119879210904, 10533.57865685364, 10547.156227501628, 10583.576656933636, 10638.946805265925, 6984.2317345093015, 7455.515391499535, 7593.506422082547, 7724.652390642322, 7745.573993430416, 8121.35029197651, 8471.61877715492, 8496.872546911925, 8592.914070859211, 8593.52735599548, 6186.659733714689, 7413.147488038729, 7446.218147094477, 7547.547147171187, 7784.92215077842, 7377.77866664001, 7465.141508726566, 7532.736354227576, 7541.283578060075, 7674.693012279669, 6939.965300173467, 6941.826454338682, 7015.859682806417, 7018.2630823762765, 7018.6490675465, 4870.878228044327, 5066.138756411493, 5068.26510156018, 5072.75264102056, 5099.954509325506, 5024.698518088926, 5072.644914856072, 5090.974545127251, 5112.079825631422, 5240.7641656126325], "value": 4551.164528071909, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.2082570774594, 302.190130450393, 306.6917747663598, 316.0896617740906, 318.1124662192483, 5468.53915737918, 5483.808066717661, 5485.506304432601, 5511.917321240179, 5516.420775818541, 5056.713136461302, 5234.345706786652, 5284.709340986245, 5295.973520132394, 5496.670199788015, 3999.7800670795395, 4041.6564592009713, 4046.858359957395, 4073.8593193905754, 4074.2684359147393, 3640.4903313536124, 3963.06867886048, 4133.739209541089, 4134.441850350195, 4148.211839750437, 3278.344331133783, 3566.518519999806, 4050.6354428101463, 4068.5117785865737, 4089.672826173914, 3117.610298712661, 3564.679178873901, 3890.260850438436, 3939.625735555118, 4021.8994525136814, 3001.9399612007855, 3289.473684210539, 3362.747793915466, 3405.2848901730667, 3504.632013638582, 5184.7407629618365, 5202.635815492917, 5213.817516386908, 5258.447862974409, 5301.310829592128, 4616.44602647681, 4631.513691062423, 4647.047355292157, 4648.953510464919, 4662.347271382009, 4934.7285899275885, 5338.119210330291, 5624.943750562483, 5652.689102099383, 5685.2091591148655, 3665.321915445651, 3840.1551658635335, 3849.2493963677093, 3855.2867719471988, 3863.1694185749916, 5955.970220148914, 5974.522038236974, 5986.970065149646, 6005.789797357115, 6014.96992515039, 3374.2239284964594, 3672.5225720656144, 3905.33609286422, 3924.3328634132267, 3933.252681990413, 3977.423273625308, 3996.500437445319, 4008.378701301303, 4016.638502534786, 4018.0868870068966, 3966.8214930328204, 4657.534246575316, 4669.649776266793, 4693.389859318335, 4707.741074240881, 5261.500157485033, 5289.894202116013, 5734.541236701054, 5789.88420231593, 5805.8548536286935, 1158.916413153704, 1269.676232560691, 1319.2678063674753, 1360.3266383140408, 1366.0232933452628, 874.6370256343673, 903.1735961595067, 907.3421769217397, 909.3452714045876, 913.9954300228457, 5236.847893463432, 5290.376092376734, 5301.628885977944, 5314.2825718528275, 5330.92003619946, 5483.217954164833, 5822.0, 5859.062549991981, 5862.237909071793, 5869.53043756507, 4325.826966921288, 4877.487863774323, 5174.327337446108, 5261.0, 5277.472252774769, 3051.206686261588, 3053.8931137410086, 3060.2808340040074, 3060.6939306069216, 3061.785675002773, 5041.0, 5550.195221692832, 5561.1082237236415, 5922.466977971917, 5926.170336152942, 5374.731263436891, 5872.324682661463, 5887.823365298962, 5906.586538942232, 5919.615225010447, 5590.049691552527, 5889.440503152194, 5915.438033386821, 5922.3417443115995, 5941.257342832059, 4985.551300382983, 5339.79854532727, 5919.852003699942, 5946.43508866657, 5965.791197308247, 5282.418933917343, 5520.067976208295, 5850.0, 5858.004139296415, 5888.705564721832, 5093.71984540839, 5900.793472228452, 6085.847853803691, 6102.877942441038, 6140.723667434887, 3909.9218015638958, 3910.338106304866, 3920.862769803043, 3929.155231625214, 3968.7023473239046, 5220.738963051908, 5455.918161227505, 5972.8805423892145, 5985.760569577343, 5989.610675306091, 4955.45489996093, 5260.526552610283, 5437.619366644455, 5670.314295707823, 5794.159846822272, 5723.627964182315, 5726.513246374105, 5735.655860648374, 5738.5696072795545, 5800.7099645018425, 4579.38178345919, 5307.57539396855, 5473.507384335429, 5537.5569954402745, 5565.3599836019375, 5156.539593251735, 5319.627626066293, 5453.536449401845, 5490.599897026233, 5720.683123335056, 4968.751562421937, 5496.532794712494, 5563.221149039218, 5611.466910643482, 5615.0], "value": 4142.449381759604, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.9002909718861, 707.8796604577221, 780.5628847845207, 816.6447595296042, 826.0706704956923, 13553.322333883303, 14929.402823887045, 15894.443694470696, 16344.673106537863, 16346.18269086547, 14888.106713597192, 15069.547913562583, 15070.924645376785, 15106.471273505429, 15238.695226095471, 676.736072931557, 694.4305669351135, 826.8966379202585, 869.9043105258417, 877.0965905117707, 824.9711260105897, 862.168007872403, 863.8704194370832, 873.7640836974014, 878.3587980774039, 895.1093661806511, 901.8016036471998, 904.2043002158092, 905.108468158863, 905.6513242401656, 709.5139829217003, 859.8796168536347, 899.1413200393608, 899.3569597737617, 912.8037471943497, 676.7563677076249, 677.5054210426367, 678.0304165043985, 678.35217367414, 678.9864202715918, 15075.54773356801, 15164.924175379163, 15170.089794612248, 15190.924045379812, 15193.392264309414, 11951.511181902464, 13973.441062357493, 14201.431942722278, 14262.714745705132, 14348.497802576963, 12809.807852882213, 13120.343982800821, 13225.140365876186, 13241.801372979413, 13478.824739501777, 4634.050019745944, 4662.230731929228, 4795.136875362434, 4849.054434385296, 4854.320395144682, 101499.9850001498, 108242.45878770635, 119386.40306798411, 120907.395463023, 121681.0, 11253.606123785628, 11303.039241664386, 11420.600278990196, 11537.19239653233, 11707.356095414834, 22723.0, 22726.20458283952, 22731.09075636989, 22741.0, 22763.203287885175, 6884.690188941509, 8004.919950800534, 8079.5960201989665, 8080.73787988597, 8198.508089514648, 4381.101874115799, 4437.844675436344, 4439.42287502629, 4442.311441726538, 4593.356930029799, 3796.962030379661, 4071.9796401017807, 4074.0, 4081.795910204478, 4084.571120032413, 723.5224751663982, 723.6200994477941, 737.0676094740159, 739.5562662402623, 747.8429529798694, 571.8313097636208, 586.4751047812184, 594.2245369792377, 672.2269390201308, 681.7511608262948, 9420.387674801254, 9428.340016198938, 9658.420494770337, 9762.260021883987, 9793.461359625146, 522.743855510797, 627.9340669229756, 645.8353119954381, 661.9404253617198, 672.6098862659645, 4462.977685111554, 4691.702360792867, 4701.600363969101, 4766.785494652749, 4791.0, 161880.0, 163076.0, 167271.0, 170567.0, 174252.0, 123842.38078809548, 131925.0, 136947.31526342503, 145338.0, 145580.0, 124112.0, 125324.0, 126117.73882261243, 126521.0, 127215.0, 7771.533707977539, 8663.830382898228, 8903.543287477503, 9125.680601178927, 9227.031161727922, 68411.3158868405, 68776.98843850134, 68918.65540672264, 69368.61262774817, 69598.0, 96761.51619241858, 103047.96952030384, 104179.0, 106151.46924265329, 107957.46021270158, 11639.47622357013, 11857.241961001315, 11975.0, 11995.64013079609, 12278.877211228131, 13400.597982060553, 13488.258145802076, 13610.183388996691, 13699.726005479635, 14038.227897465737, 12195.085368597212, 12498.125131240726, 12502.312372819582, 12826.230426174086, 12910.354482276036, 10811.837822432828, 12300.507979680713, 12434.937825310815, 12444.875551244733, 12955.417006234931, 12096.516139354679, 12273.263604183778, 12529.498820047096, 12685.93657031709, 12686.936565317113, 10242.83530951237, 10546.314489558154, 10620.415877126832, 10722.946385268024, 10821.837672434762, 10446.100179158715, 10544.367337959748, 10620.52207650642, 10630.787384252426, 10653.786924261316], "value": 7964.035874984102, "unit": "score"}], "name": "dromaeo_css", "value": 7385.016460116347, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 156.0, 164.0, 114.0, 113.0, 112.0, 113.0, 111.0, 113.0, 112.0], "value": 121.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 108.0, 159.0, 109.0, 107.0, 130.0, 108.0, 160.0, 138.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 183.0, 184.0, 184.0, 184.0, 185.0, 183.0, 184.0, 184.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 57.0, 89.0, 59.0, 57.0, 64.0, 62.0, 96.0, 57.0], "value": 69.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 89.0, 93.0, 70.0, 71.0, 69.0, 95.0, 70.0, 69.0, 99.0], "value": 80.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 128.0, 90.0, 87.0, 130.0, 70.0, 123.0, 72.0, 118.0, 102.0], "value": 103.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 93.0, 94.0, 93.0, 94.0, 94.0, 100.0, 138.0, 92.0], "value": 98.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 83.0, 87.0, 86.0, 87.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 54.0, 54.0, 52.0, 52.0, 55.0, 53.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 76.0, 80.0, 73.0, 70.0, 70.0, 69.0, 69.0, 69.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 80.0, 83.0, 78.0, 85.0, 85.0, 84.0, 80.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 110.0, 142.0, 143.0, 148.0, 143.0, 143.0, 141.0, 236.0, 153.0], "value": 151.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 171.0, 222.0, 200.0, 165.0, 163.0, 163.0, 163.0, 165.0], "value": 174.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 66.0, 65.0, 64.0, 66.0, 66.0, 65.0, 73.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1467.6, "alertThreshold": 2.0}]} 14:25:56 INFO - Return code: 0 14:25:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:25:56 INFO - # TBPL SUCCESS # 14:25:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:25:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:25:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:25:56 INFO - 2016-06-29 14:25:56.711 screenresolution[1662:9713] starting screenresolution argv=screenresolution get 14:25:56 INFO - 2016-06-29 14:25:56.713 screenresolution[1662:9713] Display 0: 1600x1200x32@60 14:25:56 INFO - 2016-06-29 14:25:56.719 screenresolution[1663:9716] starting screenresolution argv=screenresolution list 14:25:56 INFO - Available Modes on Display 0 14:25:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:25:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:25:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:25:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:25:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:25:56 INFO - Intel Iris: 14:25:56 INFO - Chipset Model: Intel Iris 14:25:56 INFO - Type: GPU 14:25:56 INFO - Bus: Built-In 14:25:56 INFO - VRAM (Dynamic, Max): 1536 MB 14:25:56 INFO - Vendor: Intel (0x8086) 14:25:56 INFO - Device ID: 0x0a2e 14:25:56 INFO - Revision ID: 0x0009 14:25:56 INFO - Displays: 14:25:56 INFO - Display: 14:25:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:25:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:25:56 INFO - Display Serial Number: 1600x1200 60 14:25:56 INFO - Main Display: Yes 14:25:56 INFO - Mirror: Off 14:25:56 INFO - Online: Yes 14:25:56 INFO - Rotation: Supported 14:25:56 INFO - Return code: 0 14:25:56 INFO - Running post-action listener: _resource_record_post_action 14:25:56 INFO - ##### 14:25:56 INFO - ##### Finished run-tests step (success) 14:25:56 INFO - ##### 14:25:56 INFO - Running post-run listener: _resource_record_post_run 14:25:57 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37709312; Write bytes: 706869248; Read time: 395; Write time: 1968 14:25:57 INFO - TinderboxPrint: CPU usage
53.6% 14:25:57 INFO - TinderboxPrint: I/O read bytes / time
37,709,312 / 395 14:25:57 INFO - TinderboxPrint: I/O write bytes / time
706,869,248 / 1,968 14:25:57 INFO - TinderboxPrint: CPU idle
2,248.5 (46.4%) 14:25:57 INFO - TinderboxPrint: CPU system
973.5 (20.1%) 14:25:57 INFO - TinderboxPrint: CPU user
1,627.5 (33.6%) 14:25:57 INFO - TinderboxPrint: Swap in / out
444,473,344 / 0 14:25:57 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388057600; Write bytes: 383125504; Read time: 29195; Write time: 772 14:25:57 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 36754944; Write bytes: 296308736; Read time: 380; Write time: 1146 14:25:57 INFO - Running post-run listener: _upload_blobber_files 14:25:57 INFO - Blob upload gear active. 14:25:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:25:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:25:57 INFO - (blobuploader) - INFO - Open directory for files ... 14:25:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:25:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:25:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:58 INFO - (blobuploader) - INFO - Done attempting. 14:25:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:25:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:25:59 INFO - (blobuploader) - INFO - Done attempting. 14:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:26:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:02 INFO - (blobuploader) - INFO - Done attempting. 14:26:02 INFO - (blobuploader) - INFO - Iteration through files over. 14:26:02 INFO - Return code: 0 14:26:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:26:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:26:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bc7faaef5cfc2f664a7304c0659135dfdfb7bd2660e9337acefe2ffd9989b3dc44ea9977c55fde420146045c62acc717a933244a9152f572416774d7192001e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23eafd20b5daed41d27492554b2356df356901e081c7a8e6e49f021553c8f58bf290ea12502a99ebf05c70bf8090236ce4dbc585507a32bce2325f334a5e4a3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f229f8d761d9aa64dac991662f0a3d7dbbb7fe26c6aa7bc95d069dbd745cf215e21e862f78017010c1e71644a3762778bf9a9cb23dd1747f99f6b055831a19b3"} 14:26:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:26:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:26:02 INFO - Contents: 14:26:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bc7faaef5cfc2f664a7304c0659135dfdfb7bd2660e9337acefe2ffd9989b3dc44ea9977c55fde420146045c62acc717a933244a9152f572416774d7192001e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23eafd20b5daed41d27492554b2356df356901e081c7a8e6e49f021553c8f58bf290ea12502a99ebf05c70bf8090236ce4dbc585507a32bce2325f334a5e4a3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f229f8d761d9aa64dac991662f0a3d7dbbb7fe26c6aa7bc95d069dbd745cf215e21e862f78017010c1e71644a3762778bf9a9cb23dd1747f99f6b055831a19b3"} 14:26:02 INFO - Running post-run listener: copy_logs_to_upload_dir 14:26:02 INFO - Copying logs to upload dir... 14:26:02 INFO - mkdir: /builds/slave/test/build/upload/logs 14:26:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.431567 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-06-29 14:26:02.386733) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:02.390756) ========= 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.F9jtjT38II/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.VnV4lhGFQq/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bc7faaef5cfc2f664a7304c0659135dfdfb7bd2660e9337acefe2ffd9989b3dc44ea9977c55fde420146045c62acc717a933244a9152f572416774d7192001e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23eafd20b5daed41d27492554b2356df356901e081c7a8e6e49f021553c8f58bf290ea12502a99ebf05c70bf8090236ce4dbc585507a32bce2325f334a5e4a3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f229f8d761d9aa64dac991662f0a3d7dbbb7fe26c6aa7bc95d069dbd745cf215e21e862f78017010c1e71644a3762778bf9a9cb23dd1747f99f6b055831a19b3"} build_url:https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010782 build_url: 'https://queue.taskcluster.net/v1/task/bWiNhciMQPWgyi_FiRCx4w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5bc7faaef5cfc2f664a7304c0659135dfdfb7bd2660e9337acefe2ffd9989b3dc44ea9977c55fde420146045c62acc717a933244a9152f572416774d7192001e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/23eafd20b5daed41d27492554b2356df356901e081c7a8e6e49f021553c8f58bf290ea12502a99ebf05c70bf8090236ce4dbc585507a32bce2325f334a5e4a3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f229f8d761d9aa64dac991662f0a3d7dbbb7fe26c6aa7bc95d069dbd745cf215e21e862f78017010c1e71644a3762778bf9a9cb23dd1747f99f6b055831a19b3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:02.424063) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:02.424399) ========= 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.F9jtjT38II/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.VnV4lhGFQq/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.004973 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 14:26:02.474516) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 14:26:02.474871) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 14:26:02.475259) ========= ========= Total master_lag: 0.18 =========