builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0201 starttime: 1469006372.28 results: success (0) buildid: 20160720010920 builduid: 56091384ce664b7eac61a60572259bef revision: e7cd99539c53235604f03a6cd56458dd2d337cdb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 02:19:32.282202) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 02:19:32.282688) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 02:19:32.282966) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 02:19:32.394122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 02:19:32.394529) ========= 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.twLUViFER1/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.UN6GfH8kxh/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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-20 02:19:32-- 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% 29.0M=0s 2016-07-20 02:19:32 (29.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102128 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 02:19:32.519713) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 02:19:32.520037) ========= 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.twLUViFER1/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.UN6GfH8kxh/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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.026449 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 02:19:32.568709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 02:19:32.569170) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e7cd99539c53235604f03a6cd56458dd2d337cdb --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 e7cd99539c53235604f03a6cd56458dd2d337cdb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.twLUViFER1/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.UN6GfH8kxh/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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-20 02:19:32,651 truncating revision to first 12 chars 2016-07-20 02:19:32,651 Setting DEBUG logging. 2016-07-20 02:19:32,651 attempt 1/10 2016-07-20 02:19:32,651 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e7cd99539c53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 02:19:33,512 unpacking tar archive at: fx-team-e7cd99539c53/testing/mozharness/ program finished with exit code 0 elapsedTime=1.130795 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-20 02:19:33.722331) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 02:19:33.722669) ========= script_repo_revision: e7cd99539c53235604f03a6cd56458dd2d337cdb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 02:19:33.723054) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 02:19:33.723320) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 02:19:33.742281) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-20 02:19:33.742703) ========= /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.twLUViFER1/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.UN6GfH8kxh/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 02:19:33 INFO - MultiFileLogger online at 20160720 02:19:33 in /builds/slave/test 02:19:33 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 02:19:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:19:33 INFO - {'append_to_log': False, 02:19:33 INFO - 'base_work_dir': '/builds/slave/test', 02:19:33 INFO - 'blob_upload_branch': 'Fx-Team', 02:19:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:19:33 INFO - 'branch': 'Fx-Team', 02:19:33 INFO - 'buildbot_json_path': 'buildprops.json', 02:19:33 INFO - 'config_files': ('talos/mac_config.py',), 02:19:33 INFO - 'default_actions': ('clobber', 02:19:33 INFO - 'read-buildbot-config', 02:19:33 INFO - 'download-and-extract', 02:19:33 INFO - 'populate-webroot', 02:19:33 INFO - 'create-virtualenv', 02:19:33 INFO - 'install', 02:19:33 INFO - 'run-tests'), 02:19:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:19:33 INFO - 'download_minidump_stackwalk': True, 02:19:33 INFO - 'download_symbols': 'ondemand', 02:19:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:19:33 INFO - 'tooltool.py': '/tools/tooltool.py', 02:19:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:19:33 INFO - '/tools/misc-python/virtualenv.py')}, 02:19:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:19:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:19:33 INFO - 'installer_path': 'installer.exe', 02:19:33 INFO - 'log_level': 'info', 02:19:33 INFO - 'log_name': 'talos', 02:19:33 INFO - 'log_to_console': True, 02:19:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:19:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:19:33 INFO - 'opt_config_files': (), 02:19:33 INFO - 'pip_index': False, 02:19:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:19:33 INFO - 'cmd': ('bash', 02:19:33 INFO - '-c', 02:19:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:19:33 INFO - 'enabled': True, 02:19:33 INFO - 'halt_on_failure': False, 02:19:33 INFO - 'name': 'check_screen_resolution'},), 02:19:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:19:33 INFO - 'cmd': ('bash', 02:19:33 INFO - '-c', 02:19:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:19:33 INFO - 'enabled': True, 02:19:33 INFO - 'halt_on_failure': False, 02:19:33 INFO - 'name': 'check_screen_resolution'},), 02:19:33 INFO - 'run_cmd_checks_enabled': True, 02:19:33 INFO - 'sps_profile': False, 02:19:33 INFO - 'sps_profile_interval': 0, 02:19:33 INFO - 'suite': 'dromaeojs', 02:19:33 INFO - 'system_bits': '32', 02:19:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:19:33 INFO - 'title': 't-yosemite-r7-0201', 02:19:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:19:33 INFO - 'use_talos_json': True, 02:19:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:19:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:19:33 INFO - 'work_dir': 'build'} 02:19:33 INFO - ##### 02:19:33 INFO - ##### Running clobber step. 02:19:33 INFO - ##### 02:19:33 INFO - Running pre-action listener: _resource_record_pre_action 02:19:33 INFO - Running main action method: clobber 02:19:33 INFO - rmtree: /builds/slave/test/build 02:19:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:19:36 INFO - Running post-action listener: _resource_record_post_action 02:19:36 INFO - ##### 02:19:36 INFO - ##### Finished clobber step (success) 02:19:36 INFO - ##### 02:19:36 INFO - ##### 02:19:36 INFO - ##### Running read-buildbot-config step. 02:19:36 INFO - ##### 02:19:36 INFO - Running pre-action listener: _resource_record_pre_action 02:19:36 INFO - Running main action method: read_buildbot_config 02:19:36 INFO - Using buildbot properties: 02:19:36 INFO - { 02:19:36 INFO - "project": "", 02:19:36 INFO - "product": "firefox", 02:19:36 INFO - "script_repo_revision": "production", 02:19:36 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:19:36 INFO - "repository": "", 02:19:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:19:36 INFO - "buildid": "20160720010920", 02:19:36 INFO - "pgo_build": "False", 02:19:36 INFO - "basedir": "/builds/slave/test", 02:19:36 INFO - "buildnumber": 99, 02:19:36 INFO - "slavename": "t-yosemite-r7-0201", 02:19:36 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:19:36 INFO - "platform": "yosemite_r7", 02:19:36 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 02:19:36 INFO - "branch": "fx-team", 02:19:36 INFO - "repo_path": "integration/fx-team", 02:19:36 INFO - "revision": "e7cd99539c53235604f03a6cd56458dd2d337cdb", 02:19:36 INFO - "stage_platform": "macosx64", 02:19:36 INFO - "builduid": "56091384ce664b7eac61a60572259bef", 02:19:36 INFO - "slavebuilddir": "test" 02:19:36 INFO - } 02:19:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 02:19:36 INFO - Running post-action listener: _resource_record_post_action 02:19:36 INFO - ##### 02:19:36 INFO - ##### Finished read-buildbot-config step (success) 02:19:36 INFO - ##### 02:19:36 INFO - ##### 02:19:36 INFO - ##### Running download-and-extract step. 02:19:36 INFO - ##### 02:19:36 INFO - Running pre-action listener: _resource_record_pre_action 02:19:36 INFO - Running main action method: download_and_extract 02:19:36 INFO - mkdir: /builds/slave/test/build/tests 02:19:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:19:36 INFO - https://queue.taskcluster.net/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:19:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 02:19:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 02:19:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/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 02:19:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/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 02:19:37 INFO - Downloaded 1199 bytes. 02:19:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 02:19:37 INFO - Using the following test package requirements: 02:19:37 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 02:19:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:19:37 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 02:19:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:19:37 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 02:19:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:19:37 INFO - u'jsshell-mac.zip'], 02:19:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:19:37 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 02:19:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 02:19:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:19:37 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 02:19:37 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:19:37 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 02:19:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:19:37 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 02:19:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 02:19:37 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 02:19:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:19:37 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')]} 02:19:37 INFO - https://queue.taskcluster.net/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:19:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:19:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:19:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/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 02:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/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 02:19:38 INFO - Downloaded 18835339 bytes. 02:19:38 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'] 02:19:38 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 02:19:41 INFO - Return code: 0 02:19:41 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 02:19:41 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')]} 02:19:41 INFO - https://queue.taskcluster.net/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:19:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:19:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 02:19:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/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 02:19:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/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 02:19:42 INFO - Downloaded 18835339 bytes. 02:19:42 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'] 02:19:42 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 02:19:46 INFO - Return code: 0 02:19:46 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')]} 02:19:46 INFO - https://queue.taskcluster.net/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:19:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 02:19:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 02:19:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/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 02:19:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/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 02:19:47 INFO - Downloaded 14403317 bytes. 02:19:47 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'] 02:19:47 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 02:19:47 INFO - Return code: 0 02:19:47 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')]} 02:19:47 INFO - https://queue.taskcluster.net/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:19:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:19:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:19:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 02:19:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FPxjAabvTniNATYgb14gGA/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 02:19:52 INFO - Downloaded 112875454 bytes. 02:19:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:19:52 INFO - mkdir: /builds/slave/test/properties 02:19:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:19:52 INFO - Writing to file /builds/slave/test/properties/build_url 02:19:52 INFO - Contents: 02:19:52 INFO - build_url:https://queue.taskcluster.net/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 02:19:52 INFO - Running post-action listener: _resource_record_post_action 02:19:52 INFO - Running post-action listener: set_extra_try_arguments 02:19:52 INFO - ##### 02:19:52 INFO - ##### Finished download-and-extract step (success) 02:19:52 INFO - ##### 02:19:52 INFO - ##### 02:19:52 INFO - ##### Running populate-webroot step. 02:19:52 INFO - ##### 02:19:52 INFO - Running pre-action listener: _resource_record_pre_action 02:19:52 INFO - Running main action method: populate_webroot 02:19:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:19:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:19:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:19:52 INFO - '--tppagecycles', 02:19:52 INFO - '7'], 02:19:52 INFO - 'tests': ['tsvgm']}}, 02:19:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:19:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:19:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:19:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:19:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:19:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:19:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:52 INFO - 'talos_options': ['--disable-e10s'], 02:19:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:19:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:52 INFO - 'talos_options': ['--disable-e10s'], 02:19:52 INFO - 'tests': ['damp', 'tps']}, 02:19:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:52 INFO - 'tests': ['damp', 'tps']}, 02:19:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:19:52 INFO - 'tests': ['dromaeo_dom']}, 02:19:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:19:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:19:52 INFO - 'tests': ['basic_compositor_video']}, 02:19:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:19:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:19:52 INFO - 'tests': ['a11yr', 02:19:52 INFO - 'ts_paint', 02:19:52 INFO - 'tpaint', 02:19:52 INFO - 'sessionrestore', 02:19:52 INFO - 'sessionrestore_no_auto_restore', 02:19:52 INFO - 'tabpaint']}, 02:19:52 INFO - 'other-e10s': {'tests': ['a11yr', 02:19:52 INFO - 'ts_paint', 02:19:52 INFO - 'tpaint', 02:19:52 INFO - 'sessionrestore', 02:19:52 INFO - 'sessionrestore_no_auto_restore', 02:19:52 INFO - 'tabpaint']}, 02:19:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:19:52 INFO - 'ts_paint', 02:19:52 INFO - 'tpaint', 02:19:52 INFO - 'sessionrestore', 02:19:52 INFO - 'sessionrestore_no_auto_restore', 02:19:52 INFO - 'tabpaint']}, 02:19:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:19:52 INFO - 'ts_paint', 02:19:52 INFO - 'tpaint', 02:19:52 INFO - 'sessionrestore', 02:19:52 INFO - 'sessionrestore_no_auto_restore', 02:19:52 INFO - 'tabpaint']}, 02:19:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:19:52 INFO - 'tests': ['a11yr', 02:19:52 INFO - 'ts_paint', 02:19:52 INFO - 'tpaint', 02:19:52 INFO - 'sessionrestore', 02:19:52 INFO - 'sessionrestore_no_auto_restore', 02:19:52 INFO - 'tabpaint']}, 02:19:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:19:52 INFO - 'tests': ['a11yr', 02:19:52 INFO - 'ts_paint', 02:19:52 INFO - 'tpaint', 02:19:52 INFO - 'sessionrestore', 02:19:52 INFO - 'sessionrestore_no_auto_restore', 02:19:52 INFO - 'tabpaint']}, 02:19:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:19:52 INFO - 'tests': ['tsvgx', 02:19:52 INFO - 'tsvgr_opacity', 02:19:52 INFO - 'tart', 02:19:52 INFO - 'tscrollx', 02:19:52 INFO - 'cart']}, 02:19:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:19:52 INFO - 'tsvgr_opacity', 02:19:52 INFO - 'tart', 02:19:52 INFO - 'tscrollx', 02:19:52 INFO - 'cart']}, 02:19:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:52 INFO - 'talos_options': ['--disable-e10s'], 02:19:52 INFO - 'tests': ['tp5o']}, 02:19:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:52 INFO - 'tests': ['tp5o']}, 02:19:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:52 INFO - 'talos_options': ['--disable-e10s', 02:19:52 INFO - '--xperf_path', 02:19:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:52 INFO - 'tests': ['tp5n']}, 02:19:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:19:52 INFO - 'talos_options': ['--xperf_path', 02:19:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:19:52 INFO - 'tests': ['tp5n']}}, 02:19:52 INFO - 'talos.zip': {'path': '', 02:19:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:19:52 INFO - Running post-action listener: _resource_record_post_action 02:19:52 INFO - ##### 02:19:52 INFO - ##### Finished populate-webroot step (success) 02:19:52 INFO - ##### 02:19:52 INFO - ##### 02:19:52 INFO - ##### Running create-virtualenv step. 02:19:52 INFO - ##### 02:19:52 INFO - Running pre-action listener: _resource_record_pre_action 02:19:52 INFO - Running main action method: create_virtualenv 02:19:52 INFO - Creating virtualenv /builds/slave/test/build/venv 02:19:52 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 02:19:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:19:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:19:53 INFO - Using real prefix '/tools/python27' 02:19:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:19:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:19:56 INFO - Installing pip.................done. 02:19:56 INFO - Return code: 0 02:19:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:19:56 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')]} 02:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:56 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')]} 02:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:56 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 0x10536ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd30149be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052cfd30>, '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 0x105034db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052c7b20>, '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.twLUViFER1/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.UN6GfH8kxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 02:19:56 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 02:19:56 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 02:19:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.twLUViFER1/Render', 02:19:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:19:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:19:56 INFO - 'HOME': '/Users/cltbld', 02:19:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:19:56 INFO - 'LOGNAME': 'cltbld', 02:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:56 INFO - 'MOZ_NO_REMOTE': '1', 02:19:56 INFO - 'NO_EM_RESTART': '1', 02:19:56 INFO - 'PAGER': '/bin/cat', 02:19:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:56 INFO - 'PWD': '/builds/slave/test', 02:19:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:19:56 INFO - 'SHELL': '/bin/bash', 02:19:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UN6GfH8kxh/Listeners', 02:19:56 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:19:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:19:56 INFO - 'USER': 'cltbld', 02:19:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:19:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:56 INFO - 'XPC_FLAGS': '0x0', 02:19:56 INFO - 'XPC_SERVICE_NAME': '0', 02:19:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:56 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 02:19:56 INFO - Cleaning up... 02:19:56 INFO - Return code: 0 02:19:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:19:56 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')]} 02:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:56 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')]} 02:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:19:56 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 0x10536ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd30149be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052cfd30>, '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 0x105034db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052c7b20>, '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.twLUViFER1/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.UN6GfH8kxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 02:19:56 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 02:19:56 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 02:19:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.twLUViFER1/Render', 02:19:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:19:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:19:56 INFO - 'HOME': '/Users/cltbld', 02:19:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:19:56 INFO - 'LOGNAME': 'cltbld', 02:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:19:56 INFO - 'MOZ_NO_REMOTE': '1', 02:19:56 INFO - 'NO_EM_RESTART': '1', 02:19:56 INFO - 'PAGER': '/bin/cat', 02:19:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:19:56 INFO - 'PWD': '/builds/slave/test', 02:19:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:19:56 INFO - 'SHELL': '/bin/bash', 02:19:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UN6GfH8kxh/Listeners', 02:19:56 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:19:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:19:56 INFO - 'USER': 'cltbld', 02:19:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:19:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:19:56 INFO - 'XPC_FLAGS': '0x0', 02:19:56 INFO - 'XPC_SERVICE_NAME': '0', 02:19:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:19:57 INFO - Downloading/unpacking psutil>=3.1.1 02:19:57 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 02:19:57 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 02:19:57 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 02:19:57 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 02:19:57 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 02:19:57 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 02:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:20:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:00 INFO - Installing collected packages: psutil 02:20:00 INFO - Running setup.py install for psutil 02:20:00 INFO - building 'psutil._psutil_osx' extension 02:20:00 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 02:20:00 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 02:20:00 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 02:20:01 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 02:20:01 INFO - building 'psutil._psutil_posix' extension 02:20:01 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 02:20:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:20:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:20:01 INFO - ^ 02:20:01 INFO - 1 warning generated. 02:20:01 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 02:20:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:20:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:20:01 INFO - Successfully installed psutil 02:20:01 INFO - Cleaning up... 02:20:01 INFO - Return code: 0 02:20:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:01 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 0x10536ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd30149be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052cfd30>, '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 0x105034db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052c7b20>, '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.twLUViFER1/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.UN6GfH8kxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 02:20:01 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 02:20:01 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 02:20:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.twLUViFER1/Render', 02:20:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:01 INFO - 'HOME': '/Users/cltbld', 02:20:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:01 INFO - 'LOGNAME': 'cltbld', 02:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:01 INFO - 'MOZ_NO_REMOTE': '1', 02:20:01 INFO - 'NO_EM_RESTART': '1', 02:20:01 INFO - 'PAGER': '/bin/cat', 02:20:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:01 INFO - 'PWD': '/builds/slave/test', 02:20:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:01 INFO - 'SHELL': '/bin/bash', 02:20:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UN6GfH8kxh/Listeners', 02:20:01 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:20:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:01 INFO - 'USER': 'cltbld', 02:20:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:01 INFO - 'XPC_FLAGS': '0x0', 02:20:01 INFO - 'XPC_SERVICE_NAME': '0', 02:20:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:20:01 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 02:20:01 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 02:20:01 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 02:20:01 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 02:20:01 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 02:20:01 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 02:20:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:20:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:20:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:20:04 INFO - Installing collected packages: mozsystemmonitor 02:20:04 INFO - Running setup.py install for mozsystemmonitor 02:20:04 INFO - Successfully installed mozsystemmonitor 02:20:04 INFO - Cleaning up... 02:20:04 INFO - Return code: 0 02:20:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:04 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 0x10536ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd30149be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052cfd30>, '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 0x105034db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052c7b20>, '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.twLUViFER1/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.UN6GfH8kxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 02:20:04 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 02:20:04 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 02:20:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.twLUViFER1/Render', 02:20:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:04 INFO - 'HOME': '/Users/cltbld', 02:20:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:04 INFO - 'LOGNAME': 'cltbld', 02:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:04 INFO - 'MOZ_NO_REMOTE': '1', 02:20:04 INFO - 'NO_EM_RESTART': '1', 02:20:04 INFO - 'PAGER': '/bin/cat', 02:20:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:04 INFO - 'PWD': '/builds/slave/test', 02:20:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:04 INFO - 'SHELL': '/bin/bash', 02:20:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UN6GfH8kxh/Listeners', 02:20:04 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:20:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:04 INFO - 'USER': 'cltbld', 02:20:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:04 INFO - 'XPC_FLAGS': '0x0', 02:20:04 INFO - 'XPC_SERVICE_NAME': '0', 02:20:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:04 INFO - Downloading/unpacking jsonschema==2.5.1 02:20:04 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 02:20:04 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 02:20:04 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 02:20:04 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 02:20:04 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 02:20:04 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 02:20:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:20:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20: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 02:20:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:20:07 INFO - warning: no files found matching '*.txt' 02:20:07 INFO - no previously-included directories found matching 'build' 02:20:07 INFO - no previously-included directories found matching 'dist' 02:20:07 INFO - no previously-included directories found matching '.git*' 02:20:07 INFO - Installing collected packages: jsonschema, functools32 02:20:07 INFO - Running setup.py install for functools32 02:20:07 INFO - warning: no files found matching '*.txt' 02:20:07 INFO - no previously-included directories found matching 'build' 02:20:07 INFO - no previously-included directories found matching 'dist' 02:20:07 INFO - no previously-included directories found matching '.git*' 02:20:07 INFO - Successfully installed jsonschema functools32 02:20:07 INFO - Cleaning up... 02:20:08 INFO - Return code: 0 02:20:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:20: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')]} 02:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20: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')]} 02:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:08 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 0x10536ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd30149be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052cfd30>, '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 0x105034db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052c7b20>, '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.twLUViFER1/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.UN6GfH8kxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 02:20:08 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 02:20:08 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 02:20:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.twLUViFER1/Render', 02:20:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:08 INFO - 'HOME': '/Users/cltbld', 02:20:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:08 INFO - 'LOGNAME': 'cltbld', 02:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:08 INFO - 'MOZ_NO_REMOTE': '1', 02:20:08 INFO - 'NO_EM_RESTART': '1', 02:20:08 INFO - 'PAGER': '/bin/cat', 02:20:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:08 INFO - 'PWD': '/builds/slave/test', 02:20:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:08 INFO - 'SHELL': '/bin/bash', 02:20:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UN6GfH8kxh/Listeners', 02:20:08 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:20:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:08 INFO - 'USER': 'cltbld', 02:20:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:08 INFO - 'XPC_FLAGS': '0x0', 02:20:08 INFO - 'XPC_SERVICE_NAME': '0', 02:20:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:20:08 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 02:20:08 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 02:20:08 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 02:20:08 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 02:20:08 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 02:20:08 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 02:20:10 INFO - Downloading blobuploader-1.2.4.tar.gz 02:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:20:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:20:10 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 02:20:10 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 02:20:10 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 02:20:10 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 02:20:10 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 02:20:10 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 02:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:20:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:20:11 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 02:20:11 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 02:20:11 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 02:20:11 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 02:20:11 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 02:20:11 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 02:20:11 INFO - Downloading docopt-0.6.1.tar.gz 02:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:20:12 INFO - Installing collected packages: blobuploader, requests, docopt 02:20:12 INFO - Running setup.py install for blobuploader 02:20:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:20:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:20:12 INFO - Running setup.py install for requests 02:20:12 INFO - Running setup.py install for docopt 02:20:12 INFO - Successfully installed blobuploader requests docopt 02:20:12 INFO - Cleaning up... 02:20:12 INFO - Return code: 0 02:20:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:12 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')]} 02:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:12 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')]} 02:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:12 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 0x10536ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd30149be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052cfd30>, '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 0x105034db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052c7b20>, '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.twLUViFER1/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.UN6GfH8kxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 02:20:12 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 02:20:12 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 02:20:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.twLUViFER1/Render', 02:20:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:12 INFO - 'HOME': '/Users/cltbld', 02:20:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:12 INFO - 'LOGNAME': 'cltbld', 02:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:12 INFO - 'MOZ_NO_REMOTE': '1', 02:20:12 INFO - 'NO_EM_RESTART': '1', 02:20:12 INFO - 'PAGER': '/bin/cat', 02:20:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:12 INFO - 'PWD': '/builds/slave/test', 02:20:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:12 INFO - 'SHELL': '/bin/bash', 02:20:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UN6GfH8kxh/Listeners', 02:20:12 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:20:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:12 INFO - 'USER': 'cltbld', 02:20:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:12 INFO - 'XPC_FLAGS': '0x0', 02:20:12 INFO - 'XPC_SERVICE_NAME': '0', 02:20:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:13 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-3KpNWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:13 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-x_d1Of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:13 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-TiKbWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:13 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-aTcFRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:13 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-XRNSFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:13 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-DlSJAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:13 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-rERvzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:13 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-iHK1A2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:13 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-odn7Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:14 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Slx5OK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:14 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-WA2axt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:14 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-zgEZuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:14 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-N7kx9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:14 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-dbW7mR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:14 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-DUq1Ur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:14 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-WWUQMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:14 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-613Yi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:20:14 INFO - Running setup.py install for manifestparser 02:20:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:20:15 INFO - Running setup.py install for mozcrash 02:20:15 INFO - Running setup.py install for mozdebug 02:20:15 INFO - Running setup.py install for mozdevice 02:20:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:20:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:20:15 INFO - Running setup.py install for mozfile 02:20:15 INFO - Running setup.py install for mozhttpd 02:20:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:20:15 INFO - Running setup.py install for mozinfo 02:20:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:20:15 INFO - Running setup.py install for mozInstall 02:20:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:20:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:20:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:20:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:20:16 INFO - Running setup.py install for mozleak 02:20:16 INFO - Running setup.py install for mozlog 02:20:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:20:16 INFO - Running setup.py install for moznetwork 02:20:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:20:16 INFO - Running setup.py install for mozprocess 02:20:16 INFO - Running setup.py install for mozprofile 02:20:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:20:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:20:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:20:16 INFO - Running setup.py install for mozrunner 02:20:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:20:17 INFO - Running setup.py install for mozscreenshot 02:20:17 INFO - Running setup.py install for moztest 02:20:17 INFO - Running setup.py install for mozversion 02:20:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:20:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:20:17 INFO - Cleaning up... 02:20:17 INFO - Return code: 0 02:20:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:20:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:17 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 0x10536ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd30149be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052cfd30>, '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 0x105034db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052c7b20>, '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.twLUViFER1/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.UN6GfH8kxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 02:20:17 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 02:20:17 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 02:20:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.twLUViFER1/Render', 02:20:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:17 INFO - 'HOME': '/Users/cltbld', 02:20:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:17 INFO - 'LOGNAME': 'cltbld', 02:20:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:17 INFO - 'MOZ_NO_REMOTE': '1', 02:20:17 INFO - 'NO_EM_RESTART': '1', 02:20:17 INFO - 'PAGER': '/bin/cat', 02:20:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:17 INFO - 'PWD': '/builds/slave/test', 02:20:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:17 INFO - 'SHELL': '/bin/bash', 02:20:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UN6GfH8kxh/Listeners', 02:20:17 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:20:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:17 INFO - 'USER': 'cltbld', 02:20:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:17 INFO - 'XPC_FLAGS': '0x0', 02:20:17 INFO - 'XPC_SERVICE_NAME': '0', 02:20:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:20:17 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-Jai9wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:20:17 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)) 02:20:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:20:17 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-TfQxiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:20:17 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)) 02:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:20:18 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-i0jo2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:20:18 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)) 02:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:20:18 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-IYeW9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:20:18 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)) 02:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:20:18 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-1MoS2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:20:18 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)) 02:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:20:18 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-uufHS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:20:18 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)) 02:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:20:18 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-g3cq3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:20:18 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)) 02:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:20:18 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-OhZZyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:20:18 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)) 02:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:20:18 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-dWnoW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:20:18 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)) 02:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:20:18 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-zAuS7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:20:18 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)) 02:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:20:18 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-5wL3RE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:20:18 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)) 02:20:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:20:18 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-ONo4pK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:20:19 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)) 02:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:20:19 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-JjhBl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:20:19 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)) 02:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:20:19 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-qY4UJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:20:19 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)) 02:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:19 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-eAznhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:20:19 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)) 02:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:20:19 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-G2Wxqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:20:19 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)) 02:20:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:20:19 INFO - Running setup.py (path:/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/pip-0NBao5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:20:19 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)) 02:20:19 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)) 02:20:19 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)) 02:20:19 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)) 02:20:19 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)) 02:20:19 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)) 02:20:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:20:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:20:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:20:22 INFO - Downloading blessings-1.6.tar.gz 02:20:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:20:22 INFO - Installing collected packages: blessings 02:20:22 INFO - Running setup.py install for blessings 02:20:22 INFO - Successfully installed blessings 02:20:22 INFO - Cleaning up... 02:20:22 INFO - Return code: 0 02:20:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:22 INFO - Reading from file tmpfile_stdout 02:20:22 INFO - Current package versions: 02:20:22 INFO - blessings == 1.6 02:20:22 INFO - blobuploader == 1.2.4 02:20:22 INFO - docopt == 0.6.1 02:20:22 INFO - functools32 == 3.2.3-2 02:20:22 INFO - jsonschema == 2.5.1 02:20:22 INFO - manifestparser == 1.1 02:20:22 INFO - mozInstall == 1.12 02:20:22 INFO - mozcrash == 0.17 02:20:22 INFO - mozdebug == 0.1 02:20:22 INFO - mozdevice == 0.48 02:20:22 INFO - mozfile == 1.2 02:20:22 INFO - mozhttpd == 0.7 02:20:22 INFO - mozinfo == 0.9 02:20:22 INFO - mozleak == 0.1 02:20:22 INFO - mozlog == 3.2 02:20:22 INFO - moznetwork == 0.27 02:20:22 INFO - mozprocess == 0.23 02:20:22 INFO - mozprofile == 0.28 02:20:22 INFO - mozrunner == 6.12 02:20:22 INFO - mozscreenshot == 0.1 02:20:22 INFO - mozsystemmonitor == 0.3 02:20:22 INFO - moztest == 0.7 02:20:22 INFO - mozversion == 1.4 02:20:22 INFO - psutil == 3.1.1 02:20:22 INFO - requests == 1.2.3 02:20:22 INFO - wsgiref == 0.1.2 02:20:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:20:22 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')]} 02:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:22 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')]} 02:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:22 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 0x10536ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd30149be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052cfd30>, '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 0x105034db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052c7b20>, '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.twLUViFER1/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.UN6GfH8kxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 02:20:22 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 02:20:22 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 02:20:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.twLUViFER1/Render', 02:20:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:22 INFO - 'HOME': '/Users/cltbld', 02:20:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:22 INFO - 'LOGNAME': 'cltbld', 02:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:22 INFO - 'MOZ_NO_REMOTE': '1', 02:20:22 INFO - 'NO_EM_RESTART': '1', 02:20:22 INFO - 'PAGER': '/bin/cat', 02:20:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:22 INFO - 'PWD': '/builds/slave/test', 02:20:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:22 INFO - 'SHELL': '/bin/bash', 02:20:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UN6GfH8kxh/Listeners', 02:20:22 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:20:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:22 INFO - 'USER': 'cltbld', 02:20:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:22 INFO - 'XPC_FLAGS': '0x0', 02:20:22 INFO - 'XPC_SERVICE_NAME': '0', 02:20:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:22 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)) 02:20:22 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)) 02:20:22 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)) 02:20:22 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)) 02:20:22 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)) 02:20:22 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)) 02:20:22 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)) 02:20:22 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)) 02:20:22 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)) 02:20:22 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)) 02:20:22 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)) 02:20:22 INFO - Cleaning up... 02:20:22 INFO - Return code: 0 02:20:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:20:22 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')]} 02:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:22 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')]} 02:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:20:22 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 0x10536ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105400618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd30149be20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052cfd30>, '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 0x105034db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052c7b20>, '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.twLUViFER1/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.UN6GfH8kxh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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 02:20:22 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 02:20:22 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 02:20:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.twLUViFER1/Render', 02:20:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:22 INFO - 'HOME': '/Users/cltbld', 02:20:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:22 INFO - 'LOGNAME': 'cltbld', 02:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:22 INFO - 'MOZ_NO_REMOTE': '1', 02:20:22 INFO - 'NO_EM_RESTART': '1', 02:20:22 INFO - 'PAGER': '/bin/cat', 02:20:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:22 INFO - 'PWD': '/builds/slave/test', 02:20:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:22 INFO - 'SHELL': '/bin/bash', 02:20:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UN6GfH8kxh/Listeners', 02:20:22 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:20:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:22 INFO - 'USER': 'cltbld', 02:20:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:22 INFO - 'XPC_FLAGS': '0x0', 02:20:22 INFO - 'XPC_SERVICE_NAME': '0', 02:20:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:20:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:20:23 INFO - Cleaning up... 02:20:23 INFO - Return code: 0 02:20:23 INFO - Running post-action listener: _resource_record_post_action 02:20:23 INFO - Running post-action listener: _start_resource_monitoring 02:20:23 INFO - Starting resource monitoring. 02:20:23 INFO - ##### 02:20:23 INFO - ##### Finished create-virtualenv step (success) 02:20:23 INFO - ##### 02:20:23 INFO - ##### 02:20:23 INFO - ##### Running install step. 02:20:23 INFO - ##### 02:20:23 INFO - Running pre-action listener: _resource_record_pre_action 02:20:23 INFO - Running main action method: install 02:20:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:20:23 INFO - Reading from file tmpfile_stdout 02:20:23 INFO - Detecting whether we're running mozinstall >=1.0... 02:20:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:20:23 INFO - Reading from file tmpfile_stdout 02:20:23 INFO - Output received: 02:20:23 INFO - Usage: mozinstall [options] installer 02:20:23 INFO - Options: 02:20:23 INFO - -h, --help show this help message and exit 02:20:23 INFO - -d DEST, --destination=DEST 02:20:23 INFO - Directory to install application into. [default: 02:20:23 INFO - "/builds/slave/test"] 02:20:23 INFO - --app=APP Application being installed. [default: firefox] 02:20:23 INFO - mkdir: /builds/slave/test/build/application 02:20:23 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'] 02:20:23 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 02:20:58 INFO - Reading from file tmpfile_stdout 02:20:58 INFO - Output received: 02:20:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:20:58 INFO - Running post-action listener: _resource_record_post_action 02:20:58 INFO - ##### 02:20:58 INFO - ##### Finished install step (success) 02:20:58 INFO - ##### 02:20:58 INFO - ##### 02:20:58 INFO - ##### Running run-tests step. 02:20:58 INFO - ##### 02:20:58 INFO - Running pre-action listener: _resource_record_pre_action 02:20:58 INFO - Running main action method: run_tests 02:20:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:20:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:20:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:20:58 INFO - 2016-07-20 02:20:58.239 screenresolution[1639:7443] starting screenresolution argv=screenresolution get 02:20:58 INFO - 2016-07-20 02:20:58.242 screenresolution[1639:7443] Display 0: 1600x1200x32@60 02:20:58 INFO - 2016-07-20 02:20:58.248 screenresolution[1640:7445] starting screenresolution argv=screenresolution list 02:20:58 INFO - Available Modes on Display 0 02:20:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:20:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:20:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:20:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:20:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:20:58 INFO - Intel Iris: 02:20:58 INFO - Chipset Model: Intel Iris 02:20:58 INFO - Type: GPU 02:20:58 INFO - Bus: Built-In 02:20:58 INFO - VRAM (Dynamic, Max): 1536 MB 02:20:58 INFO - Vendor: Intel (0x8086) 02:20:58 INFO - Device ID: 0x0a2e 02:20:58 INFO - Revision ID: 0x0009 02:20:58 INFO - Displays: 02:20:58 INFO - Display: 02:20:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:20:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:20:58 INFO - Display Serial Number: 1600x1200 60 02:20:58 INFO - Main Display: Yes 02:20:58 INFO - Mirror: Off 02:20:58 INFO - Online: Yes 02:20:58 INFO - Rotation: Supported 02:20:58 INFO - Return code: 0 02:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:20:58 INFO - Python 2.7.3 02:20:58 INFO - Return code: 0 02:20:58 INFO - grabbing minidump binary from tooltool 02:20: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')]} 02:20:58 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 0x1052cfd30>, '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 0x105034db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052c7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:20:58 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 02:20:58 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 02:20:58 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 02:20:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:20:58 INFO - Return code: 0 02:20:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:20:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:20:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:20:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:20:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:20:58 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/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0201', '--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 02:20:58 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/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0201 --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 02:20:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.twLUViFER1/Render', 02:20:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:20:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:20:58 INFO - 'HOME': '/Users/cltbld', 02:20:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:20:58 INFO - 'LOGNAME': 'cltbld', 02:20:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:20:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:20:58 INFO - 'MOZ_NO_REMOTE': '1', 02:20:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:20:58 INFO - 'NO_EM_RESTART': '1', 02:20:58 INFO - 'PAGER': '/bin/cat', 02:20:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:20:58 INFO - 'PWD': '/builds/slave/test', 02:20:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:20:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:20:58 INFO - 'SHELL': '/bin/bash', 02:20:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UN6GfH8kxh/Listeners', 02:20:58 INFO - 'TMPDIR': '/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/', 02:20:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:20:58 INFO - 'USER': 'cltbld', 02:20:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:20:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:20:58 INFO - 'XPC_FLAGS': '0x0', 02:20:58 INFO - 'XPC_SERVICE_NAME': '0', 02:20:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:20:58 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/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0201', '--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 02:20:58 INFO - mozversion application_buildid: 20160720010920 02:20:58 INFO - mozversion application_changeset: e7cd99539c53235604f03a6cd56458dd2d337cdb 02:20:58 INFO - mozversion application_display_name: Nightly 02:20:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:20:58 INFO - mozversion application_name: Firefox 02:20:58 INFO - mozversion application_remotingname: firefox 02:20:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:20:58 INFO - mozversion application_vendor: Mozilla 02:20:58 INFO - mozversion application_version: 50.0a1 02:20:58 INFO - mozversion platform_buildid: 20160720010920 02:20:58 INFO - mozversion platform_changeset: e7cd99539c53235604f03a6cd56458dd2d337cdb 02:20:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:20:58 INFO - mozversion platform_version: 50.0a1 02:20:58 INFO - using testdate: 1469006458 02:20:58 INFO - actual date: 1469006458 02:20:58 INFO - starting webserver on 'localhost:49271' 02:20:58 INFO - SUITE-START | Running 2 tests 02:20:58 INFO - TEST-START | dromaeo_css 02:20:58 INFO - operating with platform_type : mac_ 02:20:58 INFO - Initialising browser for dromaeo_css test... 02:20:58 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpT9QvUf/profile http://localhost:49271/getInfo.html) 02:21:01 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 02:21:01 INFO - PROCESS | 1650 | colorDepth:24 02:21:01 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 02:21:01 INFO - PROCESS | 1650 | __metrics 02:21:01 INFO - PROCESS | 1650 | 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" 02:21:01 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:21:02 INFO - TEST-INFO | 1650: exit 0 02:21:02 INFO - Browser initialized. 02:21:02 INFO - Running cycle 1/1 for dromaeo_css test... 02:21:02 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpT9QvUf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:21:14 INFO - PROCESS | 1651 | RSS: Main: 243662848 02:21:14 INFO - PROCESS | 1651 | 02:22:05 INFO - PROCESS | 1651 | 1469006525684 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] 02:24:16 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 02:24:17 INFO - PROCESS | 1651 | RSS: Main: 343642112 02:24:17 INFO - PROCESS | 1651 | 02:27:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 02:27:21 INFO - PROCESS | 1651 | RSS: Main: 382283776 02:27:21 INFO - PROCESS | 1651 | 02:30:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 02:30:23 INFO - PROCESS | 1651 | RSS: Main: 373547008 02:30:23 INFO - PROCESS | 1651 | 02:33:26 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 02:33:26 INFO - PROCESS | 1651 | RSS: Main: 373301248 02:33:26 INFO - PROCESS | 1651 | 02:36:30 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 02:36:30 INFO - PROCESS | 1651 | RSS: Main: 334974976 02:36:30 INFO - PROCESS | 1651 | 02:39:34 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 02:39:34 INFO - PROCESS | 1651 | RSS: Main: 383119360 02:39:34 INFO - PROCESS | 1651 | 02:39:34 INFO - PROCESS | 1651 | __start_tp_report 02:39:34 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 02:39:34 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 02:39:34 INFO - PROCESS | 1651 | |i|pagename|runs| 02:39:34 INFO - PROCESS | 1651 | |0;dojo.html;3179.348233612109;3339.6994270515647;3341.9331613367717;3366.2930784535247;3405.778624389416;5563.221149039127;5609.523190528805;5619.80330688426;5717.514011309038;5721.227634269378;4675.672702910798;5619.157126431038;5733.713314334287;5742.741576629051;5781.017227071397;5131.666441681297;5138.075146473652;5186.974065129669;5189.922151167735;5306.522412982831;5249.737513124348;5326.920096198541;5327.946720532803;5329.2006199070065;5336.252924590561;5109.974450127745;5141.53726164647;5171.50870667286;5199.896002079937;5231.738413079331;5120.462351453119;5170.793168273264;5234.659747116463;5260.395054568736;5311.7344132793205;5108.386993560759;5124.974375128138;5161.200013997799;5170.431252562215;5243.9213411798855;5685.658860468344;5696.6866822324755;5703.116017017369;5759.280089988752;5785.797497087582;6067.660533345266;6136.76416992428;6180.165677633507;6193.6903154842075;6233.096201050822;6219.1604133442315;6266.937330626726;6282.120503129566;6320.020396838498;6331.430171284606;5662.292213473316;5788.913166302509;5820;5842.444967728059;5851.707414629252;6203.47270482005;6213.502919766408;6264.874702505925;6278.529110316745;6284.874302513924;6132.724027418777;6156.29202641693;6156.415140561639;6162.291336496271;6167.938320616826;6225.190725205694;6227.937720622826;6274.749010039547;6281.403266689657;6313.779017734358;5085.669431487016;6108.615274519878;6129.9701281150365;6182.536309776785;6186;6258.624482531062;6277.905831412532;6287.748490060438;6296.307406185316;6300.30696623371;4921.409430868247;4931.457539670633;4937.259411088366;4942.35749352589;4943.8022479101155;3800.8407435731815;4349.434573505424;4362.672799540047;4367.27939889921;4430.091831174602;5728.942710572841;5732.713364331767;5734.283214598176;5750.396208398141;5785;6132.846678833065;6244.344343843922;6255.906161407583;6264.749410023639;6290.55966082379;5629.4652008059165;5680.431956804369;5718.199452076713;5720.713964301768;5723.3418156912485;5350.8662283442445;5385.3268341457315;5401.837944861661;5419.024575576355;5428.809991650273;6281.2462504498835;6282.057691346335;6286.8428289292215;6287.182666253358;6301.8109456716375;6100.793122958854;6308;6312.179416675803;6331.778387756406;6337.841553961188;5027.673201242053;6176.289726681489;6260.280067792262;6277.12120303167;6287.622742635456;6141.6007959482495;6187.443130118311;6198.2252218472695;6200.007998720183;6203.844903877259;6134.773364742421;6229.221347331583;6295.370462953668;6314.147590075281;6319.304876463493;5129.358830146231;6086.969565152146;6090.086487026804;6138.539609529393;6159.168512250789;6155.630662160284;6157.322694503511;6167.938320616737;6172.197614310111;6186.597871138361;5817.447342502455;5900.616459930091;5953.791617293374;5965.731542080704;5986.580939334205;6088.452039316483;6164.167837341902;6180;6185.381461853779;6204.627722336674;5954.791582294599;5982.371850955587;5989.700514974321;6006.279246490449;6027 02:39:34 INFO - PROCESS | 1651 | |1;ext.html;482.6259648772201;494.39436690054686;531.9361676598809;554.2572952243992;558.4220331956426;29367.853160734194;40301;40927;40966;41053.384199237;37952.24095518088;39205;41821.37267940983;42287.57712422875;42469.938251543725;8630.65477380904;9590.999999999982;9768.023197680246;9775.266854985868;9782.97278785728;8592.226699597035;9684.903150968506;11637.185397022211;11662.650120496399;11939.641810745648;11651;11729.589464368748;11730.530778768882;11740.706482337968;11743.06055515561;8670.783230419227;11418.657440276806;11562.07503399726;11624.593139240129;11684.474198661039;11603.593874214446;11659.300441973424;11683.766324673545;11695.415229238504;11722;39569;39828;39843;39844;39885;3385.5091011803397;3437.4843773434186;3718.7768733876055;3945.250402423559;4104.138130992465;27010;30237.79048838066;32082.358352832813;32396.838015810004;32588.511172332433;3319.8174100424467;3323.1692076980753;3360.4287271163716;3393.881214157517;3428.794272343642;440522;514227;515882.4205879022;516989.9999999962;517293;58483.4151658478;58816;59108.7044564783;59241.703791480766;59334;34288.82855585756;34561.827190863885;34616.30767384638;36289.63710362863;36420.81789591035;16540.255688494046;16704.41534546285;16712.41506547265;16757.41349052777;16758.162091895356;11002.119830413547;11657.533698652129;11854.703632409259;12750.234985900875;12903.096783225084;18965.051747412574;19120;19120.61758764817;19251.22995080181;19278.722617155116;6898.344657257552;7951.165127661512;8042.9597852010365;8049.195080492021;8067.233612806774;963.1957315641517;1014.4630884210427;1041.5885725138528;1053.489057806963;1057.6562617149457;29743;30001.249968750955;30059;30896.84551577228;30927.91752288704;1090.3239991205503;1091.317926296065;1104.2546281260118;1122.4668282565715;1127.7969965406305;15708.978916370399;15828.52514424569;15837.68324633501;15845.445409410615;16149.35402583907;734084;735123;740243.7804975589;741512;743055;43386.13227735428;43655;43733.34399984003;43787.562124378346;43829.12341753147;1246.5886257534992;1392.7284179584883;1399.9510017149555;1427.0937954398823;1434.5194359889554;31013;31021.224469388446;31461;31530.527042094847;31867.043988680376;43210;49768.75115624399;49782;50035;50125.749371254366;561483;583267;583711;584153;585317;23125.88437057804;25422.872885635454;26051;26060.478790423706;26153.73846261513;47054.82362940954;48242.64138737556;48619;49086;49100.508994911026;37475.063123421045;39997;40057;40695.796521017204;40938.795306023276;37864.81067594644;39249.607503925734;39516.209675805745;40379.59620403876;40620.3906941402;32421.513677294388;38002.80998594989;38606.80696596499;38866.6113338863;38882.2223555533;33525.66474335323;33932;34412.655873441945;34548.481772772924;34773.13067173341;21567.568648627253;24343.878280608482;25523.489530209663;25717.614235786852;25957.351066223495 02:39:34 INFO - PROCESS | 1651 | |2;jquery.html;347.31232160322577;365.9762115462495;371.21117625046776;372.84713267560295;392.04732500024943;15591.688166236669;16206.513804585866;16902.32390704372;21069;21265.99999999996;20468.795312046874;21134.577308453823;21441.035153418095;21494.355169344944;22270.443238919033;5118;5946.405359464052;6103.877922441548;6124.356942521038;6146.8463288417925;5920.082387229986;5968.313643930938;6012.879742405149;6021.036634138539;6021.939780602203;5627.465390787889;5904.5571582131515;5919.674417907014;5955.88088238235;5967.134765459005;5854.707264636772;5890.5582081343855;5900.527957763368;5908.320543137508;5925.762969481216;4466.307722303049;4935.259711043373;5147;5165.483451654842;5181.870453238662;26190;26322.86838565814;26388.73611263882;26469.867650661818;26530.734692653212;2063.546019875625;2231.4532939429782;2273.3293678364757;2500.2874180858366;3138.2311333723383;9929.156021738161;9930.702078937644;10096.545655445523;10359.378437293786;10365.844512332322;1830.0483748450863;1899.6580615489206;1921.193098898452;1945.2510783348512;1947.4157752674141;127257;127712.36143819221;128966;129589.70410295871;129599;9550.761230969281;9854.408735475894;10870.18473614482;11629.767404651859;11644.825327620092;13905.930470347583;14109.858901410855;14116.929415353063;14123.293835308194;14128.434862605587;8514.233718965323;8567.614457349435;8612.655493780305;8668.0898505656;8685.913140868637;7277.38142257914;8534.591792354193;8621.267192288726;8767.824643507221;8793.20861122502;4340.913181736348;4406.669499787528;4424.115176964556;4461.330800379969;4559.293309536961;1625.910574918391;1841.4659748672734;1851.8240767127102;1860.9162587683586;1873.7751469823436;911.4303560274828;914.8353296406577;943.5188054092463;980.612658000086;1025.1491262252462;21605.567888642137;22514.32457026259;22558.774412255996;22575.77424225737;22705.205317813798;837.8186756673061;852.8891244138223;934.4486752815872;948;1000.5147503460815;10686;11473.770524589629;11563.595274165364;11593.478293476814;11620.53517859293;525376;528748;546014;612722;613790;130539.34730326288;135186;141262;142567.2871635656;144776.27611861873;993.1905497019761;994.1400688404623;1024.3700124423426;1045.5869931377063;1049.1554298789547;18717.344892928682;19429.319973800848;19858.261694403405;20000.399988000383;20049.498762531053;57482.7125864368;58211.835763285344;58610.534736631926;59245;59407.405925940184;61788.76422471616;82642;84350;85100.57449712712;85142.57428712817;7102.325279098477;7184.856302873809;7429.5542267464125;7457.47797654159;7650.349720273839;7423.072115985502;10458.111060559937;12460.626181214215;13523.661908451973;13931.651708707363;11692.181547291608;11788.76422471563;11978.64064078079;12063.276203427471;12133.393330333625;11167.939045790637;11704.297742135499;11753.294802311888;11753.588624398448;12072.75854482923;8782.680350588162;11875.703107422383;11953.342566158944;12107.576234831738;12108.878911210775;7419.258074192538;7472.29013243741;7506.662200200894;7563.470557060953;7653.6555854985545;11395.487203076047;11519.76960460803;11569.768604628029;11860.110491713329;11992.520299187934 02:39:34 INFO - PROCESS | 1651 | |3;mootools.html;1386.840513340966;1529.9694006119873;1578.203007481222;1764.1179410294853;1899.9810001899984;7839.137694853569;8643.222110010098;8899.33255005874;8901.599428025738;8985.415947963378;8640.135986401358;8719.17167869053;8813.647454101829;8824.867626985584;8827.86758198626;2259.1302348595746;2322.651602259662;2357.1985524921524;2357.811375089989;2362.007956658199;1987.9503012424661;2298.8965496552696;2334.5564342774906;2337.474068334628;2339;1980.2574034736974;2302.9424264393356;2335.4628435459854;2338.240071976606;2339.777721116491;2279.589673858705;2295.908163673451;2302.021640802652;2304.5045315257134;2304.7925686688195;2301.528186721718;2306.2274138163734;2308.284431826139;2308.365199570115;2309.2379514760087;8755.956220218859;8861.689840855604;8879.778005549848;8931.821363572692;8942;4821.54195351441;5298.788048478056;5300.575953923677;5313.229581710631;5314.60140489461;3356.597208334991;3456.948145777815;3500.789952602852;3509.578850537952;3515.2793677296095;1018.8828284747275;1032.4321623107337;1040.5785656809005;1052.6210564196883;1053.3574519543072;11692.590759323468;11775.411229438494;11779.293242405398;11799.469023893946;11808.645740627795;4288.52826189119;4335.7615331157085;4476.2837945928495;4477.910441791146;4489.057297967398;9224.169824715807;9261.583228754722;9262.120098590623;9262.72211833646;9263.351565390358;5136.409312928986;5139.743012849342;5139.743012849342;5142.280080788692;5208.817691380784;4286.657067434598;4451.554844515587;4608;4753.643476739258;4797.232442809134;3641.1443310821937;3644.6173151819207;3730.9440358394645;3755.530558680165;3770.5663848657205;1091.781643671269;1115.1970581181536;1117.4301106435614;1127.4081107418506;1130.2822707580744;660.3330636057616;821.2485575698289;891.148952750122;892.0767006148606;977.5845265762023;6056.697165141725;6107.114468402146;6157.753689852445;6198.752049917953;6324.968375158095;932.7201839448138;937.901520340368;988.8170688422665;1001.0640051551823;1021.0912288063629;3936.232434675268;4111.383292506088;4121.8969525761495;4126.607972242632;4178.206140833232;10293.330933489298;10812.35125892449;10813.459327033774;10844.349339039683;10848.566057357775;10637.255392122632;10753.51609177589;10762.56949722018;10771.892281077246;10791.6222932197;8257.504549727035;8371.330293576499;8371.95814020926;8383.490971625044;8392.748217553482;5379.838604841861;5428.267183930119;5574.219609254788;5636.351819540805;6048.818535443944;9852.458114803754;10112.089911907964;10160.54277557497;10178.49107544605;10180.745481362728;10013.849792252977;10060.949695251476;10164.644237451654;10252.077313041862;10409.635662751767;7644.159142494433;7713.807154821175;7804.609769511389;7810.921890781019;7815.062192536705;8275.255227029596;8399.70601028961;8422.32621390275;8451.492910425393;8473.025602055843;7607.619619018917;7608.8478230436185;7682.347000505019;7701.537907725555;7772.650230739743;7503.287187717158;7520.323170914644;7523.7366692165515;7620.504667196615;7669.693212271447;6923.376896079176;7045.788626341218;7085.716571337089;7086.716531338689;7092.858142837217;5116.9744151279;5158.406783219978;5178.456262092426;5188.870278243074;5291;5109.795608175631;5158.535731784157;5240.397354304151;5369.167778994106;5396.1366181410785 02:39:34 INFO - PROCESS | 1651 | |4;prototype.html;291.92701824543855;304.54318522216676;307.66618219232134;320.93420848726015;322.9192701824544;4704.929426058612;5213.582913366931;5277.630565860387;5299.072662284099;5534.889302213954;4438.467383913927;5433.071259702808;5466.480684334992;5466.644668096581;5474.2609747684055;3752.555266222497;3866.3427217372973;3942.132730799227;4003.579624139467;4160.313548264533;3749.737518373715;3941.4481972523868;4118.299889018874;4132.793360331986;4177.916441671165;3384.661533846608;3388.8644454221803;4105.4252404663375;4118.608732170454;4127.236461254663;3436.4501679731247;3688.5942546319884;3912.39357899526;4089.427480152781;4097.7541347518945;3552.236269202134;3561.94657080144;3571.5357003589365;3571.821408929543;3580.051286409104;4353.368761529592;5277.8416647500635;5296;5322.600804939606;5331.5201631853315;4072.7759973201464;4567.931481027754;4715.669903106784;4723.598494128003;4774.8540350316025;4314.546972567867;4662.696924699918;5691.146328050784;5752.856178595527;5755.7625110601;3932.6460618544183;3947.50656167979;3959.1487830116375;3967.6230758077936;3970.68234541236;5446.673199608076;5448.809291674773;5840;5993.550483713739;6016;3503.386907291214;3886.261610294035;3982.8008599569907;3986.242613903349;3991.022199561126;3416.965830341665;4054.7972601369815;4066.3493840985893;4087.9591204088174;4092.3861420786525;3960.485136932238;4520.666403411002;4712.52874712526;4735.431748190239;4744.905101897943;5042;5706.942930570641;5714.428557144252;5716.771329146871;5777.30672319316;1237.3194742891374;1369.4453746232791;1385.625881012121;1387.1746310944973;1395.3581352577726;864.5849992003873;868.431177578687;878.6046279174398;882.2544949517647;913.3789023464108;4182.602652747984;4322.200392927319;5308;5417.12892167152;5429;5539.861503462365;5868.18327202945;5875.970620146957;5883.294004719461;5887.234659494324;4664.3936288282985;5131.692098474104;5182.844514664566;5363.785448582013;5367.75845086972;3018.894338698135;3066.5246886732148;3068.156257029335;3069.173841564266;3069.634012864254;5392.865178370572;6047.909281360783;6051.245138909755;6063.211782468251;6111.480524155408;5137.2037334213255;5177.145770947826;5447.906523855891;5885.205497257901;6037.792441511628;5348.705821179872;5411.810586629449;6013.12153660895;6083.908741368883;6094.39056094387;5231.979763945994;5576.721163941867;5605.831825045255;5848.912266316093;5881.735321910439;4854.78153483087;5277.8416647500635;5782.855428614318;5793.9860524408905;5812.680302583399;5969.970150149222;5995.46040856325;6021.494626343414;6082.118092876596;6110.908336375047;3349.5310656508595;3822.4266360046217;3915.804209789556;3960.5445373782386;3974.463447434675;4831.685940414002;5668.5465162787705;5836.824895253149;5838.503727183237;5839.0512791040255;4682.555157260055;5600.803971860965;5603.2909962461845;5609.242752228397;5627.606067575231;5047.845096814491;5424.698072462659;5464.64479808827;5666.263385759825;5680.6591604503865;4819.590334821439;4904.411470623548;5297.920531192112;5555.8888822222525;5587.69267690281;5627.465390788032;5665.951798917214;5683.204351390726;5685.829425117253;5698.914516282176;4616.469106052713;5255.579553635624;5534.833954981357;5545.916811247916;5546.833594992157 02:39:34 INFO - PROCESS | 1651 | |5;yui.html;788.562347896917;809.9433039687223;824.8102936324649;839.1021606880632;840.8486472434961;14355.497557585486;14948.935468228987;15486.148261845594;15534.456294029696;15768.290426930787;14370.784438233435;14400.927995360034;14567.927160364183;14576.125432474058;14645.121292722417;706.883364244899;723.7105157936841;873.1792115411524;879.560219890055;900.4822227219342;883.4655033704613;883.765802062454;884.0496466298722;884.5621417398397;885.9867101993475;950.0546955778975;952.9714108576753;953.5994882149479;955.6177528988391;956.9665061722841;747.2602123897357;765.5942350554216;766.2873527619312;768.6310570925931;958.650092716157;697.6407150317591;707.3386383731176;707.7664370757689;710.2294010998073;712.0600806934848;11976.640700778991;14451.638709032253;14457;14469.78295325571;14472.855271447255;14171.220582867938;14350;14416.279186040761;14443.78334324986;14583.927080364636;13125.803112953314;13193.40629671667;13201.339933003312;13344.399502022336;13590;4541.818327266906;4798.568128868418;4839.008003359303;4859.343988561534;4863.53796389346;116586.99999999916;116615;116975;117180;117227;11227.775444491228;11394.3163410194;11395.601153959571;11421.486033128529;11637.359945202927;20627.896860515903;21368;23027.539449210923;23033.769662303497;23090;8262.504249745034;8300.148588410104;8307.792305192419;8326.958365208135;8362.289205417608;4590.2196626572895;4641.164590373698;4663.650226233046;4764.6664733469015;4789.95210047902;3632.4914511968345;3718.4608231806237;3747.662710356081;3761.4357846322723;3765.8681946131755;670.4100391655312;671.5802623360399;679.7077256779534;703;712.6045044999971;607.401709316323;655.3119224814021;688.4526801192964;692.5394612582576;713.5575942915322;9451.810963780823;9462.29032822541;9741.512924353754;9775.853362199572;9936.489751189318;535.9812406565751;567.9290088738908;602.3977405147072;645.3224114679567;681.5842336175028;4312.870613881589;4465.508794032654;4588.908221835544;4645.466995891347;4646.697964632288;88532.5573372142;88700;88874.11192384352;89115;92905;125653;128418;130066;130330;130616;111897;112195;113252.43373783078;113957;116661.416692916;8808;8923.866142008004;8945.463272203428;9117.589708463267;9219.677311294072;48169.7957551064;51077.74461127671;56356.15465767935;57430.7128464355;65310;55173;70891;89318.10681893097;89503.10496894948;90792.54603727203;13407.664808379868;13509.392077356346;13663.316834158451;13688.384022719201;13983.580492585239;12157.331346776013;15245.923770381078;15283.46507872219;15485.225738712794;16058.197090145679;14291.785623215452;14311.988964635086;14434.783478247624;14561.635959101108;14677;13952;14236.003479756318;14273.928630357197;14274.112077332915;14885.330160143036;12605.117641764988;12943;13023.348832558144;13582.660433489242;13724.862751372759;11117.777644447227;11152.498137583665;11333.829992550283;11481.598144065252;11845.644630661094;10232.795344093225;10976.451177440937;11169.497372618089;11353.659390218307;11592.1305902056 02:39:34 INFO - PROCESS | 1651 | __end_tp_report 02:39:34 INFO - PROCESS | 1651 | __start_cc_report 02:39:34 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1129 02:39:34 INFO - PROCESS | 1651 | __end_cc_report 02:39:34 INFO - PROCESS | 1651 | __startTimestamp1469007574313__endTimestamp 02:39:34 INFO - PROCESS | 1651 | 02:39:34 INFO - PROCESS | 1651 | ------- Summary: start ------- 02:39:34 INFO - PROCESS | 1651 | Number of tests: 6 02:39:34 INFO - PROCESS | 1651 | 02:39:34 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5722.93 Median:5965.73 stddev:664.96 (11.1%) stddev-sans-first:636.36 02:39:34 INFO - PROCESS | 1651 | Values: 3179.3 3339.7 3341.9 3366.3 3405.8 5563.2 5609.5 5619.8 5717.5 5721.2 4675.7 5619.2 5733.7 5742.7 5781.0 5131.7 5138.1 5187.0 5189.9 5306.5 5249.7 5326.9 5327.9 5329.2 5336.3 5110.0 5141.5 5171.5 5199.9 5231.7 5120.5 5170.8 5234.7 5260.4 5311.7 5108.4 5125.0 5161.2 5170.4 5243.9 5685.7 5696.7 5703.1 5759.3 5785.8 6067.7 6136.8 6180.2 6193.7 6233.1 6219.2 6266.9 6282.1 6320.0 6331.4 5662.3 5788.9 5820.0 5842.4 5851.7 6203.5 6213.5 6264.9 6278.5 6284.9 6132.7 6156.3 6156.4 6162.3 6167.9 6225.2 6227.9 6274.7 6281.4 6313.8 5085.7 6108.6 6130.0 6182.5 6186.0 6258.6 6277.9 6287.7 6296.3 6300.3 4921.4 4931.5 4937.3 4942.4 4943.8 3800.8 4349.4 4362.7 4367.3 4430.1 5728.9 5732.7 5734.3 5750.4 5785.0 6132.8 6244.3 6255.9 6264.7 6290.6 5629.5 5680.4 5718.2 5720.7 5723.3 5350.9 5385.3 5401.8 5419.0 5428.8 6281.2 6282.1 6286.8 6287.2 6301.8 6100.8 6308.0 6312.2 6331.8 6337.8 5027.7 6176.3 6260.3 6277.1 6287.6 6141.6 6187.4 6198.2 6200.0 6203.8 6134.8 6229.2 6295.4 6314.1 6319.3 5129.4 6087.0 6090.1 6138.5 6159.2 6155.6 6157.3 6167.9 6172.2 6186.6 5817.4 5900.6 5953.8 5965.7 5986.6 6088.5 6164.2 6180.0 6185.4 6204.6 5954.8 5982.4 5989.7 6006.3 6027.0 02:39:34 INFO - PROCESS | 1651 | 02:39:34 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:72336.84 Median:34589.07 stddev:164863.52 (476.6%) stddev-sans-first:165237.73 02:39:34 INFO - PROCESS | 1651 | Values: 482.6 494.4 531.9 554.3 558.4 29367.9 40301.0 40927.0 40966.0 41053.4 37952.2 39205.0 41821.4 42287.6 42469.9 8630.7 9591.0 9768.0 9775.3 9783.0 8592.2 9684.9 11637.2 11662.7 11939.6 11651.0 11729.6 11730.5 11740.7 11743.1 8670.8 11418.7 11562.1 11624.6 11684.5 11603.6 11659.3 11683.8 11695.4 11722.0 39569.0 39828.0 39843.0 39844.0 39885.0 3385.5 3437.5 3718.8 3945.3 4104.1 27010.0 30237.8 32082.4 32396.8 32588.5 3319.8 3323.2 3360.4 3393.9 3428.8 440522.0 514227.0 515882.4 516990.0 517293.0 58483.4 58816.0 59108.7 59241.7 59334.0 34288.8 34561.8 34616.3 36289.6 36420.8 16540.3 16704.4 16712.4 16757.4 16758.2 11002.1 11657.5 11854.7 12750.2 12903.1 18965.1 19120.0 19120.6 19251.2 19278.7 6898.3 7951.2 8043.0 8049.2 8067.2 963.2 1014.5 1041.6 1053.5 1057.7 29743.0 30001.2 30059.0 30896.8 30927.9 1090.3 1091.3 1104.3 1122.5 1127.8 15709.0 15828.5 15837.7 15845.4 16149.4 734084.0 735123.0 740243.8 741512.0 743055.0 43386.1 43655.0 43733.3 43787.6 43829.1 1246.6 1392.7 1400.0 1427.1 1434.5 31013.0 31021.2 31461.0 31530.5 31867.0 43210.0 49768.8 49782.0 50035.0 50125.7 561483.0 583267.0 583711.0 584153.0 585317.0 23125.9 25422.9 26051.0 26060.5 26153.7 47054.8 48242.6 48619.0 49086.0 49100.5 37475.1 39997.0 40057.0 40695.8 40938.8 37864.8 39249.6 39516.2 40379.6 40620.4 32421.5 38002.8 38606.8 38866.6 38882.2 33525.7 33932.0 34412.7 34548.5 34773.1 21567.6 24343.9 25523.5 25717.6 25957.4 02:39:34 INFO - PROCESS | 1651 | 02:39:34 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:34946.62 Median:26429.30 stddev:95575.04 (361.6%) stddev-sans-first:95807.85 02:39:34 INFO - PROCESS | 1651 | Values: 347.3 366.0 371.2 372.8 392.0 15591.7 16206.5 16902.3 21069.0 21266.0 20468.8 21134.6 21441.0 21494.4 22270.4 5118.0 5946.4 6103.9 6124.4 6146.8 5920.1 5968.3 6012.9 6021.0 6021.9 5627.5 5904.6 5919.7 5955.9 5967.1 5854.7 5890.6 5900.5 5908.3 5925.8 4466.3 4935.3 5147.0 5165.5 5181.9 26190.0 26322.9 26388.7 26469.9 26530.7 2063.5 2231.5 2273.3 2500.3 3138.2 9929.2 9930.7 10096.5 10359.4 10365.8 1830.0 1899.7 1921.2 1945.3 1947.4 127257.0 127712.4 128966.0 129589.7 129599.0 9550.8 9854.4 10870.2 11629.8 11644.8 13905.9 14109.9 14116.9 14123.3 14128.4 8514.2 8567.6 8612.7 8668.1 8685.9 7277.4 8534.6 8621.3 8767.8 8793.2 4340.9 4406.7 4424.1 4461.3 4559.3 1625.9 1841.5 1851.8 1860.9 1873.8 911.4 914.8 943.5 980.6 1025.1 21605.6 22514.3 22558.8 22575.8 22705.2 837.8 852.9 934.4 948.0 1000.5 10686.0 11473.8 11563.6 11593.5 11620.5 525376.0 528748.0 546014.0 612722.0 613790.0 130539.3 135186.0 141262.0 142567.3 144776.3 993.2 994.1 1024.4 1045.6 1049.2 18717.3 19429.3 19858.3 20000.4 20049.5 57482.7 58211.8 58610.5 59245.0 59407.4 61788.8 82642.0 84350.0 85100.6 85142.6 7102.3 7184.9 7429.6 7457.5 7650.3 7423.1 10458.1 12460.6 13523.7 13931.7 11692.2 11788.8 11978.6 12063.3 12133.4 11167.9 11704.3 11753.3 11753.6 12072.8 8782.7 11875.7 11953.3 12107.6 12108.9 7419.3 7472.3 7506.7 7563.5 7653.7 11395.5 11519.8 11569.8 11860.1 11992.5 02:39:34 INFO - PROCESS | 1651 | 02:39:34 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5716.31 Median:4809.39 stddev:3236.54 (67.3%) stddev-sans-first:3229.26 02:39:34 INFO - PROCESS | 1651 | Values: 1386.8 1530.0 1578.2 1764.1 1900.0 7839.1 8643.2 8899.3 8901.6 8985.4 8640.1 8719.2 8813.6 8824.9 8827.9 2259.1 2322.7 2357.2 2357.8 2362.0 1988.0 2298.9 2334.6 2337.5 2339.0 1980.3 2302.9 2335.5 2338.2 2339.8 2279.6 2295.9 2302.0 2304.5 2304.8 2301.5 2306.2 2308.3 2308.4 2309.2 8756.0 8861.7 8879.8 8931.8 8942.0 4821.5 5298.8 5300.6 5313.2 5314.6 3356.6 3456.9 3500.8 3509.6 3515.3 1018.9 1032.4 1040.6 1052.6 1053.4 11692.6 11775.4 11779.3 11799.5 11808.6 4288.5 4335.8 4476.3 4477.9 4489.1 9224.2 9261.6 9262.1 9262.7 9263.4 5136.4 5139.7 5139.7 5142.3 5208.8 4286.7 4451.6 4608.0 4753.6 4797.2 3641.1 3644.6 3730.9 3755.5 3770.6 1091.8 1115.2 1117.4 1127.4 1130.3 660.3 821.2 891.1 892.1 977.6 6056.7 6107.1 6157.8 6198.8 6325.0 932.7 937.9 988.8 1001.1 1021.1 3936.2 4111.4 4121.9 4126.6 4178.2 10293.3 10812.4 10813.5 10844.3 10848.6 10637.3 10753.5 10762.6 10771.9 10791.6 8257.5 8371.3 8372.0 8383.5 8392.7 5379.8 5428.3 5574.2 5636.4 6048.8 9852.5 10112.1 10160.5 10178.5 10180.7 10013.8 10060.9 10164.6 10252.1 10409.6 7644.2 7713.8 7804.6 7810.9 7815.1 8275.3 8399.7 8422.3 8451.5 8473.0 7607.6 7608.8 7682.3 7701.5 7772.7 7503.3 7520.3 7523.7 7620.5 7669.7 6923.4 7045.8 7085.7 7086.7 7092.9 5117.0 5158.4 5178.5 5188.9 5291.0 5109.8 5158.5 5240.4 5369.2 5396.1 02:39:34 INFO - PROCESS | 1651 | 02:39:34 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4573.59 Median:5222.78 stddev:1410.34 (27.0%) stddev-sans-first:1377.20 02:39:34 INFO - PROCESS | 1651 | Values: 291.9 304.5 307.7 320.9 322.9 4704.9 5213.6 5277.6 5299.1 5534.9 4438.5 5433.1 5466.5 5466.6 5474.3 3752.6 3866.3 3942.1 4003.6 4160.3 3749.7 3941.4 4118.3 4132.8 4177.9 3384.7 3388.9 4105.4 4118.6 4127.2 3436.5 3688.6 3912.4 4089.4 4097.8 3552.2 3561.9 3571.5 3571.8 3580.1 4353.4 5277.8 5296.0 5322.6 5331.5 4072.8 4567.9 4715.7 4723.6 4774.9 4314.5 4662.7 5691.1 5752.9 5755.8 3932.6 3947.5 3959.1 3967.6 3970.7 5446.7 5448.8 5840.0 5993.6 6016.0 3503.4 3886.3 3982.8 3986.2 3991.0 3417.0 4054.8 4066.3 4088.0 4092.4 3960.5 4520.7 4712.5 4735.4 4744.9 5042.0 5706.9 5714.4 5716.8 5777.3 1237.3 1369.4 1385.6 1387.2 1395.4 864.6 868.4 878.6 882.3 913.4 4182.6 4322.2 5308.0 5417.1 5429.0 5539.9 5868.2 5876.0 5883.3 5887.2 4664.4 5131.7 5182.8 5363.8 5367.8 3018.9 3066.5 3068.2 3069.2 3069.6 5392.9 6047.9 6051.2 6063.2 6111.5 5137.2 5177.1 5447.9 5885.2 6037.8 5348.7 5411.8 6013.1 6083.9 6094.4 5232.0 5576.7 5605.8 5848.9 5881.7 4854.8 5277.8 5782.9 5794.0 5812.7 5970.0 5995.5 6021.5 6082.1 6110.9 3349.5 3822.4 3915.8 3960.5 3974.5 4831.7 5668.5 5836.8 5838.5 5839.1 4682.6 5600.8 5603.3 5609.2 5627.6 5047.8 5424.7 5464.6 5666.3 5680.7 4819.6 4904.4 5297.9 5555.9 5587.7 5627.5 5666.0 5683.2 5685.8 5698.9 4616.5 5255.6 5534.8 5545.9 5546.8 02:39:34 INFO - PROCESS | 1651 | 02:39:34 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:23154.15 Median:4389.19 stddev:35366.94 (805.8%) stddev-sans-first:35426.29 02:39:34 INFO - PROCESS | 1651 | Values: 788.6 809.9 824.8 839.1 840.8 14355.5 14948.9 15486.1 15534.5 15768.3 14370.8 14400.9 14567.9 14576.1 14645.1 706.9 723.7 873.2 879.6 900.5 883.5 883.8 884.0 884.6 886.0 950.1 953.0 953.6 955.6 957.0 747.3 765.6 766.3 768.6 958.7 697.6 707.3 707.8 710.2 712.1 11976.6 14451.6 14457.0 14469.8 14472.9 14171.2 14350.0 14416.3 14443.8 14583.9 13125.8 13193.4 13201.3 13344.4 13590.0 4541.8 4798.6 4839.0 4859.3 4863.5 116587.0 116615.0 116975.0 117180.0 117227.0 11227.8 11394.3 11395.6 11421.5 11637.4 20627.9 21368.0 23027.5 23033.8 23090.0 8262.5 8300.1 8307.8 8327.0 8362.3 4590.2 4641.2 4663.7 4764.7 4790.0 3632.5 3718.5 3747.7 3761.4 3765.9 670.4 671.6 679.7 703.0 712.6 607.4 655.3 688.5 692.5 713.6 9451.8 9462.3 9741.5 9775.9 9936.5 536.0 567.9 602.4 645.3 681.6 4312.9 4465.5 4588.9 4645.5 4646.7 88532.6 88700.0 88874.1 89115.0 92905.0 125653.0 128418.0 130066.0 130330.0 130616.0 111897.0 112195.0 113252.4 113957.0 116661.4 8808.0 8923.9 8945.5 9117.6 9219.7 48169.8 51077.7 56356.2 57430.7 65310.0 55173.0 70891.0 89318.1 89503.1 90792.5 13407.7 13509.4 13663.3 13688.4 13983.6 12157.3 15245.9 15283.5 15485.2 16058.2 14291.8 14312.0 14434.8 14561.6 14677.0 13952.0 14236.0 14273.9 14274.1 14885.3 12605.1 12943.0 13023.3 13582.7 13724.9 11117.8 11152.5 11333.8 11481.6 11845.6 10232.8 10976.5 11169.5 11353.7 11592.1 02:39:34 INFO - PROCESS | 1651 | -------- Summary: end -------- 02:39:34 INFO - PROCESS | 1651 | 02:39:34 INFO - TEST-INFO | 1651: exit 0 02:39:34 INFO - TEST-OK | dromaeo_css | took 1116064ms 02:39:34 INFO - TEST-START | kraken 02:39:34 INFO - operating with platform_type : mac_ 02:39:34 INFO - Initialising browser for kraken test... 02:39:34 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpdnPCBe/profile http://localhost:49271/getInfo.html) 02:39:36 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 02:39:36 INFO - PROCESS | 1661 | colorDepth:24 02:39:36 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 02:39:36 INFO - PROCESS | 1661 | __metrics 02:39:37 INFO - PROCESS | 1661 | 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" 02:39:37 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:39:37 INFO - TEST-INFO | 1661: exit 0 02:39:37 INFO - Browser initialized. 02:39:37 INFO - Running cycle 1/1 for kraken test... 02:39:37 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/T/tmpdnPCBe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:39:49 INFO - PROCESS | 1662 | RSS: Main: 243904512 02:39:49 INFO - PROCESS | 1662 | 02:39:52 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 02:39:53 INFO - PROCESS | 1662 | RSS: Main: 294326272 02:39:53 INFO - PROCESS | 1662 | 02:39:56 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 02:39:57 INFO - PROCESS | 1662 | RSS: Main: 304713728 02:39:57 INFO - PROCESS | 1662 | 02:40:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 02:40:01 INFO - PROCESS | 1662 | RSS: Main: 391004160 02:40:01 INFO - PROCESS | 1662 | 02:40:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 02:40:03 INFO - PROCESS | 1662 | RSS: Main: 291262464 02:40:03 INFO - PROCESS | 1662 | 02:40:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:40:06 INFO - PROCESS | 1662 | RSS: Main: 294612992 02:40:06 INFO - PROCESS | 1662 | 02:40:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 02:40:10 INFO - PROCESS | 1662 | RSS: Main: 332197888 02:40:10 INFO - PROCESS | 1662 | 02:40:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 02:40:13 INFO - PROCESS | 1662 | RSS: Main: 333729792 02:40:13 INFO - PROCESS | 1662 | 02:40:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 02:40:16 INFO - PROCESS | 1662 | RSS: Main: 333250560 02:40:16 INFO - PROCESS | 1662 | 02:40:18 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:40:19 INFO - PROCESS | 1662 | RSS: Main: 311545856 02:40:19 INFO - PROCESS | 1662 | 02:40:20 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:40:21 INFO - PROCESS | 1662 | RSS: Main: 318926848 02:40:21 INFO - PROCESS | 1662 | 02:40:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:40:24 INFO - PROCESS | 1662 | RSS: Main: 315850752 02:40:24 INFO - PROCESS | 1662 | 02:40:27 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:40:28 INFO - PROCESS | 1662 | RSS: Main: 324927488 02:40:28 INFO - PROCESS | 1662 | 02:40:31 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:40:31 INFO - PROCESS | 1662 | RSS: Main: 328949760 02:40:31 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 02:40:33 INFO - PROCESS | 1662 | RSS: Main: 372305920 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | __start_tp_report 02:40:33 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 02:40:33 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 02:40:33 INFO - PROCESS | 1662 | |i|pagename|runs| 02:40:33 INFO - PROCESS | 1662 | |0;ai-astar;102;118;131;89;153;167;166;112;113;114 02:40:33 INFO - PROCESS | 1662 | |1;audio-beat-detection;170;136;105;158;120;96;149;136;153;105 02:40:33 INFO - PROCESS | 1662 | |2;audio-dft;183;184;186;186;183;183;180;185;184;182 02:40:33 INFO - PROCESS | 1662 | |3;audio-fft;78;73;58;88;58;81;60;60;72;75 02:40:33 INFO - PROCESS | 1662 | |4;audio-oscillator;83;89;93;71;73;67;96;70;67;100 02:40:33 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;87;86;133;129;88;84;89;84;87;84 02:40:33 INFO - PROCESS | 1662 | |6;imaging-darkroom;92;93;93;93;93;93;97;92;93;94 02:40:33 INFO - PROCESS | 1662 | |7;imaging-desaturate;88;87;87;86;87;88;86;88;86;88 02:40:33 INFO - PROCESS | 1662 | |8;json-parse-financial;54;53;52;54;52;54;52;52;52;51 02:40:33 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;67;67;76;77;72;69;71;70;71;74 02:40:33 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;83;83;84;86;85;77;85;97;97;99 02:40:33 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;135;139;138;136;133;139;147;141;173;144 02:40:33 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;163;169;163;213;185;163;165;166;227;200 02:40:33 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;65;66;68;67;67;66;69;83;84;82 02:40:33 INFO - PROCESS | 1662 | __end_tp_report 02:40:33 INFO - PROCESS | 1662 | __start_cc_report 02:40:33 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2052 02:40:33 INFO - PROCESS | 1662 | __end_cc_report 02:40:33 INFO - PROCESS | 1662 | __startTimestamp1469007633717__endTimestamp 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | ------- Summary: start ------- 02:40:33 INFO - PROCESS | 1662 | Number of tests: 14 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:126.50 Median:142.00 stddev:26.98 (19.0%) stddev-sans-first:27.12 02:40:33 INFO - PROCESS | 1662 | Values: 102.0 118.0 131.0 89.0 153.0 167.0 166.0 112.0 113.0 114.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:151.00 stddev:25.33 (16.8%) stddev-sans-first:23.01 02:40:33 INFO - PROCESS | 1662 | Values: 170.0 136.0 105.0 158.0 120.0 96.0 149.0 136.0 153.0 105.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.84 (1.0%) stddev-sans-first:1.94 02:40:33 INFO - PROCESS | 1662 | Values: 183.0 184.0 186.0 186.0 183.0 183.0 180.0 185.0 184.0 182.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:70.30 Median:74.00 stddev:10.72 (14.5%) stddev-sans-first:11.00 02:40:33 INFO - PROCESS | 1662 | Values: 78.0 73.0 58.0 88.0 58.0 81.0 60.0 60.0 72.0 75.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:80.90 Median:78.00 stddev:12.80 (16.4%) stddev-sans-first:13.56 02:40:33 INFO - PROCESS | 1662 | Values: 83.0 89.0 93.0 71.0 73.0 67.0 96.0 70.0 67.0 100.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:95.10 Median:86.50 stddev:19.02 (22.0%) stddev-sans-first:19.95 02:40:33 INFO - PROCESS | 1662 | Values: 87.0 86.0 133.0 129.0 88.0 84.0 89.0 84.0 87.0 84.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.00 stddev:1.42 (1.5%) stddev-sans-first:1.42 02:40:33 INFO - PROCESS | 1662 | Values: 92.0 93.0 93.0 93.0 93.0 93.0 97.0 92.0 93.0 94.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:87.10 Median:87.50 stddev:0.88 (1.0%) stddev-sans-first:0.87 02:40:33 INFO - PROCESS | 1662 | Values: 88.0 87.0 87.0 86.0 87.0 88.0 86.0 88.0 86.0 88.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:52.50 stddev:1.07 (2.0%) stddev-sans-first:1.01 02:40:33 INFO - PROCESS | 1662 | Values: 54.0 53.0 52.0 54.0 52.0 54.0 52.0 52.0 52.0 51.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.50 stddev:3.44 (4.8%) stddev-sans-first:3.26 02:40:33 INFO - PROCESS | 1662 | Values: 67.0 67.0 76.0 77.0 72.0 69.0 71.0 70.0 71.0 74.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:85.50 stddev:7.38 (8.6%) stddev-sans-first:7.64 02:40:33 INFO - PROCESS | 1662 | Values: 83.0 83.0 84.0 86.0 85.0 77.0 85.0 97.0 97.0 99.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:142.50 Median:140.00 stddev:11.49 (8.2%) stddev-sans-first:11.86 02:40:33 INFO - PROCESS | 1662 | Values: 135.0 139.0 138.0 136.0 133.0 139.0 147.0 141.0 173.0 144.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.40 Median:177.00 stddev:23.83 (13.5%) stddev-sans-first:24.33 02:40:33 INFO - PROCESS | 1662 | Values: 163.0 169.0 163.0 213.0 185.0 163.0 165.0 166.0 227.0 200.0 02:40:33 INFO - PROCESS | 1662 | 02:40:33 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:68.50 stddev:7.89 (11.5%) stddev-sans-first:7.99 02:40:33 INFO - PROCESS | 1662 | Values: 65.0 66.0 68.0 67.0 67.0 66.0 69.0 83.0 84.0 82.0 02:40:33 INFO - PROCESS | 1662 | -------- Summary: end -------- 02:40:33 INFO - PROCESS | 1662 | 02:40:34 INFO - TEST-INFO | 1662: exit 0 02:40:34 INFO - TEST-OK | kraken | took 59652ms 02:40:34 INFO - SUITE-END | took 1175s 02:40:34 INFO - Completed test suite (00:19:36) 02:40:34 INFO - javascript benchmark 02:40:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3179.348233612109, 3339.6994270515647, 3341.9331613367717, 3366.2930784535247, 3405.778624389416, 5563.221149039127, 5609.523190528805, 5619.80330688426, 5717.514011309038, 5721.227634269378, 4675.672702910798, 5619.157126431038, 5733.713314334287, 5742.741576629051, 5781.017227071397, 5131.666441681297, 5138.075146473652, 5186.974065129669, 5189.922151167735, 5306.522412982831, 5249.737513124348, 5326.920096198541, 5327.946720532803, 5329.2006199070065, 5336.252924590561, 5109.974450127745, 5141.53726164647, 5171.50870667286, 5199.896002079937, 5231.738413079331, 5120.462351453119, 5170.793168273264, 5234.659747116463, 5260.395054568736, 5311.7344132793205, 5108.386993560759, 5124.974375128138, 5161.200013997799, 5170.431252562215, 5243.9213411798855, 5685.658860468344, 5696.6866822324755, 5703.116017017369, 5759.280089988752, 5785.797497087582, 6067.660533345266, 6136.76416992428, 6180.165677633507, 6193.6903154842075, 6233.096201050822, 6219.1604133442315, 6266.937330626726, 6282.120503129566, 6320.020396838498, 6331.430171284606, 5662.292213473316, 5788.913166302509, 5820.0, 5842.444967728059, 5851.707414629252, 6203.47270482005, 6213.502919766408, 6264.874702505925, 6278.529110316745, 6284.874302513924, 6132.724027418777, 6156.29202641693, 6156.415140561639, 6162.291336496271, 6167.938320616826, 6225.190725205694, 6227.937720622826, 6274.749010039547, 6281.403266689657, 6313.779017734358, 5085.669431487016, 6108.615274519878, 6129.9701281150365, 6182.536309776785, 6186.0, 6258.624482531062, 6277.905831412532, 6287.748490060438, 6296.307406185316, 6300.30696623371, 4921.409430868247, 4931.457539670633, 4937.259411088366, 4942.35749352589, 4943.8022479101155, 3800.8407435731815, 4349.434573505424, 4362.672799540047, 4367.27939889921, 4430.091831174602, 5728.942710572841, 5732.713364331767, 5734.283214598176, 5750.396208398141, 5785.0, 6132.846678833065, 6244.344343843922, 6255.906161407583, 6264.749410023639, 6290.55966082379, 5629.4652008059165, 5680.431956804369, 5718.199452076713, 5720.713964301768, 5723.3418156912485, 5350.8662283442445, 5385.3268341457315, 5401.837944861661, 5419.024575576355, 5428.809991650273, 6281.2462504498835, 6282.057691346335, 6286.8428289292215, 6287.182666253358, 6301.8109456716375, 6100.793122958854, 6308.0, 6312.179416675803, 6331.778387756406, 6337.841553961188, 5027.673201242053, 6176.289726681489, 6260.280067792262, 6277.12120303167, 6287.622742635456, 6141.6007959482495, 6187.443130118311, 6198.2252218472695, 6200.007998720183, 6203.844903877259, 6134.773364742421, 6229.221347331583, 6295.370462953668, 6314.147590075281, 6319.304876463493, 5129.358830146231, 6086.969565152146, 6090.086487026804, 6138.539609529393, 6159.168512250789, 6155.630662160284, 6157.322694503511, 6167.938320616737, 6172.197614310111, 6186.597871138361, 5817.447342502455, 5900.616459930091, 5953.791617293374, 5965.731542080704, 5986.580939334205, 6088.452039316483, 6164.167837341902, 6180.0, 6185.381461853779, 6204.627722336674, 5954.791582294599, 5982.371850955587, 5989.700514974321, 6006.279246490449, 6027.0], "value": 5679.672245972679, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.6259648772201, 494.39436690054686, 531.9361676598809, 554.2572952243992, 558.4220331956426, 29367.853160734194, 40301.0, 40927.0, 40966.0, 41053.384199237, 37952.24095518088, 39205.0, 41821.37267940983, 42287.57712422875, 42469.938251543725, 8630.65477380904, 9590.999999999982, 9768.023197680246, 9775.266854985868, 9782.97278785728, 8592.226699597035, 9684.903150968506, 11637.185397022211, 11662.650120496399, 11939.641810745648, 11651.0, 11729.589464368748, 11730.530778768882, 11740.706482337968, 11743.06055515561, 8670.783230419227, 11418.657440276806, 11562.07503399726, 11624.593139240129, 11684.474198661039, 11603.593874214446, 11659.300441973424, 11683.766324673545, 11695.415229238504, 11722.0, 39569.0, 39828.0, 39843.0, 39844.0, 39885.0, 3385.5091011803397, 3437.4843773434186, 3718.7768733876055, 3945.250402423559, 4104.138130992465, 27010.0, 30237.79048838066, 32082.358352832813, 32396.838015810004, 32588.511172332433, 3319.8174100424467, 3323.1692076980753, 3360.4287271163716, 3393.881214157517, 3428.794272343642, 440522.0, 514227.0, 515882.4205879022, 516989.9999999962, 517293.0, 58483.4151658478, 58816.0, 59108.7044564783, 59241.703791480766, 59334.0, 34288.82855585756, 34561.827190863885, 34616.30767384638, 36289.63710362863, 36420.81789591035, 16540.255688494046, 16704.41534546285, 16712.41506547265, 16757.41349052777, 16758.162091895356, 11002.119830413547, 11657.533698652129, 11854.703632409259, 12750.234985900875, 12903.096783225084, 18965.051747412574, 19120.0, 19120.61758764817, 19251.22995080181, 19278.722617155116, 6898.344657257552, 7951.165127661512, 8042.9597852010365, 8049.195080492021, 8067.233612806774, 963.1957315641517, 1014.4630884210427, 1041.5885725138528, 1053.489057806963, 1057.6562617149457, 29743.0, 30001.249968750955, 30059.0, 30896.84551577228, 30927.91752288704, 1090.3239991205503, 1091.317926296065, 1104.2546281260118, 1122.4668282565715, 1127.7969965406305, 15708.978916370399, 15828.52514424569, 15837.68324633501, 15845.445409410615, 16149.35402583907, 734084.0, 735123.0, 740243.7804975589, 741512.0, 743055.0, 43386.13227735428, 43655.0, 43733.34399984003, 43787.562124378346, 43829.12341753147, 1246.5886257534992, 1392.7284179584883, 1399.9510017149555, 1427.0937954398823, 1434.5194359889554, 31013.0, 31021.224469388446, 31461.0, 31530.527042094847, 31867.043988680376, 43210.0, 49768.75115624399, 49782.0, 50035.0, 50125.749371254366, 561483.0, 583267.0, 583711.0, 584153.0, 585317.0, 23125.88437057804, 25422.872885635454, 26051.0, 26060.478790423706, 26153.73846261513, 47054.82362940954, 48242.64138737556, 48619.0, 49086.0, 49100.508994911026, 37475.063123421045, 39997.0, 40057.0, 40695.796521017204, 40938.795306023276, 37864.81067594644, 39249.607503925734, 39516.209675805745, 40379.59620403876, 40620.3906941402, 32421.513677294388, 38002.80998594989, 38606.80696596499, 38866.6113338863, 38882.2223555533, 33525.66474335323, 33932.0, 34412.655873441945, 34548.481772772924, 34773.13067173341, 21567.568648627253, 24343.878280608482, 25523.489530209663, 25717.614235786852, 25957.351066223495], "value": 20082.172897015804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.31232160322577, 365.9762115462495, 371.21117625046776, 372.84713267560295, 392.04732500024943, 15591.688166236669, 16206.513804585866, 16902.32390704372, 21069.0, 21265.99999999996, 20468.795312046874, 21134.577308453823, 21441.035153418095, 21494.355169344944, 22270.443238919033, 5118.0, 5946.405359464052, 6103.877922441548, 6124.356942521038, 6146.8463288417925, 5920.082387229986, 5968.313643930938, 6012.879742405149, 6021.036634138539, 6021.939780602203, 5627.465390787889, 5904.5571582131515, 5919.674417907014, 5955.88088238235, 5967.134765459005, 5854.707264636772, 5890.5582081343855, 5900.527957763368, 5908.320543137508, 5925.762969481216, 4466.307722303049, 4935.259711043373, 5147.0, 5165.483451654842, 5181.870453238662, 26190.0, 26322.86838565814, 26388.73611263882, 26469.867650661818, 26530.734692653212, 2063.546019875625, 2231.4532939429782, 2273.3293678364757, 2500.2874180858366, 3138.2311333723383, 9929.156021738161, 9930.702078937644, 10096.545655445523, 10359.378437293786, 10365.844512332322, 1830.0483748450863, 1899.6580615489206, 1921.193098898452, 1945.2510783348512, 1947.4157752674141, 127257.0, 127712.36143819221, 128966.0, 129589.70410295871, 129599.0, 9550.761230969281, 9854.408735475894, 10870.18473614482, 11629.767404651859, 11644.825327620092, 13905.930470347583, 14109.858901410855, 14116.929415353063, 14123.293835308194, 14128.434862605587, 8514.233718965323, 8567.614457349435, 8612.655493780305, 8668.0898505656, 8685.913140868637, 7277.38142257914, 8534.591792354193, 8621.267192288726, 8767.824643507221, 8793.20861122502, 4340.913181736348, 4406.669499787528, 4424.115176964556, 4461.330800379969, 4559.293309536961, 1625.910574918391, 1841.4659748672734, 1851.8240767127102, 1860.9162587683586, 1873.7751469823436, 911.4303560274828, 914.8353296406577, 943.5188054092463, 980.612658000086, 1025.1491262252462, 21605.567888642137, 22514.32457026259, 22558.774412255996, 22575.77424225737, 22705.205317813798, 837.8186756673061, 852.8891244138223, 934.4486752815872, 948.0, 1000.5147503460815, 10686.0, 11473.770524589629, 11563.595274165364, 11593.478293476814, 11620.53517859293, 525376.0, 528748.0, 546014.0, 612722.0, 613790.0, 130539.34730326288, 135186.0, 141262.0, 142567.2871635656, 144776.27611861873, 993.1905497019761, 994.1400688404623, 1024.3700124423426, 1045.5869931377063, 1049.1554298789547, 18717.344892928682, 19429.319973800848, 19858.261694403405, 20000.399988000383, 20049.498762531053, 57482.7125864368, 58211.835763285344, 58610.534736631926, 59245.0, 59407.405925940184, 61788.76422471616, 82642.0, 84350.0, 85100.57449712712, 85142.57428712817, 7102.325279098477, 7184.856302873809, 7429.5542267464125, 7457.47797654159, 7650.349720273839, 7423.072115985502, 10458.111060559937, 12460.626181214215, 13523.661908451973, 13931.651708707363, 11692.181547291608, 11788.76422471563, 11978.64064078079, 12063.276203427471, 12133.393330333625, 11167.939045790637, 11704.297742135499, 11753.294802311888, 11753.588624398448, 12072.75854482923, 8782.680350588162, 11875.703107422383, 11953.342566158944, 12107.576234831738, 12108.878911210775, 7419.258074192538, 7472.29013243741, 7506.662200200894, 7563.470557060953, 7653.6555854985545, 11395.487203076047, 11519.76960460803, 11569.768604628029, 11860.110491713329, 11992.520299187934], "value": 9611.197581599381, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1386.840513340966, 1529.9694006119873, 1578.203007481222, 1764.1179410294853, 1899.9810001899984, 7839.137694853569, 8643.222110010098, 8899.33255005874, 8901.599428025738, 8985.415947963378, 8640.135986401358, 8719.17167869053, 8813.647454101829, 8824.867626985584, 8827.86758198626, 2259.1302348595746, 2322.651602259662, 2357.1985524921524, 2357.811375089989, 2362.007956658199, 1987.9503012424661, 2298.8965496552696, 2334.5564342774906, 2337.474068334628, 2339.0, 1980.2574034736974, 2302.9424264393356, 2335.4628435459854, 2338.240071976606, 2339.777721116491, 2279.589673858705, 2295.908163673451, 2302.021640802652, 2304.5045315257134, 2304.7925686688195, 2301.528186721718, 2306.2274138163734, 2308.284431826139, 2308.365199570115, 2309.2379514760087, 8755.956220218859, 8861.689840855604, 8879.778005549848, 8931.821363572692, 8942.0, 4821.54195351441, 5298.788048478056, 5300.575953923677, 5313.229581710631, 5314.60140489461, 3356.597208334991, 3456.948145777815, 3500.789952602852, 3509.578850537952, 3515.2793677296095, 1018.8828284747275, 1032.4321623107337, 1040.5785656809005, 1052.6210564196883, 1053.3574519543072, 11692.590759323468, 11775.411229438494, 11779.293242405398, 11799.469023893946, 11808.645740627795, 4288.52826189119, 4335.7615331157085, 4476.2837945928495, 4477.910441791146, 4489.057297967398, 9224.169824715807, 9261.583228754722, 9262.120098590623, 9262.72211833646, 9263.351565390358, 5136.409312928986, 5139.743012849342, 5139.743012849342, 5142.280080788692, 5208.817691380784, 4286.657067434598, 4451.554844515587, 4608.0, 4753.643476739258, 4797.232442809134, 3641.1443310821937, 3644.6173151819207, 3730.9440358394645, 3755.530558680165, 3770.5663848657205, 1091.781643671269, 1115.1970581181536, 1117.4301106435614, 1127.4081107418506, 1130.2822707580744, 660.3330636057616, 821.2485575698289, 891.148952750122, 892.0767006148606, 977.5845265762023, 6056.697165141725, 6107.114468402146, 6157.753689852445, 6198.752049917953, 6324.968375158095, 932.7201839448138, 937.901520340368, 988.8170688422665, 1001.0640051551823, 1021.0912288063629, 3936.232434675268, 4111.383292506088, 4121.8969525761495, 4126.607972242632, 4178.206140833232, 10293.330933489298, 10812.35125892449, 10813.459327033774, 10844.349339039683, 10848.566057357775, 10637.255392122632, 10753.51609177589, 10762.56949722018, 10771.892281077246, 10791.6222932197, 8257.504549727035, 8371.330293576499, 8371.95814020926, 8383.490971625044, 8392.748217553482, 5379.838604841861, 5428.267183930119, 5574.219609254788, 5636.351819540805, 6048.818535443944, 9852.458114803754, 10112.089911907964, 10160.54277557497, 10178.49107544605, 10180.745481362728, 10013.849792252977, 10060.949695251476, 10164.644237451654, 10252.077313041862, 10409.635662751767, 7644.159142494433, 7713.807154821175, 7804.609769511389, 7810.921890781019, 7815.062192536705, 8275.255227029596, 8399.70601028961, 8422.32621390275, 8451.492910425393, 8473.025602055843, 7607.619619018917, 7608.8478230436185, 7682.347000505019, 7701.537907725555, 7772.650230739743, 7503.287187717158, 7520.323170914644, 7523.7366692165515, 7620.504667196615, 7669.693212271447, 6923.376896079176, 7045.788626341218, 7085.716571337089, 7086.716531338689, 7092.858142837217, 5116.9744151279, 5158.406783219978, 5178.456262092426, 5188.870278243074, 5291.0, 5109.795608175631, 5158.535731784157, 5240.397354304151, 5369.167778994106, 5396.1366181410785], "value": 4557.624969336004, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.92701824543855, 304.54318522216676, 307.66618219232134, 320.93420848726015, 322.9192701824544, 4704.929426058612, 5213.582913366931, 5277.630565860387, 5299.072662284099, 5534.889302213954, 4438.467383913927, 5433.071259702808, 5466.480684334992, 5466.644668096581, 5474.2609747684055, 3752.555266222497, 3866.3427217372973, 3942.132730799227, 4003.579624139467, 4160.313548264533, 3749.737518373715, 3941.4481972523868, 4118.299889018874, 4132.793360331986, 4177.916441671165, 3384.661533846608, 3388.8644454221803, 4105.4252404663375, 4118.608732170454, 4127.236461254663, 3436.4501679731247, 3688.5942546319884, 3912.39357899526, 4089.427480152781, 4097.7541347518945, 3552.236269202134, 3561.94657080144, 3571.5357003589365, 3571.821408929543, 3580.051286409104, 4353.368761529592, 5277.8416647500635, 5296.0, 5322.600804939606, 5331.5201631853315, 4072.7759973201464, 4567.931481027754, 4715.669903106784, 4723.598494128003, 4774.8540350316025, 4314.546972567867, 4662.696924699918, 5691.146328050784, 5752.856178595527, 5755.7625110601, 3932.6460618544183, 3947.50656167979, 3959.1487830116375, 3967.6230758077936, 3970.68234541236, 5446.673199608076, 5448.809291674773, 5840.0, 5993.550483713739, 6016.0, 3503.386907291214, 3886.261610294035, 3982.8008599569907, 3986.242613903349, 3991.022199561126, 3416.965830341665, 4054.7972601369815, 4066.3493840985893, 4087.9591204088174, 4092.3861420786525, 3960.485136932238, 4520.666403411002, 4712.52874712526, 4735.431748190239, 4744.905101897943, 5042.0, 5706.942930570641, 5714.428557144252, 5716.771329146871, 5777.30672319316, 1237.3194742891374, 1369.4453746232791, 1385.625881012121, 1387.1746310944973, 1395.3581352577726, 864.5849992003873, 868.431177578687, 878.6046279174398, 882.2544949517647, 913.3789023464108, 4182.602652747984, 4322.200392927319, 5308.0, 5417.12892167152, 5429.0, 5539.861503462365, 5868.18327202945, 5875.970620146957, 5883.294004719461, 5887.234659494324, 4664.3936288282985, 5131.692098474104, 5182.844514664566, 5363.785448582013, 5367.75845086972, 3018.894338698135, 3066.5246886732148, 3068.156257029335, 3069.173841564266, 3069.634012864254, 5392.865178370572, 6047.909281360783, 6051.245138909755, 6063.211782468251, 6111.480524155408, 5137.2037334213255, 5177.145770947826, 5447.906523855891, 5885.205497257901, 6037.792441511628, 5348.705821179872, 5411.810586629449, 6013.12153660895, 6083.908741368883, 6094.39056094387, 5231.979763945994, 5576.721163941867, 5605.831825045255, 5848.912266316093, 5881.735321910439, 4854.78153483087, 5277.8416647500635, 5782.855428614318, 5793.9860524408905, 5812.680302583399, 5969.970150149222, 5995.46040856325, 6021.494626343414, 6082.118092876596, 6110.908336375047, 3349.5310656508595, 3822.4266360046217, 3915.804209789556, 3960.5445373782386, 3974.463447434675, 4831.685940414002, 5668.5465162787705, 5836.824895253149, 5838.503727183237, 5839.0512791040255, 4682.555157260055, 5600.803971860965, 5603.2909962461845, 5609.242752228397, 5627.606067575231, 5047.845096814491, 5424.698072462659, 5464.64479808827, 5666.263385759825, 5680.6591604503865, 4819.590334821439, 4904.411470623548, 5297.920531192112, 5555.8888822222525, 5587.69267690281, 5627.465390788032, 5665.951798917214, 5683.204351390726, 5685.829425117253, 5698.914516282176, 4616.469106052713, 5255.579553635624, 5534.833954981357, 5545.916811247916, 5546.833594992157], "value": 4126.618405031623, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.562347896917, 809.9433039687223, 824.8102936324649, 839.1021606880632, 840.8486472434961, 14355.497557585486, 14948.935468228987, 15486.148261845594, 15534.456294029696, 15768.290426930787, 14370.784438233435, 14400.927995360034, 14567.927160364183, 14576.125432474058, 14645.121292722417, 706.883364244899, 723.7105157936841, 873.1792115411524, 879.560219890055, 900.4822227219342, 883.4655033704613, 883.765802062454, 884.0496466298722, 884.5621417398397, 885.9867101993475, 950.0546955778975, 952.9714108576753, 953.5994882149479, 955.6177528988391, 956.9665061722841, 747.2602123897357, 765.5942350554216, 766.2873527619312, 768.6310570925931, 958.650092716157, 697.6407150317591, 707.3386383731176, 707.7664370757689, 710.2294010998073, 712.0600806934848, 11976.640700778991, 14451.638709032253, 14457.0, 14469.78295325571, 14472.855271447255, 14171.220582867938, 14350.0, 14416.279186040761, 14443.78334324986, 14583.927080364636, 13125.803112953314, 13193.40629671667, 13201.339933003312, 13344.399502022336, 13590.0, 4541.818327266906, 4798.568128868418, 4839.008003359303, 4859.343988561534, 4863.53796389346, 116586.99999999916, 116615.0, 116975.0, 117180.0, 117227.0, 11227.775444491228, 11394.3163410194, 11395.601153959571, 11421.486033128529, 11637.359945202927, 20627.896860515903, 21368.0, 23027.539449210923, 23033.769662303497, 23090.0, 8262.504249745034, 8300.148588410104, 8307.792305192419, 8326.958365208135, 8362.289205417608, 4590.2196626572895, 4641.164590373698, 4663.650226233046, 4764.6664733469015, 4789.95210047902, 3632.4914511968345, 3718.4608231806237, 3747.662710356081, 3761.4357846322723, 3765.8681946131755, 670.4100391655312, 671.5802623360399, 679.7077256779534, 703.0, 712.6045044999971, 607.401709316323, 655.3119224814021, 688.4526801192964, 692.5394612582576, 713.5575942915322, 9451.810963780823, 9462.29032822541, 9741.512924353754, 9775.853362199572, 9936.489751189318, 535.9812406565751, 567.9290088738908, 602.3977405147072, 645.3224114679567, 681.5842336175028, 4312.870613881589, 4465.508794032654, 4588.908221835544, 4645.466995891347, 4646.697964632288, 88532.5573372142, 88700.0, 88874.11192384352, 89115.0, 92905.0, 125653.0, 128418.0, 130066.0, 130330.0, 130616.0, 111897.0, 112195.0, 113252.43373783078, 113957.0, 116661.416692916, 8808.0, 8923.866142008004, 8945.463272203428, 9117.589708463267, 9219.677311294072, 48169.7957551064, 51077.74461127671, 56356.15465767935, 57430.7128464355, 65310.0, 55173.0, 70891.0, 89318.10681893097, 89503.10496894948, 90792.54603727203, 13407.664808379868, 13509.392077356346, 13663.316834158451, 13688.384022719201, 13983.580492585239, 12157.331346776013, 15245.923770381078, 15283.46507872219, 15485.225738712794, 16058.197090145679, 14291.785623215452, 14311.988964635086, 14434.783478247624, 14561.635959101108, 14677.0, 13952.0, 14236.003479756318, 14273.928630357197, 14274.112077332915, 14885.330160143036, 12605.117641764988, 12943.0, 13023.348832558144, 13582.660433489242, 13724.862751372759, 11117.777644447227, 11152.498137583665, 11333.829992550283, 11481.598144065252, 11845.644630661094, 10232.795344093225, 10976.451177440937, 11169.497372618089, 11353.659390218307, 11592.1305902056], "value": 7864.03487164141, "unit": "score"}], "name": "dromaeo_css", "value": 7384.526620110025, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 118.0, 131.0, 89.0, 153.0, 167.0, 166.0, 112.0, 113.0, 114.0], "value": 126.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 136.0, 105.0, 158.0, 120.0, 96.0, 149.0, 136.0, 153.0, 105.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 186.0, 186.0, 183.0, 183.0, 180.0, 185.0, 184.0, 182.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 58.0, 88.0, 58.0, 81.0, 60.0, 60.0, 72.0, 75.0], "value": 70.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 89.0, 93.0, 71.0, 73.0, 67.0, 96.0, 70.0, 67.0, 100.0], "value": 80.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 133.0, 129.0, 88.0, 84.0, 89.0, 84.0, 87.0, 84.0], "value": 95.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 93.0, 93.0, 93.0, 97.0, 92.0, 93.0, 94.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 86.0, 87.0, 88.0, 86.0, 88.0, 86.0, 88.0], "value": 87.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 54.0, 52.0, 54.0, 52.0, 52.0, 52.0, 51.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 76.0, 77.0, 72.0, 69.0, 71.0, 70.0, 71.0, 74.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 86.0, 85.0, 77.0, 85.0, 97.0, 97.0, 99.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 139.0, 138.0, 136.0, 133.0, 139.0, 147.0, 141.0, 173.0, 144.0], "value": 142.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 169.0, 163.0, 213.0, 185.0, 163.0, 165.0, 166.0, 227.0, 200.0], "value": 181.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 68.0, 67.0, 67.0, 66.0, 69.0, 83.0, 84.0, 82.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1476.8, "alertThreshold": 2.0}]} 02:40:34 INFO - Return code: 0 02:40:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:40:34 INFO - # TBPL SUCCESS # 02:40:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:40:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:40:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:40:34 INFO - 2016-07-20 02:40:34.993 screenresolution[1666:9637] starting screenresolution argv=screenresolution get 02:40:34 INFO - 2016-07-20 02:40:34.995 screenresolution[1666:9637] Display 0: 1600x1200x32@60 02:40:35 INFO - 2016-07-20 02:40:35.001 screenresolution[1667:9640] starting screenresolution argv=screenresolution list 02:40:35 INFO - Available Modes on Display 0 02:40:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:40:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:40:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:40:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:40:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:40:35 INFO - Intel Iris: 02:40:35 INFO - Chipset Model: Intel Iris 02:40:35 INFO - Type: GPU 02:40:35 INFO - Bus: Built-In 02:40:35 INFO - VRAM (Dynamic, Max): 1536 MB 02:40:35 INFO - Vendor: Intel (0x8086) 02:40:35 INFO - Device ID: 0x0a2e 02:40:35 INFO - Revision ID: 0x0009 02:40:35 INFO - Displays: 02:40:35 INFO - Display: 02:40:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:40:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:40:35 INFO - Display Serial Number: 1600x1200 60 02:40:35 INFO - Main Display: Yes 02:40:35 INFO - Mirror: Off 02:40:35 INFO - Online: Yes 02:40:35 INFO - Rotation: Supported 02:40:35 INFO - Return code: 0 02:40:35 INFO - Running post-action listener: _resource_record_post_action 02:40:35 INFO - ##### 02:40:35 INFO - ##### Finished run-tests step (success) 02:40:35 INFO - ##### 02:40:35 INFO - Running post-run listener: _resource_record_post_run 02:40:35 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 36730368; Write bytes: 702380544; Read time: 230; Write time: 1948 02:40:35 INFO - TinderboxPrint: CPU usage
53.4% 02:40:35 INFO - TinderboxPrint: I/O read bytes / time
36,730,368 / 230 02:40:35 INFO - TinderboxPrint: I/O write bytes / time
702,380,544 / 1,948 02:40:35 INFO - TinderboxPrint: CPU idle
2,256.7 (46.6%) 02:40:35 INFO - TinderboxPrint: CPU system
964.8 (19.9%) 02:40:35 INFO - TinderboxPrint: CPU user
1,624.1 (33.5%) 02:40:35 INFO - TinderboxPrint: Swap in / out
444,215,296 / 0 02:40:35 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 384713216; Write bytes: 379602432; Read time: 29201; Write time: 825 02:40:35 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 35784192; Write bytes: 292357120; Read time: 219; Write time: 1058 02:40:35 INFO - Running post-run listener: _upload_blobber_files 02:40:35 INFO - Blob upload gear active. 02:40:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:40:35 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 02:40:35 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'] 02:40:35 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 02:40:36 INFO - (blobuploader) - INFO - Open directory for files ... 02:40:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:40:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:40:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:36 INFO - (blobuploader) - INFO - Done attempting. 02:40:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:40:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:40:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:37 INFO - (blobuploader) - INFO - Done attempting. 02:40:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:40:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:40:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:40:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:40:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:40:42 INFO - (blobuploader) - INFO - Done attempting. 02:40:42 INFO - (blobuploader) - INFO - Iteration through files over. 02:40:42 INFO - Return code: 0 02:40:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:40:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:40:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbf3d0fb3fb8c31d6c49b03dc8a55c379e163800b7e7c5f1bab45dab3b42b52f8f6c273e2cea211296764dc56ca2f260873228c577ce7035d2da12e6f2d3c9bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d19302294e1939a5a3c44e1dfff9149f505881268a1e007c215fbca0a2b9c3c2e49f5dfe581cd7337ff3bc7748986a7bc4670d9c75bebbcb339ba4ea0cac71b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b325645f35c20827efa5f164bfdab68e96b71ee3e5f7d2cd08956c71abe145c9c6982af277c0620d730df7c21ce1720639c78314aa60c82dc4d26b3e32d12c46"} 02:40:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:40:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:40:42 INFO - Contents: 02:40:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbf3d0fb3fb8c31d6c49b03dc8a55c379e163800b7e7c5f1bab45dab3b42b52f8f6c273e2cea211296764dc56ca2f260873228c577ce7035d2da12e6f2d3c9bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d19302294e1939a5a3c44e1dfff9149f505881268a1e007c215fbca0a2b9c3c2e49f5dfe581cd7337ff3bc7748986a7bc4670d9c75bebbcb339ba4ea0cac71b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b325645f35c20827efa5f164bfdab68e96b71ee3e5f7d2cd08956c71abe145c9c6982af277c0620d730df7c21ce1720639c78314aa60c82dc4d26b3e32d12c46"} 02:40:42 INFO - Running post-run listener: copy_logs_to_upload_dir 02:40:42 INFO - Copying logs to upload dir... 02:40:42 INFO - mkdir: /builds/slave/test/build/upload/logs 02:40:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.421741 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-07-20 02:40:42.207519) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 02:40:42.211159) ========= 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.twLUViFER1/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.UN6GfH8kxh/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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/cbf3d0fb3fb8c31d6c49b03dc8a55c379e163800b7e7c5f1bab45dab3b42b52f8f6c273e2cea211296764dc56ca2f260873228c577ce7035d2da12e6f2d3c9bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d19302294e1939a5a3c44e1dfff9149f505881268a1e007c215fbca0a2b9c3c2e49f5dfe581cd7337ff3bc7748986a7bc4670d9c75bebbcb339ba4ea0cac71b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b325645f35c20827efa5f164bfdab68e96b71ee3e5f7d2cd08956c71abe145c9c6982af277c0620d730df7c21ce1720639c78314aa60c82dc4d26b3e32d12c46"} build_url:https://queue.taskcluster.net/v1/task/FPxjAabvTniNATYgb14gGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/FPxjAabvTniNATYgb14gGA/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/cbf3d0fb3fb8c31d6c49b03dc8a55c379e163800b7e7c5f1bab45dab3b42b52f8f6c273e2cea211296764dc56ca2f260873228c577ce7035d2da12e6f2d3c9bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d19302294e1939a5a3c44e1dfff9149f505881268a1e007c215fbca0a2b9c3c2e49f5dfe581cd7337ff3bc7748986a7bc4670d9c75bebbcb339ba4ea0cac71b8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b325645f35c20827efa5f164bfdab68e96b71ee3e5f7d2cd08956c71abe145c9c6982af277c0620d730df7c21ce1720639c78314aa60c82dc4d26b3e32d12c46"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 02:40:42.246154) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 02:40:42.246771) ========= 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.twLUViFER1/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.UN6GfH8kxh/Listeners TMPDIR=/var/folders/2b/6mwmwf0s0bq77rvdxxl4xn9h00000w/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.005163 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 02:40:42.296622) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 02:40:42.296944) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 02:40:42.297291) ========= ========= Total master_lag: 0.18 =========