builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0141 starttime: 1468235083.73 results: success (0) buildid: 20160711012926 builduid: 4d62b50923894a60ad72f8fe9b9a3f05 revision: 76d556ef9180969ee8d690ed069732faded934a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 04:04:43.733239) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 04:04:43.733710) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 04:04:43.734030) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 04:04:43.760117) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:04:43.760451) ========= 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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-11 04:04:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 35.6M=0s 2016-07-11 04:04:43 (35.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145591 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:04:43.933688) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:04:43.934496) ========= 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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.028125 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:04:43.987351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-11 04:04:43.988107) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 76d556ef9180969ee8d690ed069732faded934a2 --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 76d556ef9180969ee8d690ed069732faded934a2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Vs845Xzf1z/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.m4qYbJlRQF/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-11 04:04:44,066 truncating revision to first 12 chars 2016-07-11 04:04:44,067 Setting DEBUG logging. 2016-07-11 04:04:44,067 attempt 1/10 2016-07-11 04:04:44,067 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/76d556ef9180?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 04:04:45,110 unpacking tar archive at: fx-team-76d556ef9180/testing/mozharness/ program finished with exit code 0 elapsedTime=2.004904 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-11 04:04:46.018222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 04:04:46.018611) ========= script_repo_revision: 76d556ef9180969ee8d690ed069732faded934a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 04:04:46.019062) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 04:04:46.019437) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 04:04:46.037668) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-11 04:04:46.037980) ========= /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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 04:04:46 INFO - MultiFileLogger online at 20160711 04:04:46 in /builds/slave/test 04:04:46 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 04:04:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:04:46 INFO - {'append_to_log': False, 04:04:46 INFO - 'base_work_dir': '/builds/slave/test', 04:04:46 INFO - 'blob_upload_branch': 'Fx-Team', 04:04:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:04:46 INFO - 'branch': 'Fx-Team', 04:04:46 INFO - 'buildbot_json_path': 'buildprops.json', 04:04:46 INFO - 'config_files': ('talos/mac_config.py',), 04:04:46 INFO - 'default_actions': ('clobber', 04:04:46 INFO - 'read-buildbot-config', 04:04:46 INFO - 'download-and-extract', 04:04:46 INFO - 'populate-webroot', 04:04:46 INFO - 'create-virtualenv', 04:04:46 INFO - 'install', 04:04:46 INFO - 'run-tests'), 04:04:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:04:46 INFO - 'download_minidump_stackwalk': True, 04:04:46 INFO - 'download_symbols': 'ondemand', 04:04:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:04:46 INFO - 'tooltool.py': '/tools/tooltool.py', 04:04:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:04:46 INFO - '/tools/misc-python/virtualenv.py')}, 04:04:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:04:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:04:46 INFO - 'installer_path': 'installer.exe', 04:04:46 INFO - 'log_level': 'info', 04:04:46 INFO - 'log_name': 'talos', 04:04:46 INFO - 'log_to_console': True, 04:04:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:04:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:04:46 INFO - 'opt_config_files': (), 04:04:46 INFO - 'pip_index': False, 04:04:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:04:46 INFO - 'cmd': ('bash', 04:04:46 INFO - '-c', 04:04:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:04:46 INFO - 'enabled': True, 04:04:46 INFO - 'halt_on_failure': False, 04:04:46 INFO - 'name': 'check_screen_resolution'},), 04:04:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:04:46 INFO - 'cmd': ('bash', 04:04:46 INFO - '-c', 04:04:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:04:46 INFO - 'enabled': True, 04:04:46 INFO - 'halt_on_failure': False, 04:04:46 INFO - 'name': 'check_screen_resolution'},), 04:04:46 INFO - 'run_cmd_checks_enabled': True, 04:04:46 INFO - 'sps_profile': False, 04:04:46 INFO - 'sps_profile_interval': 0, 04:04:46 INFO - 'suite': 'dromaeojs', 04:04:46 INFO - 'system_bits': '32', 04:04:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:04:46 INFO - 'title': 't-yosemite-r7-0141', 04:04:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:04:46 INFO - 'use_talos_json': True, 04:04:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:04:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:04:46 INFO - 'work_dir': 'build'} 04:04:46 INFO - ##### 04:04:46 INFO - ##### Running clobber step. 04:04:46 INFO - ##### 04:04:46 INFO - Running pre-action listener: _resource_record_pre_action 04:04:46 INFO - Running main action method: clobber 04:04:46 INFO - rmtree: /builds/slave/test/build 04:04:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:04:48 INFO - Running post-action listener: _resource_record_post_action 04:04:48 INFO - ##### 04:04:48 INFO - ##### Finished clobber step (success) 04:04:48 INFO - ##### 04:04:48 INFO - ##### 04:04:48 INFO - ##### Running read-buildbot-config step. 04:04:48 INFO - ##### 04:04:48 INFO - Running pre-action listener: _resource_record_pre_action 04:04:48 INFO - Running main action method: read_buildbot_config 04:04:48 INFO - Using buildbot properties: 04:04:48 INFO - { 04:04:48 INFO - "project": "", 04:04:48 INFO - "product": "firefox", 04:04:48 INFO - "script_repo_revision": "production", 04:04:48 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:04:48 INFO - "repository": "", 04:04:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:04:48 INFO - "buildid": "20160711012926", 04:04:48 INFO - "pgo_build": "False", 04:04:48 INFO - "basedir": "/builds/slave/test", 04:04:48 INFO - "buildnumber": 67, 04:04:48 INFO - "slavename": "t-yosemite-r7-0141", 04:04:48 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:04:48 INFO - "platform": "yosemite_r7", 04:04:48 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:04:48 INFO - "branch": "fx-team", 04:04:48 INFO - "repo_path": "integration/fx-team", 04:04:48 INFO - "revision": "76d556ef9180969ee8d690ed069732faded934a2", 04:04:48 INFO - "stage_platform": "macosx64", 04:04:48 INFO - "builduid": "4d62b50923894a60ad72f8fe9b9a3f05", 04:04:48 INFO - "slavebuilddir": "test" 04:04:48 INFO - } 04:04:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 04:04:48 INFO - Running post-action listener: _resource_record_post_action 04:04:48 INFO - ##### 04:04:48 INFO - ##### Finished read-buildbot-config step (success) 04:04:48 INFO - ##### 04:04:48 INFO - ##### 04:04:48 INFO - ##### Running download-and-extract step. 04:04:48 INFO - ##### 04:04:48 INFO - Running pre-action listener: _resource_record_pre_action 04:04:48 INFO - Running main action method: download_and_extract 04:04:48 INFO - mkdir: /builds/slave/test/build/tests 04:04:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:48 INFO - https://queue.taskcluster.net/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:04:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 04:04:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 04:04:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/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 04:04:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/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 04:04:49 INFO - Downloaded 1199 bytes. 04:04:49 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 04:04:49 INFO - Using the following test package requirements: 04:04:49 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 04:04:49 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:04:49 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 04:04:49 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:04:49 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 04:04:49 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:04:49 INFO - u'jsshell-mac.zip'], 04:04:49 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:04:49 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 04:04:49 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 04:04:49 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:04:49 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 04:04:49 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:04:49 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 04:04:49 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:04:49 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 04:04:49 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 04:04:49 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 04:04:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:49 INFO - https://queue.taskcluster.net/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:04:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:04:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:04:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/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 04:04:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/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 04:04:50 INFO - Downloaded 18806905 bytes. 04:04:50 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'] 04:04:50 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 04:04:53 INFO - Return code: 0 04:04:53 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 04:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:53 INFO - https://queue.taskcluster.net/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:04:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:04:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 04:04:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/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 04:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/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 04:04:54 INFO - Downloaded 18806905 bytes. 04:04:54 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'] 04:04:54 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 04:04:58 INFO - Return code: 0 04:04:58 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')]} 04:04:58 INFO - https://queue.taskcluster.net/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:04:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:04:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 04:04:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/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 04:04:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/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 04:04:59 INFO - Downloaded 14403333 bytes. 04:04:59 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'] 04:04:59 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 04:04:59 INFO - Return code: 0 04:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:04:59 INFO - https://queue.taskcluster.net/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:04:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:04:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:04:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 04:04:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/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 04:05:02 INFO - Downloaded 112351958 bytes. 04:05:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:05:02 INFO - mkdir: /builds/slave/test/properties 04:05:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:05:02 INFO - Writing to file /builds/slave/test/properties/build_url 04:05:02 INFO - Contents: 04:05:02 INFO - build_url:https://queue.taskcluster.net/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 04:05:03 INFO - Running post-action listener: _resource_record_post_action 04:05:03 INFO - Running post-action listener: set_extra_try_arguments 04:05:03 INFO - ##### 04:05:03 INFO - ##### Finished download-and-extract step (success) 04:05:03 INFO - ##### 04:05:03 INFO - ##### 04:05:03 INFO - ##### Running populate-webroot step. 04:05:03 INFO - ##### 04:05:03 INFO - Running pre-action listener: _resource_record_pre_action 04:05:03 INFO - Running main action method: populate_webroot 04:05:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:05:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:05:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:05:03 INFO - '--tppagecycles', 04:05:03 INFO - '7'], 04:05:03 INFO - 'tests': ['tsvgm']}}, 04:05:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:05:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:05:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:05:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:05:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:05:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:05:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:03 INFO - 'talos_options': ['--disable-e10s'], 04:05:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:05:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:03 INFO - 'talos_options': ['--disable-e10s'], 04:05:03 INFO - 'tests': ['damp', 'tps']}, 04:05:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:03 INFO - 'tests': ['damp', 'tps']}, 04:05:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:05:03 INFO - 'tests': ['dromaeo_dom']}, 04:05:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:05:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:05:03 INFO - 'tests': ['basic_compositor_video']}, 04:05:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:05:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:05:03 INFO - 'tests': ['a11yr', 04:05:03 INFO - 'ts_paint', 04:05:03 INFO - 'tpaint', 04:05:03 INFO - 'sessionrestore', 04:05:03 INFO - 'sessionrestore_no_auto_restore', 04:05:03 INFO - 'tabpaint']}, 04:05:03 INFO - 'other-e10s': {'tests': ['a11yr', 04:05:03 INFO - 'ts_paint', 04:05:03 INFO - 'tpaint', 04:05:03 INFO - 'sessionrestore', 04:05:03 INFO - 'sessionrestore_no_auto_restore', 04:05:03 INFO - 'tabpaint']}, 04:05:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:05:03 INFO - 'ts_paint', 04:05:03 INFO - 'tpaint', 04:05:03 INFO - 'sessionrestore', 04:05:03 INFO - 'sessionrestore_no_auto_restore', 04:05:03 INFO - 'tabpaint']}, 04:05:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:05:03 INFO - 'ts_paint', 04:05:03 INFO - 'tpaint', 04:05:03 INFO - 'sessionrestore', 04:05:03 INFO - 'sessionrestore_no_auto_restore', 04:05:03 INFO - 'tabpaint']}, 04:05:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:05:03 INFO - 'tests': ['a11yr', 04:05:03 INFO - 'ts_paint', 04:05:03 INFO - 'tpaint', 04:05:03 INFO - 'sessionrestore', 04:05:03 INFO - 'sessionrestore_no_auto_restore', 04:05:03 INFO - 'tabpaint']}, 04:05:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:05:03 INFO - 'tests': ['a11yr', 04:05:03 INFO - 'ts_paint', 04:05:03 INFO - 'tpaint', 04:05:03 INFO - 'sessionrestore', 04:05:03 INFO - 'sessionrestore_no_auto_restore', 04:05:03 INFO - 'tabpaint']}, 04:05:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:05:03 INFO - 'tests': ['tsvgx', 04:05:03 INFO - 'tsvgr_opacity', 04:05:03 INFO - 'tart', 04:05:03 INFO - 'tscrollx', 04:05:03 INFO - 'cart']}, 04:05:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:05:03 INFO - 'tsvgr_opacity', 04:05:03 INFO - 'tart', 04:05:03 INFO - 'tscrollx', 04:05:03 INFO - 'cart']}, 04:05:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:03 INFO - 'talos_options': ['--disable-e10s'], 04:05:03 INFO - 'tests': ['tp5o']}, 04:05:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:03 INFO - 'tests': ['tp5o']}, 04:05:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:03 INFO - 'talos_options': ['--disable-e10s', 04:05:03 INFO - '--xperf_path', 04:05:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:03 INFO - 'tests': ['tp5n']}, 04:05:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:05:03 INFO - 'talos_options': ['--xperf_path', 04:05:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:05:03 INFO - 'tests': ['tp5n']}}, 04:05:03 INFO - 'talos.zip': {'path': '', 04:05:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:05:03 INFO - Running post-action listener: _resource_record_post_action 04:05:03 INFO - ##### 04:05:03 INFO - ##### Finished populate-webroot step (success) 04:05:03 INFO - ##### 04:05:03 INFO - ##### 04:05:03 INFO - ##### Running create-virtualenv step. 04:05:03 INFO - ##### 04:05:03 INFO - Running pre-action listener: _resource_record_pre_action 04:05:03 INFO - Running main action method: create_virtualenv 04:05:03 INFO - Creating virtualenv /builds/slave/test/build/venv 04:05:03 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 04:05:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:05:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:05:03 INFO - Using real prefix '/tools/python27' 04:05:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:05:04 INFO - Installing distribute.............................................................................................................................................................................................done. 04:05:07 INFO - Installing pip.................done. 04:05:07 INFO - Return code: 0 04:05:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:07 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 0x101d9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5ad6a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d01d30>, '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 0x101a66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cf9b20>, '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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 04:05:07 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 04:05:07 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 04:05:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vs845Xzf1z/Render', 04:05:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:07 INFO - 'HOME': '/Users/cltbld', 04:05:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:07 INFO - 'LOGNAME': 'cltbld', 04:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:07 INFO - 'MOZ_NO_REMOTE': '1', 04:05:07 INFO - 'NO_EM_RESTART': '1', 04:05:07 INFO - 'PAGER': '/bin/cat', 04:05:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:07 INFO - 'PWD': '/builds/slave/test', 04:05:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:07 INFO - 'SHELL': '/bin/bash', 04:05:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4qYbJlRQF/Listeners', 04:05:07 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 04:05:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:07 INFO - 'USER': 'cltbld', 04:05:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:07 INFO - 'XPC_FLAGS': '0x0', 04:05:07 INFO - 'XPC_SERVICE_NAME': '0', 04:05:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:07 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 04:05:07 INFO - Cleaning up... 04:05:07 INFO - Return code: 0 04:05:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:07 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 0x101d9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5ad6a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d01d30>, '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 0x101a66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cf9b20>, '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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 04:05:07 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 04:05:07 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 04:05:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vs845Xzf1z/Render', 04:05:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:07 INFO - 'HOME': '/Users/cltbld', 04:05:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:07 INFO - 'LOGNAME': 'cltbld', 04:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:07 INFO - 'MOZ_NO_REMOTE': '1', 04:05:07 INFO - 'NO_EM_RESTART': '1', 04:05:07 INFO - 'PAGER': '/bin/cat', 04:05:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:07 INFO - 'PWD': '/builds/slave/test', 04:05:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:07 INFO - 'SHELL': '/bin/bash', 04:05:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4qYbJlRQF/Listeners', 04:05:07 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 04:05:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:07 INFO - 'USER': 'cltbld', 04:05:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:07 INFO - 'XPC_FLAGS': '0x0', 04:05:07 INFO - 'XPC_SERVICE_NAME': '0', 04:05:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:07 INFO - Downloading/unpacking psutil>=3.1.1 04:05:07 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 04:05:07 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 04:05:07 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 04:05:07 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 04:05:07 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 04:05:07 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 04:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:05:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:10 INFO - Installing collected packages: psutil 04:05:10 INFO - Running setup.py install for psutil 04:05:10 INFO - building 'psutil._psutil_osx' extension 04:05:10 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 04:05:11 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 04:05:11 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 04:05:11 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 04:05:11 INFO - building 'psutil._psutil_posix' extension 04:05:11 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 04:05:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:05:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:05:11 INFO - ^ 04:05:11 INFO - 1 warning generated. 04:05:11 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 04:05:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:05:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:05:11 INFO - Successfully installed psutil 04:05:11 INFO - Cleaning up... 04:05:11 INFO - Return code: 0 04:05:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:05:11 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')]} 04:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:11 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')]} 04:05:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:11 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 0x101d9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5ad6a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d01d30>, '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 0x101a66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cf9b20>, '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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 04:05:11 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 04:05:11 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 04:05:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vs845Xzf1z/Render', 04:05:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:11 INFO - 'HOME': '/Users/cltbld', 04:05:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:11 INFO - 'LOGNAME': 'cltbld', 04:05:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:11 INFO - 'MOZ_NO_REMOTE': '1', 04:05:11 INFO - 'NO_EM_RESTART': '1', 04:05:11 INFO - 'PAGER': '/bin/cat', 04:05:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:11 INFO - 'PWD': '/builds/slave/test', 04:05:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:11 INFO - 'SHELL': '/bin/bash', 04:05:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4qYbJlRQF/Listeners', 04:05:11 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 04:05:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:11 INFO - 'USER': 'cltbld', 04:05:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:11 INFO - 'XPC_FLAGS': '0x0', 04:05:11 INFO - 'XPC_SERVICE_NAME': '0', 04:05:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:05:12 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 04:05:12 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 04:05:12 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 04:05:12 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 04:05:12 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 04:05:12 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 04:05:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:05:14 INFO - Installing collected packages: mozsystemmonitor 04:05:14 INFO - Running setup.py install for mozsystemmonitor 04:05:14 INFO - Successfully installed mozsystemmonitor 04:05:14 INFO - Cleaning up... 04:05:14 INFO - Return code: 0 04:05:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:14 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 0x101d9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5ad6a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d01d30>, '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 0x101a66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cf9b20>, '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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 04:05:14 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 04:05:14 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 04:05:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vs845Xzf1z/Render', 04:05:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:14 INFO - 'HOME': '/Users/cltbld', 04:05:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:14 INFO - 'LOGNAME': 'cltbld', 04:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:14 INFO - 'MOZ_NO_REMOTE': '1', 04:05:14 INFO - 'NO_EM_RESTART': '1', 04:05:14 INFO - 'PAGER': '/bin/cat', 04:05:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:14 INFO - 'PWD': '/builds/slave/test', 04:05:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:14 INFO - 'SHELL': '/bin/bash', 04:05:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4qYbJlRQF/Listeners', 04:05:14 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 04:05:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:14 INFO - 'USER': 'cltbld', 04:05:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:14 INFO - 'XPC_FLAGS': '0x0', 04:05:14 INFO - 'XPC_SERVICE_NAME': '0', 04:05:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:14 INFO - Downloading/unpacking jsonschema==2.5.1 04:05:14 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 04:05:14 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 04:05:14 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 04:05:14 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 04:05:14 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 04:05:14 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 04:05:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:05:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04: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 04: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 04: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 04: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 04: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 04: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 04:05:17 INFO - Downloading functools32-3.2.3-2.tar.gz 04:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:05:17 INFO - warning: no files found matching '*.txt' 04:05:17 INFO - no previously-included directories found matching 'build' 04:05:17 INFO - no previously-included directories found matching 'dist' 04:05:17 INFO - no previously-included directories found matching '.git*' 04:05:18 INFO - Installing collected packages: jsonschema, functools32 04:05:18 INFO - Running setup.py install for functools32 04:05:18 INFO - warning: no files found matching '*.txt' 04:05:18 INFO - no previously-included directories found matching 'build' 04:05:18 INFO - no previously-included directories found matching 'dist' 04:05:18 INFO - no previously-included directories found matching '.git*' 04:05:18 INFO - Successfully installed jsonschema functools32 04:05:18 INFO - Cleaning up... 04:05:18 INFO - Return code: 0 04:05:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:18 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 0x101d9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5ad6a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d01d30>, '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 0x101a66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cf9b20>, '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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 04:05:18 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 04:05:18 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 04:05:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vs845Xzf1z/Render', 04:05:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:18 INFO - 'HOME': '/Users/cltbld', 04:05:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:18 INFO - 'LOGNAME': 'cltbld', 04:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:18 INFO - 'MOZ_NO_REMOTE': '1', 04:05:18 INFO - 'NO_EM_RESTART': '1', 04:05:18 INFO - 'PAGER': '/bin/cat', 04:05:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:18 INFO - 'PWD': '/builds/slave/test', 04:05:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:18 INFO - 'SHELL': '/bin/bash', 04:05:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4qYbJlRQF/Listeners', 04:05:18 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 04:05:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:18 INFO - 'USER': 'cltbld', 04:05:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:18 INFO - 'XPC_FLAGS': '0x0', 04:05:18 INFO - 'XPC_SERVICE_NAME': '0', 04:05:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:18 INFO - Downloading/unpacking blobuploader==1.2.4 04:05:18 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 04:05:18 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 04:05:18 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 04:05:18 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 04:05:18 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 04:05:18 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 04:05:20 INFO - Downloading blobuploader-1.2.4.tar.gz 04:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:05:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04: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 04: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 04: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 04: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 04: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 04: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 04:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:05:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04: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 04: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 04: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 04: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 04: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 04: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 04:05:22 INFO - Downloading docopt-0.6.1.tar.gz 04:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:05:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:05:22 INFO - Running setup.py install for blobuploader 04:05:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:05:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:05:22 INFO - Running setup.py install for requests 04:05:22 INFO - Running setup.py install for docopt 04:05:23 INFO - Successfully installed blobuploader requests docopt 04:05:23 INFO - Cleaning up... 04:05:23 INFO - Return code: 0 04:05:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:23 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 0x101d9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5ad6a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d01d30>, '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 0x101a66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cf9b20>, '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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 04:05:23 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 04:05:23 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 04:05:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vs845Xzf1z/Render', 04:05:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:23 INFO - 'HOME': '/Users/cltbld', 04:05:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:23 INFO - 'LOGNAME': 'cltbld', 04:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:23 INFO - 'MOZ_NO_REMOTE': '1', 04:05:23 INFO - 'NO_EM_RESTART': '1', 04:05:23 INFO - 'PAGER': '/bin/cat', 04:05:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:23 INFO - 'PWD': '/builds/slave/test', 04:05:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:23 INFO - 'SHELL': '/bin/bash', 04:05:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4qYbJlRQF/Listeners', 04:05:23 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 04:05:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:23 INFO - 'USER': 'cltbld', 04:05:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:23 INFO - 'XPC_FLAGS': '0x0', 04:05:23 INFO - 'XPC_SERVICE_NAME': '0', 04:05:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:05:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-pwoQF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:05:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-lELr21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:05:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-D1gG3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:05:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-FTqfpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:05:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-78iJjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:05:23 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-98ZjaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:05:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:05:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-AIpWpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:05:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-b2OAUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:05:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-bTeoww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:05:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-E9C6Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:05:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-SmdbbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:05:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-c184ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:05:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-hVLcQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:05:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-_l8Rz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-j51l0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:05:24 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-aSYETm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:05:25 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Fjgqma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:05:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:05:25 INFO - Running setup.py install for manifestparser 04:05:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:05:25 INFO - Running setup.py install for mozcrash 04:05:25 INFO - Running setup.py install for mozdebug 04:05:25 INFO - Running setup.py install for mozdevice 04:05:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:05:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:05:25 INFO - Running setup.py install for mozfile 04:05:25 INFO - Running setup.py install for mozhttpd 04:05:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Running setup.py install for mozinfo 04:05:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Running setup.py install for mozInstall 04:05:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Running setup.py install for mozleak 04:05:26 INFO - Running setup.py install for mozlog 04:05:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Running setup.py install for moznetwork 04:05:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:05:26 INFO - Running setup.py install for mozprocess 04:05:26 INFO - Running setup.py install for mozprofile 04:05:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:05:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:05:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:05:27 INFO - Running setup.py install for mozrunner 04:05:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:05:27 INFO - Running setup.py install for mozscreenshot 04:05:27 INFO - Running setup.py install for moztest 04:05:27 INFO - Running setup.py install for mozversion 04:05:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:05:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:05:27 INFO - Cleaning up... 04:05:27 INFO - Return code: 0 04:05:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:27 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 0x101d9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5ad6a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d01d30>, '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 0x101a66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cf9b20>, '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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 04:05:27 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 04:05:27 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 04:05:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vs845Xzf1z/Render', 04:05:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:27 INFO - 'HOME': '/Users/cltbld', 04:05:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:27 INFO - 'LOGNAME': 'cltbld', 04:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:27 INFO - 'MOZ_NO_REMOTE': '1', 04:05:27 INFO - 'NO_EM_RESTART': '1', 04:05:27 INFO - 'PAGER': '/bin/cat', 04:05:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:27 INFO - 'PWD': '/builds/slave/test', 04:05:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:27 INFO - 'SHELL': '/bin/bash', 04:05:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4qYbJlRQF/Listeners', 04:05:27 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 04:05:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:27 INFO - 'USER': 'cltbld', 04:05:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:27 INFO - 'XPC_FLAGS': '0x0', 04:05:27 INFO - 'XPC_SERVICE_NAME': '0', 04:05:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:05:27 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-ehTt_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:05:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-4eq8KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:05:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Q9_xos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:05:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-RP5D3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:05:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-n5hv54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:05:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-tB_zCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:05:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Jot7fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:05:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-HKc2om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:05:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-BZFg03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:05:28 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)) 04:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:05:28 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-MOcj5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:05:29 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)) 04:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:05:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-7Ze2Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:05:29 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)) 04:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:05:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-IOfynk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:05:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-xqBr2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:05:29 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)) 04:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:05:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-ILNvW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-v0uZrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:05:29 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)) 04:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:05:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Qft321-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:05:29 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)) 04:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:05:29 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-ct2kCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:05:29 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)) 04:05:29 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)) 04:05:29 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)) 04:05:29 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)) 04:05:29 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)) 04:05:29 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)) 04:05:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04: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 04: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 04: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 04: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 04: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 04: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 04:05:32 INFO - Downloading blessings-1.6.tar.gz 04:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:05:32 INFO - Installing collected packages: blessings 04:05:32 INFO - Running setup.py install for blessings 04:05:32 INFO - Successfully installed blessings 04:05:32 INFO - Cleaning up... 04:05:32 INFO - Return code: 0 04:05:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:05:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:05:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:05:32 INFO - Reading from file tmpfile_stdout 04:05:32 INFO - Current package versions: 04:05:32 INFO - blessings == 1.6 04:05:32 INFO - blobuploader == 1.2.4 04:05:32 INFO - docopt == 0.6.1 04:05:32 INFO - functools32 == 3.2.3-2 04:05:32 INFO - jsonschema == 2.5.1 04:05:32 INFO - manifestparser == 1.1 04:05:32 INFO - mozInstall == 1.12 04:05:32 INFO - mozcrash == 0.17 04:05:32 INFO - mozdebug == 0.1 04:05:32 INFO - mozdevice == 0.48 04:05:32 INFO - mozfile == 1.2 04:05:32 INFO - mozhttpd == 0.7 04:05:32 INFO - mozinfo == 0.9 04:05:32 INFO - mozleak == 0.1 04:05:32 INFO - mozlog == 3.2 04:05:32 INFO - moznetwork == 0.27 04:05:32 INFO - mozprocess == 0.23 04:05:32 INFO - mozprofile == 0.28 04:05:32 INFO - mozrunner == 6.12 04:05:32 INFO - mozscreenshot == 0.1 04:05:32 INFO - mozsystemmonitor == 0.3 04:05:32 INFO - moztest == 0.7 04:05:32 INFO - mozversion == 1.4 04:05:32 INFO - psutil == 3.1.1 04:05:32 INFO - requests == 1.2.3 04:05:32 INFO - wsgiref == 0.1.2 04:05:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:05:32 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')]} 04:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:32 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')]} 04:05:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:32 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 0x101d9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5ad6a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d01d30>, '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 0x101a66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cf9b20>, '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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 04:05:32 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 04:05:32 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 04:05:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vs845Xzf1z/Render', 04:05:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:32 INFO - 'HOME': '/Users/cltbld', 04:05:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:32 INFO - 'LOGNAME': 'cltbld', 04:05:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:32 INFO - 'MOZ_NO_REMOTE': '1', 04:05:32 INFO - 'NO_EM_RESTART': '1', 04:05:32 INFO - 'PAGER': '/bin/cat', 04:05:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:32 INFO - 'PWD': '/builds/slave/test', 04:05:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:32 INFO - 'SHELL': '/bin/bash', 04:05:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4qYbJlRQF/Listeners', 04:05:32 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 04:05:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:32 INFO - 'USER': 'cltbld', 04:05:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:32 INFO - 'XPC_FLAGS': '0x0', 04:05:32 INFO - 'XPC_SERVICE_NAME': '0', 04:05:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 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)) 04:05:33 INFO - Cleaning up... 04:05:33 INFO - Return code: 0 04:05:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04: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')]} 04:05:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:05:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04: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')]} 04:05:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:05:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:05:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101d9da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e32618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab5ad6a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d01d30>, '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 0x101a66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cf9b20>, '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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 04:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:05:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vs845Xzf1z/Render', 04:05:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:05:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:05:33 INFO - 'HOME': '/Users/cltbld', 04:05:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:05:33 INFO - 'LOGNAME': 'cltbld', 04:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:05:33 INFO - 'MOZ_NO_REMOTE': '1', 04:05:33 INFO - 'NO_EM_RESTART': '1', 04:05:33 INFO - 'PAGER': '/bin/cat', 04:05:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:05:33 INFO - 'PWD': '/builds/slave/test', 04:05:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:05:33 INFO - 'SHELL': '/bin/bash', 04:05:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4qYbJlRQF/Listeners', 04:05:33 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 04:05:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:05:33 INFO - 'USER': 'cltbld', 04:05:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:05:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:05:33 INFO - 'XPC_FLAGS': '0x0', 04:05:33 INFO - 'XPC_SERVICE_NAME': '0', 04:05:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:05:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:05:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:05:33 INFO - Cleaning up... 04:05:33 INFO - Return code: 0 04:05:33 INFO - Running post-action listener: _resource_record_post_action 04:05:33 INFO - Running post-action listener: _start_resource_monitoring 04:05:33 INFO - Starting resource monitoring. 04:05:33 INFO - ##### 04:05:33 INFO - ##### Finished create-virtualenv step (success) 04:05:33 INFO - ##### 04:05:33 INFO - ##### 04:05:33 INFO - ##### Running install step. 04:05:33 INFO - ##### 04:05:33 INFO - Running pre-action listener: _resource_record_pre_action 04:05:33 INFO - Running main action method: install 04:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:05:33 INFO - Reading from file tmpfile_stdout 04:05:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:05:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:05:33 INFO - Reading from file tmpfile_stdout 04:05:33 INFO - Output received: 04:05:33 INFO - Usage: mozinstall [options] installer 04:05:33 INFO - Options: 04:05:33 INFO - -h, --help show this help message and exit 04:05:33 INFO - -d DEST, --destination=DEST 04:05:33 INFO - Directory to install application into. [default: 04:05:33 INFO - "/builds/slave/test"] 04:05:33 INFO - --app=APP Application being installed. [default: firefox] 04:05:33 INFO - mkdir: /builds/slave/test/build/application 04:05:33 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'] 04:05:33 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 04:06:07 INFO - Reading from file tmpfile_stdout 04:06:07 INFO - Output received: 04:06:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:06:07 INFO - Running post-action listener: _resource_record_post_action 04:06:07 INFO - ##### 04:06:07 INFO - ##### Finished install step (success) 04:06:07 INFO - ##### 04:06:07 INFO - ##### 04:06:07 INFO - ##### Running run-tests step. 04:06:07 INFO - ##### 04:06:07 INFO - Running pre-action listener: _resource_record_pre_action 04:06:07 INFO - Running main action method: run_tests 04:06:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:06:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:06:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:06:07 INFO - 2016-07-11 04:06:07.965 screenresolution[1636:7366] starting screenresolution argv=screenresolution get 04:06:07 INFO - 2016-07-11 04:06:07.968 screenresolution[1636:7366] Display 0: 1600x1200x32@60 04:06:07 INFO - 2016-07-11 04:06:07.973 screenresolution[1637:7368] starting screenresolution argv=screenresolution list 04:06:07 INFO - Available Modes on Display 0 04:06:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:06:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:06:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:06:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:06:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:06:08 INFO - Intel Iris: 04:06:08 INFO - Chipset Model: Intel Iris 04:06:08 INFO - Type: GPU 04:06:08 INFO - Bus: Built-In 04:06:08 INFO - VRAM (Dynamic, Max): 1536 MB 04:06:08 INFO - Vendor: Intel (0x8086) 04:06:08 INFO - Device ID: 0x0a2e 04:06:08 INFO - Revision ID: 0x0009 04:06:08 INFO - Displays: 04:06:08 INFO - Display: 04:06:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:06:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:06:08 INFO - Display Serial Number: 1600x1200 60 04:06:08 INFO - Main Display: Yes 04:06:08 INFO - Mirror: Off 04:06:08 INFO - Online: Yes 04:06:08 INFO - Rotation: Supported 04:06:08 INFO - Return code: 0 04:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:06:08 INFO - Python 2.7.3 04:06:08 INFO - Return code: 0 04:06:08 INFO - grabbing minidump binary from tooltool 04:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:06:08 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 0x101d01d30>, '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 0x101a66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cf9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:06:08 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 04:06:08 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 04:06:08 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 04:06:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:06:08 INFO - Return code: 0 04:06:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:06:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:06:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:06:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:06:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:06:08 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/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--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 04:06:08 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/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0141 --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 04:06:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Vs845Xzf1z/Render', 04:06:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:08 INFO - 'HOME': '/Users/cltbld', 04:06:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:08 INFO - 'LOGNAME': 'cltbld', 04:06:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:06:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:08 INFO - 'MOZ_NO_REMOTE': '1', 04:06:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:06:08 INFO - 'NO_EM_RESTART': '1', 04:06:08 INFO - 'PAGER': '/bin/cat', 04:06:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:08 INFO - 'PWD': '/builds/slave/test', 04:06:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:06:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:08 INFO - 'SHELL': '/bin/bash', 04:06:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m4qYbJlRQF/Listeners', 04:06:08 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 04:06:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:08 INFO - 'USER': 'cltbld', 04:06:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:08 INFO - 'XPC_FLAGS': '0x0', 04:06:08 INFO - 'XPC_SERVICE_NAME': '0', 04:06:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:08 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/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--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 04:06:08 INFO - mozversion application_buildid: 20160711012926 04:06:08 INFO - mozversion application_changeset: 76d556ef9180969ee8d690ed069732faded934a2 04:06:08 INFO - mozversion application_display_name: Nightly 04:06:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:06:08 INFO - mozversion application_name: Firefox 04:06:08 INFO - mozversion application_remotingname: firefox 04:06:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:06:08 INFO - mozversion application_vendor: Mozilla 04:06:08 INFO - mozversion application_version: 50.0a1 04:06:08 INFO - mozversion platform_buildid: 20160711012926 04:06:08 INFO - mozversion platform_changeset: 76d556ef9180969ee8d690ed069732faded934a2 04:06:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:06:08 INFO - mozversion platform_version: 50.0a1 04:06:08 INFO - using testdate: 1468235168 04:06:08 INFO - actual date: 1468235168 04:06:08 INFO - starting webserver on 'localhost:49267' 04:06:08 INFO - SUITE-START | Running 2 tests 04:06:08 INFO - TEST-START | dromaeo_css 04:06:08 INFO - operating with platform_type : mac_ 04:06:08 INFO - Initialising browser for dromaeo_css test... 04:06:08 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmp8TizdC/profile http://localhost:49267/getInfo.html) 04:06:10 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 04:06:10 INFO - PROCESS | 1647 | colorDepth:24 04:06:10 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 04:06:10 INFO - PROCESS | 1647 | __metrics 04:06:10 INFO - PROCESS | 1647 | 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" 04:06:10 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:06:11 INFO - TEST-INFO | 1647: exit 0 04:06:11 INFO - Browser initialized. 04:06:11 INFO - Running cycle 1/1 for dromaeo_css test... 04:06:11 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmp8TizdC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:23 INFO - PROCESS | 1649 | RSS: Main: 243802112 04:06:23 INFO - PROCESS | 1649 | 04:07:14 INFO - PROCESS | 1649 | 1468235234603 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] 04:09:25 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 04:09:27 INFO - PROCESS | 1649 | RSS: Main: 387239936 04:09:27 INFO - PROCESS | 1649 | 04:12:30 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 04:12:31 INFO - PROCESS | 1649 | RSS: Main: 377683968 04:12:31 INFO - PROCESS | 1649 | 04:15:33 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 04:15:34 INFO - PROCESS | 1649 | RSS: Main: 372850688 04:15:34 INFO - PROCESS | 1649 | 04:18:36 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 04:18:37 INFO - PROCESS | 1649 | RSS: Main: 367517696 04:18:37 INFO - PROCESS | 1649 | 04:21:40 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 04:21:41 INFO - PROCESS | 1649 | RSS: Main: 341610496 04:21:41 INFO - PROCESS | 1649 | 04:24:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 04:24:44 INFO - PROCESS | 1649 | RSS: Main: 438607872 04:24:44 INFO - PROCESS | 1649 | 04:24:44 INFO - PROCESS | 1649 | __start_tp_report 04:24:44 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 04:24:44 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 04:24:44 INFO - PROCESS | 1649 | |i|pagename|runs| 04:24:44 INFO - PROCESS | 1649 | |0;dojo.html;2571.6014017827238;3353.48021056736;3371.359441706076;3393.3043726036167;3409.147713071732;5651.434856514356;5724.685142317171;5735.311762588485;5815.360310365862;5840.153177789218;5748.5401167906575;5796.913046304308;5828.271466066731;5857.472827445529;5868.589198756089;5160.2517634942915;5167.121589329823;5236.371635403757;5241.292425522563;5370.624056316059;5356.1697936819855;5359.276497672803;5369.5972802039805;5374.032674118657;5402.513773760361;5202.635815492917;5210.687358758487;5216.660917040418;5265.341832270966;5274.156135018378;5238.292830467876;5263.210518422229;5266.078436273637;5285.762140703678;5291.1798671206025;4497.550244975476;5197.376314842205;5212.50481204285;5221;5277.973610131925;5778.624389414675;5879.823605291848;5897.085951677497;5902.498287645555;5921.970390148022;5443.537299329561;6094.471245618287;6166.167567378437;6213.099100630428;6274.623522588659;6286.46565041972;6340.144080549113;6351.96824015877;6368.10846481493;6377.426031657174;5941.1088336749835;5964.8807023860145;5967.403259674084;5967.552433567456;5971.104334349839;6154.5076393888385;6271.6550589718;6292.968535157295;6293.213348331458;6387.041943708388;6227.657478838707;6230.376962303824;6241.375862413813;6244.937550624436;6253.874922501524;6333.2716737575765;6349.365063493706;6349.6507692077375;6359.395857393541;6379.457746091542;5974.462298393166;6095.146679464879;6110.725017374229;6133.151048553363;6208.286047104641;6146.6004709693725;6226.346233645492;6286.779962701284;6318.273398559132;6358.109864618957;5008.248762685626;5025.894303253279;5052.898942021139;5056.292119103328;5078.873028174326;4432.756198409054;4460.219461594208;4492.685512014127;4495.213337665896;4498.842540511132;5821.970890145607;5861.501772349313;5864.091065884794;5878.882422351529;5935.080062590219;6128.961487065963;6257.906131408033;6277.52918531112;6326.272478665012;6327.96836015817;5756.539476841926;5770.711464426762;5782.566307526952;5803;5817.360090390053;5443.101888188405;5502.174673798882;5503.3395992481155;5513.917291240635;5533.418991005967;6307.905381419282;6315.747370105236;6395.008773640093;6397.4562162216735;6409.0066039763915;6256;6257.092721555258;6306.842328941813;6325.399087086719;6340.809775706736;6168.629882207082;6235.875282494416;6305.936940630719;6394.136791533084;6423.261324947691;6177.722002509988;6205.100260462117;6278.843028924313;6287.2769631492965;6293.685315734287;4981.775820088177;6311.305756366704;6313.273973493107;6356.173697419491;6359.046143078575;5970.164177015135;6033.456988871023;6059.182010428712;6088.238970128734;6129.325774164749;6096.817095487142;6108.786192483241;6128.50971922254;6147.877042459037;6158.32258451561;6040.184575082308;6051.546134039877;6053.727582258721;6075.848103797441;6087.817365479043;6107.69461526913;6131.54013449002;6174.753009879734;6180.134781130555;6190.1952746142715;5760.1935728998815;5815.651060936358;5928.9110663339225;5934.970325148347;5997.280326360865 04:24:44 INFO - PROCESS | 1649 | |1;ext.html;503.0793647624847;511.6623028800992;519.9324087868576;529.0265910724266;532.4595535531437;26075.087371941987;42465.363019554694;42495.78752106235;42960.78519607398;46070;41032.17935641285;44693;44744.10511789762;44983.77508112463;45077.54922450775;8750.168733970295;9702.272329575275;9874.605015799396;9877.061679140506;9888.555015024305;8829.587266037435;10882.782344353109;10933.671989840317;11828.172027958046;12265.0187984961;12009.579664711737;12042.036637069014;12071.758564828699;12075.094367922396;12101.636950891487;8792.252658524034;8959.328050396181;12004.759904801898;12124.575639852652;12136.15046946714;8865.335099867536;8945.642174313085;11465.484053217626;11725.94137029318;11732.472038758277;42353.57646423527;42710.35934460985;42793.35809962853;42804.57195428037;42845.14309713788;3593.425051991695;3670.308476901526;3820.6460492066535;3870.206607645454;4307.741535507879;32378.838105809322;32891.01326960195;33665.6633433665;33716;33871.830640846885;3292.720118789906;3415;3453.5510383650217;3467.3412051710093;3484.529588505545;531258;531745.9999999962;532776;532793;533622.6637733611;62332.376676233565;62613.68693156505;62619.74760504856;62621.37378626155;62693.68653156796;58161.4183858156;66569;66686.33313666898;67152;67181;16606.169691515377;17060.57348566271;17064.829351706325;17088;17159.742603860952;11867.70330741721;12085.939570302267;12990.155639883378;13160.473581056842;13212.603621891358;17075.633949284027;17171.570710732332;17207.483775486755;17234.741478877826;17244.568885777957;6361.805177213946;6445.065465507475;6838.658067096625;6910.101686780687;7244.203137654854;899.3389858454032;968.4915419404869;1016.8678071850612;1026.9897301027042;1057.582255009267;31098.378032439225;31271.21821954424;31456.842715786734;31815.681843181734;32215.684412072213;899.2670973156856;1132.184826924613;1152.5389844062443;1153.9249948753304;1171.3967306836985;16137.193140342935;16292.592685182728;16398.508044758677;16414.83585164157;16770.161491925355;657754;658494;659114;660330;660590;60766;60814.695926520086;60833.08750368748;60873.78252434926;60981.390186098455;1259.4962015194178;1300.9154404963647;1379.9788156763923;1398.3288021749413;1452.208546342267;26827;31634.683653163174;32039.519407208445;32634;32659.34681306408;53116.73441632767;53949;54321;54371.18443223434;54519.18221226605;568077;577579;578307;579250;580233;24196.153134640204;24545.50908981846;26196.607050894632;26390.86804565965;26802;49184.50815491942;49578;49578.25632615441;50191.74904125456;50594.49405505898;34535;40141.397879031254;40485.19029619332;41666.1666766669;41908.79045604752;40392.596074038884;40453;40799.18401631891;40810;41565.168696626504;39074.609253907096;39724;40120.598794012854;40326;42587.36118958156;27617.72382276232;32326.676733233307;36420.81789591035;36568.90293291205;37074.62925370712;25803.225903222934;26442.471150577265;26770.732292677603;26776.19671409861;26906.92372305086 04:24:44 INFO - PROCESS | 1649 | |2;jquery.html;362.83672347443655;382.2240851072323;392.687813188515;395.6775228189024;416.35049323056035;15526.92236538817;15791.684166316667;20920.790792092073;21393.037313320918;21426.678599820978;21110.26114086007;21464.678029829563;21866.797326147054;22301.330960071224;22318.553628927453;5834.241548598698;5915.763369465216;6177.629342239457;6178.783742569011;6189.690515474231;3899.883003509899;6124.6325220486915;6135.846603834895;6180.351063138373;6565.277819439858;6809.965950170243;6820.522563420563;6829.658517074151;6837.794866154023;6838.589684618939;5525.613207075507;6376.617402955814;6731.158605174353;6751;6819.897701534481;3736.9439458408146;5597.860053498654;5970.701464926779;5976.312724036705;5982.252218472691;13242.00684948623;13834.515791947335;13839.446422143103;13853.099548529313;23158.305250842503;2048.8156065953985;2208.933731988043;2271.2277825539395;2443.816713746476;2929.5605659151083;10127.13919316859;10514;12844.165129266568;14437.772789312921;15063.774043389358;1789.33794496036;1847.5658220318214;1867.7385166076624;1883.8587105967108;1895.8672892897503;80653.59673201655;98694;107959;123287.3835630825;123485;9301.581428835718;11487.36819474937;11577.60750742503;11689.006434453167;11776.52893884252;14386.208758518382;14483.420663173565;14507;14524.782128268085;14580.270986450634;7102.60935648534;8399.118092600189;8638.438501497383;8646.697365592174;8666.956665216634;8571.185737354941;8579.871301930476;8604.440711353867;8690.391672582859;8734.781630459289;4505.346724724962;4578.6108180805;4588.334691469785;4644.58198762113;4651.651126165551;1630.8228514932462;1642.4169419856019;1884.1615481111048;1922.3944457495843;1935.4967708395636;739.4638886807022;917.9265658747285;949.539473355422;959.4291396619001;1077.4181941751367;18420;21338.14647414086;22042.669359959615;22150.55698886013;22595.20916767905;931.8695382646434;952.7951490429591;968.5544649461327;985.9992108010375;1004.4525733475274;11416.657500275005;11582.733812949607;11617.76764464706;11675.824862627067;11693.649190524298;522520.38739806815;523555.14667280024;526224;526850;529710;126082.73917260894;126575;131061;131159.34420328029;132909;993.6323560282597;999.7100840756244;1021.8262895307815;1022.6471867205802;1027.3733022855902;19272.518187045436;19372.8062719371;19401.708974365112;19408.61182776365;19451.61096778085;51508.484915150366;52777.472225277255;53794.73102634462;54707.45292547183;54974.67791204063;57330.713346433;75498.62250688711;76320.61839690988;77294;77321;7284.271572842674;7499.812504687427;7582.090149182133;8053.6778528858185;8595.269402100892;9432.764180895532;13022.2837743925;13577.932110339385;13709;13835.100718453268;11484.770304594029;11726.179167458196;11829.34938578352;11850.111241657083;11977.401129943293;11552.133589980953;11678.124140689652;11716;11767.882321177021;11917.702057448632;11748.177627565989;11748.236364636272;11845.822312665145;11995.880041199476;12030.338331391857;7576.810579735551;7629.580373079534;7648.80877978055;7684.807879802826;7815.687372505036;8243.464174828618;10903.236773425784;11340.489677964346;11345.659630211107;11504 04:24:44 INFO - PROCESS | 1649 | |3;mootools.html;1391.3599744117705;1559.2125976381928;1580.652256503569;1819.1450018491312;1970.566475375417;7819;8567.400281980264;8809.911900880988;8818.294536437086;8951.641934322635;8569.400141990047;8798.472091674505;8802.07578204289;8804.339674524404;8804.559772011406;2057.351934140748;2127.9147634706333;2132.296342207068;2374.5607062693416;2405.56699794037;2184.3010236724253;2204.933851984443;2333.6032874411308;2414.8913298901593;2418.4558474343307;2385.8329916905823;2388.5461762265113;2389.569877422063;2392.079049565912;2393.365758074112;2333.0784340185614;2376.65538496917;2378.310290015902;2381.6427535869584;2385.594448943684;2088.112552165339;2172.4134483689472;2173.1850556041486;2178.8692678439343;2305.3775480620307;8630.050694423608;8819.470831750052;8819.823603527893;8825.51459669718;8828.205461508494;5214.45248248936;5383.165609330521;5386.13821788512;5390.056740070511;5397.541208997201;3329.6503867094093;3334.1164591383304;3395.8471868765964;3398.5411969384063;3424.0412684448393;1099.5272033025797;1100.3617901617042;1105.8728246251624;1119.0599896087244;1124.4883577972084;11638.941805291004;11643.24318919276;11643.941780291128;11646.068314534901;11668.533258669642;4555.2256116460285;4602.194615942197;4805.207140821725;4808.735519546459;4823.5658790709;8523.74428767138;9869.802603947881;9875.160611348116;9882.604695812232;9890.505474726235;5361.705106219118;5362.544183744348;5366.973165134149;5369.785208591613;5384.461553844584;3826.521684789401;4445.3998710174355;4897.877553061131;4898.363212782316;4906.239532872411;3281.507773833944;3578.946315805265;3770.472133901256;3837.9253808933545;3869.6710779583486;1165.7493638867516;1167.7430965187646;1177.0226020286002;1180.0677464802882;1180.4097951024487;674.8987651852261;809.4050872608628;843.2621456225802;929.8558723397884;941.684535680541;4936.506349365035;6079.8480037998515;6149.96925015372;6199.752009919643;6270.090836828635;953.5804246131819;962.259060523393;962.8363178259713;976.9169620582188;1022.9590816367411;3369.595648522193;4126.793660316972;4149.37759336102;4185.22573323936;4230.576942305806;10094.747631309128;10452.634157804441;10742.89257107419;10840.024397804236;10848.457577121113;10558.577656893793;10644.095251903675;10755.139588832875;10771;10809.729756755987;7941.245581669732;8096.8380632387025;8279.54462504568;8295.95852020736;8326.375521835766;5604.943950560442;5609.709766753588;5941.702914854153;6159.692015399122;6241;10049.748756280858;10060.0945914868;10070.647527336509;10081.395116293046;10095.293329466867;9656.855147172657;10034;10175.731884490593;10258.794824103625;10275.897241027495;7480.214577469287;7702.53784772893;7706.267904549059;7713.074431068308;7718.729844455417;8146.959265203636;8164.387670924823;8323.875141872755;8325.167483251626;8342.499450033018;7492.887606686013;7519.060117485315;7547.924520754942;7686.769396918102;7712.807179820549;7376.114866216089;7455.179930207564;7468.9626551866895;7515.549067055994;7586.582737949466;7023.157221133497;7032.050673159262;7090.822729431599;7091.787246382617;7112.0754301940415;4476.5075841658045;4912.066707325596;5055.747212639427;5107.259447380184;5107.846764597068;4840.273958906051;4997.575206107522;5110.66780659256;5168.147255702767;5269.1569348903995 04:24:44 INFO - PROCESS | 1649 | |4;prototype.html;303.9224997625605;309.30097978568426;313.36387134117734;316.1542872815219;318.73544957685095;4549.99900021995;4844.781984810683;5484.670919744814;5485.807996720116;5501.669899806015;5383.273258110154;5441.428649991743;5442.945570544293;5456.672599644025;5460.798624302657;3884.7086468514835;3944.605539446047;4019.075612609102;4064.695147863907;4193.643540299063;3248.4964830451318;3580.4629305604108;3988.24223397555;4108.26051310764;4167.499900011988;3248.96751032489;3315.834208289588;3639.5632524097146;4076.490438695163;4117.5882411758885;3541.592716837571;3824.9235015299814;3851;3894.559013165147;4120.711550191488;3005.6092707948046;3188.6651901550235;3565.4830049642915;3573.4991303652528;3582.444721068239;4339;4800.159972004885;5226.608004399685;5264.6051546134195;5327.30745003151;3960.960390396088;3968.3849003404516;4584.977075114603;4672.229082201433;4741.786619602126;5084.110280700899;5199.934013527218;5574.136008918624;5627.296587926509;5673;3337.8998630040896;3952.8734310721306;3965.0658512700684;3982.542007669097;3985.9800700996598;4862.8784280392565;4896.7758060484875;5781.843631273762;5884.7940322088525;5915.408459154093;3560.91097722559;3695.4456831475495;3883.786391748481;3891.2217556488818;3896.4350169225304;3955.7428767130045;3975.7018223632763;3989.4441167944524;4001.7398869073418;4004.699647526389;4286.721363111388;4647.18674232008;4648.86053418398;4649.837255696035;4711.7879695413785;4155.168966206771;5564.805231816867;5698.401667824902;5729.3984131665575;5746.597738158289;1339.3659735123329;1355.722076974218;1357.6062941746782;1364.979525307121;1370.6847425092285;633.3729607688356;768.6272158003364;788.8934993775881;815.995920020396;833.791552111972;5072.9746351268;5155.690658560498;5251.553617942442;5265.446693225431;5333.280007199056;5124.308218390544;5585.58108141891;5629;5780.364159942403;5806.925718741962;5124.615653825978;5161.870953226199;5217.713025783618;5324.736986780603;5327.440618735054;2733.3986522964915;2944.1304771470272;3027.894023709204;3044.375902939892;3050.80169788963;4918.852434426973;4962.925556116661;5487.725613719298;5673.432656734376;5988.760449581968;5164;5633.63381380209;5734.627249228787;5816.8947899898885;5889.823305300848;4983.725895075806;5507.752151153208;5962.284525856839;5963.419693781151;6002.849928751816;5359.651622644516;5738.971305143447;5742.5118864895285;5836.737346819488;5854.209681693087;4456.821727130879;4746.477887432448;5218.765155568084;5528.765672081877;5639.392773059658;5209.921851172311;5372.274742909657;5827.3007239131575;5944.484156540228;5973.731182096729;3631.092226943264;3832.8118283332255;3837.865674701372;3852.3643598805884;3857.9421308680953;5882.470577648032;5892.466239517049;5899.882002360015;5908.252662511953;5908.970455147697;5711.8857622848145;5732.369439361751;5765.423457654201;5770.596058275881;5782.074868021096;4687.257954096892;5073.898522029613;5475.288212532345;5712.400197979152;5744.511716504144;5039;5393.325834270716;5602.467765562265;5697.886042279214;5698.002849501404;5120.129577971828;5358.6248962572245;5468.7578092981685;5687.350668306145;5731.455511726379;5341.813036543703;5580.358258800127;5623.465770751772;5633.338330085314;5634.464725851038 04:24:44 INFO - PROCESS | 1649 | |5;yui.html;719.2268311565067;725.137086866629;755.3164386230463;778.5834578500502;808.4583329169456;15487.070775753462;16762.41331553396;16791.160441977914;16795.49613511595;16806.159692015397;15059;15254.923725381384;15261.160636165007;15262.618434539114;15294.388224471008;716.5879619218944;733.4169335378386;892.4957399069522;894.4141587260355;928.2481190235897;893.6291439052785;906.1618003346911;909.7862002429457;909.9317551183655;909.9944561259812;963.0081016552926;964.0793042644258;965.3532133470592;968.4915419404798;969.4038166527605;764.2204950949999;944.1738478831023;961.130177189641;971.5482300730124;972.7276362618478;716.1406312425058;716.4197000429616;717.150177040209;718.2027948976684;718.6622287524855;15117.47088851896;15167.848321516754;15168.924155379153;15181.240937953058;15200.46798362063;14021.929890350482;14091.82933839888;14119.858801411958;14154.575362739135;14311.57065288043;12942.61172164827;12948.546800861925;12998.285094319808;13212.537561185312;13436.798448023288;4607.631389488833;4620.422447194101;4653.371794807692;4813.975930120362;4832.758362081917;105219;107866;108262.45868770605;110583;113149.86850131476;11250.774984500264;11266.098712103012;11287;11287.153463490107;11366.033887119687;18426.170822313026;22204.55590888173;22239.777602224094;22246.55506889853;22258.99834507451;7984.24149705777;8150.184981501802;8176.264136227649;8193.139720329398;8273.917260827315;4377.1683380157665;4523.660725445605;4537.636989040869;4539.296409056601;4620.445546534437;3482.1294676330917;3583.4983102365168;3594.2452085061905;3600.837962291703;3602.693771029492;656.9737210511526;659.1200747002805;663.5255792108569;663.7510933399975;672.4183581202225;599.4275466929072;645.4836131095105;647.2104033079729;656.0880376276979;659.2122413715564;8704.738857834274;9074.137956894085;9169.449833010041;9317.580708868118;9691.854622180674;595.4105435618707;597.9581429299907;637.178040327981;642.2902692524787;656.4125108028288;4375.190589740908;4424.446944131983;4525.818142048301;4654.720716756938;4665.743384113838;148881.76677349847;151586;156023;157891.21054394884;159346;81876;84875;130118;134510;136664.56353366122;116957.41521292509;118346.4082679581;118348;119382.403087984;119759.99999999825;8561.785955350917;8579.571021448777;8683.305335573265;8771.877692924882;9115.134062264075;57367;60891.963938058805;61732.38267617267;62427.68786156222;65464.345356545826;90224.54887725782;91296.54351728199;94235;97194;97705;13499.190048597116;13650.249236291702;13771.655708607364;14265.500707475188;14285.214313212873;12634.936825315815;15009.249537522861;15204.433755097472;15391.230438477807;16054.43809466663;9758;12391.256524608552;12478.500859965863;12709.8093528599;12821.358932053547;12028.338441385458;12309.322987235788;12443.25340479538;12672.6831829205;12705.936470317589;12037.398130093636;12213.816792748294;12370.876291236973;12561.309127998047;12643.178193417398;10277.743056423351;10427.791444170922;10443.321184123008;10596.205284603531;11060.170487213652;7612.885806713015;8668.826623467621;9464.290178236522;9696.321257511907;9785.85321220168 04:24:44 INFO - PROCESS | 1649 | __end_tp_report 04:24:44 INFO - PROCESS | 1649 | __start_cc_report 04:24:44 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1484 04:24:44 INFO - PROCESS | 1649 | __end_cc_report 04:24:44 INFO - PROCESS | 1649 | __startTimestamp1468236284399__endTimestamp 04:24:44 INFO - PROCESS | 1649 | 04:24:44 INFO - PROCESS | 1649 | ------- Summary: start ------- 04:24:44 INFO - PROCESS | 1649 | Number of tests: 6 04:24:44 INFO - PROCESS | 1649 | 04:24:44 INFO - PROCESS | 1649 | [#0] dojo.html Cycles:165 Average:5786.79 Median:5974.46 stddev:663.85 (11.1%) stddev-sans-first:616.11 04:24:44 INFO - PROCESS | 1649 | Values: 2571.6 3353.5 3371.4 3393.3 3409.1 5651.4 5724.7 5735.3 5815.4 5840.2 5748.5 5796.9 5828.3 5857.5 5868.6 5160.3 5167.1 5236.4 5241.3 5370.6 5356.2 5359.3 5369.6 5374.0 5402.5 5202.6 5210.7 5216.7 5265.3 5274.2 5238.3 5263.2 5266.1 5285.8 5291.2 4497.6 5197.4 5212.5 5221.0 5278.0 5778.6 5879.8 5897.1 5902.5 5922.0 5443.5 6094.5 6166.2 6213.1 6274.6 6286.5 6340.1 6352.0 6368.1 6377.4 5941.1 5964.9 5967.4 5967.6 5971.1 6154.5 6271.7 6293.0 6293.2 6387.0 6227.7 6230.4 6241.4 6244.9 6253.9 6333.3 6349.4 6349.7 6359.4 6379.5 5974.5 6095.1 6110.7 6133.2 6208.3 6146.6 6226.3 6286.8 6318.3 6358.1 5008.2 5025.9 5052.9 5056.3 5078.9 4432.8 4460.2 4492.7 4495.2 4498.8 5822.0 5861.5 5864.1 5878.9 5935.1 6129.0 6257.9 6277.5 6326.3 6328.0 5756.5 5770.7 5782.6 5803.0 5817.4 5443.1 5502.2 5503.3 5513.9 5533.4 6307.9 6315.7 6395.0 6397.5 6409.0 6256.0 6257.1 6306.8 6325.4 6340.8 6168.6 6235.9 6305.9 6394.1 6423.3 6177.7 6205.1 6278.8 6287.3 6293.7 4981.8 6311.3 6313.3 6356.2 6359.0 5970.2 6033.5 6059.2 6088.2 6129.3 6096.8 6108.8 6128.5 6147.9 6158.3 6040.2 6051.5 6053.7 6075.8 6087.8 6107.7 6131.5 6174.8 6180.1 6190.2 5760.2 5815.7 5928.9 5935.0 5997.3 04:24:44 INFO - PROCESS | 1649 | 04:24:44 INFO - PROCESS | 1649 | [#1] ext.html Cycles:180 Average:72945.03 Median:40131.00 stddev:158028.15 (393.8%) stddev-sans-first:158377.86 04:24:44 INFO - PROCESS | 1649 | Values: 503.1 511.7 519.9 529.0 532.5 26075.1 42465.4 42495.8 42960.8 46070.0 41032.2 44693.0 44744.1 44983.8 45077.5 8750.2 9702.3 9874.6 9877.1 9888.6 8829.6 10882.8 10933.7 11828.2 12265.0 12009.6 12042.0 12071.8 12075.1 12101.6 8792.3 8959.3 12004.8 12124.6 12136.2 8865.3 8945.6 11465.5 11725.9 11732.5 42353.6 42710.4 42793.4 42804.6 42845.1 3593.4 3670.3 3820.6 3870.2 4307.7 32378.8 32891.0 33665.7 33716.0 33871.8 3292.7 3415.0 3453.6 3467.3 3484.5 531258.0 531746.0 532776.0 532793.0 533622.7 62332.4 62613.7 62619.7 62621.4 62693.7 58161.4 66569.0 66686.3 67152.0 67181.0 16606.2 17060.6 17064.8 17088.0 17159.7 11867.7 12085.9 12990.2 13160.5 13212.6 17075.6 17171.6 17207.5 17234.7 17244.6 6361.8 6445.1 6838.7 6910.1 7244.2 899.3 968.5 1016.9 1027.0 1057.6 31098.4 31271.2 31456.8 31815.7 32215.7 899.3 1132.2 1152.5 1153.9 1171.4 16137.2 16292.6 16398.5 16414.8 16770.2 657754.0 658494.0 659114.0 660330.0 660590.0 60766.0 60814.7 60833.1 60873.8 60981.4 1259.5 1300.9 1380.0 1398.3 1452.2 26827.0 31634.7 32039.5 32634.0 32659.3 53116.7 53949.0 54321.0 54371.2 54519.2 568077.0 577579.0 578307.0 579250.0 580233.0 24196.2 24545.5 26196.6 26390.9 26802.0 49184.5 49578.0 49578.3 50191.7 50594.5 34535.0 40141.4 40485.2 41666.2 41908.8 40392.6 40453.0 40799.2 40810.0 41565.2 39074.6 39724.0 40120.6 40326.0 42587.4 27617.7 32326.7 36420.8 36568.9 37074.6 25803.2 26442.5 26770.7 26776.2 26906.9 04:24:44 INFO - PROCESS | 1649 | 04:24:44 INFO - PROCESS | 1649 | [#2] jquery.html Cycles:180 Average:32529.50 Median:12433.22 stddev:88246.02 (709.8%) stddev-sans-first:88460.52 04:24:44 INFO - PROCESS | 1649 | Values: 362.8 382.2 392.7 395.7 416.4 15526.9 15791.7 20920.8 21393.0 21426.7 21110.3 21464.7 21866.8 22301.3 22318.6 5834.2 5915.8 6177.6 6178.8 6189.7 3899.9 6124.6 6135.8 6180.4 6565.3 6810.0 6820.5 6829.7 6837.8 6838.6 5525.6 6376.6 6731.2 6751.0 6819.9 3736.9 5597.9 5970.7 5976.3 5982.3 13242.0 13834.5 13839.4 13853.1 23158.3 2048.8 2208.9 2271.2 2443.8 2929.6 10127.1 10514.0 12844.2 14437.8 15063.8 1789.3 1847.6 1867.7 1883.9 1895.9 80653.6 98694.0 107959.0 123287.4 123485.0 9301.6 11487.4 11577.6 11689.0 11776.5 14386.2 14483.4 14507.0 14524.8 14580.3 7102.6 8399.1 8638.4 8646.7 8667.0 8571.2 8579.9 8604.4 8690.4 8734.8 4505.3 4578.6 4588.3 4644.6 4651.7 1630.8 1642.4 1884.2 1922.4 1935.5 739.5 917.9 949.5 959.4 1077.4 18420.0 21338.1 22042.7 22150.6 22595.2 931.9 952.8 968.6 986.0 1004.5 11416.7 11582.7 11617.8 11675.8 11693.6 522520.4 523555.1 526224.0 526850.0 529710.0 126082.7 126575.0 131061.0 131159.3 132909.0 993.6 999.7 1021.8 1022.6 1027.4 19272.5 19372.8 19401.7 19408.6 19451.6 51508.5 52777.5 53794.7 54707.5 54974.7 57330.7 75498.6 76320.6 77294.0 77321.0 7284.3 7499.8 7582.1 8053.7 8595.3 9432.8 13022.3 13577.9 13709.0 13835.1 11484.8 11726.2 11829.3 11850.1 11977.4 11552.1 11678.1 11716.0 11767.9 11917.7 11748.2 11748.2 11845.8 11995.9 12030.3 7576.8 7629.6 7648.8 7684.8 7815.7 8243.5 10903.2 11340.5 11345.7 11504.0 04:24:44 INFO - PROCESS | 1649 | 04:24:44 INFO - PROCESS | 1649 | [#3] mootools.html Cycles:180 Average:5702.25 Median:4902.30 stddev:3213.12 (65.5%) stddev-sans-first:3205.80 04:24:44 INFO - PROCESS | 1649 | Values: 1391.4 1559.2 1580.7 1819.1 1970.6 7819.0 8567.4 8809.9 8818.3 8951.6 8569.4 8798.5 8802.1 8804.3 8804.6 2057.4 2127.9 2132.3 2374.6 2405.6 2184.3 2204.9 2333.6 2414.9 2418.5 2385.8 2388.5 2389.6 2392.1 2393.4 2333.1 2376.7 2378.3 2381.6 2385.6 2088.1 2172.4 2173.2 2178.9 2305.4 8630.1 8819.5 8819.8 8825.5 8828.2 5214.5 5383.2 5386.1 5390.1 5397.5 3329.7 3334.1 3395.8 3398.5 3424.0 1099.5 1100.4 1105.9 1119.1 1124.5 11638.9 11643.2 11643.9 11646.1 11668.5 4555.2 4602.2 4805.2 4808.7 4823.6 8523.7 9869.8 9875.2 9882.6 9890.5 5361.7 5362.5 5367.0 5369.8 5384.5 3826.5 4445.4 4897.9 4898.4 4906.2 3281.5 3578.9 3770.5 3837.9 3869.7 1165.7 1167.7 1177.0 1180.1 1180.4 674.9 809.4 843.3 929.9 941.7 4936.5 6079.8 6150.0 6199.8 6270.1 953.6 962.3 962.8 976.9 1023.0 3369.6 4126.8 4149.4 4185.2 4230.6 10094.7 10452.6 10742.9 10840.0 10848.5 10558.6 10644.1 10755.1 10771.0 10809.7 7941.2 8096.8 8279.5 8296.0 8326.4 5604.9 5609.7 5941.7 6159.7 6241.0 10049.7 10060.1 10070.6 10081.4 10095.3 9656.9 10034.0 10175.7 10258.8 10275.9 7480.2 7702.5 7706.3 7713.1 7718.7 8147.0 8164.4 8323.9 8325.2 8342.5 7492.9 7519.1 7547.9 7686.8 7712.8 7376.1 7455.2 7469.0 7515.5 7586.6 7023.2 7032.1 7090.8 7091.8 7112.1 4476.5 4912.1 5055.7 5107.3 5107.8 4840.3 4997.6 5110.7 5168.1 5269.2 04:24:44 INFO - PROCESS | 1649 | 04:24:44 INFO - PROCESS | 1649 | [#4] prototype.html Cycles:180 Average:4533.15 Median:5158.78 stddev:1413.12 (27.4%) stddev-sans-first:1380.98 04:24:44 INFO - PROCESS | 1649 | Values: 303.9 309.3 313.4 316.2 318.7 4550.0 4844.8 5484.7 5485.8 5501.7 5383.3 5441.4 5442.9 5456.7 5460.8 3884.7 3944.6 4019.1 4064.7 4193.6 3248.5 3580.5 3988.2 4108.3 4167.5 3249.0 3315.8 3639.6 4076.5 4117.6 3541.6 3824.9 3851.0 3894.6 4120.7 3005.6 3188.7 3565.5 3573.5 3582.4 4339.0 4800.2 5226.6 5264.6 5327.3 3961.0 3968.4 4585.0 4672.2 4741.8 5084.1 5199.9 5574.1 5627.3 5673.0 3337.9 3952.9 3965.1 3982.5 3986.0 4862.9 4896.8 5781.8 5884.8 5915.4 3560.9 3695.4 3883.8 3891.2 3896.4 3955.7 3975.7 3989.4 4001.7 4004.7 4286.7 4647.2 4648.9 4649.8 4711.8 4155.2 5564.8 5698.4 5729.4 5746.6 1339.4 1355.7 1357.6 1365.0 1370.7 633.4 768.6 788.9 816.0 833.8 5073.0 5155.7 5251.6 5265.4 5333.3 5124.3 5585.6 5629.0 5780.4 5806.9 5124.6 5161.9 5217.7 5324.7 5327.4 2733.4 2944.1 3027.9 3044.4 3050.8 4918.9 4962.9 5487.7 5673.4 5988.8 5164.0 5633.6 5734.6 5816.9 5889.8 4983.7 5507.8 5962.3 5963.4 6002.8 5359.7 5739.0 5742.5 5836.7 5854.2 4456.8 4746.5 5218.8 5528.8 5639.4 5209.9 5372.3 5827.3 5944.5 5973.7 3631.1 3832.8 3837.9 3852.4 3857.9 5882.5 5892.5 5899.9 5908.3 5909.0 5711.9 5732.4 5765.4 5770.6 5782.1 4687.3 5073.9 5475.3 5712.4 5744.5 5039.0 5393.3 5602.5 5697.9 5698.0 5120.1 5358.6 5468.8 5687.4 5731.5 5341.8 5580.4 5623.5 5633.3 5634.5 04:24:44 INFO - PROCESS | 1649 | 04:24:44 INFO - PROCESS | 1649 | [#5] yui.html Cycles:180 Average:24839.21 Median:4524.74 stddev:39887.81 (881.5%) stddev-sans-first:39958.59 04:24:44 INFO - PROCESS | 1649 | Values: 719.2 725.1 755.3 778.6 808.5 15487.1 16762.4 16791.2 16795.5 16806.2 15059.0 15254.9 15261.2 15262.6 15294.4 716.6 733.4 892.5 894.4 928.2 893.6 906.2 909.8 909.9 910.0 963.0 964.1 965.4 968.5 969.4 764.2 944.2 961.1 971.5 972.7 716.1 716.4 717.2 718.2 718.7 15117.5 15167.8 15168.9 15181.2 15200.5 14021.9 14091.8 14119.9 14154.6 14311.6 12942.6 12948.5 12998.3 13212.5 13436.8 4607.6 4620.4 4653.4 4814.0 4832.8 105219.0 107866.0 108262.5 110583.0 113149.9 11250.8 11266.1 11287.0 11287.2 11366.0 18426.2 22204.6 22239.8 22246.6 22259.0 7984.2 8150.2 8176.3 8193.1 8273.9 4377.2 4523.7 4537.6 4539.3 4620.4 3482.1 3583.5 3594.2 3600.8 3602.7 657.0 659.1 663.5 663.8 672.4 599.4 645.5 647.2 656.1 659.2 8704.7 9074.1 9169.4 9317.6 9691.9 595.4 598.0 637.2 642.3 656.4 4375.2 4424.4 4525.8 4654.7 4665.7 148881.8 151586.0 156023.0 157891.2 159346.0 81876.0 84875.0 130118.0 134510.0 136664.6 116957.4 118346.4 118348.0 119382.4 119760.0 8561.8 8579.6 8683.3 8771.9 9115.1 57367.0 60892.0 61732.4 62427.7 65464.3 90224.5 91296.5 94235.0 97194.0 97705.0 13499.2 13650.2 13771.7 14265.5 14285.2 12634.9 15009.2 15204.4 15391.2 16054.4 9758.0 12391.3 12478.5 12709.8 12821.4 12028.3 12309.3 12443.3 12672.7 12705.9 12037.4 12213.8 12370.9 12561.3 12643.2 10277.7 10427.8 10443.3 10596.2 11060.2 7612.9 8668.8 9464.3 9696.3 9785.9 04:24:44 INFO - PROCESS | 1649 | -------- Summary: end -------- 04:24:44 INFO - PROCESS | 1649 | 04:24:44 INFO - TEST-INFO | 1649: exit 0 04:24:44 INFO - TEST-OK | dromaeo_css | took 1116435ms 04:24:44 INFO - TEST-START | kraken 04:24:44 INFO - operating with platform_type : mac_ 04:24:44 INFO - Initialising browser for kraken test... 04:24:45 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmp55ybRW/profile http://localhost:49267/getInfo.html) 04:24:47 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 04:24:47 INFO - PROCESS | 1658 | colorDepth:24 04:24:47 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 04:24:47 INFO - PROCESS | 1658 | __metrics 04:24:47 INFO - PROCESS | 1658 | 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" 04:24:47 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:24:47 INFO - TEST-INFO | 1658: exit 0 04:24:47 INFO - Browser initialized. 04:24:47 INFO - Running cycle 1/1 for kraken test... 04:24:47 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmp55ybRW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:59 INFO - PROCESS | 1659 | RSS: Main: 243384320 04:24:59 INFO - PROCESS | 1659 | 04:25:02 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 04:25:03 INFO - PROCESS | 1659 | RSS: Main: 293883904 04:25:03 INFO - PROCESS | 1659 | 04:25:05 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 04:25:06 INFO - PROCESS | 1659 | RSS: Main: 303992832 04:25:06 INFO - PROCESS | 1659 | 04:25:10 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 04:25:10 INFO - PROCESS | 1659 | RSS: Main: 391700480 04:25:10 INFO - PROCESS | 1659 | 04:25:12 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 04:25:13 INFO - PROCESS | 1659 | RSS: Main: 292507648 04:25:13 INFO - PROCESS | 1659 | 04:25:15 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:25:16 INFO - PROCESS | 1659 | RSS: Main: 296439808 04:25:16 INFO - PROCESS | 1659 | 04:25:18 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 04:25:19 INFO - PROCESS | 1659 | RSS: Main: 334356480 04:25:19 INFO - PROCESS | 1659 | 04:25:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 04:25:22 INFO - PROCESS | 1659 | RSS: Main: 335138816 04:25:22 INFO - PROCESS | 1659 | 04:25:25 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 04:25:26 INFO - PROCESS | 1659 | RSS: Main: 335400960 04:25:26 INFO - PROCESS | 1659 | 04:25:27 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:25:28 INFO - PROCESS | 1659 | RSS: Main: 313053184 04:25:28 INFO - PROCESS | 1659 | 04:25:30 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:25:31 INFO - PROCESS | 1659 | RSS: Main: 319700992 04:25:31 INFO - PROCESS | 1659 | 04:25:33 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:25:33 INFO - PROCESS | 1659 | RSS: Main: 317304832 04:25:33 INFO - PROCESS | 1659 | 04:25:36 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:25:37 INFO - PROCESS | 1659 | RSS: Main: 326979584 04:25:37 INFO - PROCESS | 1659 | 04:25:40 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:25:40 INFO - PROCESS | 1659 | RSS: Main: 328364032 04:25:40 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 04:25:42 INFO - PROCESS | 1659 | RSS: Main: 371642368 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | __start_tp_report 04:25:42 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 04:25:42 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 04:25:42 INFO - PROCESS | 1659 | |i|pagename|runs| 04:25:42 INFO - PROCESS | 1659 | |0;ai-astar;102;111;112;111;113;112;111;112;111;112 04:25:42 INFO - PROCESS | 1659 | |1;audio-beat-detection;142;120;137;191;105;106;129;107;137;107 04:25:42 INFO - PROCESS | 1659 | |2;audio-dft;184;187;188;184;184;184;185;199;185;185 04:25:42 INFO - PROCESS | 1659 | |3;audio-fft;77;74;56;110;82;80;85;68;83;58 04:25:42 INFO - PROCESS | 1659 | |4;audio-oscillator;85;84;91;70;71;68;97;70;67;99 04:25:42 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;87;85;87;84;87;84;86;84;86;84 04:25:42 INFO - PROCESS | 1659 | |6;imaging-darkroom;92;93;92;93;92;93;92;93;92;105 04:25:42 INFO - PROCESS | 1659 | |7;imaging-desaturate;86;86;85;85;84;92;84;85;87;86 04:25:42 INFO - PROCESS | 1659 | |8;json-parse-financial;55;55;54;55;54;54;53;55;54;53 04:25:42 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;63;66;79;77;72;70;71;72;71;69 04:25:42 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;86;78;83;84;81;84;80;85;98;100 04:25:42 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;138;144;140;135;135;135;138;137;199;126 04:25:42 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;163;157;160;161;162;163;163;163;162;163 04:25:42 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;65;70;78;84;84;84;72;64;65;67 04:25:42 INFO - PROCESS | 1659 | __end_tp_report 04:25:42 INFO - PROCESS | 1659 | __start_cc_report 04:25:42 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2059 04:25:42 INFO - PROCESS | 1659 | __end_cc_report 04:25:42 INFO - PROCESS | 1659 | __startTimestamp1468236342853__endTimestamp 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | ------- Summary: start ------- 04:25:42 INFO - PROCESS | 1659 | Number of tests: 14 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.13 (2.8%) stddev-sans-first:0.71 04:25:42 INFO - PROCESS | 1659 | Values: 102.0 111.0 112.0 111.0 113.0 112.0 111.0 112.0 111.0 112.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:133.00 stddev:26.43 (19.9%) stddev-sans-first:27.55 04:25:42 INFO - PROCESS | 1659 | Values: 142.0 120.0 137.0 191.0 105.0 106.0 129.0 107.0 137.0 107.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:186.50 Median:185.00 stddev:4.60 (2.5%) stddev-sans-first:4.79 04:25:42 INFO - PROCESS | 1659 | Values: 184.0 187.0 188.0 184.0 184.0 184.0 185.0 199.0 185.0 185.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:77.30 Median:78.50 stddev:15.33 (19.5%) stddev-sans-first:16.26 04:25:42 INFO - PROCESS | 1659 | Values: 77.0 74.0 56.0 110.0 82.0 80.0 85.0 68.0 83.0 58.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:84.50 stddev:12.50 (14.8%) stddev-sans-first:13.13 04:25:42 INFO - PROCESS | 1659 | Values: 85.0 84.0 91.0 70.0 71.0 68.0 97.0 70.0 67.0 99.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.00 stddev:1.35 (1.6%) stddev-sans-first:1.30 04:25:42 INFO - PROCESS | 1659 | Values: 87.0 85.0 87.0 84.0 87.0 84.0 86.0 84.0 86.0 84.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:92.50 stddev:4.00 (4.3%) stddev-sans-first:4.20 04:25:42 INFO - PROCESS | 1659 | Values: 92.0 93.0 92.0 93.0 92.0 93.0 92.0 93.0 92.0 105.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.00 stddev:2.31 (2.7%) stddev-sans-first:2.45 04:25:42 INFO - PROCESS | 1659 | Values: 86.0 86.0 85.0 85.0 84.0 92.0 84.0 85.0 87.0 86.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:0.79 (1.4%) stddev-sans-first:0.78 04:25:42 INFO - PROCESS | 1659 | Values: 55.0 55.0 54.0 55.0 54.0 54.0 53.0 55.0 54.0 53.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.50 stddev:4.67 (6.5%) stddev-sans-first:3.95 04:25:42 INFO - PROCESS | 1659 | Values: 63.0 66.0 79.0 77.0 72.0 70.0 71.0 72.0 71.0 69.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:84.00 stddev:7.32 (8.7%) stddev-sans-first:7.77 04:25:42 INFO - PROCESS | 1659 | Values: 86.0 78.0 83.0 84.0 81.0 84.0 80.0 85.0 98.0 100.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:138.00 stddev:20.31 (14.7%) stddev-sans-first:21.47 04:25:42 INFO - PROCESS | 1659 | Values: 138.0 144.0 140.0 135.0 135.0 135.0 138.0 137.0 199.0 126.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:163.00 stddev:1.95 (1.2%) stddev-sans-first:2.01 04:25:42 INFO - PROCESS | 1659 | Values: 163.0 157.0 160.0 161.0 162.0 163.0 163.0 163.0 162.0 163.0 04:25:42 INFO - PROCESS | 1659 | 04:25:42 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:75.00 stddev:8.45 (11.3%) stddev-sans-first:8.41 04:25:42 INFO - PROCESS | 1659 | Values: 65.0 70.0 78.0 84.0 84.0 84.0 72.0 64.0 65.0 67.0 04:25:42 INFO - PROCESS | 1659 | -------- Summary: end -------- 04:25:42 INFO - PROCESS | 1659 | 04:25:43 INFO - TEST-INFO | 1659: exit 0 04:25:43 INFO - TEST-OK | kraken | took 58742ms 04:25:43 INFO - SUITE-END | took 1175s 04:25:44 INFO - Completed test suite (00:19:35) 04:25:44 INFO - javascript benchmark 04:25:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2571.6014017827238, 3353.48021056736, 3371.359441706076, 3393.3043726036167, 3409.147713071732, 5651.434856514356, 5724.685142317171, 5735.311762588485, 5815.360310365862, 5840.153177789218, 5748.5401167906575, 5796.913046304308, 5828.271466066731, 5857.472827445529, 5868.589198756089, 5160.2517634942915, 5167.121589329823, 5236.371635403757, 5241.292425522563, 5370.624056316059, 5356.1697936819855, 5359.276497672803, 5369.5972802039805, 5374.032674118657, 5402.513773760361, 5202.635815492917, 5210.687358758487, 5216.660917040418, 5265.341832270966, 5274.156135018378, 5238.292830467876, 5263.210518422229, 5266.078436273637, 5285.762140703678, 5291.1798671206025, 4497.550244975476, 5197.376314842205, 5212.50481204285, 5221.0, 5277.973610131925, 5778.624389414675, 5879.823605291848, 5897.085951677497, 5902.498287645555, 5921.970390148022, 5443.537299329561, 6094.471245618287, 6166.167567378437, 6213.099100630428, 6274.623522588659, 6286.46565041972, 6340.144080549113, 6351.96824015877, 6368.10846481493, 6377.426031657174, 5941.1088336749835, 5964.8807023860145, 5967.403259674084, 5967.552433567456, 5971.104334349839, 6154.5076393888385, 6271.6550589718, 6292.968535157295, 6293.213348331458, 6387.041943708388, 6227.657478838707, 6230.376962303824, 6241.375862413813, 6244.937550624436, 6253.874922501524, 6333.2716737575765, 6349.365063493706, 6349.6507692077375, 6359.395857393541, 6379.457746091542, 5974.462298393166, 6095.146679464879, 6110.725017374229, 6133.151048553363, 6208.286047104641, 6146.6004709693725, 6226.346233645492, 6286.779962701284, 6318.273398559132, 6358.109864618957, 5008.248762685626, 5025.894303253279, 5052.898942021139, 5056.292119103328, 5078.873028174326, 4432.756198409054, 4460.219461594208, 4492.685512014127, 4495.213337665896, 4498.842540511132, 5821.970890145607, 5861.501772349313, 5864.091065884794, 5878.882422351529, 5935.080062590219, 6128.961487065963, 6257.906131408033, 6277.52918531112, 6326.272478665012, 6327.96836015817, 5756.539476841926, 5770.711464426762, 5782.566307526952, 5803.0, 5817.360090390053, 5443.101888188405, 5502.174673798882, 5503.3395992481155, 5513.917291240635, 5533.418991005967, 6307.905381419282, 6315.747370105236, 6395.008773640093, 6397.4562162216735, 6409.0066039763915, 6256.0, 6257.092721555258, 6306.842328941813, 6325.399087086719, 6340.809775706736, 6168.629882207082, 6235.875282494416, 6305.936940630719, 6394.136791533084, 6423.261324947691, 6177.722002509988, 6205.100260462117, 6278.843028924313, 6287.2769631492965, 6293.685315734287, 4981.775820088177, 6311.305756366704, 6313.273973493107, 6356.173697419491, 6359.046143078575, 5970.164177015135, 6033.456988871023, 6059.182010428712, 6088.238970128734, 6129.325774164749, 6096.817095487142, 6108.786192483241, 6128.50971922254, 6147.877042459037, 6158.32258451561, 6040.184575082308, 6051.546134039877, 6053.727582258721, 6075.848103797441, 6087.817365479043, 6107.69461526913, 6131.54013449002, 6174.753009879734, 6180.134781130555, 6190.1952746142715, 5760.1935728998815, 5815.651060936358, 5928.9110663339225, 5934.970325148347, 5997.280326360865], "value": 5742.2412781885105, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.0793647624847, 511.6623028800992, 519.9324087868576, 529.0265910724266, 532.4595535531437, 26075.087371941987, 42465.363019554694, 42495.78752106235, 42960.78519607398, 46070.0, 41032.17935641285, 44693.0, 44744.10511789762, 44983.77508112463, 45077.54922450775, 8750.168733970295, 9702.272329575275, 9874.605015799396, 9877.061679140506, 9888.555015024305, 8829.587266037435, 10882.782344353109, 10933.671989840317, 11828.172027958046, 12265.0187984961, 12009.579664711737, 12042.036637069014, 12071.758564828699, 12075.094367922396, 12101.636950891487, 8792.252658524034, 8959.328050396181, 12004.759904801898, 12124.575639852652, 12136.15046946714, 8865.335099867536, 8945.642174313085, 11465.484053217626, 11725.94137029318, 11732.472038758277, 42353.57646423527, 42710.35934460985, 42793.35809962853, 42804.57195428037, 42845.14309713788, 3593.425051991695, 3670.308476901526, 3820.6460492066535, 3870.206607645454, 4307.741535507879, 32378.838105809322, 32891.01326960195, 33665.6633433665, 33716.0, 33871.830640846885, 3292.720118789906, 3415.0, 3453.5510383650217, 3467.3412051710093, 3484.529588505545, 531258.0, 531745.9999999962, 532776.0, 532793.0, 533622.6637733611, 62332.376676233565, 62613.68693156505, 62619.74760504856, 62621.37378626155, 62693.68653156796, 58161.4183858156, 66569.0, 66686.33313666898, 67152.0, 67181.0, 16606.169691515377, 17060.57348566271, 17064.829351706325, 17088.0, 17159.742603860952, 11867.70330741721, 12085.939570302267, 12990.155639883378, 13160.473581056842, 13212.603621891358, 17075.633949284027, 17171.570710732332, 17207.483775486755, 17234.741478877826, 17244.568885777957, 6361.805177213946, 6445.065465507475, 6838.658067096625, 6910.101686780687, 7244.203137654854, 899.3389858454032, 968.4915419404869, 1016.8678071850612, 1026.9897301027042, 1057.582255009267, 31098.378032439225, 31271.21821954424, 31456.842715786734, 31815.681843181734, 32215.684412072213, 899.2670973156856, 1132.184826924613, 1152.5389844062443, 1153.9249948753304, 1171.3967306836985, 16137.193140342935, 16292.592685182728, 16398.508044758677, 16414.83585164157, 16770.161491925355, 657754.0, 658494.0, 659114.0, 660330.0, 660590.0, 60766.0, 60814.695926520086, 60833.08750368748, 60873.78252434926, 60981.390186098455, 1259.4962015194178, 1300.9154404963647, 1379.9788156763923, 1398.3288021749413, 1452.208546342267, 26827.0, 31634.683653163174, 32039.519407208445, 32634.0, 32659.34681306408, 53116.73441632767, 53949.0, 54321.0, 54371.18443223434, 54519.18221226605, 568077.0, 577579.0, 578307.0, 579250.0, 580233.0, 24196.153134640204, 24545.50908981846, 26196.607050894632, 26390.86804565965, 26802.0, 49184.50815491942, 49578.0, 49578.25632615441, 50191.74904125456, 50594.49405505898, 34535.0, 40141.397879031254, 40485.19029619332, 41666.1666766669, 41908.79045604752, 40392.596074038884, 40453.0, 40799.18401631891, 40810.0, 41565.168696626504, 39074.609253907096, 39724.0, 40120.598794012854, 40326.0, 42587.36118958156, 27617.72382276232, 32326.676733233307, 36420.81789591035, 36568.90293291205, 37074.62925370712, 25803.225903222934, 26442.471150577265, 26770.732292677603, 26776.19671409861, 26906.92372305086], "value": 20849.105648362023, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.83672347443655, 382.2240851072323, 392.687813188515, 395.6775228189024, 416.35049323056035, 15526.92236538817, 15791.684166316667, 20920.790792092073, 21393.037313320918, 21426.678599820978, 21110.26114086007, 21464.678029829563, 21866.797326147054, 22301.330960071224, 22318.553628927453, 5834.241548598698, 5915.763369465216, 6177.629342239457, 6178.783742569011, 6189.690515474231, 3899.883003509899, 6124.6325220486915, 6135.846603834895, 6180.351063138373, 6565.277819439858, 6809.965950170243, 6820.522563420563, 6829.658517074151, 6837.794866154023, 6838.589684618939, 5525.613207075507, 6376.617402955814, 6731.158605174353, 6751.0, 6819.897701534481, 3736.9439458408146, 5597.860053498654, 5970.701464926779, 5976.312724036705, 5982.252218472691, 13242.00684948623, 13834.515791947335, 13839.446422143103, 13853.099548529313, 23158.305250842503, 2048.8156065953985, 2208.933731988043, 2271.2277825539395, 2443.816713746476, 2929.5605659151083, 10127.13919316859, 10514.0, 12844.165129266568, 14437.772789312921, 15063.774043389358, 1789.33794496036, 1847.5658220318214, 1867.7385166076624, 1883.8587105967108, 1895.8672892897503, 80653.59673201655, 98694.0, 107959.0, 123287.3835630825, 123485.0, 9301.581428835718, 11487.36819474937, 11577.60750742503, 11689.006434453167, 11776.52893884252, 14386.208758518382, 14483.420663173565, 14507.0, 14524.782128268085, 14580.270986450634, 7102.60935648534, 8399.118092600189, 8638.438501497383, 8646.697365592174, 8666.956665216634, 8571.185737354941, 8579.871301930476, 8604.440711353867, 8690.391672582859, 8734.781630459289, 4505.346724724962, 4578.6108180805, 4588.334691469785, 4644.58198762113, 4651.651126165551, 1630.8228514932462, 1642.4169419856019, 1884.1615481111048, 1922.3944457495843, 1935.4967708395636, 739.4638886807022, 917.9265658747285, 949.539473355422, 959.4291396619001, 1077.4181941751367, 18420.0, 21338.14647414086, 22042.669359959615, 22150.55698886013, 22595.20916767905, 931.8695382646434, 952.7951490429591, 968.5544649461327, 985.9992108010375, 1004.4525733475274, 11416.657500275005, 11582.733812949607, 11617.76764464706, 11675.824862627067, 11693.649190524298, 522520.38739806815, 523555.14667280024, 526224.0, 526850.0, 529710.0, 126082.73917260894, 126575.0, 131061.0, 131159.34420328029, 132909.0, 993.6323560282597, 999.7100840756244, 1021.8262895307815, 1022.6471867205802, 1027.3733022855902, 19272.518187045436, 19372.8062719371, 19401.708974365112, 19408.61182776365, 19451.61096778085, 51508.484915150366, 52777.472225277255, 53794.73102634462, 54707.45292547183, 54974.67791204063, 57330.713346433, 75498.62250688711, 76320.61839690988, 77294.0, 77321.0, 7284.271572842674, 7499.812504687427, 7582.090149182133, 8053.6778528858185, 8595.269402100892, 9432.764180895532, 13022.2837743925, 13577.932110339385, 13709.0, 13835.100718453268, 11484.770304594029, 11726.179167458196, 11829.34938578352, 11850.111241657083, 11977.401129943293, 11552.133589980953, 11678.124140689652, 11716.0, 11767.882321177021, 11917.702057448632, 11748.177627565989, 11748.236364636272, 11845.822312665145, 11995.880041199476, 12030.338331391857, 7576.810579735551, 7629.580373079534, 7648.80877978055, 7684.807879802826, 7815.687372505036, 8243.464174828618, 10903.236773425784, 11340.489677964346, 11345.659630211107, 11504.0], "value": 9545.673641325708, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.3599744117705, 1559.2125976381928, 1580.652256503569, 1819.1450018491312, 1970.566475375417, 7819.0, 8567.400281980264, 8809.911900880988, 8818.294536437086, 8951.641934322635, 8569.400141990047, 8798.472091674505, 8802.07578204289, 8804.339674524404, 8804.559772011406, 2057.351934140748, 2127.9147634706333, 2132.296342207068, 2374.5607062693416, 2405.56699794037, 2184.3010236724253, 2204.933851984443, 2333.6032874411308, 2414.8913298901593, 2418.4558474343307, 2385.8329916905823, 2388.5461762265113, 2389.569877422063, 2392.079049565912, 2393.365758074112, 2333.0784340185614, 2376.65538496917, 2378.310290015902, 2381.6427535869584, 2385.594448943684, 2088.112552165339, 2172.4134483689472, 2173.1850556041486, 2178.8692678439343, 2305.3775480620307, 8630.050694423608, 8819.470831750052, 8819.823603527893, 8825.51459669718, 8828.205461508494, 5214.45248248936, 5383.165609330521, 5386.13821788512, 5390.056740070511, 5397.541208997201, 3329.6503867094093, 3334.1164591383304, 3395.8471868765964, 3398.5411969384063, 3424.0412684448393, 1099.5272033025797, 1100.3617901617042, 1105.8728246251624, 1119.0599896087244, 1124.4883577972084, 11638.941805291004, 11643.24318919276, 11643.941780291128, 11646.068314534901, 11668.533258669642, 4555.2256116460285, 4602.194615942197, 4805.207140821725, 4808.735519546459, 4823.5658790709, 8523.74428767138, 9869.802603947881, 9875.160611348116, 9882.604695812232, 9890.505474726235, 5361.705106219118, 5362.544183744348, 5366.973165134149, 5369.785208591613, 5384.461553844584, 3826.521684789401, 4445.3998710174355, 4897.877553061131, 4898.363212782316, 4906.239532872411, 3281.507773833944, 3578.946315805265, 3770.472133901256, 3837.9253808933545, 3869.6710779583486, 1165.7493638867516, 1167.7430965187646, 1177.0226020286002, 1180.0677464802882, 1180.4097951024487, 674.8987651852261, 809.4050872608628, 843.2621456225802, 929.8558723397884, 941.684535680541, 4936.506349365035, 6079.8480037998515, 6149.96925015372, 6199.752009919643, 6270.090836828635, 953.5804246131819, 962.259060523393, 962.8363178259713, 976.9169620582188, 1022.9590816367411, 3369.595648522193, 4126.793660316972, 4149.37759336102, 4185.22573323936, 4230.576942305806, 10094.747631309128, 10452.634157804441, 10742.89257107419, 10840.024397804236, 10848.457577121113, 10558.577656893793, 10644.095251903675, 10755.139588832875, 10771.0, 10809.729756755987, 7941.245581669732, 8096.8380632387025, 8279.54462504568, 8295.95852020736, 8326.375521835766, 5604.943950560442, 5609.709766753588, 5941.702914854153, 6159.692015399122, 6241.0, 10049.748756280858, 10060.0945914868, 10070.647527336509, 10081.395116293046, 10095.293329466867, 9656.855147172657, 10034.0, 10175.731884490593, 10258.794824103625, 10275.897241027495, 7480.214577469287, 7702.53784772893, 7706.267904549059, 7713.074431068308, 7718.729844455417, 8146.959265203636, 8164.387670924823, 8323.875141872755, 8325.167483251626, 8342.499450033018, 7492.887606686013, 7519.060117485315, 7547.924520754942, 7686.769396918102, 7712.807179820549, 7376.114866216089, 7455.179930207564, 7468.9626551866895, 7515.549067055994, 7586.582737949466, 7023.157221133497, 7032.050673159262, 7090.822729431599, 7091.787246382617, 7112.0754301940415, 4476.5075841658045, 4912.066707325596, 5055.747212639427, 5107.259447380184, 5107.846764597068, 4840.273958906051, 4997.575206107522, 5110.66780659256, 5168.147255702767, 5269.1569348903995], "value": 4564.033150423437, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.9224997625605, 309.30097978568426, 313.36387134117734, 316.1542872815219, 318.73544957685095, 4549.99900021995, 4844.781984810683, 5484.670919744814, 5485.807996720116, 5501.669899806015, 5383.273258110154, 5441.428649991743, 5442.945570544293, 5456.672599644025, 5460.798624302657, 3884.7086468514835, 3944.605539446047, 4019.075612609102, 4064.695147863907, 4193.643540299063, 3248.4964830451318, 3580.4629305604108, 3988.24223397555, 4108.26051310764, 4167.499900011988, 3248.96751032489, 3315.834208289588, 3639.5632524097146, 4076.490438695163, 4117.5882411758885, 3541.592716837571, 3824.9235015299814, 3851.0, 3894.559013165147, 4120.711550191488, 3005.6092707948046, 3188.6651901550235, 3565.4830049642915, 3573.4991303652528, 3582.444721068239, 4339.0, 4800.159972004885, 5226.608004399685, 5264.6051546134195, 5327.30745003151, 3960.960390396088, 3968.3849003404516, 4584.977075114603, 4672.229082201433, 4741.786619602126, 5084.110280700899, 5199.934013527218, 5574.136008918624, 5627.296587926509, 5673.0, 3337.8998630040896, 3952.8734310721306, 3965.0658512700684, 3982.542007669097, 3985.9800700996598, 4862.8784280392565, 4896.7758060484875, 5781.843631273762, 5884.7940322088525, 5915.408459154093, 3560.91097722559, 3695.4456831475495, 3883.786391748481, 3891.2217556488818, 3896.4350169225304, 3955.7428767130045, 3975.7018223632763, 3989.4441167944524, 4001.7398869073418, 4004.699647526389, 4286.721363111388, 4647.18674232008, 4648.86053418398, 4649.837255696035, 4711.7879695413785, 4155.168966206771, 5564.805231816867, 5698.401667824902, 5729.3984131665575, 5746.597738158289, 1339.3659735123329, 1355.722076974218, 1357.6062941746782, 1364.979525307121, 1370.6847425092285, 633.3729607688356, 768.6272158003364, 788.8934993775881, 815.995920020396, 833.791552111972, 5072.9746351268, 5155.690658560498, 5251.553617942442, 5265.446693225431, 5333.280007199056, 5124.308218390544, 5585.58108141891, 5629.0, 5780.364159942403, 5806.925718741962, 5124.615653825978, 5161.870953226199, 5217.713025783618, 5324.736986780603, 5327.440618735054, 2733.3986522964915, 2944.1304771470272, 3027.894023709204, 3044.375902939892, 3050.80169788963, 4918.852434426973, 4962.925556116661, 5487.725613719298, 5673.432656734376, 5988.760449581968, 5164.0, 5633.63381380209, 5734.627249228787, 5816.8947899898885, 5889.823305300848, 4983.725895075806, 5507.752151153208, 5962.284525856839, 5963.419693781151, 6002.849928751816, 5359.651622644516, 5738.971305143447, 5742.5118864895285, 5836.737346819488, 5854.209681693087, 4456.821727130879, 4746.477887432448, 5218.765155568084, 5528.765672081877, 5639.392773059658, 5209.921851172311, 5372.274742909657, 5827.3007239131575, 5944.484156540228, 5973.731182096729, 3631.092226943264, 3832.8118283332255, 3837.865674701372, 3852.3643598805884, 3857.9421308680953, 5882.470577648032, 5892.466239517049, 5899.882002360015, 5908.252662511953, 5908.970455147697, 5711.8857622848145, 5732.369439361751, 5765.423457654201, 5770.596058275881, 5782.074868021096, 4687.257954096892, 5073.898522029613, 5475.288212532345, 5712.400197979152, 5744.511716504144, 5039.0, 5393.325834270716, 5602.467765562265, 5697.886042279214, 5698.002849501404, 5120.129577971828, 5358.6248962572245, 5468.7578092981685, 5687.350668306145, 5731.455511726379, 5341.813036543703, 5580.358258800127, 5623.465770751772, 5633.338330085314, 5634.464725851038], "value": 4076.970042858459, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.2268311565067, 725.137086866629, 755.3164386230463, 778.5834578500502, 808.4583329169456, 15487.070775753462, 16762.41331553396, 16791.160441977914, 16795.49613511595, 16806.159692015397, 15059.0, 15254.923725381384, 15261.160636165007, 15262.618434539114, 15294.388224471008, 716.5879619218944, 733.4169335378386, 892.4957399069522, 894.4141587260355, 928.2481190235897, 893.6291439052785, 906.1618003346911, 909.7862002429457, 909.9317551183655, 909.9944561259812, 963.0081016552926, 964.0793042644258, 965.3532133470592, 968.4915419404798, 969.4038166527605, 764.2204950949999, 944.1738478831023, 961.130177189641, 971.5482300730124, 972.7276362618478, 716.1406312425058, 716.4197000429616, 717.150177040209, 718.2027948976684, 718.6622287524855, 15117.47088851896, 15167.848321516754, 15168.924155379153, 15181.240937953058, 15200.46798362063, 14021.929890350482, 14091.82933839888, 14119.858801411958, 14154.575362739135, 14311.57065288043, 12942.61172164827, 12948.546800861925, 12998.285094319808, 13212.537561185312, 13436.798448023288, 4607.631389488833, 4620.422447194101, 4653.371794807692, 4813.975930120362, 4832.758362081917, 105219.0, 107866.0, 108262.45868770605, 110583.0, 113149.86850131476, 11250.774984500264, 11266.098712103012, 11287.0, 11287.153463490107, 11366.033887119687, 18426.170822313026, 22204.55590888173, 22239.777602224094, 22246.55506889853, 22258.99834507451, 7984.24149705777, 8150.184981501802, 8176.264136227649, 8193.139720329398, 8273.917260827315, 4377.1683380157665, 4523.660725445605, 4537.636989040869, 4539.296409056601, 4620.445546534437, 3482.1294676330917, 3583.4983102365168, 3594.2452085061905, 3600.837962291703, 3602.693771029492, 656.9737210511526, 659.1200747002805, 663.5255792108569, 663.7510933399975, 672.4183581202225, 599.4275466929072, 645.4836131095105, 647.2104033079729, 656.0880376276979, 659.2122413715564, 8704.738857834274, 9074.137956894085, 9169.449833010041, 9317.580708868118, 9691.854622180674, 595.4105435618707, 597.9581429299907, 637.178040327981, 642.2902692524787, 656.4125108028288, 4375.190589740908, 4424.446944131983, 4525.818142048301, 4654.720716756938, 4665.743384113838, 148881.76677349847, 151586.0, 156023.0, 157891.21054394884, 159346.0, 81876.0, 84875.0, 130118.0, 134510.0, 136664.56353366122, 116957.41521292509, 118346.4082679581, 118348.0, 119382.403087984, 119759.99999999825, 8561.785955350917, 8579.571021448777, 8683.305335573265, 8771.877692924882, 9115.134062264075, 57367.0, 60891.963938058805, 61732.38267617267, 62427.68786156222, 65464.345356545826, 90224.54887725782, 91296.54351728199, 94235.0, 97194.0, 97705.0, 13499.190048597116, 13650.249236291702, 13771.655708607364, 14265.500707475188, 14285.214313212873, 12634.936825315815, 15009.249537522861, 15204.433755097472, 15391.230438477807, 16054.43809466663, 9758.0, 12391.256524608552, 12478.500859965863, 12709.8093528599, 12821.358932053547, 12028.338441385458, 12309.322987235788, 12443.25340479538, 12672.6831829205, 12705.936470317589, 12037.398130093636, 12213.816792748294, 12370.876291236973, 12561.309127998047, 12643.178193417398, 10277.743056423351, 10427.791444170922, 10443.321184123008, 10596.205284603531, 11060.170487213652, 7612.885806713015, 8668.826623467621, 9464.290178236522, 9696.321257511907, 9785.85321220168], "value": 7873.249687210146, "unit": "score"}], "name": "dromaeo_css", "value": 7424.102006686785, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 111.0, 113.0, 112.0, 111.0, 112.0, 111.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 120.0, 137.0, 191.0, 105.0, 106.0, 129.0, 107.0, 137.0, 107.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 188.0, 184.0, 184.0, 184.0, 185.0, 199.0, 185.0, 185.0], "value": 186.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 56.0, 110.0, 82.0, 80.0, 85.0, 68.0, 83.0, 58.0], "value": 77.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 91.0, 70.0, 71.0, 68.0, 97.0, 70.0, 67.0, 99.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 87.0, 84.0, 86.0, 84.0, 86.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 92.0, 93.0, 92.0, 93.0, 92.0, 93.0, 92.0, 105.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 85.0, 84.0, 92.0, 84.0, 85.0, 87.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 54.0, 54.0, 53.0, 55.0, 54.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 79.0, 77.0, 72.0, 70.0, 71.0, 72.0, 71.0, 69.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 78.0, 83.0, 84.0, 81.0, 84.0, 80.0, 85.0, 98.0, 100.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 144.0, 140.0, 135.0, 135.0, 135.0, 138.0, 137.0, 199.0, 126.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 157.0, 160.0, 161.0, 162.0, 163.0, 163.0, 163.0, 162.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 78.0, 84.0, 84.0, 84.0, 72.0, 64.0, 65.0, 67.0], "value": 73.3, "unit": "score"}], "name": "kraken", "value": 1436.7000000000003, "alertThreshold": 2.0}]} 04:25:44 INFO - Return code: 0 04:25:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:25:44 INFO - # TBPL SUCCESS # 04:25:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:25:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:25:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:25:44 INFO - 2016-07-11 04:25:44.187 screenresolution[1663:9563] starting screenresolution argv=screenresolution get 04:25:44 INFO - 2016-07-11 04:25:44.190 screenresolution[1663:9563] Display 0: 1600x1200x32@60 04:25:44 INFO - 2016-07-11 04:25:44.196 screenresolution[1664:9566] starting screenresolution argv=screenresolution list 04:25:44 INFO - Available Modes on Display 0 04:25:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:25:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:25:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:25:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:25:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:25:44 INFO - Intel Iris: 04:25:44 INFO - Chipset Model: Intel Iris 04:25:44 INFO - Type: GPU 04:25:44 INFO - Bus: Built-In 04:25:44 INFO - VRAM (Dynamic, Max): 1536 MB 04:25:44 INFO - Vendor: Intel (0x8086) 04:25:44 INFO - Device ID: 0x0a2e 04:25:44 INFO - Revision ID: 0x0009 04:25:44 INFO - Displays: 04:25:44 INFO - Display: 04:25:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:25:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:25:44 INFO - Display Serial Number: 1600x1200 60 04:25:44 INFO - Main Display: Yes 04:25:44 INFO - Mirror: Off 04:25:44 INFO - Online: Yes 04:25:44 INFO - Rotation: Supported 04:25:44 INFO - Return code: 0 04:25:44 INFO - Running post-action listener: _resource_record_post_action 04:25:44 INFO - ##### 04:25:44 INFO - ##### Finished run-tests step (success) 04:25:44 INFO - ##### 04:25:44 INFO - Running post-run listener: _resource_record_post_run 04:25:44 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37901824; Write bytes: 703688704; Read time: 384; Write time: 2308 04:25:44 INFO - TinderboxPrint: CPU usage
53.7% 04:25:44 INFO - TinderboxPrint: I/O read bytes / time
37,901,824 / 384 04:25:44 INFO - TinderboxPrint: I/O write bytes / time
703,688,704 / 2,308 04:25:44 INFO - TinderboxPrint: CPU idle
2,242.4 (46.3%) 04:25:44 INFO - TinderboxPrint: CPU system
971.4 (20.1%) 04:25:44 INFO - TinderboxPrint: CPU user
1,627.8 (33.6%) 04:25:44 INFO - TinderboxPrint: Swap in / out
443,940,864 / 0 04:25:44 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 395921920; Write bytes: 390174720; Read time: 29584; Write time: 752 04:25:44 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35997184; Write bytes: 293836800; Read time: 364; Write time: 1513 04:25:44 INFO - Running post-run listener: _upload_blobber_files 04:25:44 INFO - Blob upload gear active. 04:25:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:25:44 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 04:25:44 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'] 04:25:44 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 04:25:45 INFO - (blobuploader) - INFO - Open directory for files ... 04:25:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:25:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:25:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:46 INFO - (blobuploader) - INFO - Done attempting. 04:25:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:25:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:25:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:47 INFO - (blobuploader) - INFO - Done attempting. 04:25:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:25:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:25:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:25:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:25:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:25:50 INFO - (blobuploader) - INFO - Done attempting. 04:25:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:25:50 INFO - Return code: 0 04:25:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:25:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:25:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04cd2044cc9611201f31e551772ee5dc445ee3b8fc44fa50b8f2d4074c78bea55e31209f1e0d1257f81c9d7dfb627194b1174f8b746063965db5652554940eab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50febd366e051428aff7e2e0e3fe3f8e5abf60409ebf4964cb9905daa216ce1f4ac3f11d5503de3cba251e7e8c3236c487904db1d810a5c52a2d9b9603573057", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7874f62e77d14f8527d174f0c8c9376e3bdd2f3c00c6a6686b8287669c68511b7ea4062cf586a6929524a7d5c57203eec229d9213204e22c46e66f513b533d2"} 04:25:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:25:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:25:50 INFO - Contents: 04:25:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04cd2044cc9611201f31e551772ee5dc445ee3b8fc44fa50b8f2d4074c78bea55e31209f1e0d1257f81c9d7dfb627194b1174f8b746063965db5652554940eab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50febd366e051428aff7e2e0e3fe3f8e5abf60409ebf4964cb9905daa216ce1f4ac3f11d5503de3cba251e7e8c3236c487904db1d810a5c52a2d9b9603573057", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7874f62e77d14f8527d174f0c8c9376e3bdd2f3c00c6a6686b8287669c68511b7ea4062cf586a6929524a7d5c57203eec229d9213204e22c46e66f513b533d2"} 04:25:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:25:50 INFO - Copying logs to upload dir... 04:25:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:25:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.568985 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-11 04:25:50.646861) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 04:25:50.650593) ========= 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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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/04cd2044cc9611201f31e551772ee5dc445ee3b8fc44fa50b8f2d4074c78bea55e31209f1e0d1257f81c9d7dfb627194b1174f8b746063965db5652554940eab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50febd366e051428aff7e2e0e3fe3f8e5abf60409ebf4964cb9905daa216ce1f4ac3f11d5503de3cba251e7e8c3236c487904db1d810a5c52a2d9b9603573057", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7874f62e77d14f8527d174f0c8c9376e3bdd2f3c00c6a6686b8287669c68511b7ea4062cf586a6929524a7d5c57203eec229d9213204e22c46e66f513b533d2"} build_url:https://queue.taskcluster.net/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011423 build_url: 'https://queue.taskcluster.net/v1/task/DRrwKSd2TGC_8jM2R0HO5Q/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/04cd2044cc9611201f31e551772ee5dc445ee3b8fc44fa50b8f2d4074c78bea55e31209f1e0d1257f81c9d7dfb627194b1174f8b746063965db5652554940eab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/50febd366e051428aff7e2e0e3fe3f8e5abf60409ebf4964cb9905daa216ce1f4ac3f11d5503de3cba251e7e8c3236c487904db1d810a5c52a2d9b9603573057", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7874f62e77d14f8527d174f0c8c9376e3bdd2f3c00c6a6686b8287669c68511b7ea4062cf586a6929524a7d5c57203eec229d9213204e22c46e66f513b533d2"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 04:25:50.691754) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:25:50.692481) ========= 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.Vs845Xzf1z/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.m4qYbJlRQF/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.005540 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 04:25:50.742005) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 04:25:50.742331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 04:25:50.742877) ========= ========= Total master_lag: 0.19 =========