builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0253 starttime: 1471976079.88 results: success (0) buildid: 20160823071247 builduid: 5eb627eec68c4db8a2ce58f5ab029c6a revision: 1b93a25d0fe22bd10bae50eb705a25616f84477c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:39.875875) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:39.876348) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:39.876638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:39.902714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:39.903068) ========= 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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-08-23 11:14:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2016-08-23 11:14:40 (18.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:40.052245) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:40.052577) ========= 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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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.035342 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:40.109321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:40.109687) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1b93a25d0fe22bd10bae50eb705a25616f84477c --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 1b93a25d0fe22bd10bae50eb705a25616f84477c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MhUvbgJcg6/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.wyzIO7UpsC/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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-08-23 11:14:40,193 truncating revision to first 12 chars 2016-08-23 11:14:40,193 Setting DEBUG logging. 2016-08-23 11:14:40,193 attempt 1/10 2016-08-23 11:14:40,193 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1b93a25d0fe2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-23 11:14:40,806 unpacking tar archive at: fx-team-1b93a25d0fe2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.875838 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:41.007629) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:41.008099) ========= script_repo_revision: 1b93a25d0fe22bd10bae50eb705a25616f84477c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:41.008670) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:41.009070) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-23 11:14:41.028680) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-23 11:14:41.029202) ========= /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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:14:41 INFO - MultiFileLogger online at 20160823 11:14:41 in /builds/slave/test 11:14:41 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 11:14:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:14:41 INFO - {'append_to_log': False, 11:14:41 INFO - 'base_work_dir': '/builds/slave/test', 11:14:41 INFO - 'blob_upload_branch': 'Fx-Team', 11:14:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:14:41 INFO - 'branch': 'Fx-Team', 11:14:41 INFO - 'buildbot_json_path': 'buildprops.json', 11:14:41 INFO - 'config_files': ('talos/mac_config.py',), 11:14:41 INFO - 'default_actions': ('clobber', 11:14:41 INFO - 'read-buildbot-config', 11:14:41 INFO - 'download-and-extract', 11:14:41 INFO - 'populate-webroot', 11:14:41 INFO - 'create-virtualenv', 11:14:41 INFO - 'install', 11:14:41 INFO - 'run-tests'), 11:14:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:14:41 INFO - 'download_minidump_stackwalk': True, 11:14:41 INFO - 'download_symbols': 'ondemand', 11:14:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:14:41 INFO - 'tooltool.py': '/tools/tooltool.py', 11:14:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:14:41 INFO - '/tools/misc-python/virtualenv.py')}, 11:14:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:14:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:14:41 INFO - 'installer_path': 'installer.exe', 11:14:41 INFO - 'log_level': 'info', 11:14:41 INFO - 'log_name': 'talos', 11:14:41 INFO - 'log_to_console': True, 11:14:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:14:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:14:41 INFO - 'opt_config_files': (), 11:14:41 INFO - 'pip_index': False, 11:14:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:14:41 INFO - 'cmd': ('bash', 11:14:41 INFO - '-c', 11:14:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:14:41 INFO - 'enabled': True, 11:14:41 INFO - 'halt_on_failure': False, 11:14:41 INFO - 'name': 'check_screen_resolution'},), 11:14:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:14:41 INFO - 'cmd': ('bash', 11:14:41 INFO - '-c', 11:14:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:14:41 INFO - 'enabled': True, 11:14:41 INFO - 'halt_on_failure': False, 11:14:41 INFO - 'name': 'check_screen_resolution'},), 11:14:41 INFO - 'run_cmd_checks_enabled': True, 11:14:41 INFO - 'sps_profile': False, 11:14:41 INFO - 'sps_profile_interval': 0, 11:14:41 INFO - 'suite': 'dromaeojs', 11:14:41 INFO - 'system_bits': '32', 11:14:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:14:41 INFO - 'title': 't-yosemite-r7-0253', 11:14:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:14:41 INFO - 'use_talos_json': True, 11:14:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:14:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:14:41 INFO - 'work_dir': 'build'} 11:14:41 INFO - [mozharness: 2016-08-23 18:14:41.211983Z] Running clobber step. 11:14:41 INFO - Running pre-action listener: _resource_record_pre_action 11:14:41 INFO - Running main action method: clobber 11:14:41 INFO - rmtree: /builds/slave/test/build 11:14:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:14:43 INFO - Running post-action listener: _resource_record_post_action 11:14:43 INFO - [mozharness: 2016-08-23 18:14:43.172788Z] Finished clobber step (success) 11:14:43 INFO - [mozharness: 2016-08-23 18:14:43.172902Z] Running read-buildbot-config step. 11:14:43 INFO - Running pre-action listener: _resource_record_pre_action 11:14:43 INFO - Running main action method: read_buildbot_config 11:14:43 INFO - Using buildbot properties: 11:14:43 INFO - { 11:14:43 INFO - "project": "", 11:14:43 INFO - "product": "firefox", 11:14:43 INFO - "script_repo_revision": "production", 11:14:43 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:14:43 INFO - "repository": "", 11:14:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:14:43 INFO - "buildid": "20160823071247", 11:14:43 INFO - "pgo_build": "False", 11:14:43 INFO - "basedir": "/builds/slave/test", 11:14:43 INFO - "buildnumber": 927, 11:14:43 INFO - "slavename": "t-yosemite-r7-0253", 11:14:43 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:14:43 INFO - "platform": "yosemite_r7", 11:14:43 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:14:43 INFO - "branch": "fx-team", 11:14:43 INFO - "repo_path": "integration/fx-team", 11:14:43 INFO - "revision": "1b93a25d0fe22bd10bae50eb705a25616f84477c", 11:14:43 INFO - "stage_platform": "macosx64", 11:14:43 INFO - "builduid": "5eb627eec68c4db8a2ce58f5ab029c6a", 11:14:43 INFO - "slavebuilddir": "test" 11:14:43 INFO - } 11:14:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 11:14:43 INFO - Running post-action listener: _resource_record_post_action 11:14:43 INFO - [mozharness: 2016-08-23 18:14:43.175747Z] Finished read-buildbot-config step (success) 11:14:43 INFO - [mozharness: 2016-08-23 18:14:43.175853Z] Running download-and-extract step. 11:14:43 INFO - Running pre-action listener: _resource_record_pre_action 11:14:43 INFO - Running main action method: download_and_extract 11:14:43 INFO - mkdir: /builds/slave/test/build/tests 11:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:43 INFO - trying https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 11:14:43 INFO - Downloading https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:14:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 11:14:44 INFO - Downloaded 1199 bytes. 11:14:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 11:14:44 INFO - Using the following test package requirements: 11:14:44 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:14:44 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:14:44 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 11:14:44 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:14:44 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 11:14:44 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:14:44 INFO - u'jsshell-mac.zip'], 11:14:44 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:14:44 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 11:14:44 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 11:14:44 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:14:44 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 11:14:44 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:14:44 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 11:14:44 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:14:44 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 11:14:44 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 11:14:44 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 11:14:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:44 INFO - trying https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:14:44 INFO - Downloading https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:14:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:14:45 INFO - Downloaded 16346230 bytes. 11:14:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:14:51 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:14:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:51 INFO - trying https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:14:51 INFO - Downloading https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 11:14:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:14:52 INFO - Downloaded 16346230 bytes. 11:14:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 11:14:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:14:59 INFO - trying https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:14:59 INFO - Downloading https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 11:14:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:15:00 INFO - Downloaded 14413981 bytes. 11:15:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 11:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:01 INFO - trying https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:15:01 INFO - Downloading https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 11:15:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 11:15:04 INFO - Downloaded 111489837 bytes. 11:15:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:15:04 INFO - mkdir: /builds/slave/test/properties 11:15:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:15:04 INFO - Writing to file /builds/slave/test/properties/build_url 11:15:04 INFO - Contents: 11:15:04 INFO - build_url:https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 11:15:04 INFO - Running post-action listener: _resource_record_post_action 11:15:04 INFO - Running post-action listener: set_extra_try_arguments 11:15:04 INFO - [mozharness: 2016-08-23 18:15:04.868211Z] Finished download-and-extract step (success) 11:15:04 INFO - [mozharness: 2016-08-23 18:15:04.868324Z] Running populate-webroot step. 11:15:04 INFO - Running pre-action listener: _resource_record_pre_action 11:15:04 INFO - Running main action method: populate_webroot 11:15:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:15:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:15:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:15:04 INFO - '--tppagecycles', 11:15:04 INFO - '7'], 11:15:04 INFO - 'tests': ['tsvgm']}}, 11:15:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:15:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:15:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:15:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:15:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:15:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:15:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:04 INFO - 'talos_options': ['--disable-e10s'], 11:15:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:15:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:04 INFO - 'talos_options': ['--disable-e10s'], 11:15:04 INFO - 'tests': ['damp', 'tps']}, 11:15:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:04 INFO - 'tests': ['damp', 'tps']}, 11:15:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:15:04 INFO - 'tests': ['dromaeo_dom']}, 11:15:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:15:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:15:04 INFO - 'tests': ['basic_compositor_video']}, 11:15:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:15:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:15:04 INFO - 'tests': ['a11yr', 11:15:04 INFO - 'ts_paint', 11:15:04 INFO - 'tpaint', 11:15:04 INFO - 'sessionrestore', 11:15:04 INFO - 'sessionrestore_no_auto_restore', 11:15:04 INFO - 'tabpaint']}, 11:15:04 INFO - 'other-e10s': {'tests': ['a11yr', 11:15:04 INFO - 'ts_paint', 11:15:04 INFO - 'tpaint', 11:15:04 INFO - 'sessionrestore', 11:15:04 INFO - 'sessionrestore_no_auto_restore', 11:15:04 INFO - 'tabpaint']}, 11:15:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:15:04 INFO - 'ts_paint', 11:15:04 INFO - 'tpaint', 11:15:04 INFO - 'sessionrestore', 11:15:04 INFO - 'sessionrestore_no_auto_restore', 11:15:04 INFO - 'tabpaint']}, 11:15:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:15:04 INFO - 'ts_paint', 11:15:04 INFO - 'tpaint', 11:15:04 INFO - 'sessionrestore', 11:15:04 INFO - 'sessionrestore_no_auto_restore', 11:15:04 INFO - 'tabpaint']}, 11:15:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:15:04 INFO - 'tests': ['a11yr', 11:15:04 INFO - 'ts_paint', 11:15:04 INFO - 'tpaint', 11:15:04 INFO - 'sessionrestore', 11:15:04 INFO - 'sessionrestore_no_auto_restore', 11:15:04 INFO - 'tabpaint']}, 11:15:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:15:04 INFO - 'tests': ['a11yr', 11:15:04 INFO - 'ts_paint', 11:15:04 INFO - 'tpaint', 11:15:04 INFO - 'sessionrestore', 11:15:04 INFO - 'sessionrestore_no_auto_restore', 11:15:04 INFO - 'tabpaint']}, 11:15:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:15:04 INFO - 'tests': ['tsvgx', 11:15:04 INFO - 'tsvgr_opacity', 11:15:04 INFO - 'tart', 11:15:04 INFO - 'tscrollx', 11:15:04 INFO - 'cart']}, 11:15:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:15:04 INFO - 'tsvgr_opacity', 11:15:04 INFO - 'tart', 11:15:04 INFO - 'tscrollx', 11:15:04 INFO - 'cart']}, 11:15:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:04 INFO - 'talos_options': ['--disable-e10s'], 11:15:04 INFO - 'tests': ['tp5o']}, 11:15:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:04 INFO - 'tests': ['tp5o']}, 11:15:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:04 INFO - 'talos_options': ['--disable-e10s', 11:15:04 INFO - '--xperf_path', 11:15:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:04 INFO - 'tests': ['tp5n']}, 11:15:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:15:04 INFO - 'talos_options': ['--xperf_path', 11:15:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:15:04 INFO - 'tests': ['tp5n']}}, 11:15:04 INFO - 'talos.zip': {'path': '', 11:15:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:15:04 INFO - Running post-action listener: _resource_record_post_action 11:15:04 INFO - [mozharness: 2016-08-23 18:15:04.887798Z] Finished populate-webroot step (success) 11:15:04 INFO - [mozharness: 2016-08-23 18:15:04.887914Z] Running create-virtualenv step. 11:15:04 INFO - Running pre-action listener: _resource_record_pre_action 11:15:04 INFO - Running main action method: create_virtualenv 11:15:04 INFO - Creating virtualenv /builds/slave/test/build/venv 11:15:04 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 11:15:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:15:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:15:05 INFO - Using real prefix '/tools/python27' 11:15:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:15:05 INFO - Installing distribute.............................................................................................................................................................................................done. 11:15:08 INFO - Installing pip.................done. 11:15:08 INFO - Return code: 0 11:15:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec97a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed2c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b1cc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebfbd30>, '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 0x10e960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebf3b20>, '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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:15: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', 'pip>=1.5'] in /builds/slave/test/build 11:15: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 pip>=1.5 11:15:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MhUvbgJcg6/Render', 11:15:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:08 INFO - 'HOME': '/Users/cltbld', 11:15:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:08 INFO - 'LOGNAME': 'cltbld', 11:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:08 INFO - 'MOZ_NO_REMOTE': '1', 11:15:08 INFO - 'NO_EM_RESTART': '1', 11:15:08 INFO - 'PAGER': '/bin/cat', 11:15:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:08 INFO - 'PWD': '/builds/slave/test', 11:15:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:08 INFO - 'SHELL': '/bin/bash', 11:15:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wyzIO7UpsC/Listeners', 11:15:08 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:15:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:08 INFO - 'USER': 'cltbld', 11:15:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:08 INFO - 'XPC_FLAGS': '0x0', 11:15:08 INFO - 'XPC_SERVICE_NAME': '0', 11:15:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:08 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 11:15:08 INFO - Cleaning up... 11:15:08 INFO - Return code: 0 11:15:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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', '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 0x10ec97a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed2c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b1cc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebfbd30>, '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 0x10e960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebf3b20>, '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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:15: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:15: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 psutil>=3.1.1 11:15:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MhUvbgJcg6/Render', 11:15:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:08 INFO - 'HOME': '/Users/cltbld', 11:15:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:08 INFO - 'LOGNAME': 'cltbld', 11:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:08 INFO - 'MOZ_NO_REMOTE': '1', 11:15:08 INFO - 'NO_EM_RESTART': '1', 11:15:08 INFO - 'PAGER': '/bin/cat', 11:15:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:08 INFO - 'PWD': '/builds/slave/test', 11:15:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:08 INFO - 'SHELL': '/bin/bash', 11:15:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wyzIO7UpsC/Listeners', 11:15:08 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:15:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:08 INFO - 'USER': 'cltbld', 11:15:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:08 INFO - 'XPC_FLAGS': '0x0', 11:15:08 INFO - 'XPC_SERVICE_NAME': '0', 11:15:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:09 INFO - Downloading/unpacking psutil>=3.1.1 11:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:15:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:11 INFO - Installing collected packages: psutil 11:15:11 INFO - Running setup.py install for psutil 11:15:11 INFO - building 'psutil._psutil_osx' extension 11:15:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 11:15:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:15:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:15:12 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 11:15:12 INFO - building 'psutil._psutil_posix' extension 11:15:12 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 11:15:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:15:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:15:12 INFO - ^ 11:15:12 INFO - 1 warning generated. 11:15:12 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 11:15:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:15:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:15:12 INFO - Successfully installed psutil 11:15:12 INFO - Cleaning up... 11:15:12 INFO - Return code: 0 11:15:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:12 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 0x10ec97a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed2c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b1cc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebfbd30>, '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 0x10e960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebf3b20>, '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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:15:12 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 11:15:12 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 11:15:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MhUvbgJcg6/Render', 11:15:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:12 INFO - 'HOME': '/Users/cltbld', 11:15:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:12 INFO - 'LOGNAME': 'cltbld', 11:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:12 INFO - 'MOZ_NO_REMOTE': '1', 11:15:12 INFO - 'NO_EM_RESTART': '1', 11:15:12 INFO - 'PAGER': '/bin/cat', 11:15:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:12 INFO - 'PWD': '/builds/slave/test', 11:15:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:12 INFO - 'SHELL': '/bin/bash', 11:15:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wyzIO7UpsC/Listeners', 11:15:12 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:15:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:12 INFO - 'USER': 'cltbld', 11:15:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:12 INFO - 'XPC_FLAGS': '0x0', 11:15:12 INFO - 'XPC_SERVICE_NAME': '0', 11:15:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:15:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:15:15 INFO - Installing collected packages: mozsystemmonitor 11:15:15 INFO - Running setup.py install for mozsystemmonitor 11:15:15 INFO - Successfully installed mozsystemmonitor 11:15:15 INFO - Cleaning up... 11:15:15 INFO - Return code: 0 11:15:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:15 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 0x10ec97a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed2c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b1cc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebfbd30>, '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 0x10e960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebf3b20>, '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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:15:15 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 11:15:15 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 11:15:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MhUvbgJcg6/Render', 11:15:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:16 INFO - 'HOME': '/Users/cltbld', 11:15:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:16 INFO - 'LOGNAME': 'cltbld', 11:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:16 INFO - 'MOZ_NO_REMOTE': '1', 11:15:16 INFO - 'NO_EM_RESTART': '1', 11:15:16 INFO - 'PAGER': '/bin/cat', 11:15:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:16 INFO - 'PWD': '/builds/slave/test', 11:15:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:16 INFO - 'SHELL': '/bin/bash', 11:15:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wyzIO7UpsC/Listeners', 11:15:16 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:15:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:16 INFO - 'USER': 'cltbld', 11:15:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:16 INFO - 'XPC_FLAGS': '0x0', 11:15:16 INFO - 'XPC_SERVICE_NAME': '0', 11:15:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:16 INFO - Downloading/unpacking jsonschema==2.5.1 11:15:16 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 11:15:16 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 11:15:16 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 11:15:16 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 11:15:16 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 11:15:16 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 11:15:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:15:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:19 INFO - Downloading functools32-3.2.3-2.tar.gz 11:15:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:15:19 INFO - warning: no files found matching '*.txt' 11:15:19 INFO - no previously-included directories found matching 'build' 11:15:19 INFO - no previously-included directories found matching 'dist' 11:15:19 INFO - no previously-included directories found matching '.git*' 11:15:19 INFO - Installing collected packages: jsonschema, functools32 11:15:19 INFO - Running setup.py install for functools32 11:15:19 INFO - warning: no files found matching '*.txt' 11:15:19 INFO - no previously-included directories found matching 'build' 11:15:19 INFO - no previously-included directories found matching 'dist' 11:15:19 INFO - no previously-included directories found matching '.git*' 11:15:19 INFO - Successfully installed jsonschema functools32 11:15:19 INFO - Cleaning up... 11:15:19 INFO - Return code: 0 11:15:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:19 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec97a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed2c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b1cc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebfbd30>, '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 0x10e960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebf3b20>, '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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:15:19 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:15:19 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 functools32==3.2.3-2 11:15:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MhUvbgJcg6/Render', 11:15:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:19 INFO - 'HOME': '/Users/cltbld', 11:15:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:19 INFO - 'LOGNAME': 'cltbld', 11:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:19 INFO - 'MOZ_NO_REMOTE': '1', 11:15:19 INFO - 'NO_EM_RESTART': '1', 11:15:19 INFO - 'PAGER': '/bin/cat', 11:15:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:19 INFO - 'PWD': '/builds/slave/test', 11:15:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:19 INFO - 'SHELL': '/bin/bash', 11:15:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wyzIO7UpsC/Listeners', 11:15:19 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:15:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:19 INFO - 'USER': 'cltbld', 11:15:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:19 INFO - 'XPC_FLAGS': '0x0', 11:15:19 INFO - 'XPC_SERVICE_NAME': '0', 11:15:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:15:19 INFO - Cleaning up... 11:15:19 INFO - Return code: 0 11:15:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:19 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 0x10ec97a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed2c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b1cc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebfbd30>, '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 0x10e960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebf3b20>, '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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:15:19 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 11:15:19 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 11:15:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MhUvbgJcg6/Render', 11:15:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:19 INFO - 'HOME': '/Users/cltbld', 11:15:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:19 INFO - 'LOGNAME': 'cltbld', 11:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:19 INFO - 'MOZ_NO_REMOTE': '1', 11:15:19 INFO - 'NO_EM_RESTART': '1', 11:15:19 INFO - 'PAGER': '/bin/cat', 11:15:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:19 INFO - 'PWD': '/builds/slave/test', 11:15:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:19 INFO - 'SHELL': '/bin/bash', 11:15:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wyzIO7UpsC/Listeners', 11:15:19 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:15:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:19 INFO - 'USER': 'cltbld', 11:15:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:19 INFO - 'XPC_FLAGS': '0x0', 11:15:19 INFO - 'XPC_SERVICE_NAME': '0', 11:15:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:19 INFO - Downloading/unpacking blobuploader==1.2.4 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15: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 11:15:22 INFO - Downloading blobuploader-1.2.4.tar.gz 11:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:15:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:15:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:23 INFO - Downloading docopt-0.6.1.tar.gz 11:15:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:15:23 INFO - Installing collected packages: blobuploader, requests, docopt 11:15:23 INFO - Running setup.py install for blobuploader 11:15:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:15:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:15:23 INFO - Running setup.py install for requests 11:15:24 INFO - Running setup.py install for docopt 11:15:24 INFO - Successfully installed blobuploader requests docopt 11:15:24 INFO - Cleaning up... 11:15:24 INFO - Return code: 0 11:15:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:24 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 0x10ec97a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed2c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b1cc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebfbd30>, '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 0x10e960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebf3b20>, '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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:15:24 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 11:15:24 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 11:15:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MhUvbgJcg6/Render', 11:15:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:24 INFO - 'HOME': '/Users/cltbld', 11:15:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:24 INFO - 'LOGNAME': 'cltbld', 11:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:24 INFO - 'MOZ_NO_REMOTE': '1', 11:15:24 INFO - 'NO_EM_RESTART': '1', 11:15:24 INFO - 'PAGER': '/bin/cat', 11:15:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:24 INFO - 'PWD': '/builds/slave/test', 11:15:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:24 INFO - 'SHELL': '/bin/bash', 11:15:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wyzIO7UpsC/Listeners', 11:15:24 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:15:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:24 INFO - 'USER': 'cltbld', 11:15:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:24 INFO - 'XPC_FLAGS': '0x0', 11:15:24 INFO - 'XPC_SERVICE_NAME': '0', 11:15:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:24 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-vvjKS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:24 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Udb1gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:24 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-RwOk7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:25 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-VLh0XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:25 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-lfhbrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:25 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-i4K_jO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:25 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-X6xthv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:25 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ABg64S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:25 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-W0dDkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:25 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-gNpee9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:25 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-fr_uYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:25 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Ml8iQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:25 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-_Z_0gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:26 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-0olrZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:26 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-MF18qR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:26 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-lx7pJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:26 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-pAF9ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:15:26 INFO - Running setup.py install for manifestparser 11:15:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:15:26 INFO - Running setup.py install for mozcrash 11:15:26 INFO - Running setup.py install for mozdebug 11:15:26 INFO - Running setup.py install for mozdevice 11:15:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:15:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:15:27 INFO - Running setup.py install for mozfile 11:15:27 INFO - Running setup.py install for mozhttpd 11:15:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:15:27 INFO - Running setup.py install for mozinfo 11:15:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:15:27 INFO - Running setup.py install for mozInstall 11:15:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:15:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:15:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:15:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:15:27 INFO - Running setup.py install for mozleak 11:15:27 INFO - Running setup.py install for mozlog 11:15:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:15:27 INFO - Running setup.py install for moznetwork 11:15:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:15:28 INFO - Running setup.py install for mozprocess 11:15:28 INFO - Running setup.py install for mozprofile 11:15:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:15:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:15:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:15:28 INFO - Running setup.py install for mozrunner 11:15:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:15:28 INFO - Running setup.py install for mozscreenshot 11:15:28 INFO - Running setup.py install for moztest 11:15:28 INFO - Running setup.py install for mozversion 11:15:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:15:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:15:28 INFO - Cleaning up... 11:15:29 INFO - Return code: 0 11:15:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec97a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed2c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b1cc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebfbd30>, '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 0x10e960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebf3b20>, '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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:15:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:15:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MhUvbgJcg6/Render', 11:15:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:29 INFO - 'HOME': '/Users/cltbld', 11:15:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:29 INFO - 'LOGNAME': 'cltbld', 11:15:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:29 INFO - 'MOZ_NO_REMOTE': '1', 11:15:29 INFO - 'NO_EM_RESTART': '1', 11:15:29 INFO - 'PAGER': '/bin/cat', 11:15:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:29 INFO - 'PWD': '/builds/slave/test', 11:15:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:29 INFO - 'SHELL': '/bin/bash', 11:15:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wyzIO7UpsC/Listeners', 11:15:29 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:15:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:29 INFO - 'USER': 'cltbld', 11:15:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:29 INFO - 'XPC_FLAGS': '0x0', 11:15:29 INFO - 'XPC_SERVICE_NAME': '0', 11:15:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:15:29 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-GZ04tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:15:29 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)) 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:15:29 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-uoLpCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:15:29 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)) 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:15:29 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-O3DoXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:15:29 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)) 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:15:29 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-fqXgQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:15:29 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)) 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:15:29 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-62eOR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:15:29 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)) 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:15:29 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-9_F03H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:15:29 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)) 11:15:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:15:29 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-6IMUVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:15:30 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-APHLSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:15:30 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-c1JnGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:15:30 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-q72vbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 11:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:15:30 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-iy1NyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:15:30 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)) 11:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:15:30 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-nkWUmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:15:30 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)) 11:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:15:30 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-6QgJdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:15:30 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)) 11:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:15:30 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-YPfw7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:15:30 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)) 11:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:30 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-yHYblc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:15:30 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)) 11:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:15:30 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-jbmbiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:15:30 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)) 11:15:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:15:30 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-JWThK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:15:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:15:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:15:33 INFO - Downloading blessings-1.6.tar.gz 11:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:15:33 INFO - Installing collected packages: blessings 11:15:33 INFO - Running setup.py install for blessings 11:15:33 INFO - Successfully installed blessings 11:15:33 INFO - Cleaning up... 11:15:33 INFO - Return code: 0 11:15:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:15:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:34 INFO - Reading from file tmpfile_stdout 11:15:34 INFO - Current package versions: 11:15:34 INFO - blessings == 1.6 11:15:34 INFO - blobuploader == 1.2.4 11:15:34 INFO - docopt == 0.6.1 11:15:34 INFO - functools32 == 3.2.3-2 11:15:34 INFO - jsonschema == 2.5.1 11:15:34 INFO - manifestparser == 1.1 11:15:34 INFO - mozInstall == 1.12 11:15:34 INFO - mozcrash == 0.17 11:15:34 INFO - mozdebug == 0.1 11:15:34 INFO - mozdevice == 0.48 11:15:34 INFO - mozfile == 1.2 11:15:34 INFO - mozhttpd == 0.7 11:15:34 INFO - mozinfo == 0.9 11:15:34 INFO - mozleak == 0.1 11:15:34 INFO - mozlog == 3.3 11:15:34 INFO - moznetwork == 0.27 11:15:34 INFO - mozprocess == 0.23 11:15:34 INFO - mozprofile == 0.28 11:15:34 INFO - mozrunner == 6.12 11:15:34 INFO - mozscreenshot == 0.1 11:15:34 INFO - mozsystemmonitor == 0.3 11:15:34 INFO - moztest == 0.7 11:15:34 INFO - mozversion == 1.4 11:15:34 INFO - psutil == 3.1.1 11:15:34 INFO - requests == 1.2.3 11:15:34 INFO - wsgiref == 0.1.2 11:15:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ec97a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed2c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b1cc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebfbd30>, '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 0x10e960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebf3b20>, '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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MhUvbgJcg6/Render', 11:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:34 INFO - 'HOME': '/Users/cltbld', 11:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:34 INFO - 'LOGNAME': 'cltbld', 11:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:34 INFO - 'MOZ_NO_REMOTE': '1', 11:15:34 INFO - 'NO_EM_RESTART': '1', 11:15:34 INFO - 'PAGER': '/bin/cat', 11:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:34 INFO - 'PWD': '/builds/slave/test', 11:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:34 INFO - 'SHELL': '/bin/bash', 11:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wyzIO7UpsC/Listeners', 11:15:34 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:34 INFO - 'USER': 'cltbld', 11:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:34 INFO - 'XPC_FLAGS': '0x0', 11:15:34 INFO - 'XPC_SERVICE_NAME': '0', 11:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:34 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)) 11:15:34 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)) 11:15:34 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)) 11:15:34 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)) 11:15:34 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)) 11:15:34 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)) 11:15:34 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)) 11:15:34 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)) 11:15:34 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)) 11:15:34 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)) 11:15:34 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)) 11:15:34 INFO - Cleaning up... 11:15:34 INFO - Return code: 0 11:15:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:15:34 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 0x10ec97a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ed2c618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa6b1cc8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ebfbd30>, '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 0x10e960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebf3b20>, '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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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 11:15:34 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 11:15:34 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 11:15:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MhUvbgJcg6/Render', 11:15:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:15:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:15:34 INFO - 'HOME': '/Users/cltbld', 11:15:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:15:34 INFO - 'LOGNAME': 'cltbld', 11:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:15:34 INFO - 'MOZ_NO_REMOTE': '1', 11:15:34 INFO - 'NO_EM_RESTART': '1', 11:15:34 INFO - 'PAGER': '/bin/cat', 11:15:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:15:34 INFO - 'PWD': '/builds/slave/test', 11:15:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:15:34 INFO - 'SHELL': '/bin/bash', 11:15:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wyzIO7UpsC/Listeners', 11:15:34 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:15:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:15:34 INFO - 'USER': 'cltbld', 11:15:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:15:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:15:34 INFO - 'XPC_FLAGS': '0x0', 11:15:34 INFO - 'XPC_SERVICE_NAME': '0', 11:15:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:15:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:15:34 INFO - Cleaning up... 11:15:34 INFO - Return code: 0 11:15:34 INFO - Running post-action listener: _resource_record_post_action 11:15:34 INFO - Running post-action listener: _start_resource_monitoring 11:15:34 INFO - Starting resource monitoring. 11:15:34 INFO - [mozharness: 2016-08-23 18:15:34.694571Z] Finished create-virtualenv step (success) 11:15:34 INFO - [mozharness: 2016-08-23 18:15:34.695569Z] Running install step. 11:15:34 INFO - Running pre-action listener: _resource_record_pre_action 11:15:34 INFO - Running main action method: install 11:15:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:15:34 INFO - Reading from file tmpfile_stdout 11:15:34 INFO - Detecting whether we're running mozinstall >=1.0... 11:15:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:15:35 INFO - Reading from file tmpfile_stdout 11:15:35 INFO - Output received: 11:15:35 INFO - Usage: mozinstall [options] installer 11:15:35 INFO - Options: 11:15:35 INFO - -h, --help show this help message and exit 11:15:35 INFO - -d DEST, --destination=DEST 11:15:35 INFO - Directory to install application into. [default: 11:15:35 INFO - "/builds/slave/test"] 11:15:35 INFO - --app=APP Application being installed. [default: firefox] 11:15:35 INFO - mkdir: /builds/slave/test/build/application 11:15:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:16:09 INFO - Reading from file tmpfile_stdout 11:16:09 INFO - Output received: 11:16:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:16:09 INFO - Running post-action listener: _resource_record_post_action 11:16:09 INFO - [mozharness: 2016-08-23 18:16:09.231205Z] Finished install step (success) 11:16:09 INFO - [mozharness: 2016-08-23 18:16:09.231354Z] Running run-tests step. 11:16:09 INFO - Running pre-action listener: _resource_record_pre_action 11:16:09 INFO - Running main action method: run_tests 11:16:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:16:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:16:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:16:09 INFO - 2016-08-23 11:16:09.245 screenresolution[1638:8198] starting screenresolution argv=screenresolution get 11:16:09 INFO - 2016-08-23 11:16:09.248 screenresolution[1638:8198] Display 0: 1600x1200x32@60 11:16:09 INFO - 2016-08-23 11:16:09.254 screenresolution[1639:8200] starting screenresolution argv=screenresolution list 11:16:09 INFO - Available Modes on Display 0 11:16:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:16:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:16:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:16:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:16:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:16:09 INFO - Intel Iris: 11:16:09 INFO - Chipset Model: Intel Iris 11:16:09 INFO - Type: GPU 11:16:09 INFO - Bus: Built-In 11:16:09 INFO - VRAM (Dynamic, Max): 1536 MB 11:16:09 INFO - Vendor: Intel (0x8086) 11:16:09 INFO - Device ID: 0x0a2e 11:16:09 INFO - Revision ID: 0x0009 11:16:09 INFO - Displays: 11:16:09 INFO - Display: 11:16:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:16:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:16:09 INFO - Display Serial Number: 1600x1200 60 11:16:09 INFO - Main Display: Yes 11:16:09 INFO - Mirror: Off 11:16:09 INFO - Online: Yes 11:16:09 INFO - Rotation: Supported 11:16:09 INFO - Return code: 0 11:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:16:09 INFO - Python 2.7.3 11:16:09 INFO - Return code: 0 11:16:09 INFO - grabbing minidump binary from tooltool 11:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:16:09 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 0x10ebfbd30>, '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 0x10e960db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ebf3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:16:09 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 11:16:09 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 11:16:09 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 11:16:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:16:09 INFO - Return code: 0 11:16:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:16:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:16:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:16:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:16:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:16:09 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/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--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 11:16:09 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/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0253 --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 11:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MhUvbgJcg6/Render', 11:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:16:09 INFO - 'HOME': '/Users/cltbld', 11:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:16:09 INFO - 'LOGNAME': 'cltbld', 11:16:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:16:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:16:09 INFO - 'MOZ_NO_REMOTE': '1', 11:16:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:16:09 INFO - 'NO_EM_RESTART': '1', 11:16:09 INFO - 'PAGER': '/bin/cat', 11:16:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:16:09 INFO - 'PWD': '/builds/slave/test', 11:16:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:16:09 INFO - 'SHELL': '/bin/bash', 11:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wyzIO7UpsC/Listeners', 11:16:09 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 11:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:16:09 INFO - 'USER': 'cltbld', 11:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:16:09 INFO - 'XPC_FLAGS': '0x0', 11:16:09 INFO - 'XPC_SERVICE_NAME': '0', 11:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:16:09 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/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0253', '--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 11:16:09 INFO - mozversion application_buildid: 20160823071247 11:16:09 INFO - mozversion application_changeset: 1b93a25d0fe22bd10bae50eb705a25616f84477c 11:16:09 INFO - mozversion application_display_name: Nightly 11:16:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:16:09 INFO - mozversion application_name: Firefox 11:16:09 INFO - mozversion application_remotingname: firefox 11:16:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:16:09 INFO - mozversion application_vendor: Mozilla 11:16:09 INFO - mozversion application_version: 51.0a1 11:16:09 INFO - mozversion platform_buildid: 20160823071247 11:16:09 INFO - mozversion platform_changeset: 1b93a25d0fe22bd10bae50eb705a25616f84477c 11:16:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:16:09 INFO - mozversion platform_version: 51.0a1 11:16:09 INFO - using testdate: 1471976169 11:16:09 INFO - actual date: 1471976169 11:16:09 INFO - starting webserver on 'localhost:49262' 11:16:09 INFO - SUITE-START | Running 2 tests 11:16:09 INFO - TEST-START | dromaeo_css 11:16:09 INFO - operating with platform_type : mac_ 11:16:09 INFO - Initialising browser for dromaeo_css test... 11:16:09 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpTl0tAb/profile http://localhost:49262/getInfo.html) 11:16:12 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 11:16:12 INFO - PROCESS | 1649 | colorDepth:24 11:16:12 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 11:16:12 INFO - PROCESS | 1649 | __metrics 11:16:12 INFO - PROCESS | 1649 | 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" 11:16:12 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:16:13 INFO - TEST-INFO | 1649: exit 0 11:16:13 INFO - Browser initialized. 11:16:13 INFO - Running cycle 1/1 for dromaeo_css test... 11:16:13 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpTl0tAb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:24 INFO - PROCESS | 1652 | RSS: Main: 234483712 11:16:24 INFO - PROCESS | 1652 | 11:17:16 INFO - PROCESS | 1652 | 1471976236376 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] 11:19:27 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 11:19:30 INFO - PROCESS | 1652 | RSS: Main: 434393088 11:19:30 INFO - PROCESS | 1652 | 11:22:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 11:22:33 INFO - PROCESS | 1652 | RSS: Main: 372772864 11:22:33 INFO - PROCESS | 1652 | 11:25:36 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 11:25:37 INFO - PROCESS | 1652 | RSS: Main: 365989888 11:25:37 INFO - PROCESS | 1652 | 11:28:39 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 11:28:40 INFO - PROCESS | 1652 | RSS: Main: 346415104 11:28:40 INFO - PROCESS | 1652 | 11:31:43 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 11:31:44 INFO - PROCESS | 1652 | RSS: Main: 338251776 11:31:44 INFO - PROCESS | 1652 | 11:34:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 11:34:47 INFO - PROCESS | 1652 | RSS: Main: 507068416 11:34:47 INFO - PROCESS | 1652 | 11:34:47 INFO - PROCESS | 1652 | __start_tp_report 11:34:47 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 11:34:47 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 11:34:47 INFO - PROCESS | 1652 | |i|pagename|runs| 11:34:47 INFO - PROCESS | 1652 | |0;dojo.html;2917.883284668613;3275.6724327567244;3289.6874796894303;3328.6005679318487;3334.1664583854035;5507.118860982244;5549.38956714761;5619.887602247953;5620.072688006479;5630.127330263816;5631.958087753768;5650.095984642448;5656.604037717361;5665.206871038048;5665.8583535411635;5136.460671629481;5181.948180518184;5186.818461353853;5208.8437346879655;5264.210368444745;4296.849610263642;5144.868129011611;5201.323827902367;5232.895342093156;5232.927249913759;5131.281620573122;5169.819056333029;5185.351831021122;5193.480651934814;5221.71280579568;4313;5222.7649755760895;5282.471752824726;5288.550473209782;5324.494173053554;5090.261912022736;5109.6167787415725;5130.871728206787;5189.1697328427645;5214.322138122057;5539.861503462445;5541.972290138564;5548.750306236188;5582.692951887645;5606.411326810667;6154.569180157391;6176.69116544171;6176.783812566584;6178.38216178383;6179.598326108789;6055.848603784896;6093.2524753215375;6128.747575574743;6206.379362063803;6210.813675589739;5694.231278777394;5719.027765279912;5732.455416735404;5756.309242890838;5816.5928385013485;6252.6873656317;6257.5932564383165;6308.526860485482;6335.809925702236;6340.841478963062;5908.881822363529;5944.791932282349;6011.939880601138;6062.787802426894;6089.634621922699;6176.258848938156;6206;6222.62664240147;6226.003839385767;6229.968850155811;6173.290071641819;6186.628802271878;6189.04069869171;6192.195014648067;6195.19462469876;6003.099535069687;6004.309504407049;6188.412100850412;6202;6217;4852.587530059914;4866.683665561727;4879.95120048795;4891.3396691446915;4911.115999120193;4340.652747780233;4372.606465418127;4382.6493880490125;4386.956130438654;4408.933865992013;5492.258545096441;5572.777088916398;5623.100303951348;5626.212330273765;5630.40880707528;6097.312956045969;6159.414855588712;6182.629042257479;6280.057991301342;6292.653904035322;5609.5792815539;5635.802746903839;5660.433956604389;5660.773569057274;5676.262085928803;5210.791568337224;5372.758225879845;5374.328208973879;5376.865578360494;5387.326584176978;6230.844228894132;6300.621962682254;6305.211848518935;6314.305426403;6314.8737025258315;6247.718852651551;6259.843503912439;6270.561060725706;6281.057841323838;6281.089242059968;6318.6840657965995;6324.209473815773;6355.1420558224045;6356.364363563792;6399.688063946786;5875.6474611523445;5931.169636251015;5932.733027013708;5995.280566332068;6026.427489388501;6112.229929638781;6130.417610327012;6133.946794548733;6170.969145154246;6251.374862513712;5868.002439585366;6026.650968105667;6028.2766068072115;6030.698465076816;6090.817275481742;5558.444155584571;5678.403767604342;6019.819405417845;6030.547708921761;6052.848678783065;5706.42935706426;5816.360200377871;5872;5885.293764748258;5938.8218353449465;5855.092460668603;6016.939830601638;6037.969810151097;6053.969730151321;6055.485283750754;5725.427457254241;5730.3410107838135;5781.756922261734;5834.095715164156;5838.532917366685 11:34:47 INFO - PROCESS | 1652 | |1;ext.html;433.86983904828554;484.39692582734494;521.1609309012491;524.4964833759591;527.0171130840982;39896.40155397671;40941;41074;41095.17809643805;43583;41947.79026104873;42344.576554234525;42352.152956940845;42455.78772106135;42501.787491062576;8816.823663526726;9019.503927283997;9664.75838104046;9870.358426702242;9886.90113098867;8547.188017138362;8915.242204412632;8996.145366190201;11878.94060529696;12251.632451026484;12262.264264144136;12273.447694853709;12311.015118790476;12315.692107697334;12328.19866708661;12123;12211.206271592408;12218.816717749241;12224.633261002184;12229.082818788627;11952;12021;12022.338771367571;12034.21777584463;12043.93978030113;39908.80045599753;40154.39768403476;40209.39685904714;40226.19547609061;40237.59762402368;2992.2818523554406;3352.396568617648;3431.4509678451577;3443.9827800861085;3762.830672619711;30571;31035.534466983012;31701;31768.364632707217;31902;3233.692799184074;3306.7519936004896;3346.8159251241173;3379.5268662387284;3385.0352649494776;508177;511532;511888.44055779855;511949;512622;55381.723091385094;55511.72244138754;55588.444115559134;55936.72031639897;56019.71990140023;58262.417375826546;58442;58484.70757646184;58538.7073064632;58566.12150817741;15878.364865405254;16122.75815862763;16129.758053629204;16151.577263410583;16174.353025879069;12709.237445753284;12773.169743966613;12781.424835882408;12789.488420463264;12794.68013299675;12951.546695865787;13417.597472075853;14554.199519026555;15009;15113.773293400607;6743.595384276861;6794.354536319141;6882.655867206619;6912.827179320558;6918.238993710688;866.3632230310717;953.4565297780338;975.8777405983176;998.0518507417837;1007.7279134633608;29788.2552936174;29871;29902.70097298999;30276.848615757222;30538.69461305403;1003.6988903328972;1004.4425343934041;1010.4695035106628;1045.926785125034;1059.4914441068177;14732.55802325932;15510.844891551165;15542.145182014872;15546.067235965878;15789.447369342019;641818;648503;651608;652832;654361;50193;50904.490955089976;57318;58166.7091664539;58246.708766456744;1388.0838646493266;1399.4891864469396;1434.6269969807925;1436.2100844535464;1436.8491308412465;29263.85368073231;30628;31446.899358522343;32104.036878893672;32348.676513234568;49480.50519494759;50168.7457813543;50209.24686129784;50229.74425639388;50339.496605033484;522265;524002;524819;525350;526648;25920;26523.204303870916;26554;39150;39500;47295.763521182176;47541;48118.5188148114;48129;48290.75854620704;33054.67781288818;37823.81088094542;39058.414123787596;40464.79767601143;40763;37912.81043594764;38877.6112238874;39137.60862391454;39806.20387592174;40330.395044073775;37160.62839371571;37666.2466750658;37788.43317350187;37816;38163.42754858735;27579.448411031266;33284.500732488545;34649.30701386009;34752.65247347494;34775.47836782501;23261.41846453852;25313.49373012566;25480.490390192463;25563.872180638977;26461 11:34:47 INFO - PROCESS | 1652 | |2;jquery.html;350.89823951054194;369.29833316698284;371.93119272934507;380.6231830487818;400.86370633984455;14978;15270.847291527081;20431.667589033317;21015.579688406222;21239.893800531016;19524.804751952477;20106.899465502687;20197.364474394602;20770.896145519288;20974.49048454582;5766.942330576703;6079.240094988127;6085.087236914476;6090.208272924514;6090.60411073281;5889.8822023559505;6045.395460453963;6173.290071641752;6185.969070154643;6256.937430625704;6239.968800156015;6255.124282600417;6258.030005349178;6265.185525881629;6273.12176295319;5985.401459854023;6148.938510614881;6215.627062376272;6220.87558248837;6224.533160012972;5791.218185544982;5980.431858973434;6012.699365031731;6019.488343490765;6027.336992930774;13547.864521354857;13761.862381376159;13775.035747497679;13847.584572462742;15988.200589970455;2153.3755210988793;2180.433087397288;2204.349716833522;2220.844540882139;2414.8188885833633;9106.81786364269;9797.510124493818;9989.450580218085;10236.53935572901;10355.844662330072;1854.77742670879;1873.3443294846695;1895.6777347850898;1955.9119839607251;1957.9671227990227;104399.47800261027;111536.88463115427;112704.4364778179;113293;113417;11203.047740942111;11207.831882521768;11242.213045086928;11381.203315767982;11499.655010349536;12648.494060237488;13302.068855180238;13346.599602011762;13987.930060349634;14101.435942562388;8348.582570871433;8456;8545.2309292164;8679.392442529088;8740.300775937909;8512.616932238065;8515.531645759418;8530.530820804915;8680.609372578123;8682;4440.844570440084;4525.303011370736;4533.297338912474;4611.146937816515;4611.354410382549;1875.8124187581407;1915.668610315845;1926.5743349921238;1961.6978251819105;1977.3968939473311;801.8797180422866;861.6036623153294;899.4423457456288;927.9582418791035;949.9335046546676;20905.163793448395;21148.259810906544;21390.893045534674;21539.67690484644;21710.34868953934;768.4851149729694;884.5754038061766;914.1224424552371;944.573693722484;997.9650712225038;10856.2400631955;11266.774664506827;11312.151588630886;11343.829842552368;11385.544578216945;573559;617461;631580;636869;638151;115034.84965150409;132473.33763331315;136004;136288;139876;918.5774543709969;923.8891333040078;951;951.9286053546011;952.4618590496348;18632.534186645444;19050.237990480226;19178.520536986685;19178.90410547938;19286.842789432678;44578.66264012085;53276;56627.71686141543;57248;57328.28015159552;83965;84259.15740842513;84352;84378;84831;8061.1938806118915;8099.919000809917;8171.387145963958;8276.751697449086;8333.333333333198;13138.868611314147;13187.60437186886;13284.003699722367;13517.188968661912;13611.251381173734;11421.828672569753;11429.59996400122;11496.770064598828;11613.6515904523;11749.060075193793;9539.570719317786;11059.447027648424;11203.271787333797;11226.831597525881;11438.42807859587;10795.892041079489;11244.55021799119;11638.825417618573;11677.474513646737;11793.29240245588;6761.729530818909;7556.508826926232;7662.233776622294;8033;8069.233422824822;10945.960133787277;11110.389123535046;11194.66416007521;11539.942300288445;11543.018843398406 11:34:47 INFO - PROCESS | 1652 | |3;mootools.html;1306.209743105421;1344.3815844711432;1501.159350763572;1630.1686140068568;1835.9082045897694;7779.494332868359;8281;8284.62719177637;8285.585720713963;8309.667613295462;8461;8695.434796738207;8757.7810554736;8878.600462979166;8884.600192991315;2395.6526303686;2422.176460003607;2422.7213870404867;2425.1754403502805;2425.2360506440505;1994.9601007979832;2007.2773801431474;2367.8342516023886;2412.746661600524;2418.6492958521003;2372.893219805113;2402;2405.747396523366;2407.6629271901948;2409.8915548800346;2361.3388251289666;2380;2384.76152384761;2386.033656369173;2405.56699794037;1982.742243508349;2385.7017872765905;2387.9164229252065;2393.1863166523467;2397.376682062659;8806.20744133031;8839.204471597523;8947.865782013276;8951.86572201411;8964.327675424303;4794.5205479452125;4968.205087186033;5350.224217488481;5362.624616276862;5364.329458817648;3297.835108244602;3595.227026189356;3709.7217708671956;3713.4615480755137;3741.484698697032;963.8506031565119;1098.2531878322736;1114.7324642085923;1118.4453609482825;1126.5212284779018;11649.883501164964;11715.355655438947;11739.647810565697;11745.882541174564;11754;4653.883652908705;4714.127886341038;4816;4859.003904199631;4883.58489528387;10015.298929075041;10028.398296102258;10039.548220330104;10040.196784257241;10042.799144017225;5388.299521062237;5392.5416339611575;5395.190721391823;5396.91904621431;5400.21696853954;4844.031193761191;4864.148773964542;4958.826441074545;4963.181075122564;4965.32968049316;3778.981105094457;3806.7715937043868;3860.4402361657403;3893.844246230176;3905.7932268268337;1257.9874201257871;1265.1649911058657;1265.7658333208385;1284.383495921944;1285.9935700321626;867.4231635962141;888.5646033443566;911.8267529169436;929.693201243588;940.4279296125093;5809.477147056785;6129.84675383119;6155.076738489173;6182;6400.583962042452;877.7717793373769;909.1454033208763;969.1907257439975;986.4585245795851;1015.9847602285971;3822.7706337619834;4043.872104010751;4047.352423612208;4115.588441155861;4179.707420480598;9982.700518984442;10417.843732344021;10621.362718236931;10831.67504974852;11056.502457389437;10355.17158627308;10507.264491485523;10510.684679459628;10521.947390263;10523.947605239415;8148.592570371457;8189.631466584018;8253.917460825314;8381.455205411507;8444.831103378021;5942.851428714317;5965.940340596539;6137.478314343331;6224.62652240867;6258.3741625838875;8371.497710137412;10079.294449388766;10155.289129760846;10233.692989210336;10262.948685256526;9725;10266.178705703376;10346.793064138825;10367.533460994424;10393.9480302598;7024.613646249505;7148.785536433916;7150.356467917913;7156.141263048467;7157.212706602374;8268.09051004401;8269.503829770232;8301.958490207511;8361.247487726134;8369.539675317916;7475.476716629783;7553.32020118192;7588.089429268523;7646.426518011061;7653.502522336031;7423.257674232534;7530.209328020479;7593.924060759322;7610.200928902607;7837.568933708472;6559.8032059038305;6843.144606924135;6902.758403455855;7044.612546309797;7051.964740176266;5101.566366858859;5151.407588127413;5160.354955630546;5186.09243382399;5311.336082989626;4270.145970805789;4655.6973796703105;4925.433575138905;5146.099432599205;5422.349318081855 11:34:47 INFO - PROCESS | 1652 | |4;prototype.html;298.2394893022792;302.62776784554995;306.94474994500996;312.3783670495714;313.0764245475847;4348.673459699057;5251.92335571208;5273.604479664031;5282.894342113155;5297.947020529794;4812.893034602043;5111.591072714184;5200.921986170201;5227.712475813829;5265.368155821307;3050.4051709916575;3745.887623371303;3908.7263891527464;4003.8989277948654;4019.718619696622;3971.523417189941;3989.620986006339;3994.2410941920944;3995.3207954647633;4012.6990475714438;3689.335919534483;3764.9058773530605;3896.4544963705102;3940.192260586587;3960.168364643414;3102.2317279150893;3224.500202468621;3612.169201083739;3922.8038598070266;3976.3041467743174;3136.952945705816;3434.7423943204108;3453.3093381323583;3468.167639766438;3469.271452994849;4115.176964607061;4403.867883963486;5031.899362012776;5051;5071.7971281149075;4061.878143655695;4072.3077076897;4176.979115104405;4325.697201195918;4537.183307004738;4262.786860656955;4441.977790111061;4938.555530002282;4989.201727723546;5449.155380915964;3479.460683594047;3528.8235588220487;3796.791176485292;3807.9238415231816;3836.232753449321;5547.306586676666;5632.605717599769;5705.914411283834;5722.227499287585;5738.540916726652;3786.4320351947426;3829.008915363995;3859.208862183246;3869.903252418712;3872.302985462644;3088.6911308869385;3248.8213148277073;3634.00064982132;3928.2929072767174;3933.783641899666;3764.3976963685677;3788.6969042477085;4530.954690453119;4533.818647254073;4564.794584243717;4369.509379653567;5329.786808527616;5489.890202196014;5562.332520097614;5577.888442231133;1314.3034191878319;1334.7063645997864;1335.1855368225374;1337.2778699502355;1343.7984302354726;699.629196525832;768.6041688530412;820.8932838730926;833.0836080311609;838.8783626374142;4167.790801083149;4444.466664000341;4471.8658440246845;4684.320773487893;4972.265254110297;5310.415854256029;5465.754041068161;5487.862803429866;5493.478119578634;5663.207150998864;4181.97909010453;4698.8120475181295;4798.808047678054;5000.000000000029;5142.254373115952;2470.987645061763;2576.6779152605923;2617.9607305890427;2892;2926.5024945759274;5417.160340147283;5564.276644036249;5771.30744310677;5867.735951882176;5880.294364676266;5229.607779416559;5336.519713225828;5559.916601250984;5721.196613659277;5734.598578099493;5059.924101138486;5294.802656897422;5518.91721624176;5817.243758311392;5846.363018354868;5491.835244942658;5512.200730893917;5630.831075067755;5631.7184140793615;5635.351934527582;4572.216835434117;4800.279958006327;5211.895762084661;5630.662160270397;5632.408597097409;5900.5574581907385;5904.0553511437965;5905.970470147622;5935.762569497345;6003.609765365237;3401.7618766686096;3874.922501549897;3915.5497117831815;3950.249452603996;3956.782376969179;4990.6063876564285;5298.947010529845;5589.972050139723;5602.52378547828;5619.606627536034;4305.09592985464;5368.147988943808;5429.131338985743;5468.429837976145;5473.014857325719;4197.97901010493;4946.233333833262;5351.1973204019705;5392.299001129828;5409.5672346213;4310.870673879788;4800.495947925418;4834.250691142738;5343.385510666168;5394.892102158014;4239.25812982733;4834.63740219492;5174.7930082796265;5186.299849520417;5319.324412809952;5046.949530504648;5089.150075957476;5252.894942101213;5354.152817278033;5384.596155288447 11:34:47 INFO - PROCESS | 1652 | |5;yui.html;716.7742161219215;729.6607077708868;775.9301662850343;819.7335865843602;828.747232094211;15049.62375940602;15566.45517406891;15727.685446291081;15885.84114158858;15955.760663590041;14165.220912849789;14181.220032898187;14247;14340.067895586779;14359.64100897478;663.8539521305305;687.3847906124016;820.1347578304886;827.9006519217687;843.0557775291682;823.4935514658472;842.3135144856952;842.4145219072747;843.3843294395095;843.9367047471434;892.5626443042927;893.6246776353914;897.0939351255247;898.6270697660464;899.2895612466144;705.2418649951322;727.4943913979786;730.3280981497036;891.3359547137392;893.3567831161554;534.6204195021539;537.2237117365408;639.2871947778241;659.8746238214724;663.3068443476578;14278.928605356907;14411.063280886709;14432.639184020483;14477.34851931655;14500.202488863108;13378.93310533441;13579.728405431935;13723.656908577266;13826.723465530733;14181.858181418156;12226.134391272006;12657.30384828834;12798.872011279955;13254.933725331408;13354.86645133546;4521.389612402317;4579.3131030345385;4587.977060114711;4723.527647235283;4749.691270067435;123732;124224;125959.99999999908;126592;127464.08803867949;9165.954170229239;10818.567257309776;10973.615923442801;11071.114310855111;11407;20855.165793368094;20865.1653933844;21129.471763205736;21136.15455381798;21153.788462115182;7554.093508778982;7584.924150758422;7621.237876212334;7791;7818.765437036898;4144.067584793458;4206.768627725504;4253.383259427427;4256.553061928453;4386.912261754747;3302.983485082559;3365.158710322419;3365.730741540671;3366.898993030213;3394.9830250848586;641.2689533931322;641.6054126712038;643.652427689052;650.7592190889306;665.4676258992787;570.164708701754;605.1452298704456;631.7378288010424;632.5003247434475;639.3414782773658;8711.564421779012;8757.430767000125;8862.468251904906;8888.066752990972;8902.465852048897;531.8563987723293;590.052964991183;599.12228585123;623.1680706257107;643.0771842406162;4011.3581826907553;4021.477207962946;4244.72409293395;4301.268784306675;4377.409049778303;102114;151640.72538911924;167416;169926;170872.145639271;142011;142081.28959355137;144131.5586844139;145235.54764452222;147215;81922.59038704769;82163.17836821674;98890.5055474718;104043.4797826006;108926;9327.533623318943;9783.510824458606;9878.555465003948;10018.64934727281;10061.547230374505;56451.435485644615;57181.142282866625;57365.713171433876;62522;63715.36284637095;85759;85993.57003214944;95202.52398737962;95657.521712391;101429.49285253526;12627;13208.933955330162;13306.800397993844;13666.726665466835;13926.4429422826;14807.226579011682;14886.330115144629;15482.922585387001;15537.533873983799;15630.374785008928;13914.721705566035;14101.576952691436;14135.575932722035;14191.574252772434;14198.00613957013;13633.590992270249;13824;13904.58286251414;14369;14437.7834332483;11145.442727863736;13533.255670938193;13723.931380343034;14365.425382984982;14499.92750036243;9210.401323913924;10873.45632718345;11485.3803490462;11588.188826782045;12043.638690839289;10357.533910973874;11356.659300221007;11471.369074700971;11620.244684095507;11645.59240426581 11:34:47 INFO - PROCESS | 1652 | __end_tp_report 11:34:47 INFO - PROCESS | 1652 | __start_cc_report 11:34:47 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2140 11:34:47 INFO - PROCESS | 1652 | __end_cc_report 11:34:47 INFO - PROCESS | 1652 | __startTimestamp1471977287769__endTimestamp 11:34:47 INFO - PROCESS | 1652 | 11:34:47 INFO - PROCESS | 1652 | ------- Summary: start ------- 11:34:47 INFO - PROCESS | 1652 | Number of tests: 6 11:34:47 INFO - PROCESS | 1652 | 11:34:47 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5670.24 Median:5834.10 stddev:657.41 (11.3%) stddev-sans-first:622.96 11:34:47 INFO - PROCESS | 1652 | Values: 2917.9 3275.7 3289.7 3328.6 3334.2 5507.1 5549.4 5619.9 5620.1 5630.1 5632.0 5650.1 5656.6 5665.2 5665.9 5136.5 5181.9 5186.8 5208.8 5264.2 4296.8 5144.9 5201.3 5232.9 5232.9 5131.3 5169.8 5185.4 5193.5 5221.7 4313.0 5222.8 5282.5 5288.6 5324.5 5090.3 5109.6 5130.9 5189.2 5214.3 5539.9 5542.0 5548.8 5582.7 5606.4 6154.6 6176.7 6176.8 6178.4 6179.6 6055.8 6093.3 6128.7 6206.4 6210.8 5694.2 5719.0 5732.5 5756.3 5816.6 6252.7 6257.6 6308.5 6335.8 6340.8 5908.9 5944.8 6011.9 6062.8 6089.6 6176.3 6206.0 6222.6 6226.0 6230.0 6173.3 6186.6 6189.0 6192.2 6195.2 6003.1 6004.3 6188.4 6202.0 6217.0 4852.6 4866.7 4880.0 4891.3 4911.1 4340.7 4372.6 4382.6 4387.0 4408.9 5492.3 5572.8 5623.1 5626.2 5630.4 6097.3 6159.4 6182.6 6280.1 6292.7 5609.6 5635.8 5660.4 5660.8 5676.3 5210.8 5372.8 5374.3 5376.9 5387.3 6230.8 6300.6 6305.2 6314.3 6314.9 6247.7 6259.8 6270.6 6281.1 6281.1 6318.7 6324.2 6355.1 6356.4 6399.7 5875.6 5931.2 5932.7 5995.3 6026.4 6112.2 6130.4 6133.9 6171.0 6251.4 5868.0 6026.7 6028.3 6030.7 6090.8 5558.4 5678.4 6019.8 6030.5 6052.8 5706.4 5816.4 5872.0 5885.3 5938.8 5855.1 6016.9 6038.0 6054.0 6055.5 5725.4 5730.3 5781.8 5834.1 5838.5 11:34:47 INFO - PROCESS | 1652 | 11:34:47 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:69614.97 Median:37819.91 stddev:150929.81 (399.1%) stddev-sans-first:151263.83 11:34:47 INFO - PROCESS | 1652 | Values: 433.9 484.4 521.2 524.5 527.0 39896.4 40941.0 41074.0 41095.2 43583.0 41947.8 42344.6 42352.2 42455.8 42501.8 8816.8 9019.5 9664.8 9870.4 9886.9 8547.2 8915.2 8996.1 11878.9 12251.6 12262.3 12273.4 12311.0 12315.7 12328.2 12123.0 12211.2 12218.8 12224.6 12229.1 11952.0 12021.0 12022.3 12034.2 12043.9 39908.8 40154.4 40209.4 40226.2 40237.6 2992.3 3352.4 3431.5 3444.0 3762.8 30571.0 31035.5 31701.0 31768.4 31902.0 3233.7 3306.8 3346.8 3379.5 3385.0 508177.0 511532.0 511888.4 511949.0 512622.0 55381.7 55511.7 55588.4 55936.7 56019.7 58262.4 58442.0 58484.7 58538.7 58566.1 15878.4 16122.8 16129.8 16151.6 16174.4 12709.2 12773.2 12781.4 12789.5 12794.7 12951.5 13417.6 14554.2 15009.0 15113.8 6743.6 6794.4 6882.7 6912.8 6918.2 866.4 953.5 975.9 998.1 1007.7 29788.3 29871.0 29902.7 30276.8 30538.7 1003.7 1004.4 1010.5 1045.9 1059.5 14732.6 15510.8 15542.1 15546.1 15789.4 641818.0 648503.0 651608.0 652832.0 654361.0 50193.0 50904.5 57318.0 58166.7 58246.7 1388.1 1399.5 1434.6 1436.2 1436.8 29263.9 30628.0 31446.9 32104.0 32348.7 49480.5 50168.7 50209.2 50229.7 50339.5 522265.0 524002.0 524819.0 525350.0 526648.0 25920.0 26523.2 26554.0 39150.0 39500.0 47295.8 47541.0 48118.5 48129.0 48290.8 33054.7 37823.8 39058.4 40464.8 40763.0 37912.8 38877.6 39137.6 39806.2 40330.4 37160.6 37666.2 37788.4 37816.0 38163.4 27579.4 33284.5 34649.3 34752.7 34775.5 23261.4 25313.5 25480.5 25563.9 26461.0 11:34:47 INFO - PROCESS | 1652 | 11:34:47 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:35437.92 Median:1382.86 stddev:103372.34 (7475.3%) stddev-sans-first:103628.76 11:34:47 INFO - PROCESS | 1652 | Values: 350.9 369.3 371.9 380.6 400.9 14978.0 15270.8 20431.7 21015.6 21239.9 19524.8 20106.9 20197.4 20770.9 20974.5 5766.9 6079.2 6085.1 6090.2 6090.6 5889.9 6045.4 6173.3 6186.0 6256.9 6240.0 6255.1 6258.0 6265.2 6273.1 5985.4 6148.9 6215.6 6220.9 6224.5 5791.2 5980.4 6012.7 6019.5 6027.3 13547.9 13761.9 13775.0 13847.6 15988.2 2153.4 2180.4 2204.3 2220.8 2414.8 9106.8 9797.5 9989.5 10236.5 10355.8 1854.8 1873.3 1895.7 1955.9 1958.0 104399.5 111536.9 112704.4 113293.0 113417.0 11203.0 11207.8 11242.2 11381.2 11499.7 12648.5 13302.1 13346.6 13987.9 14101.4 8348.6 8456.0 8545.2 8679.4 8740.3 8512.6 8515.5 8530.5 8680.6 8682.0 4440.8 4525.3 4533.3 4611.1 4611.4 1875.8 1915.7 1926.6 1961.7 1977.4 801.9 861.6 899.4 928.0 949.9 20905.2 21148.3 21390.9 21539.7 21710.3 768.5 884.6 914.1 944.6 998.0 10856.2 11266.8 11312.2 11343.8 11385.5 573559.0 617461.0 631580.0 636869.0 638151.0 115034.8 132473.3 136004.0 136288.0 139876.0 918.6 923.9 951.0 951.9 952.5 18632.5 19050.2 19178.5 19178.9 19286.8 44578.7 53276.0 56627.7 57248.0 57328.3 83965.0 84259.2 84352.0 84378.0 84831.0 8061.2 8099.9 8171.4 8276.8 8333.3 13138.9 13187.6 13284.0 13517.2 13611.3 11421.8 11429.6 11496.8 11613.7 11749.1 9539.6 11059.4 11203.3 11226.8 11438.4 10795.9 11244.6 11638.8 11677.5 11793.3 6761.7 7556.5 7662.2 8033.0 8069.2 10946.0 11110.4 11194.7 11539.9 11543.0 11:34:47 INFO - PROCESS | 1652 | 11:34:47 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5723.36 Median:4873.87 stddev:3187.98 (65.4%) stddev-sans-first:3179.64 11:34:47 INFO - PROCESS | 1652 | Values: 1306.2 1344.4 1501.2 1630.2 1835.9 7779.5 8281.0 8284.6 8285.6 8309.7 8461.0 8695.4 8757.8 8878.6 8884.6 2395.7 2422.2 2422.7 2425.2 2425.2 1995.0 2007.3 2367.8 2412.7 2418.6 2372.9 2402.0 2405.7 2407.7 2409.9 2361.3 2380.0 2384.8 2386.0 2405.6 1982.7 2385.7 2387.9 2393.2 2397.4 8806.2 8839.2 8947.9 8951.9 8964.3 4794.5 4968.2 5350.2 5362.6 5364.3 3297.8 3595.2 3709.7 3713.5 3741.5 963.9 1098.3 1114.7 1118.4 1126.5 11649.9 11715.4 11739.6 11745.9 11754.0 4653.9 4714.1 4816.0 4859.0 4883.6 10015.3 10028.4 10039.5 10040.2 10042.8 5388.3 5392.5 5395.2 5396.9 5400.2 4844.0 4864.1 4958.8 4963.2 4965.3 3779.0 3806.8 3860.4 3893.8 3905.8 1258.0 1265.2 1265.8 1284.4 1286.0 867.4 888.6 911.8 929.7 940.4 5809.5 6129.8 6155.1 6182.0 6400.6 877.8 909.1 969.2 986.5 1016.0 3822.8 4043.9 4047.4 4115.6 4179.7 9982.7 10417.8 10621.4 10831.7 11056.5 10355.2 10507.3 10510.7 10521.9 10523.9 8148.6 8189.6 8253.9 8381.5 8444.8 5942.9 5965.9 6137.5 6224.6 6258.4 8371.5 10079.3 10155.3 10233.7 10262.9 9725.0 10266.2 10346.8 10367.5 10393.9 7024.6 7148.8 7150.4 7156.1 7157.2 8268.1 8269.5 8302.0 8361.2 8369.5 7475.5 7553.3 7588.1 7646.4 7653.5 7423.3 7530.2 7593.9 7610.2 7837.6 6559.8 6843.1 6902.8 7044.6 7052.0 5101.6 5151.4 5160.4 5186.1 5311.3 4270.1 4655.7 4925.4 5146.1 5422.3 11:34:47 INFO - PROCESS | 1652 | 11:34:47 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4354.77 Median:4823.57 stddev:1359.17 (28.2%) stddev-sans-first:1328.44 11:34:47 INFO - PROCESS | 1652 | Values: 298.2 302.6 306.9 312.4 313.1 4348.7 5251.9 5273.6 5282.9 5297.9 4812.9 5111.6 5200.9 5227.7 5265.4 3050.4 3745.9 3908.7 4003.9 4019.7 3971.5 3989.6 3994.2 3995.3 4012.7 3689.3 3764.9 3896.5 3940.2 3960.2 3102.2 3224.5 3612.2 3922.8 3976.3 3137.0 3434.7 3453.3 3468.2 3469.3 4115.2 4403.9 5031.9 5051.0 5071.8 4061.9 4072.3 4177.0 4325.7 4537.2 4262.8 4442.0 4938.6 4989.2 5449.2 3479.5 3528.8 3796.8 3807.9 3836.2 5547.3 5632.6 5705.9 5722.2 5738.5 3786.4 3829.0 3859.2 3869.9 3872.3 3088.7 3248.8 3634.0 3928.3 3933.8 3764.4 3788.7 4531.0 4533.8 4564.8 4369.5 5329.8 5489.9 5562.3 5577.9 1314.3 1334.7 1335.2 1337.3 1343.8 699.6 768.6 820.9 833.1 838.9 4167.8 4444.5 4471.9 4684.3 4972.3 5310.4 5465.8 5487.9 5493.5 5663.2 4182.0 4698.8 4798.8 5000.0 5142.3 2471.0 2576.7 2618.0 2892.0 2926.5 5417.2 5564.3 5771.3 5867.7 5880.3 5229.6 5336.5 5559.9 5721.2 5734.6 5059.9 5294.8 5518.9 5817.2 5846.4 5491.8 5512.2 5630.8 5631.7 5635.4 4572.2 4800.3 5211.9 5630.7 5632.4 5900.6 5904.1 5906.0 5935.8 6003.6 3401.8 3874.9 3915.5 3950.2 3956.8 4990.6 5298.9 5590.0 5602.5 5619.6 4305.1 5368.1 5429.1 5468.4 5473.0 4198.0 4946.2 5351.2 5392.3 5409.6 4310.9 4800.5 4834.3 5343.4 5394.9 4239.3 4834.6 5174.8 5186.3 5319.3 5046.9 5089.2 5252.9 5354.2 5384.6 11:34:47 INFO - PROCESS | 1652 | 11:34:47 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:25389.40 Median:3366.31 stddev:41530.40 (1233.7%) stddev-sans-first:41605.59 11:34:47 INFO - PROCESS | 1652 | Values: 716.8 729.7 775.9 819.7 828.7 15049.6 15566.5 15727.7 15885.8 15955.8 14165.2 14181.2 14247.0 14340.1 14359.6 663.9 687.4 820.1 827.9 843.1 823.5 842.3 842.4 843.4 843.9 892.6 893.6 897.1 898.6 899.3 705.2 727.5 730.3 891.3 893.4 534.6 537.2 639.3 659.9 663.3 14278.9 14411.1 14432.6 14477.3 14500.2 13378.9 13579.7 13723.7 13826.7 14181.9 12226.1 12657.3 12798.9 13254.9 13354.9 4521.4 4579.3 4588.0 4723.5 4749.7 123732.0 124224.0 125960.0 126592.0 127464.1 9166.0 10818.6 10973.6 11071.1 11407.0 20855.2 20865.2 21129.5 21136.2 21153.8 7554.1 7584.9 7621.2 7791.0 7818.8 4144.1 4206.8 4253.4 4256.6 4386.9 3303.0 3365.2 3365.7 3366.9 3395.0 641.3 641.6 643.7 650.8 665.5 570.2 605.1 631.7 632.5 639.3 8711.6 8757.4 8862.5 8888.1 8902.5 531.9 590.1 599.1 623.2 643.1 4011.4 4021.5 4244.7 4301.3 4377.4 102114.0 151640.7 167416.0 169926.0 170872.1 142011.0 142081.3 144131.6 145235.5 147215.0 81922.6 82163.2 98890.5 104043.5 108926.0 9327.5 9783.5 9878.6 10018.6 10061.5 56451.4 57181.1 57365.7 62522.0 63715.4 85759.0 85993.6 95202.5 95657.5 101429.5 12627.0 13208.9 13306.8 13666.7 13926.4 14807.2 14886.3 15482.9 15537.5 15630.4 13914.7 14101.6 14135.6 14191.6 14198.0 13633.6 13824.0 13904.6 14369.0 14437.8 11145.4 13533.3 13723.9 14365.4 14499.9 9210.4 10873.5 11485.4 11588.2 12043.6 10357.5 11356.7 11471.4 11620.2 11645.6 11:34:47 INFO - PROCESS | 1652 | -------- Summary: end -------- 11:34:47 INFO - PROCESS | 1652 | 11:34:48 INFO - TEST-INFO | 1652: exit 0 11:34:48 INFO - TEST-OK | dromaeo_css | took 1118560ms 11:34:48 INFO - TEST-START | kraken 11:34:48 INFO - operating with platform_type : mac_ 11:34:48 INFO - Initialising browser for kraken test... 11:34:48 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmp3TSbJP/profile http://localhost:49262/getInfo.html) 11:34:50 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 11:34:50 INFO - PROCESS | 1658 | colorDepth:24 11:34:50 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 11:34:50 INFO - PROCESS | 1658 | __metrics 11:34:50 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:34:50 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:34:51 INFO - TEST-INFO | 1658: exit 0 11:34:51 INFO - Browser initialized. 11:34:51 INFO - Running cycle 1/1 for kraken test... 11:34:51 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmp3TSbJP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:35:03 INFO - PROCESS | 1659 | RSS: Main: 234745856 11:35:03 INFO - PROCESS | 1659 | 11:35:06 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 11:35:06 INFO - PROCESS | 1659 | RSS: Main: 293990400 11:35:06 INFO - PROCESS | 1659 | 11:35:09 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 11:35:10 INFO - PROCESS | 1659 | RSS: Main: 292028416 11:35:10 INFO - PROCESS | 1659 | 11:35:13 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 11:35:14 INFO - PROCESS | 1659 | RSS: Main: 380002304 11:35:14 INFO - PROCESS | 1659 | 11:35:16 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 11:35:16 INFO - PROCESS | 1659 | RSS: Main: 282755072 11:35:16 INFO - PROCESS | 1659 | 11:35:19 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:35:19 INFO - PROCESS | 1659 | RSS: Main: 286244864 11:35:19 INFO - PROCESS | 1659 | 11:35:22 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 11:35:23 INFO - PROCESS | 1659 | RSS: Main: 326160384 11:35:23 INFO - PROCESS | 1659 | 11:35:26 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 11:35:26 INFO - PROCESS | 1659 | RSS: Main: 327610368 11:35:26 INFO - PROCESS | 1659 | 11:35:29 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 11:35:30 INFO - PROCESS | 1659 | RSS: Main: 326500352 11:35:30 INFO - PROCESS | 1659 | 11:35:32 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:35:32 INFO - PROCESS | 1659 | RSS: Main: 298553344 11:35:32 INFO - PROCESS | 1659 | 11:35:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:35:35 INFO - PROCESS | 1659 | RSS: Main: 304988160 11:35:35 INFO - PROCESS | 1659 | 11:35:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:35:38 INFO - PROCESS | 1659 | RSS: Main: 305483776 11:35:38 INFO - PROCESS | 1659 | 11:35:41 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:35:41 INFO - PROCESS | 1659 | RSS: Main: 314216448 11:35:41 INFO - PROCESS | 1659 | 11:35:44 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:35:45 INFO - PROCESS | 1659 | RSS: Main: 316784640 11:35:45 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 11:35:47 INFO - PROCESS | 1659 | RSS: Main: 360501248 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | __start_tp_report 11:35:47 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 11:35:47 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 11:35:47 INFO - PROCESS | 1659 | |i|pagename|runs| 11:35:47 INFO - PROCESS | 1659 | |0;ai-astar;112;113;113;112;113;111;113;113;113;120 11:35:47 INFO - PROCESS | 1659 | |1;audio-beat-detection;148;107;129;160;106;131;126;107;159;106 11:35:47 INFO - PROCESS | 1659 | |2;audio-dft;185;184;182;183;183;182;179;183;180;181 11:35:47 INFO - PROCESS | 1659 | |3;audio-fft;77;75;78;174;81;80;58;62;142;60 11:35:47 INFO - PROCESS | 1659 | |4;audio-oscillator;83;84;136;69;70;75;117;71;69;119 11:35:47 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;85;87;88;84;89;130;135;84;86;84 11:35:47 INFO - PROCESS | 1659 | |6;imaging-darkroom;134;151;90;93;92;91;92;93;113;150 11:35:47 INFO - PROCESS | 1659 | |7;imaging-desaturate;77;132;144;113;85;86;86;103;138;143 11:35:47 INFO - PROCESS | 1659 | |8;json-parse-financial;55;54;55;53;54;56;54;55;54;54 11:35:47 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;66;65;70;76;76;71;69;69;69;70 11:35:47 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;87;86;86;85;85;84;82;85;85;88 11:35:47 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;139;140;136;139;136;139;140;137;228;156 11:35:47 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;214;167;169;166;168;168;167;172;225;212 11:35:47 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;68;66;67;66;67;66;67;67;65;65 11:35:47 INFO - PROCESS | 1659 | __end_tp_report 11:35:47 INFO - PROCESS | 1659 | __start_cc_report 11:35:47 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2089 11:35:47 INFO - PROCESS | 1659 | __end_cc_report 11:35:47 INFO - PROCESS | 1659 | __startTimestamp1471977347360__endTimestamp 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | ------- Summary: start ------- 11:35:47 INFO - PROCESS | 1659 | Number of tests: 14 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:2.45 (2.2%) stddev-sans-first:2.55 11:35:47 INFO - PROCESS | 1659 | Values: 112.0 113.0 113.0 112.0 113.0 111.0 113.0 113.0 113.0 120.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:130.00 stddev:21.73 (16.7%) stddev-sans-first:21.79 11:35:47 INFO - PROCESS | 1659 | Values: 148.0 107.0 129.0 160.0 106.0 131.0 126.0 107.0 159.0 106.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:182.20 Median:183.00 stddev:1.81 (1.0%) stddev-sans-first:1.62 11:35:47 INFO - PROCESS | 1659 | Values: 185.0 184.0 182.0 183.0 183.0 182.0 179.0 183.0 180.0 181.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:88.70 Median:76.00 stddev:38.25 (50.3%) stddev-sans-first:40.34 11:35:47 INFO - PROCESS | 1659 | Values: 77.0 75.0 78.0 174.0 81.0 80.0 58.0 62.0 142.0 60.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:70.50 stddev:25.02 (35.5%) stddev-sans-first:26.43 11:35:47 INFO - PROCESS | 1659 | Values: 83.0 84.0 136.0 69.0 70.0 75.0 117.0 71.0 69.0 119.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:95.20 Median:85.50 stddev:19.77 (23.1%) stddev-sans-first:20.62 11:35:47 INFO - PROCESS | 1659 | Values: 85.0 87.0 88.0 84.0 89.0 130.0 135.0 84.0 86.0 84.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:109.90 Median:91.50 stddev:25.50 (27.9%) stddev-sans-first:25.51 11:35:47 INFO - PROCESS | 1659 | Values: 134.0 151.0 90.0 93.0 92.0 91.0 92.0 93.0 113.0 150.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:110.70 Median:110.50 stddev:26.73 (24.2%) stddev-sans-first:25.42 11:35:47 INFO - PROCESS | 1659 | Values: 77.0 132.0 144.0 113.0 85.0 86.0 86.0 103.0 138.0 143.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:0.84 (1.5%) stddev-sans-first:0.87 11:35:47 INFO - PROCESS | 1659 | Values: 55.0 54.0 55.0 53.0 54.0 56.0 54.0 55.0 54.0 54.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.00 stddev:3.60 (5.1%) stddev-sans-first:3.50 11:35:47 INFO - PROCESS | 1659 | Values: 66.0 65.0 70.0 76.0 76.0 71.0 69.0 69.0 69.0 70.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:1.64 (1.9%) stddev-sans-first:1.62 11:35:47 INFO - PROCESS | 1659 | Values: 87.0 86.0 86.0 85.0 85.0 84.0 82.0 85.0 85.0 88.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:139.50 stddev:28.35 (20.3%) stddev-sans-first:29.84 11:35:47 INFO - PROCESS | 1659 | Values: 139.0 140.0 136.0 139.0 136.0 139.0 140.0 137.0 228.0 156.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.80 Median:170.50 stddev:23.88 (14.0%) stddev-sans-first:22.51 11:35:47 INFO - PROCESS | 1659 | Values: 214.0 167.0 169.0 166.0 168.0 168.0 167.0 172.0 225.0 212.0 11:35:47 INFO - PROCESS | 1659 | 11:35:47 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:0.83 11:35:47 INFO - PROCESS | 1659 | Values: 68.0 66.0 67.0 66.0 67.0 66.0 67.0 67.0 65.0 65.0 11:35:47 INFO - PROCESS | 1659 | -------- Summary: end -------- 11:35:47 INFO - PROCESS | 1659 | 11:35:48 INFO - TEST-INFO | 1659: exit 0 11:35:48 INFO - TEST-OK | kraken | took 59798ms 11:35:48 INFO - SUITE-END | took 1178s 11:35:48 INFO - Completed test suite (00:19:38) 11:35:48 INFO - javascript benchmark 11:35:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2917.883284668613, 3275.6724327567244, 3289.6874796894303, 3328.6005679318487, 3334.1664583854035, 5507.118860982244, 5549.38956714761, 5619.887602247953, 5620.072688006479, 5630.127330263816, 5631.958087753768, 5650.095984642448, 5656.604037717361, 5665.206871038048, 5665.8583535411635, 5136.460671629481, 5181.948180518184, 5186.818461353853, 5208.8437346879655, 5264.210368444745, 4296.849610263642, 5144.868129011611, 5201.323827902367, 5232.895342093156, 5232.927249913759, 5131.281620573122, 5169.819056333029, 5185.351831021122, 5193.480651934814, 5221.71280579568, 4313.0, 5222.7649755760895, 5282.471752824726, 5288.550473209782, 5324.494173053554, 5090.261912022736, 5109.6167787415725, 5130.871728206787, 5189.1697328427645, 5214.322138122057, 5539.861503462445, 5541.972290138564, 5548.750306236188, 5582.692951887645, 5606.411326810667, 6154.569180157391, 6176.69116544171, 6176.783812566584, 6178.38216178383, 6179.598326108789, 6055.848603784896, 6093.2524753215375, 6128.747575574743, 6206.379362063803, 6210.813675589739, 5694.231278777394, 5719.027765279912, 5732.455416735404, 5756.309242890838, 5816.5928385013485, 6252.6873656317, 6257.5932564383165, 6308.526860485482, 6335.809925702236, 6340.841478963062, 5908.881822363529, 5944.791932282349, 6011.939880601138, 6062.787802426894, 6089.634621922699, 6176.258848938156, 6206.0, 6222.62664240147, 6226.003839385767, 6229.968850155811, 6173.290071641819, 6186.628802271878, 6189.04069869171, 6192.195014648067, 6195.19462469876, 6003.099535069687, 6004.309504407049, 6188.412100850412, 6202.0, 6217.0, 4852.587530059914, 4866.683665561727, 4879.95120048795, 4891.3396691446915, 4911.115999120193, 4340.652747780233, 4372.606465418127, 4382.6493880490125, 4386.956130438654, 4408.933865992013, 5492.258545096441, 5572.777088916398, 5623.100303951348, 5626.212330273765, 5630.40880707528, 6097.312956045969, 6159.414855588712, 6182.629042257479, 6280.057991301342, 6292.653904035322, 5609.5792815539, 5635.802746903839, 5660.433956604389, 5660.773569057274, 5676.262085928803, 5210.791568337224, 5372.758225879845, 5374.328208973879, 5376.865578360494, 5387.326584176978, 6230.844228894132, 6300.621962682254, 6305.211848518935, 6314.305426403, 6314.8737025258315, 6247.718852651551, 6259.843503912439, 6270.561060725706, 6281.057841323838, 6281.089242059968, 6318.6840657965995, 6324.209473815773, 6355.1420558224045, 6356.364363563792, 6399.688063946786, 5875.6474611523445, 5931.169636251015, 5932.733027013708, 5995.280566332068, 6026.427489388501, 6112.229929638781, 6130.417610327012, 6133.946794548733, 6170.969145154246, 6251.374862513712, 5868.002439585366, 6026.650968105667, 6028.2766068072115, 6030.698465076816, 6090.817275481742, 5558.444155584571, 5678.403767604342, 6019.819405417845, 6030.547708921761, 6052.848678783065, 5706.42935706426, 5816.360200377871, 5872.0, 5885.293764748258, 5938.8218353449465, 5855.092460668603, 6016.939830601638, 6037.969810151097, 6053.969730151321, 6055.485283750754, 5725.427457254241, 5730.3410107838135, 5781.756922261734, 5834.095715164156, 5838.532917366685], "value": 5626.142983843161, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.86983904828554, 484.39692582734494, 521.1609309012491, 524.4964833759591, 527.0171130840982, 39896.40155397671, 40941.0, 41074.0, 41095.17809643805, 43583.0, 41947.79026104873, 42344.576554234525, 42352.152956940845, 42455.78772106135, 42501.787491062576, 8816.823663526726, 9019.503927283997, 9664.75838104046, 9870.358426702242, 9886.90113098867, 8547.188017138362, 8915.242204412632, 8996.145366190201, 11878.94060529696, 12251.632451026484, 12262.264264144136, 12273.447694853709, 12311.015118790476, 12315.692107697334, 12328.19866708661, 12123.0, 12211.206271592408, 12218.816717749241, 12224.633261002184, 12229.082818788627, 11952.0, 12021.0, 12022.338771367571, 12034.21777584463, 12043.93978030113, 39908.80045599753, 40154.39768403476, 40209.39685904714, 40226.19547609061, 40237.59762402368, 2992.2818523554406, 3352.396568617648, 3431.4509678451577, 3443.9827800861085, 3762.830672619711, 30571.0, 31035.534466983012, 31701.0, 31768.364632707217, 31902.0, 3233.692799184074, 3306.7519936004896, 3346.8159251241173, 3379.5268662387284, 3385.0352649494776, 508177.0, 511532.0, 511888.44055779855, 511949.0, 512622.0, 55381.723091385094, 55511.72244138754, 55588.444115559134, 55936.72031639897, 56019.71990140023, 58262.417375826546, 58442.0, 58484.70757646184, 58538.7073064632, 58566.12150817741, 15878.364865405254, 16122.75815862763, 16129.758053629204, 16151.577263410583, 16174.353025879069, 12709.237445753284, 12773.169743966613, 12781.424835882408, 12789.488420463264, 12794.68013299675, 12951.546695865787, 13417.597472075853, 14554.199519026555, 15009.0, 15113.773293400607, 6743.595384276861, 6794.354536319141, 6882.655867206619, 6912.827179320558, 6918.238993710688, 866.3632230310717, 953.4565297780338, 975.8777405983176, 998.0518507417837, 1007.7279134633608, 29788.2552936174, 29871.0, 29902.70097298999, 30276.848615757222, 30538.69461305403, 1003.6988903328972, 1004.4425343934041, 1010.4695035106628, 1045.926785125034, 1059.4914441068177, 14732.55802325932, 15510.844891551165, 15542.145182014872, 15546.067235965878, 15789.447369342019, 641818.0, 648503.0, 651608.0, 652832.0, 654361.0, 50193.0, 50904.490955089976, 57318.0, 58166.7091664539, 58246.708766456744, 1388.0838646493266, 1399.4891864469396, 1434.6269969807925, 1436.2100844535464, 1436.8491308412465, 29263.85368073231, 30628.0, 31446.899358522343, 32104.036878893672, 32348.676513234568, 49480.50519494759, 50168.7457813543, 50209.24686129784, 50229.74425639388, 50339.496605033484, 522265.0, 524002.0, 524819.0, 525350.0, 526648.0, 25920.0, 26523.204303870916, 26554.0, 39150.0, 39500.0, 47295.763521182176, 47541.0, 48118.5188148114, 48129.0, 48290.75854620704, 33054.67781288818, 37823.81088094542, 39058.414123787596, 40464.79767601143, 40763.0, 37912.81043594764, 38877.6112238874, 39137.60862391454, 39806.20387592174, 40330.395044073775, 37160.62839371571, 37666.2466750658, 37788.43317350187, 37816.0, 38163.42754858735, 27579.448411031266, 33284.500732488545, 34649.30701386009, 34752.65247347494, 34775.47836782501, 23261.41846453852, 25313.49373012566, 25480.490390192463, 25563.872180638977, 26461.0], "value": 20188.978534784517, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.89823951054194, 369.29833316698284, 371.93119272934507, 380.6231830487818, 400.86370633984455, 14978.0, 15270.847291527081, 20431.667589033317, 21015.579688406222, 21239.893800531016, 19524.804751952477, 20106.899465502687, 20197.364474394602, 20770.896145519288, 20974.49048454582, 5766.942330576703, 6079.240094988127, 6085.087236914476, 6090.208272924514, 6090.60411073281, 5889.8822023559505, 6045.395460453963, 6173.290071641752, 6185.969070154643, 6256.937430625704, 6239.968800156015, 6255.124282600417, 6258.030005349178, 6265.185525881629, 6273.12176295319, 5985.401459854023, 6148.938510614881, 6215.627062376272, 6220.87558248837, 6224.533160012972, 5791.218185544982, 5980.431858973434, 6012.699365031731, 6019.488343490765, 6027.336992930774, 13547.864521354857, 13761.862381376159, 13775.035747497679, 13847.584572462742, 15988.200589970455, 2153.3755210988793, 2180.433087397288, 2204.349716833522, 2220.844540882139, 2414.8188885833633, 9106.81786364269, 9797.510124493818, 9989.450580218085, 10236.53935572901, 10355.844662330072, 1854.77742670879, 1873.3443294846695, 1895.6777347850898, 1955.9119839607251, 1957.9671227990227, 104399.47800261027, 111536.88463115427, 112704.4364778179, 113293.0, 113417.0, 11203.047740942111, 11207.831882521768, 11242.213045086928, 11381.203315767982, 11499.655010349536, 12648.494060237488, 13302.068855180238, 13346.599602011762, 13987.930060349634, 14101.435942562388, 8348.582570871433, 8456.0, 8545.2309292164, 8679.392442529088, 8740.300775937909, 8512.616932238065, 8515.531645759418, 8530.530820804915, 8680.609372578123, 8682.0, 4440.844570440084, 4525.303011370736, 4533.297338912474, 4611.146937816515, 4611.354410382549, 1875.8124187581407, 1915.668610315845, 1926.5743349921238, 1961.6978251819105, 1977.3968939473311, 801.8797180422866, 861.6036623153294, 899.4423457456288, 927.9582418791035, 949.9335046546676, 20905.163793448395, 21148.259810906544, 21390.893045534674, 21539.67690484644, 21710.34868953934, 768.4851149729694, 884.5754038061766, 914.1224424552371, 944.573693722484, 997.9650712225038, 10856.2400631955, 11266.774664506827, 11312.151588630886, 11343.829842552368, 11385.544578216945, 573559.0, 617461.0, 631580.0, 636869.0, 638151.0, 115034.84965150409, 132473.33763331315, 136004.0, 136288.0, 139876.0, 918.5774543709969, 923.8891333040078, 951.0, 951.9286053546011, 952.4618590496348, 18632.534186645444, 19050.237990480226, 19178.520536986685, 19178.90410547938, 19286.842789432678, 44578.66264012085, 53276.0, 56627.71686141543, 57248.0, 57328.28015159552, 83965.0, 84259.15740842513, 84352.0, 84378.0, 84831.0, 8061.1938806118915, 8099.919000809917, 8171.387145963958, 8276.751697449086, 8333.333333333198, 13138.868611314147, 13187.60437186886, 13284.003699722367, 13517.188968661912, 13611.251381173734, 11421.828672569753, 11429.59996400122, 11496.770064598828, 11613.6515904523, 11749.060075193793, 9539.570719317786, 11059.447027648424, 11203.271787333797, 11226.831597525881, 11438.42807859587, 10795.892041079489, 11244.55021799119, 11638.825417618573, 11677.474513646737, 11793.29240245588, 6761.729530818909, 7556.508826926232, 7662.233776622294, 8033.0, 8069.233422824822, 10945.960133787277, 11110.389123535046, 11194.66416007521, 11539.942300288445, 11543.018843398406], "value": 9459.560286300995, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1306.209743105421, 1344.3815844711432, 1501.159350763572, 1630.1686140068568, 1835.9082045897694, 7779.494332868359, 8281.0, 8284.62719177637, 8285.585720713963, 8309.667613295462, 8461.0, 8695.434796738207, 8757.7810554736, 8878.600462979166, 8884.600192991315, 2395.6526303686, 2422.176460003607, 2422.7213870404867, 2425.1754403502805, 2425.2360506440505, 1994.9601007979832, 2007.2773801431474, 2367.8342516023886, 2412.746661600524, 2418.6492958521003, 2372.893219805113, 2402.0, 2405.747396523366, 2407.6629271901948, 2409.8915548800346, 2361.3388251289666, 2380.0, 2384.76152384761, 2386.033656369173, 2405.56699794037, 1982.742243508349, 2385.7017872765905, 2387.9164229252065, 2393.1863166523467, 2397.376682062659, 8806.20744133031, 8839.204471597523, 8947.865782013276, 8951.86572201411, 8964.327675424303, 4794.5205479452125, 4968.205087186033, 5350.224217488481, 5362.624616276862, 5364.329458817648, 3297.835108244602, 3595.227026189356, 3709.7217708671956, 3713.4615480755137, 3741.484698697032, 963.8506031565119, 1098.2531878322736, 1114.7324642085923, 1118.4453609482825, 1126.5212284779018, 11649.883501164964, 11715.355655438947, 11739.647810565697, 11745.882541174564, 11754.0, 4653.883652908705, 4714.127886341038, 4816.0, 4859.003904199631, 4883.58489528387, 10015.298929075041, 10028.398296102258, 10039.548220330104, 10040.196784257241, 10042.799144017225, 5388.299521062237, 5392.5416339611575, 5395.190721391823, 5396.91904621431, 5400.21696853954, 4844.031193761191, 4864.148773964542, 4958.826441074545, 4963.181075122564, 4965.32968049316, 3778.981105094457, 3806.7715937043868, 3860.4402361657403, 3893.844246230176, 3905.7932268268337, 1257.9874201257871, 1265.1649911058657, 1265.7658333208385, 1284.383495921944, 1285.9935700321626, 867.4231635962141, 888.5646033443566, 911.8267529169436, 929.693201243588, 940.4279296125093, 5809.477147056785, 6129.84675383119, 6155.076738489173, 6182.0, 6400.583962042452, 877.7717793373769, 909.1454033208763, 969.1907257439975, 986.4585245795851, 1015.9847602285971, 3822.7706337619834, 4043.872104010751, 4047.352423612208, 4115.588441155861, 4179.707420480598, 9982.700518984442, 10417.843732344021, 10621.362718236931, 10831.67504974852, 11056.502457389437, 10355.17158627308, 10507.264491485523, 10510.684679459628, 10521.947390263, 10523.947605239415, 8148.592570371457, 8189.631466584018, 8253.917460825314, 8381.455205411507, 8444.831103378021, 5942.851428714317, 5965.940340596539, 6137.478314343331, 6224.62652240867, 6258.3741625838875, 8371.497710137412, 10079.294449388766, 10155.289129760846, 10233.692989210336, 10262.948685256526, 9725.0, 10266.178705703376, 10346.793064138825, 10367.533460994424, 10393.9480302598, 7024.613646249505, 7148.785536433916, 7150.356467917913, 7156.141263048467, 7157.212706602374, 8268.09051004401, 8269.503829770232, 8301.958490207511, 8361.247487726134, 8369.539675317916, 7475.476716629783, 7553.32020118192, 7588.089429268523, 7646.426518011061, 7653.502522336031, 7423.257674232534, 7530.209328020479, 7593.924060759322, 7610.200928902607, 7837.568933708472, 6559.8032059038305, 6843.144606924135, 6902.758403455855, 7044.612546309797, 7051.964740176266, 5101.566366858859, 5151.407588127413, 5160.354955630546, 5186.09243382399, 5311.336082989626, 4270.145970805789, 4655.6973796703105, 4925.433575138905, 5146.099432599205, 5422.349318081855], "value": 4602.73697877862, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.2394893022792, 302.62776784554995, 306.94474994500996, 312.3783670495714, 313.0764245475847, 4348.673459699057, 5251.92335571208, 5273.604479664031, 5282.894342113155, 5297.947020529794, 4812.893034602043, 5111.591072714184, 5200.921986170201, 5227.712475813829, 5265.368155821307, 3050.4051709916575, 3745.887623371303, 3908.7263891527464, 4003.8989277948654, 4019.718619696622, 3971.523417189941, 3989.620986006339, 3994.2410941920944, 3995.3207954647633, 4012.6990475714438, 3689.335919534483, 3764.9058773530605, 3896.4544963705102, 3940.192260586587, 3960.168364643414, 3102.2317279150893, 3224.500202468621, 3612.169201083739, 3922.8038598070266, 3976.3041467743174, 3136.952945705816, 3434.7423943204108, 3453.3093381323583, 3468.167639766438, 3469.271452994849, 4115.176964607061, 4403.867883963486, 5031.899362012776, 5051.0, 5071.7971281149075, 4061.878143655695, 4072.3077076897, 4176.979115104405, 4325.697201195918, 4537.183307004738, 4262.786860656955, 4441.977790111061, 4938.555530002282, 4989.201727723546, 5449.155380915964, 3479.460683594047, 3528.8235588220487, 3796.791176485292, 3807.9238415231816, 3836.232753449321, 5547.306586676666, 5632.605717599769, 5705.914411283834, 5722.227499287585, 5738.540916726652, 3786.4320351947426, 3829.008915363995, 3859.208862183246, 3869.903252418712, 3872.302985462644, 3088.6911308869385, 3248.8213148277073, 3634.00064982132, 3928.2929072767174, 3933.783641899666, 3764.3976963685677, 3788.6969042477085, 4530.954690453119, 4533.818647254073, 4564.794584243717, 4369.509379653567, 5329.786808527616, 5489.890202196014, 5562.332520097614, 5577.888442231133, 1314.3034191878319, 1334.7063645997864, 1335.1855368225374, 1337.2778699502355, 1343.7984302354726, 699.629196525832, 768.6041688530412, 820.8932838730926, 833.0836080311609, 838.8783626374142, 4167.790801083149, 4444.466664000341, 4471.8658440246845, 4684.320773487893, 4972.265254110297, 5310.415854256029, 5465.754041068161, 5487.862803429866, 5493.478119578634, 5663.207150998864, 4181.97909010453, 4698.8120475181295, 4798.808047678054, 5000.000000000029, 5142.254373115952, 2470.987645061763, 2576.6779152605923, 2617.9607305890427, 2892.0, 2926.5024945759274, 5417.160340147283, 5564.276644036249, 5771.30744310677, 5867.735951882176, 5880.294364676266, 5229.607779416559, 5336.519713225828, 5559.916601250984, 5721.196613659277, 5734.598578099493, 5059.924101138486, 5294.802656897422, 5518.91721624176, 5817.243758311392, 5846.363018354868, 5491.835244942658, 5512.200730893917, 5630.831075067755, 5631.7184140793615, 5635.351934527582, 4572.216835434117, 4800.279958006327, 5211.895762084661, 5630.662160270397, 5632.408597097409, 5900.5574581907385, 5904.0553511437965, 5905.970470147622, 5935.762569497345, 6003.609765365237, 3401.7618766686096, 3874.922501549897, 3915.5497117831815, 3950.249452603996, 3956.782376969179, 4990.6063876564285, 5298.947010529845, 5589.972050139723, 5602.52378547828, 5619.606627536034, 4305.09592985464, 5368.147988943808, 5429.131338985743, 5468.429837976145, 5473.014857325719, 4197.97901010493, 4946.233333833262, 5351.1973204019705, 5392.299001129828, 5409.5672346213, 4310.870673879788, 4800.495947925418, 4834.250691142738, 5343.385510666168, 5394.892102158014, 4239.25812982733, 4834.63740219492, 5174.7930082796265, 5186.299849520417, 5319.324412809952, 5046.949530504648, 5089.150075957476, 5252.894942101213, 5354.152817278033, 5384.596155288447], "value": 3926.1633621693863, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7742161219215, 729.6607077708868, 775.9301662850343, 819.7335865843602, 828.747232094211, 15049.62375940602, 15566.45517406891, 15727.685446291081, 15885.84114158858, 15955.760663590041, 14165.220912849789, 14181.220032898187, 14247.0, 14340.067895586779, 14359.64100897478, 663.8539521305305, 687.3847906124016, 820.1347578304886, 827.9006519217687, 843.0557775291682, 823.4935514658472, 842.3135144856952, 842.4145219072747, 843.3843294395095, 843.9367047471434, 892.5626443042927, 893.6246776353914, 897.0939351255247, 898.6270697660464, 899.2895612466144, 705.2418649951322, 727.4943913979786, 730.3280981497036, 891.3359547137392, 893.3567831161554, 534.6204195021539, 537.2237117365408, 639.2871947778241, 659.8746238214724, 663.3068443476578, 14278.928605356907, 14411.063280886709, 14432.639184020483, 14477.34851931655, 14500.202488863108, 13378.93310533441, 13579.728405431935, 13723.656908577266, 13826.723465530733, 14181.858181418156, 12226.134391272006, 12657.30384828834, 12798.872011279955, 13254.933725331408, 13354.86645133546, 4521.389612402317, 4579.3131030345385, 4587.977060114711, 4723.527647235283, 4749.691270067435, 123732.0, 124224.0, 125959.99999999908, 126592.0, 127464.08803867949, 9165.954170229239, 10818.567257309776, 10973.615923442801, 11071.114310855111, 11407.0, 20855.165793368094, 20865.1653933844, 21129.471763205736, 21136.15455381798, 21153.788462115182, 7554.093508778982, 7584.924150758422, 7621.237876212334, 7791.0, 7818.765437036898, 4144.067584793458, 4206.768627725504, 4253.383259427427, 4256.553061928453, 4386.912261754747, 3302.983485082559, 3365.158710322419, 3365.730741540671, 3366.898993030213, 3394.9830250848586, 641.2689533931322, 641.6054126712038, 643.652427689052, 650.7592190889306, 665.4676258992787, 570.164708701754, 605.1452298704456, 631.7378288010424, 632.5003247434475, 639.3414782773658, 8711.564421779012, 8757.430767000125, 8862.468251904906, 8888.066752990972, 8902.465852048897, 531.8563987723293, 590.052964991183, 599.12228585123, 623.1680706257107, 643.0771842406162, 4011.3581826907553, 4021.477207962946, 4244.72409293395, 4301.268784306675, 4377.409049778303, 102114.0, 151640.72538911924, 167416.0, 169926.0, 170872.145639271, 142011.0, 142081.28959355137, 144131.5586844139, 145235.54764452222, 147215.0, 81922.59038704769, 82163.17836821674, 98890.5055474718, 104043.4797826006, 108926.0, 9327.533623318943, 9783.510824458606, 9878.555465003948, 10018.64934727281, 10061.547230374505, 56451.435485644615, 57181.142282866625, 57365.713171433876, 62522.0, 63715.36284637095, 85759.0, 85993.57003214944, 95202.52398737962, 95657.521712391, 101429.49285253526, 12627.0, 13208.933955330162, 13306.800397993844, 13666.726665466835, 13926.4429422826, 14807.226579011682, 14886.330115144629, 15482.922585387001, 15537.533873983799, 15630.374785008928, 13914.721705566035, 14101.576952691436, 14135.575932722035, 14191.574252772434, 14198.00613957013, 13633.590992270249, 13824.0, 13904.58286251414, 14369.0, 14437.7834332483, 11145.442727863736, 13533.255670938193, 13723.931380343034, 14365.425382984982, 14499.92750036243, 9210.401323913924, 10873.45632718345, 11485.3803490462, 11588.188826782045, 12043.638690839289, 10357.533910973874, 11356.659300221007, 11471.369074700971, 11620.244684095507, 11645.59240426581], "value": 7780.370760394673, "unit": "score"}], "name": "dromaeo_css", "value": 7298.016983309878, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 112.0, 113.0, 111.0, 113.0, 113.0, 113.0, 120.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 107.0, 129.0, 160.0, 106.0, 131.0, 126.0, 107.0, 159.0, 106.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 182.0, 183.0, 183.0, 182.0, 179.0, 183.0, 180.0, 181.0], "value": 182.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 78.0, 174.0, 81.0, 80.0, 58.0, 62.0, 142.0, 60.0], "value": 88.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 136.0, 69.0, 70.0, 75.0, 117.0, 71.0, 69.0, 119.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 88.0, 84.0, 89.0, 130.0, 135.0, 84.0, 86.0, 84.0], "value": 95.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 151.0, 90.0, 93.0, 92.0, 91.0, 92.0, 93.0, 113.0, 150.0], "value": 109.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 132.0, 144.0, 113.0, 85.0, 86.0, 86.0, 103.0, 138.0, 143.0], "value": 110.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 53.0, 54.0, 56.0, 54.0, 55.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 70.0, 76.0, 76.0, 71.0, 69.0, 69.0, 69.0, 70.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 85.0, 85.0, 84.0, 82.0, 85.0, 85.0, 88.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 136.0, 139.0, 136.0, 139.0, 140.0, 137.0, 228.0, 156.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 167.0, 169.0, 166.0, 168.0, 168.0, 167.0, 172.0, 225.0, 212.0], "value": 182.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0, 65.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1525.2, "alertThreshold": 2.0}]} 11:35:48 INFO - Return code: 0 11:35:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:35:48 INFO - # TBPL SUCCESS # 11:35:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:35:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:35:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:35:48 INFO - 2016-08-23 11:35:48.693 screenresolution[1663:10343] starting screenresolution argv=screenresolution get 11:35:48 INFO - 2016-08-23 11:35:48.696 screenresolution[1663:10343] Display 0: 1600x1200x32@60 11:35:48 INFO - 2016-08-23 11:35:48.702 screenresolution[1664:10346] starting screenresolution argv=screenresolution list 11:35:48 INFO - Available Modes on Display 0 11:35:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:35:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:35:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:35:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:35:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:35:48 INFO - Intel Iris: 11:35:48 INFO - Chipset Model: Intel Iris 11:35:48 INFO - Type: GPU 11:35:48 INFO - Bus: Built-In 11:35:48 INFO - VRAM (Dynamic, Max): 1536 MB 11:35:48 INFO - Vendor: Intel (0x8086) 11:35:48 INFO - Device ID: 0x0a2e 11:35:48 INFO - Revision ID: 0x0009 11:35:48 INFO - Displays: 11:35:48 INFO - Display: 11:35:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:35:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:35:48 INFO - Display Serial Number: 1600x1200 60 11:35:48 INFO - Main Display: Yes 11:35:48 INFO - Mirror: Off 11:35:48 INFO - Online: Yes 11:35:48 INFO - Rotation: Supported 11:35:48 INFO - Return code: 0 11:35:48 INFO - Running post-action listener: _resource_record_post_action 11:35:48 INFO - [mozharness: 2016-08-23 18:35:48.934884Z] Finished run-tests step (success) 11:35:48 INFO - Running post-run listener: _resource_record_post_run 11:35:48 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 31874048; Write bytes: 705480704; Read time: 192; Write time: 1952 11:35:48 INFO - TinderboxPrint: CPU usage
53.3% 11:35:48 INFO - TinderboxPrint: I/O read bytes / time
31,874,048 / 192 11:35:48 INFO - TinderboxPrint: I/O write bytes / time
705,480,704 / 1,952 11:35:48 INFO - TinderboxPrint: CPU idle
2,265.0 (46.7%) 11:35:48 INFO - TinderboxPrint: CPU system
968.3 (19.9%) 11:35:48 INFO - TinderboxPrint: CPU user
1,620.4 (33.4%) 11:35:48 INFO - TinderboxPrint: Swap in / out
433,135,616 / 0 11:35:48 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394965504; Write bytes: 389502464; Read time: 29543; Write time: 789 11:35:49 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 29928448; Write bytes: 295985664; Read time: 175; Write time: 1111 11:35:49 INFO - Running post-run listener: _upload_blobber_files 11:35:49 INFO - Blob upload gear active. 11:35:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:35:49 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 11:35:49 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'] 11:35:49 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 11:35:49 INFO - (blobuploader) - INFO - Open directory for files ... 11:35:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:35:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:50 INFO - (blobuploader) - INFO - Done attempting. 11:35:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:35:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:35:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:51 INFO - (blobuploader) - INFO - Done attempting. 11:35:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:35:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:35:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:35:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:35:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:35:53 INFO - (blobuploader) - INFO - Done attempting. 11:35:53 INFO - (blobuploader) - INFO - Iteration through files over. 11:35:53 INFO - Return code: 0 11:35:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:35:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:35:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aab577c6827779ce66b66eebb84ac9904446e890a5eed23611da1332fe22e525b8c7fb38135652db6bb9038d07da1ccaa9f63448669ede5f18082b1baf8e6431", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e710e22de97d62421136bdaf8785a7d24dae7cefaadc18a367cbef8350eb8fa157dfc1eb282fc3a082f2530107240de3b7ec5c7c602917e8bd4225bde11932a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61305b671cafc82924a5c486137c54ea137e20aa8a1cb9474e549dbae6cca4fd5a77181459c49e8bad65b7ce89c2b9c91d9e8ddca53cebc004f35ee1450ebb84"} 11:35:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:35:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:35:53 INFO - Contents: 11:35:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aab577c6827779ce66b66eebb84ac9904446e890a5eed23611da1332fe22e525b8c7fb38135652db6bb9038d07da1ccaa9f63448669ede5f18082b1baf8e6431", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e710e22de97d62421136bdaf8785a7d24dae7cefaadc18a367cbef8350eb8fa157dfc1eb282fc3a082f2530107240de3b7ec5c7c602917e8bd4225bde11932a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61305b671cafc82924a5c486137c54ea137e20aa8a1cb9474e549dbae6cca4fd5a77181459c49e8bad65b7ce89c2b9c91d9e8ddca53cebc004f35ee1450ebb84"} 11:35:53 INFO - Running post-run listener: copy_logs_to_upload_dir 11:35:53 INFO - Copying logs to upload dir... 11:35:53 INFO - mkdir: /builds/slave/test/build/upload/logs 11:35:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.899878 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-23 11:35:53.966299) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 11:35:53.969920) ========= 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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/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/aab577c6827779ce66b66eebb84ac9904446e890a5eed23611da1332fe22e525b8c7fb38135652db6bb9038d07da1ccaa9f63448669ede5f18082b1baf8e6431", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e710e22de97d62421136bdaf8785a7d24dae7cefaadc18a367cbef8350eb8fa157dfc1eb282fc3a082f2530107240de3b7ec5c7c602917e8bd4225bde11932a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61305b671cafc82924a5c486137c54ea137e20aa8a1cb9474e549dbae6cca4fd5a77181459c49e8bad65b7ce89c2b9c91d9e8ddca53cebc004f35ee1450ebb84"} build_url:https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011189 build_url: 'https://queue.taskcluster.net/v1/task/JoX8H5TbRkibau5AqFS8lg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aab577c6827779ce66b66eebb84ac9904446e890a5eed23611da1332fe22e525b8c7fb38135652db6bb9038d07da1ccaa9f63448669ede5f18082b1baf8e6431", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e710e22de97d62421136bdaf8785a7d24dae7cefaadc18a367cbef8350eb8fa157dfc1eb282fc3a082f2530107240de3b7ec5c7c602917e8bd4225bde11932a4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61305b671cafc82924a5c486137c54ea137e20aa8a1cb9474e549dbae6cca4fd5a77181459c49e8bad65b7ce89c2b9c91d9e8ddca53cebc004f35ee1450ebb84"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-23 11:35:54.002635) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:35:54.002917) ========= 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.MhUvbgJcg6/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.wyzIO7UpsC/Listeners TMPDIR=/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005206 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-23 11:35:54.051028) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 11:35:54.051319) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-23 11:35:54.051632) ========= ========= Total master_lag: 0.17 =========