builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0253 starttime: 1471520653.58 results: success (0) buildid: 20160818023814 builduid: 3c3cd6219c2c476db425737bc50e3032 revision: a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 04:44:13.576532) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 04:44:13.577048) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 04:44:13.577394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 04:44:13.602060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:44:13.602446) ========= 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.PtAyilHf8x/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.siJWOSPIPH/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-18 04:44:13-- 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% 9.87M=0.001s 2016-08-18 04:44:13 (9.87 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133921 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:44:13.759124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:44:13.759468) ========= 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.PtAyilHf8x/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.siJWOSPIPH/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.020850 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 04:44:13.808422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 04:44:13.808871) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388 --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 a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PtAyilHf8x/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.siJWOSPIPH/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-18 04:44:13,894 truncating revision to first 12 chars 2016-08-18 04:44:13,894 Setting DEBUG logging. 2016-08-18 04:44:13,894 attempt 1/10 2016-08-18 04:44:13,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a6f67ab4a4ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 04:44:15,496 unpacking tar archive at: fx-team-a6f67ab4a4ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.880339 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 04:44:15.712320) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 04:44:15.712702) ========= script_repo_revision: a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 04:44:15.713148) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 04:44:15.713458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 04:44:15.732171) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-18 04:44:15.732478) ========= /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.PtAyilHf8x/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.siJWOSPIPH/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 04:44:15 INFO - MultiFileLogger online at 20160818 04:44:15 in /builds/slave/test 04:44:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:44:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:44:15 INFO - {'append_to_log': False, 04:44:15 INFO - 'base_work_dir': '/builds/slave/test', 04:44:15 INFO - 'blob_upload_branch': 'Fx-Team', 04:44:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:44:15 INFO - 'branch': 'Fx-Team', 04:44:15 INFO - 'buildbot_json_path': 'buildprops.json', 04:44:15 INFO - 'config_files': ('talos/mac_config.py',), 04:44:15 INFO - 'default_actions': ('clobber', 04:44:15 INFO - 'read-buildbot-config', 04:44:15 INFO - 'download-and-extract', 04:44:15 INFO - 'populate-webroot', 04:44:15 INFO - 'create-virtualenv', 04:44:15 INFO - 'install', 04:44:15 INFO - 'run-tests'), 04:44:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:44:15 INFO - 'download_minidump_stackwalk': True, 04:44:15 INFO - 'download_symbols': 'ondemand', 04:44:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:44:15 INFO - 'tooltool.py': '/tools/tooltool.py', 04:44:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:44:15 INFO - '/tools/misc-python/virtualenv.py')}, 04:44:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:44:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:44:15 INFO - 'installer_path': 'installer.exe', 04:44:15 INFO - 'log_level': 'info', 04:44:15 INFO - 'log_name': 'talos', 04:44:15 INFO - 'log_to_console': True, 04:44:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:44:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:44:15 INFO - 'opt_config_files': (), 04:44:15 INFO - 'pip_index': False, 04:44:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:44:15 INFO - 'cmd': ('bash', 04:44:15 INFO - '-c', 04:44:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:44:15 INFO - 'enabled': True, 04:44:15 INFO - 'halt_on_failure': False, 04:44:15 INFO - 'name': 'check_screen_resolution'},), 04:44:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:44:15 INFO - 'cmd': ('bash', 04:44:15 INFO - '-c', 04:44:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:44:15 INFO - 'enabled': True, 04:44:15 INFO - 'halt_on_failure': False, 04:44:15 INFO - 'name': 'check_screen_resolution'},), 04:44:15 INFO - 'run_cmd_checks_enabled': True, 04:44:15 INFO - 'sps_profile': False, 04:44:15 INFO - 'sps_profile_interval': 0, 04:44:15 INFO - 'suite': 'dromaeojs', 04:44:15 INFO - 'system_bits': '32', 04:44:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:44:15 INFO - 'title': 't-yosemite-r7-0253', 04:44:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:44:15 INFO - 'use_talos_json': True, 04:44:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:44:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:44:15 INFO - 'work_dir': 'build'} 04:44:15 INFO - [mozharness: 2016-08-18 11:44:15.936722Z] Running clobber step. 04:44:15 INFO - Running pre-action listener: _resource_record_pre_action 04:44:15 INFO - Running main action method: clobber 04:44:15 INFO - rmtree: /builds/slave/test/build 04:44:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:44:16 INFO - Running post-action listener: _resource_record_post_action 04:44:16 INFO - [mozharness: 2016-08-18 11:44:16.990356Z] Finished clobber step (success) 04:44:16 INFO - [mozharness: 2016-08-18 11:44:16.990465Z] Running read-buildbot-config step. 04:44:16 INFO - Running pre-action listener: _resource_record_pre_action 04:44:16 INFO - Running main action method: read_buildbot_config 04:44:16 INFO - Using buildbot properties: 04:44:16 INFO - { 04:44:16 INFO - "project": "", 04:44:16 INFO - "product": "firefox", 04:44:16 INFO - "script_repo_revision": "production", 04:44:16 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:44:16 INFO - "repository": "", 04:44:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:44:16 INFO - "buildid": "20160818023814", 04:44:16 INFO - "pgo_build": "False", 04:44:16 INFO - "basedir": "/builds/slave/test", 04:44:16 INFO - "buildnumber": 916, 04:44:16 INFO - "slavename": "t-yosemite-r7-0253", 04:44:16 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:44:16 INFO - "platform": "yosemite_r7", 04:44:16 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 04:44:16 INFO - "branch": "fx-team", 04:44:16 INFO - "repo_path": "integration/fx-team", 04:44:16 INFO - "revision": "a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388", 04:44:16 INFO - "stage_platform": "macosx64", 04:44:16 INFO - "builduid": "3c3cd6219c2c476db425737bc50e3032", 04:44:16 INFO - "slavebuilddir": "test" 04:44:16 INFO - } 04:44:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 04:44:16 INFO - Running post-action listener: _resource_record_post_action 04:44:16 INFO - [mozharness: 2016-08-18 11:44:16.993429Z] Finished read-buildbot-config step (success) 04:44:16 INFO - [mozharness: 2016-08-18 11:44:16.993540Z] Running download-and-extract step. 04:44:16 INFO - Running pre-action listener: _resource_record_pre_action 04:44:16 INFO - Running main action method: download_and_extract 04:44:16 INFO - mkdir: /builds/slave/test/build/tests 04:44:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:16 INFO - trying https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 04:44:16 INFO - Downloading https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/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 04:44:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/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 04:44:18 INFO - Downloaded 1199 bytes. 04:44:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:44:18 INFO - Using the following test package requirements: 04:44:18 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:44:18 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:18 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 04:44:18 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:18 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 04:44:18 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:18 INFO - u'jsshell-mac.zip'], 04:44:18 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:18 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 04:44:18 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:44:18 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:18 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 04:44:18 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:18 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 04:44:18 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:18 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 04:44:18 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:44:18 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 04:44:18 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:18 INFO - trying https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:44:18 INFO - Downloading https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/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 04:44:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/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 04:44:19 INFO - Downloaded 16339426 bytes. 04:44:19 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:44:26 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 04:44:26 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')]} 04:44:26 INFO - trying https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:44:26 INFO - Downloading https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/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 04:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/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 04:44:27 INFO - Downloaded 16339426 bytes. 04:44:27 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:33 INFO - trying https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:44:33 INFO - Downloading https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/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 04:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/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 04:44:34 INFO - Downloaded 14413981 bytes. 04:44:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 04:44:35 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')]} 04:44:35 INFO - trying https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:44:35 INFO - Downloading https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 04:44:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/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 04:44:38 INFO - Downloaded 111293115 bytes. 04:44:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:44:38 INFO - mkdir: /builds/slave/test/properties 04:44:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:44:38 INFO - Writing to file /builds/slave/test/properties/build_url 04:44:38 INFO - Contents: 04:44:38 INFO - build_url:https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:44:38 INFO - Running post-action listener: _resource_record_post_action 04:44:38 INFO - Running post-action listener: set_extra_try_arguments 04:44:38 INFO - [mozharness: 2016-08-18 11:44:38.685249Z] Finished download-and-extract step (success) 04:44:38 INFO - [mozharness: 2016-08-18 11:44:38.685399Z] Running populate-webroot step. 04:44:38 INFO - Running pre-action listener: _resource_record_pre_action 04:44:38 INFO - Running main action method: populate_webroot 04:44:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:44:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:44:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:44:38 INFO - '--tppagecycles', 04:44:38 INFO - '7'], 04:44:38 INFO - 'tests': ['tsvgm']}}, 04:44:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:44:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:44:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:44:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:44:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:38 INFO - 'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:38 INFO - 'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['damp', 'tps']}, 04:44:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:38 INFO - 'tests': ['damp', 'tps']}, 04:44:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['dromaeo_dom']}, 04:44:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:44:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['basic_compositor_video']}, 04:44:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:44:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['a11yr', 04:44:38 INFO - 'ts_paint', 04:44:38 INFO - 'tpaint', 04:44:38 INFO - 'sessionrestore', 04:44:38 INFO - 'sessionrestore_no_auto_restore', 04:44:38 INFO - 'tabpaint']}, 04:44:38 INFO - 'other-e10s': {'tests': ['a11yr', 04:44:38 INFO - 'ts_paint', 04:44:38 INFO - 'tpaint', 04:44:38 INFO - 'sessionrestore', 04:44:38 INFO - 'sessionrestore_no_auto_restore', 04:44:38 INFO - 'tabpaint']}, 04:44:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:44:38 INFO - 'ts_paint', 04:44:38 INFO - 'tpaint', 04:44:38 INFO - 'sessionrestore', 04:44:38 INFO - 'sessionrestore_no_auto_restore', 04:44:38 INFO - 'tabpaint']}, 04:44:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:44:38 INFO - 'ts_paint', 04:44:38 INFO - 'tpaint', 04:44:38 INFO - 'sessionrestore', 04:44:38 INFO - 'sessionrestore_no_auto_restore', 04:44:38 INFO - 'tabpaint']}, 04:44:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['a11yr', 04:44:38 INFO - 'ts_paint', 04:44:38 INFO - 'tpaint', 04:44:38 INFO - 'sessionrestore', 04:44:38 INFO - 'sessionrestore_no_auto_restore', 04:44:38 INFO - 'tabpaint']}, 04:44:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['a11yr', 04:44:38 INFO - 'ts_paint', 04:44:38 INFO - 'tpaint', 04:44:38 INFO - 'sessionrestore', 04:44:38 INFO - 'sessionrestore_no_auto_restore', 04:44:38 INFO - 'tabpaint']}, 04:44:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['tsvgx', 04:44:38 INFO - 'tsvgr_opacity', 04:44:38 INFO - 'tart', 04:44:38 INFO - 'tscrollx', 04:44:38 INFO - 'cart']}, 04:44:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:44:38 INFO - 'tsvgr_opacity', 04:44:38 INFO - 'tart', 04:44:38 INFO - 'tscrollx', 04:44:38 INFO - 'cart']}, 04:44:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:38 INFO - 'talos_options': ['--disable-e10s'], 04:44:38 INFO - 'tests': ['tp5o']}, 04:44:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:38 INFO - 'tests': ['tp5o']}, 04:44:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:38 INFO - 'talos_options': ['--disable-e10s', 04:44:38 INFO - '--xperf_path', 04:44:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:38 INFO - 'tests': ['tp5n']}, 04:44:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:44:38 INFO - 'talos_options': ['--xperf_path', 04:44:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:38 INFO - 'tests': ['tp5n']}}, 04:44:38 INFO - 'talos.zip': {'path': '', 04:44:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:44:38 INFO - Running post-action listener: _resource_record_post_action 04:44:38 INFO - [mozharness: 2016-08-18 11:44:38.703777Z] Finished populate-webroot step (success) 04:44:38 INFO - [mozharness: 2016-08-18 11:44:38.703890Z] Running create-virtualenv step. 04:44:38 INFO - Running pre-action listener: _resource_record_pre_action 04:44:38 INFO - Running main action method: create_virtualenv 04:44:38 INFO - Creating virtualenv /builds/slave/test/build/venv 04:44:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:44:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:44:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:44:38 INFO - Using real prefix '/tools/python27' 04:44:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:44:39 INFO - Installing distribute.............................................................................................................................................................................................done. 04:44:42 INFO - Installing pip.................done. 04:44:42 INFO - Return code: 0 04:44:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:44:42 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')]} 04:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:42 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')]} 04:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:42 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 0x10d19fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d234618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f884aca3000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d103d30>, '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 0x10ce68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0fbb20>, '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.PtAyilHf8x/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.siJWOSPIPH/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 04:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:44:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PtAyilHf8x/Render', 04:44:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:42 INFO - 'HOME': '/Users/cltbld', 04:44:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:42 INFO - 'LOGNAME': 'cltbld', 04:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:42 INFO - 'MOZ_NO_REMOTE': '1', 04:44:42 INFO - 'NO_EM_RESTART': '1', 04:44:42 INFO - 'PAGER': '/bin/cat', 04:44:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:42 INFO - 'PWD': '/builds/slave/test', 04:44:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:42 INFO - 'SHELL': '/bin/bash', 04:44:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.siJWOSPIPH/Listeners', 04:44:42 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:44:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:42 INFO - 'USER': 'cltbld', 04:44:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:42 INFO - 'XPC_FLAGS': '0x0', 04:44:42 INFO - 'XPC_SERVICE_NAME': '0', 04:44:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:44:42 INFO - Cleaning up... 04:44:42 INFO - Return code: 0 04:44:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:44:42 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')]} 04:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:42 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')]} 04:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:42 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 0x10d19fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d234618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f884aca3000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d103d30>, '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 0x10ce68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0fbb20>, '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.PtAyilHf8x/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.siJWOSPIPH/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 04:44:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:44:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:44:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PtAyilHf8x/Render', 04:44:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:42 INFO - 'HOME': '/Users/cltbld', 04:44:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:42 INFO - 'LOGNAME': 'cltbld', 04:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:42 INFO - 'MOZ_NO_REMOTE': '1', 04:44:42 INFO - 'NO_EM_RESTART': '1', 04:44:42 INFO - 'PAGER': '/bin/cat', 04:44:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:42 INFO - 'PWD': '/builds/slave/test', 04:44:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:42 INFO - 'SHELL': '/bin/bash', 04:44:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.siJWOSPIPH/Listeners', 04:44:42 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:44:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:42 INFO - 'USER': 'cltbld', 04:44:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:42 INFO - 'XPC_FLAGS': '0x0', 04:44:42 INFO - 'XPC_SERVICE_NAME': '0', 04:44:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:42 INFO - Downloading/unpacking psutil>=3.1.1 04:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:44:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:46 INFO - Installing collected packages: psutil 04:44:46 INFO - Running setup.py install for psutil 04:44:46 INFO - building 'psutil._psutil_osx' extension 04:44:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:44:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:44:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:44:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:44:46 INFO - building 'psutil._psutil_posix' extension 04:44:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:44:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:44:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:44:46 INFO - ^ 04:44:46 INFO - 1 warning generated. 04:44:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:44:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:46 INFO - Successfully installed psutil 04:44:46 INFO - Cleaning up... 04:44:46 INFO - Return code: 0 04:44:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:46 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 0x10d19fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d234618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f884aca3000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d103d30>, '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 0x10ce68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0fbb20>, '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.PtAyilHf8x/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.siJWOSPIPH/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 04:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:44:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PtAyilHf8x/Render', 04:44:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:46 INFO - 'HOME': '/Users/cltbld', 04:44:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:46 INFO - 'LOGNAME': 'cltbld', 04:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:46 INFO - 'MOZ_NO_REMOTE': '1', 04:44:46 INFO - 'NO_EM_RESTART': '1', 04:44:46 INFO - 'PAGER': '/bin/cat', 04:44:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:46 INFO - 'PWD': '/builds/slave/test', 04:44:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:46 INFO - 'SHELL': '/bin/bash', 04:44:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.siJWOSPIPH/Listeners', 04:44:46 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:44:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:46 INFO - 'USER': 'cltbld', 04:44:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:46 INFO - 'XPC_FLAGS': '0x0', 04:44:46 INFO - 'XPC_SERVICE_NAME': '0', 04:44:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:44:49 INFO - Installing collected packages: mozsystemmonitor 04:44:49 INFO - Running setup.py install for mozsystemmonitor 04:44:49 INFO - Successfully installed mozsystemmonitor 04:44:49 INFO - Cleaning up... 04:44:50 INFO - Return code: 0 04:44:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:44:50 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')]} 04:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:50 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')]} 04:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:50 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 0x10d19fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d234618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f884aca3000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d103d30>, '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 0x10ce68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0fbb20>, '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.PtAyilHf8x/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.siJWOSPIPH/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 04:44:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:44:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PtAyilHf8x/Render', 04:44:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:50 INFO - 'HOME': '/Users/cltbld', 04:44:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:50 INFO - 'LOGNAME': 'cltbld', 04:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:50 INFO - 'MOZ_NO_REMOTE': '1', 04:44:50 INFO - 'NO_EM_RESTART': '1', 04:44:50 INFO - 'PAGER': '/bin/cat', 04:44:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:50 INFO - 'PWD': '/builds/slave/test', 04:44:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:50 INFO - 'SHELL': '/bin/bash', 04:44:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.siJWOSPIPH/Listeners', 04:44:50 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:44:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:50 INFO - 'USER': 'cltbld', 04:44:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:50 INFO - 'XPC_FLAGS': '0x0', 04:44:50 INFO - 'XPC_SERVICE_NAME': '0', 04:44:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:50 INFO - Downloading/unpacking jsonschema==2.5.1 04:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:44:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:53 INFO - Downloading functools32-3.2.3-2.tar.gz 04:44:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:44:53 INFO - warning: no files found matching '*.txt' 04:44:53 INFO - no previously-included directories found matching 'build' 04:44:53 INFO - no previously-included directories found matching 'dist' 04:44:53 INFO - no previously-included directories found matching '.git*' 04:44:53 INFO - Installing collected packages: jsonschema, functools32 04:44:53 INFO - Running setup.py install for functools32 04:44:53 INFO - warning: no files found matching '*.txt' 04:44:53 INFO - no previously-included directories found matching 'build' 04:44:53 INFO - no previously-included directories found matching 'dist' 04:44:53 INFO - no previously-included directories found matching '.git*' 04:44:53 INFO - Successfully installed jsonschema functools32 04:44:53 INFO - Cleaning up... 04:44:53 INFO - Return code: 0 04:44:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:53 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 0x10d19fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d234618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f884aca3000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d103d30>, '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 0x10ce68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0fbb20>, '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.PtAyilHf8x/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.siJWOSPIPH/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 04:44:53 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 04:44:53 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 04:44:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PtAyilHf8x/Render', 04:44:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:53 INFO - 'HOME': '/Users/cltbld', 04:44:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:53 INFO - 'LOGNAME': 'cltbld', 04:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:53 INFO - 'MOZ_NO_REMOTE': '1', 04:44:53 INFO - 'NO_EM_RESTART': '1', 04:44:53 INFO - 'PAGER': '/bin/cat', 04:44:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:53 INFO - 'PWD': '/builds/slave/test', 04:44:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:53 INFO - 'SHELL': '/bin/bash', 04:44:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.siJWOSPIPH/Listeners', 04:44:53 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:44:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:53 INFO - 'USER': 'cltbld', 04:44:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:53 INFO - 'XPC_FLAGS': '0x0', 04:44:53 INFO - 'XPC_SERVICE_NAME': '0', 04:44:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:44:53 INFO - Cleaning up... 04:44:53 INFO - Return code: 0 04:44:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:53 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 0x10d19fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d234618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f884aca3000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d103d30>, '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 0x10ce68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0fbb20>, '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.PtAyilHf8x/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.siJWOSPIPH/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 04:44:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:44:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PtAyilHf8x/Render', 04:44:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:53 INFO - 'HOME': '/Users/cltbld', 04:44:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:53 INFO - 'LOGNAME': 'cltbld', 04:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:53 INFO - 'MOZ_NO_REMOTE': '1', 04:44:53 INFO - 'NO_EM_RESTART': '1', 04:44:53 INFO - 'PAGER': '/bin/cat', 04:44:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:53 INFO - 'PWD': '/builds/slave/test', 04:44:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:53 INFO - 'SHELL': '/bin/bash', 04:44:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.siJWOSPIPH/Listeners', 04:44:53 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:44:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:53 INFO - 'USER': 'cltbld', 04:44:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:53 INFO - 'XPC_FLAGS': '0x0', 04:44:53 INFO - 'XPC_SERVICE_NAME': '0', 04:44:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:54 INFO - Downloading/unpacking blobuploader==1.2.4 04:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:56 INFO - Downloading blobuploader-1.2.4.tar.gz 04:44:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:44:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:44:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:44:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:44:57 INFO - Downloading docopt-0.6.1.tar.gz 04:44:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:57 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:57 INFO - Running setup.py install for blobuploader 04:44:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:57 INFO - Running setup.py install for requests 04:44:58 INFO - Running setup.py install for docopt 04:44:58 INFO - Successfully installed blobuploader requests docopt 04:44:58 INFO - Cleaning up... 04:44:58 INFO - Return code: 0 04:44:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44:58 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 0x10d19fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d234618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f884aca3000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d103d30>, '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 0x10ce68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0fbb20>, '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.PtAyilHf8x/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.siJWOSPIPH/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 04:44:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:44:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:44:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PtAyilHf8x/Render', 04:44:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:58 INFO - 'HOME': '/Users/cltbld', 04:44:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:58 INFO - 'LOGNAME': 'cltbld', 04:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:58 INFO - 'MOZ_NO_REMOTE': '1', 04:44:58 INFO - 'NO_EM_RESTART': '1', 04:44:58 INFO - 'PAGER': '/bin/cat', 04:44:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:58 INFO - 'PWD': '/builds/slave/test', 04:44:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:58 INFO - 'SHELL': '/bin/bash', 04:44:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.siJWOSPIPH/Listeners', 04:44:58 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:44:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:58 INFO - 'USER': 'cltbld', 04:44:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:58 INFO - 'XPC_FLAGS': '0x0', 04:44:58 INFO - 'XPC_SERVICE_NAME': '0', 04:44:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:44:58 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-PHKCRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:44:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:44:58 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-5qVaSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:44:59 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-XxNrVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:44:59 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-1sWdcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:44:59 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-gAHPdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:44:59 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-1RgViS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:44:59 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ds58Ay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:44:59 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-gLTRUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:44:59 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-yv2Fco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:44:59 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-cqdLTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:44:59 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-pKdIBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:44:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:00 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-pZfEkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:00 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-FZNVur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:00 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-NDB1VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:00 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-lJX7iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:00 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-Ol2wN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:00 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-GWboSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:00 INFO - Running setup.py install for manifestparser 04:45:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:45:00 INFO - Running setup.py install for mozcrash 04:45:00 INFO - Running setup.py install for mozdebug 04:45:01 INFO - Running setup.py install for mozdevice 04:45:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:45:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:45:01 INFO - Running setup.py install for mozfile 04:45:01 INFO - Running setup.py install for mozhttpd 04:45:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:45:01 INFO - Running setup.py install for mozinfo 04:45:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:45:01 INFO - Running setup.py install for mozInstall 04:45:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:45:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:45:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:45:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:45:01 INFO - Running setup.py install for mozleak 04:45:01 INFO - Running setup.py install for mozlog 04:45:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:45:02 INFO - Running setup.py install for moznetwork 04:45:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:45:02 INFO - Running setup.py install for mozprocess 04:45:02 INFO - Running setup.py install for mozprofile 04:45:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:45:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:45:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:45:02 INFO - Running setup.py install for mozrunner 04:45:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:45:02 INFO - Running setup.py install for mozscreenshot 04:45:02 INFO - Running setup.py install for moztest 04:45:03 INFO - Running setup.py install for mozversion 04:45:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:03 INFO - Cleaning up... 04:45:03 INFO - Return code: 0 04:45:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45:03 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')]} 04:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:03 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')]} 04:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:03 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 0x10d19fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d234618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f884aca3000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d103d30>, '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 0x10ce68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0fbb20>, '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.PtAyilHf8x/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.siJWOSPIPH/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 04:45:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:45:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:45:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PtAyilHf8x/Render', 04:45:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:03 INFO - 'HOME': '/Users/cltbld', 04:45:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:03 INFO - 'LOGNAME': 'cltbld', 04:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:03 INFO - 'MOZ_NO_REMOTE': '1', 04:45:03 INFO - 'NO_EM_RESTART': '1', 04:45:03 INFO - 'PAGER': '/bin/cat', 04:45:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:03 INFO - 'PWD': '/builds/slave/test', 04:45:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:03 INFO - 'SHELL': '/bin/bash', 04:45:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.siJWOSPIPH/Listeners', 04:45:03 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:45:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:03 INFO - 'USER': 'cltbld', 04:45:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:03 INFO - 'XPC_FLAGS': '0x0', 04:45:03 INFO - 'XPC_SERVICE_NAME': '0', 04:45:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-syPI2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-qpnbDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-nSdwFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-7oNn_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-bZRroR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:45:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:03 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-he_wNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-ap3_C5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-fxKqT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-IHwJLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-VqNEVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:04 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)) 04:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-iRtoai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-GCfJ7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-de3jfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-g8lfbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:04 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-q1IN_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:05 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-mTcg6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:05 INFO - Running setup.py (path:/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/pip-spUC1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:45:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:45:07 INFO - Downloading blessings-1.6.tar.gz 04:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:07 INFO - Installing collected packages: blessings 04:45:07 INFO - Running setup.py install for blessings 04:45:08 INFO - Successfully installed blessings 04:45:08 INFO - Cleaning up... 04:45:08 INFO - Return code: 0 04:45:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:08 INFO - Reading from file tmpfile_stdout 04:45:08 INFO - Current package versions: 04:45:08 INFO - blessings == 1.6 04:45:08 INFO - blobuploader == 1.2.4 04:45:08 INFO - docopt == 0.6.1 04:45:08 INFO - functools32 == 3.2.3-2 04:45:08 INFO - jsonschema == 2.5.1 04:45:08 INFO - manifestparser == 1.1 04:45:08 INFO - mozInstall == 1.12 04:45:08 INFO - mozcrash == 0.17 04:45:08 INFO - mozdebug == 0.1 04:45:08 INFO - mozdevice == 0.48 04:45:08 INFO - mozfile == 1.2 04:45:08 INFO - mozhttpd == 0.7 04:45:08 INFO - mozinfo == 0.9 04:45:08 INFO - mozleak == 0.1 04:45:08 INFO - mozlog == 3.3 04:45:08 INFO - moznetwork == 0.27 04:45:08 INFO - mozprocess == 0.23 04:45:08 INFO - mozprofile == 0.28 04:45:08 INFO - mozrunner == 6.12 04:45:08 INFO - mozscreenshot == 0.1 04:45:08 INFO - mozsystemmonitor == 0.3 04:45:08 INFO - moztest == 0.7 04:45:08 INFO - mozversion == 1.4 04:45:08 INFO - psutil == 3.1.1 04:45:08 INFO - requests == 1.2.3 04:45:08 INFO - wsgiref == 0.1.2 04:45:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:08 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 0x10d19fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d234618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f884aca3000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d103d30>, '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 0x10ce68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0fbb20>, '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.PtAyilHf8x/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.siJWOSPIPH/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 04:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:45:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PtAyilHf8x/Render', 04:45:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:08 INFO - 'HOME': '/Users/cltbld', 04:45:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:08 INFO - 'LOGNAME': 'cltbld', 04:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:08 INFO - 'MOZ_NO_REMOTE': '1', 04:45:08 INFO - 'NO_EM_RESTART': '1', 04:45:08 INFO - 'PAGER': '/bin/cat', 04:45:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:08 INFO - 'PWD': '/builds/slave/test', 04:45:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:08 INFO - 'SHELL': '/bin/bash', 04:45:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.siJWOSPIPH/Listeners', 04:45:08 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:45:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:08 INFO - 'USER': 'cltbld', 04:45:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:08 INFO - 'XPC_FLAGS': '0x0', 04:45:08 INFO - 'XPC_SERVICE_NAME': '0', 04:45:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:45:08 INFO - Cleaning up... 04:45:08 INFO - Return code: 0 04:45:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:45: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')]} 04:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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')]} 04:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d19fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d234618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f884aca3000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d103d30>, '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 0x10ce68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0fbb20>, '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.PtAyilHf8x/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.siJWOSPIPH/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 04:45: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', 'jsonschema'] in /builds/slave/test/build 04:45: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 jsonschema 04:45:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PtAyilHf8x/Render', 04:45:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:08 INFO - 'HOME': '/Users/cltbld', 04:45:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:08 INFO - 'LOGNAME': 'cltbld', 04:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:08 INFO - 'MOZ_NO_REMOTE': '1', 04:45:08 INFO - 'NO_EM_RESTART': '1', 04:45:08 INFO - 'PAGER': '/bin/cat', 04:45:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:08 INFO - 'PWD': '/builds/slave/test', 04:45:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:08 INFO - 'SHELL': '/bin/bash', 04:45:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.siJWOSPIPH/Listeners', 04:45:08 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:45:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:08 INFO - 'USER': 'cltbld', 04:45:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:08 INFO - 'XPC_FLAGS': '0x0', 04:45:08 INFO - 'XPC_SERVICE_NAME': '0', 04:45:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:45:08 INFO - Cleaning up... 04:45:08 INFO - Return code: 0 04:45:08 INFO - Running post-action listener: _resource_record_post_action 04:45:08 INFO - Running post-action listener: _start_resource_monitoring 04:45:08 INFO - Starting resource monitoring. 04:45:08 INFO - [mozharness: 2016-08-18 11:45:08.959420Z] Finished create-virtualenv step (success) 04:45:08 INFO - [mozharness: 2016-08-18 11:45:08.960390Z] Running install step. 04:45:08 INFO - Running pre-action listener: _resource_record_pre_action 04:45:08 INFO - Running main action method: install 04:45:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:09 INFO - Reading from file tmpfile_stdout 04:45:09 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:09 INFO - Reading from file tmpfile_stdout 04:45:09 INFO - Output received: 04:45:09 INFO - Usage: mozinstall [options] installer 04:45:09 INFO - Options: 04:45:09 INFO - -h, --help show this help message and exit 04:45:09 INFO - -d DEST, --destination=DEST 04:45:09 INFO - Directory to install application into. [default: 04:45:09 INFO - "/builds/slave/test"] 04:45:09 INFO - --app=APP Application being installed. [default: firefox] 04:45:09 INFO - mkdir: /builds/slave/test/build/application 04:45:09 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'] 04:45:09 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 04:45:43 INFO - Reading from file tmpfile_stdout 04:45:43 INFO - Output received: 04:45:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:45:43 INFO - Running post-action listener: _resource_record_post_action 04:45:43 INFO - [mozharness: 2016-08-18 11:45:43.834686Z] Finished install step (success) 04:45:43 INFO - [mozharness: 2016-08-18 11:45:43.834895Z] Running run-tests step. 04:45:43 INFO - Running pre-action listener: _resource_record_pre_action 04:45:43 INFO - Running main action method: run_tests 04:45:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:45:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:45:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:45:43 INFO - 2016-08-18 04:45:43.849 screenresolution[2239:19835] starting screenresolution argv=screenresolution get 04:45:43 INFO - 2016-08-18 04:45:43.852 screenresolution[2239:19835] Display 0: 1600x1200x32@60 04:45:43 INFO - 2016-08-18 04:45:43.858 screenresolution[2240:19837] starting screenresolution argv=screenresolution list 04:45:43 INFO - Available Modes on Display 0 04:45:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:45:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:45:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:45:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:45:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:45:44 INFO - Intel Iris: 04:45:44 INFO - Chipset Model: Intel Iris 04:45:44 INFO - Type: GPU 04:45:44 INFO - Bus: Built-In 04:45:44 INFO - VRAM (Dynamic, Max): 1536 MB 04:45:44 INFO - Vendor: Intel (0x8086) 04:45:44 INFO - Device ID: 0x0a2e 04:45:44 INFO - Revision ID: 0x0009 04:45:44 INFO - Displays: 04:45:44 INFO - Display: 04:45:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:45:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:45:44 INFO - Display Serial Number: 1600x1200 60 04:45:44 INFO - Main Display: Yes 04:45:44 INFO - Mirror: Off 04:45:44 INFO - Online: Yes 04:45:44 INFO - Rotation: Supported 04:45:44 INFO - Return code: 0 04:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:44 INFO - Python 2.7.3 04:45:44 INFO - Return code: 0 04:45:44 INFO - grabbing minidump binary from tooltool 04:45: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')]} 04:45:44 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 0x10d103d30>, '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 0x10ce68db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d0fbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:45:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:45:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:45:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:44 INFO - Return code: 0 04:45:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:45:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:45:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:44 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/D6oeb6RrT5mCk0JcSemt7w/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 04:45:44 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/D6oeb6RrT5mCk0JcSemt7w/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 04:45:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PtAyilHf8x/Render', 04:45:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:44 INFO - 'HOME': '/Users/cltbld', 04:45:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:44 INFO - 'LOGNAME': 'cltbld', 04:45:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:44 INFO - 'MOZ_NO_REMOTE': '1', 04:45:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:44 INFO - 'NO_EM_RESTART': '1', 04:45:44 INFO - 'PAGER': '/bin/cat', 04:45:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:44 INFO - 'PWD': '/builds/slave/test', 04:45:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:44 INFO - 'SHELL': '/bin/bash', 04:45:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.siJWOSPIPH/Listeners', 04:45:44 INFO - 'TMPDIR': '/var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/', 04:45:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:44 INFO - 'USER': 'cltbld', 04:45:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:44 INFO - 'XPC_FLAGS': '0x0', 04:45:44 INFO - 'XPC_SERVICE_NAME': '0', 04:45:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:44 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/D6oeb6RrT5mCk0JcSemt7w/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 04:45:44 INFO - mozversion application_buildid: 20160818023814 04:45:44 INFO - mozversion application_changeset: a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388 04:45:44 INFO - mozversion application_display_name: Nightly 04:45:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:44 INFO - mozversion application_name: Firefox 04:45:44 INFO - mozversion application_remotingname: firefox 04:45:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:45:44 INFO - mozversion application_vendor: Mozilla 04:45:44 INFO - mozversion application_version: 51.0a1 04:45:44 INFO - mozversion platform_buildid: 20160818023814 04:45:44 INFO - mozversion platform_changeset: a6f67ab4a4ec4dd66f53c4b4423e5b8b63023388 04:45:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:45:44 INFO - mozversion platform_version: 51.0a1 04:45:44 INFO - using testdate: 1471520744 04:45:44 INFO - actual date: 1471520744 04:45:44 INFO - starting webserver on 'localhost:53010' 04:45:44 INFO - SUITE-START | Running 2 tests 04:45:44 INFO - TEST-START | dromaeo_css 04:45:44 INFO - operating with platform_type : mac_ 04:45:44 INFO - Initialising browser for dromaeo_css test... 04:45:44 INFO - TEST-INFO | started process 2250 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpaTFaQC/profile http://localhost:53010/getInfo.html) 04:45:46 INFO - PROCESS | 2250 | __metrics Screen width/height:1600/1200 04:45:46 INFO - PROCESS | 2250 | colorDepth:24 04:45:46 INFO - PROCESS | 2250 | Browser inner width/height: 1024/689 04:45:46 INFO - PROCESS | 2250 | __metrics 04:45:46 INFO - PROCESS | 2250 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:45:46 INFO - PROCESS | 2250 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:47 INFO - TEST-INFO | 2250: exit 0 04:45:47 INFO - Browser initialized. 04:45:47 INFO - Running cycle 1/1 for dromaeo_css test... 04:45:47 INFO - TEST-INFO | started process 2252 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpaTFaQC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:59 INFO - PROCESS | 2252 | RSS: Main: 228016128 04:45:59 INFO - PROCESS | 2252 | 04:46:51 INFO - PROCESS | 2252 | 1471520811107 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:49:03 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:53010/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53010/tests/dromaeo/cssquery-ext.html) 04:49:04 INFO - PROCESS | 2252 | RSS: Main: 373780480 04:49:04 INFO - PROCESS | 2252 | 04:52:07 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:53010/tests/dromaeo/cssquery-ext.html (next: http://localhost:53010/tests/dromaeo/cssquery-jquery.html) 04:52:08 INFO - PROCESS | 2252 | RSS: Main: 369795072 04:52:08 INFO - PROCESS | 2252 | 04:55:10 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:53010/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53010/tests/dromaeo/cssquery-mootools.html) 04:55:11 INFO - PROCESS | 2252 | RSS: Main: 338817024 04:55:11 INFO - PROCESS | 2252 | 04:58:13 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:53010/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53010/tests/dromaeo/cssquery-prototype.html) 04:58:14 INFO - PROCESS | 2252 | RSS: Main: 331841536 04:58:14 INFO - PROCESS | 2252 | 05:01:17 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:53010/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53010/tests/dromaeo/cssquery-yui.html) 05:01:18 INFO - PROCESS | 2252 | RSS: Main: 330911744 05:01:18 INFO - PROCESS | 2252 | 05:04:22 INFO - PROCESS | 2252 | Cycle 1(1): loaded http://localhost:53010/tests/dromaeo/cssquery-yui.html (next: http://localhost:53010/tests/dromaeo/cssquery-dojo.html) 05:04:22 INFO - PROCESS | 2252 | RSS: Main: 447201280 05:04:22 INFO - PROCESS | 2252 | 05:04:22 INFO - PROCESS | 2252 | __start_tp_report 05:04:22 INFO - PROCESS | 2252 | _x_x_mozilla_page_load 05:04:22 INFO - PROCESS | 2252 | _x_x_mozilla_page_load_details 05:04:22 INFO - PROCESS | 2252 | |i|pagename|runs| 05:04:22 INFO - PROCESS | 2252 | |0;dojo.html;3279.721223695986;3338.482535207042;3339.2486690494643;3341.7159541438978;3358.2108204571937;5559.527440167581;5640.153976903456;5652.915206271904;5733.913991290129;5744.712764361786;4975.228839529869;5675;5730;5759.510441612458;5786.768529258835;5163.432022477525;5190.974045129769;5223.2165175223645;5236.581073514109;5331.706756128411;4670.836520721776;5309.070912590281;5319.521243088121;5324.068288049595;5364.812231571896;5133.614978876599;5140.126178549655;5197.402298735656;5240.816571420001;5335.359756829166;5138.075146473633;5166.974165129188;5173.379194496647;5195;5290.365156181283;5185.118529849935;5193.68837869729;5199.922001169985;5216.4522725114075;5270.736463176864;5583.3858275589655;5633.60564760467;5720.828375148711;5779.537636989031;5780.595358324919;5212.29633999409;6183.412575805336;6249.468795152417;6250.15622890913;6315.526335524854;5206;6318.684065796738;6327.588706734094;6333.588316759442;6337.461315788163;5729.1119876419225;5763.077907534775;5878.412828536314;5932.9406705932815;5934.465898069108;6063.242094738158;6278.560500764903;6313.242410910629;6329;6350.206224221973;6229.595076320024;6239.844003899939;6240.937590624127;6250.218722659668;6255.218097737783;6116.457510225599;6225.906611400833;6287.371262873676;6316.115743795872;6330.113784070234;6146.139540464339;6190.071489276645;6215.9378406216265;6221.346758590374;6272.059191121277;6257.655828929453;6263.561550691408;6273.309935907047;6275.435210831047;6291.276503202191;4920.991196804646;5006.324146240284;5021.573166280834;5031.899362012739;5050.747462626928;4379.912401751947;4545.954540454619;4559.589636932626;4563.110193512233;4568.977155114203;5689.715514224272;5701.344345400249;5704.087346024699;5711.8857622848145;5729.255196824386;6171.537134714914;6273.560850740496;6315.242170939517;6319.178506794179;6349.238091429058;5728;5740.368559458456;5756.7121643917635;5761.949952549806;5804.1293805929445;4608.723476591415;5467.808626698046;5468.371137319259;5478.863028424321;5499.780008799603;6235.906461403082;6255.311915689271;6279.152314437584;6290.937090629035;6325.399087086904;6355.523335749745;6356.68216589178;6369.394907483782;6386.329435409401;6391.073294372383;6319.715612797527;6348.873022539616;6351.07909353132;6352.6506042166275;6355.237371515448;6123.8162855114415;6146.309764814711;6179.16581261524;6212.9068063979985;6298.968505157445;6169.56813023084;6287.874242515216;6337.207849018872;6343.429091381798;6344.492440604648;6155.507559395327;6200.441960223421;6201.751929922933;6203.65879876593;6207.224096987877;5944.3164036136395;5963.373845746134;6021.187139736079;6044;6125.510168486406;5988.970055149696;6056.394360563909;6057.956036093341;6081.665508397081;6092.208012958465;6159.393149460502;6199.628022318675;6206.658633775186;6211.192544969125;6217.253929528486;5733.168690539932;5924.140999555127;5934.554908381802;6016.127661488972;6019.578629495893 05:04:22 INFO - PROCESS | 2252 | |1;ext.html;449.86279184848627;460.38768437977495;516.1071346570433;528.931238938938;545.8962797068559;26841.865790671043;32224.838875805617;39861;41022.58977410225;41023.58976410243;42035.57964420355;42196.78901605495;42264.943376415606;42396.36405453913;42401;8945.792318037047;9334.20659243965;9597.712068637935;9812.264080193978;9839;8660.437071590359;8868.201861832435;11666.766664666702;11976.94011529941;11995.520179192821;11898.643040708792;11924.463399147016;11963.7607247855;11987.40062996851;11989.64031079069;11849;11949.163558550905;11955.462004209832;11957.521699132025;11971.485987942542;11815.822762658481;11882.821757673642;11895.702607434796;11898.22661526998;11921.463534140898;39403.40894886579;39687.8015609923;39752.006199844946;39765;39792.40311395331;3310.5696259486112;3371.4100032494216;3404.9829750851336;3410.4884267360094;3527.3298073366236;30639.693603063908;31644.05067847968;31733.682663173302;31738.365232695218;31836.6816331836;3200.311932934407;3333.283344081034;3362.495625656147;3369.528266042756;3401.3877502049622;460321;461010.6949465231;462388;463463;466970.6651466755;55601.721991389786;55723.44276557264;56113.43886561082;56116;56134.43865561292;57234.42765572374;58051.70974145102;58138.127928081114;58255.41744582585;58277.125843112386;16033.438829640907;16247.268872900748;16247.431339903047;16258.268377923021;16259.430919917982;10933.453327333602;11536.307821530734;12667.809982850265;12672.873271267354;12757.744845103232;13133.277669728257;13193.625147473354;13210.471581136648;13229.867701323055;14426.495072672406;5210.53105220532;6522.869542609216;7143.069675179767;7244.529105608224;7306.232845551141;846.7417437681567;876.4346996187423;989.5992123189975;1012.7974405119006;1016.2378216337746;28675.56986645202;29040.983565575105;29650.851745741133;29833.30025798761;30027.39945201084;1031.783325501653;1038.7558923652934;1062.559037999237;1122.4790408995693;1139.1627154041773;14461.638459038399;15347.61630959235;15484;15663.765043524356;15831.920840395955;625156;627613;629334;629525.8523707353;891431;47725;56988;57945.551361216305;58064.41935580675;61208;1356;1376.5388594820847;1397.4270549074831;1397.4899161805665;1398.6433459467974;29302.70697293085;30282.84858575693;31217.751289948148;31773.682263177998;32202.516962245118;48729;49066.75466622644;49105.75447122742;49146.508534914195;49183.7540812308;559029;560456;561630;562146;564217;38017.2396552073;38453.80773096117;38836.41745373765;38970.415443768936;39077.80461097676;46288.53711462977;46492;47312.290315644605;47775;48157.03685926192;33093.503597445575;38330.80834595921;38619.80690096531;39496.210075797746;40410;37307.44038839474;37766.866993990225;38349;38650.16872890889;39183;37199.442008369355;37582.36264560338;38189.809050954565;38586.22827543377;40567.39148912828;30409;32215.51676724898;33110.50334245036;33593.49609755807;34355.65644343525;24927.626085608368;25739.356516087246;25791.03050584105;25820.741792581834;25899.611505827805 05:04:22 INFO - PROCESS | 2252 | |2;jquery.html;320.2426261890629;342.10027627340094;356.56142944178646;365.19838953497066;392.23318412503556;15688.294026768794;18715.62568748624;21231.57536849262;21933.232336868212;22026.788526631048;20343.389698309074;20592.176312947464;20651.483712907186;20862.165513379485;21389.251376201835;5888.793892213774;5928.733207005674;6101.2983506896835;6173.691315434233;6177.413145751147;4204.516480604739;6050.2437195350585;6134.110553969672;6152.723127459275;6167.5065994720535;6556.639384833832;6847.109875716174;6877.58734475933;6903.171619405678;6984.476164287698;6614.040964060185;6654.26803051664;6740.191177058784;6744.460443164535;6871.656417179146;5744.054903175193;5830.125481177814;5840.8247752567495;5846.736896839652;5846.801405711819;21021.474463138544;21411;26509.204723858315;26906.327341816417;27256.31859203516;2287.451011757183;2325.5348930214027;2414.2033129067368;2442.995116007321;2498.4253621667117;11938.462769175321;15668.294926728211;16031.91984040084;16038.35846566136;16040.598985025352;1579.5024567261275;1621.764844097611;1748.77265955425;1839.350162558783;2001.0495014867968;101953.49023254836;119588.40205799002;127741;128115;131552;10634.458003589436;10830.350178989285;11284.98524838531;11299.548018079186;11493.885061149449;14133.71732565343;14168.22074785876;14193.78709319361;14225.502107426191;14260.50088246927;8503.829923401498;8783.61830695187;8819.29445644347;8930.955345223232;8941.776455588662;8801.47191168532;8811.383203175716;8812.325658124935;9011.459312441275;9028.232600229054;6730.9326906731285;6856.862862742817;6863.897041544381;6874.106366172366;6877.277885822016;1631.3393075804318;1840.6778813707547;1888.631716815208;1897.6489349470392;1919.2994556986878;375.6525214176875;731.7109741652017;780.9297163255334;961.4808003678075;968.7142293023575;10927.016568508872;11465.484053217626;12009.63971080869;12042.81935770964;12112.39438028095;420.2771233478412;423.78175239750936;434.6327353386383;442.7255101836882;443.6450839328524;5851.210086638334;5932.2584676915385;6109.083637454418;6145.170401995673;6146.170267013896;592556;593370;599991;605253;607561;96276.51861740787;137647;140883;141198;141916;437.9693421460467;450.293039927311;450.7430764464224;451.9977400112978;452.16801086001914;11008.559657613605;11077.501512432122;11273.436328183721;11294.717632059264;11310.321380717183;54676;55318.17022744742;56220;56375.71812140913;56516.43483565112;81751.59856616327;82687.5865620668;83958;85073.57463212892;87050.1294987042;5417.593680474059;7814.33578145864;7902.288794008567;7912.248336408032;8277.95861020691;7753.573553454388;12170.695732606755;12316.692082698004;12594.685132871751;13214.603561893158;11102.167337449562;11598.536058557564;11627.127965402799;11641.808948778602;11929.642110736691;11093.611723589636;11207.383593902414;11328.32030078198;11540.769184616429;11662.94168529152;11260.493277802354;11533.653990380302;11792.469338879942;11865.525378984745;11923.940380298043;8132.1867813218205;8179.918200818153;8187.099419063779;8190.959045204736;8229.42394032436;8152.551609661526;10341.638042668772;10880.183986200907;11263.436828158723;11487.655370338904 05:04:22 INFO - PROCESS | 2252 | |3;mootools.html;1530.5255370835039;1561.5393458929616;1653.446095557988;1851.7592712947314;1859.2841755923964;8321.54231517267;8836.425632333901;8843;8851.77870553235;8851.955740221298;7669.309762121408;7922.088959769629;8371.204735550113;8591.18383753544;8592.742217733477;2338.5206032763326;2364.9763502364926;2375.0499800079933;2376.691030166076;2376.893039813204;2327.359976006595;2347.0142540133184;2370.5140446208484;2372.027468737818;2372.6238781506772;2350.2949115265437;2357.6463530470396;2369.336585755991;2369.763023697634;2379.5121999990047;2337.544178885118;2344.132670911765;2350.059976009601;2351.1418332308754;2366.8816559171973;2324.5583339165505;2343.238447504568;2345.64815277708;2353.1058197884863;2353.7528559501347;8578.270846978014;8773.341999350074;8773.692920747742;8780.121987801169;8796.692115775917;5178.689278643294;5336.332958380202;5345.1447768356875;5345.946540534584;5345.957538280037;3361.6134144573443;3596.6403359664087;3661.340958627446;3677.797721125337;3700.0564855961825;1097.025354362153;1100.7963526747578;1102.0412241349998;1110.7500812317164;1130.756887269233;11448.026917712004;11498.482568284448;11540.019098376564;11549.711257218552;11555.53777848885;4467.620252278528;4561.863144105682;4759.262314341283;4768.809247630056;4780;9861.408315501092;9870.851937220947;9872.950635246778;9901.702948911545;9904.15814655748;5299.072662284085;5307.3896501902;5307.65500242483;5311.920321195185;5327.227552004938;4329.415528903621;4494.9325760113625;4685.180093483695;4783.545563171493;4865.026994601094;3827.349350610403;3885.630865067814;3972.165845172546;3990.4213888985932;4001.15975645112;1283.1915892987358;1299.0711641176415;1300.629320643631;1306.73865226955;1315.1648703073618;894.6913314906346;917.9449233046039;923.607466826596;940.7083804020775;977.4477420257532;4983;5688.175214593944;5808.709564521757;5838.715482593822;6109.816705498843;434.45909842246607;882.188386684252;945.5792172483317;996.3274789517047;1006.8741407324085;3318.369509793132;4003.5542776130405;4089.6114869087387;4102.077032667686;4135.503739551273;10393.948030259951;10637.840432393521;10640.574377024832;10711.571537138583;10723.624673136403;10669.986351296615;10683.358998460117;10688.679339619825;10690.144788416908;10703.1437485001;7673.923260767432;8113.188681131957;8229.588520573947;8235.794105147299;8250.54621995784;5938.970305148447;6086.421789929949;6120.969395152996;6136.208025348366;6178.907316390348;9536.57085431171;9862.358946668444;9956.800863982824;10006.549705263425;10081.344712593658;9699.224062074876;10070.345427547187;10224.182065434896;10332.173426126043;10343.534540945526;7294.270572942663;7481.925180748341;7569.47013709035;7578.204288549843;7606.543607383574;8172.713955011784;8255.42212045151;8256.628451719567;8267.214614611603;8268.131846156068;7297.562146271241;7409.777706668809;7446.776596702108;7615.961920190363;7652.617369131633;7265.891011634935;7371.741989030358;7373.8156546086775;7374.889376659462;7438.702451901863;6680.732770689118;6939.16729992384;7051.964740176266;7069.363757261871;7076.646167691491;4543.568361005699;4580.3587497751005;4911.557959783637;4975.353204083446;5060.8987820242655;4521;5086.059079070384;5088.109580823415;5140.588752899685;5148.176291793295 05:04:22 INFO - PROCESS | 2252 | |4;prototype.html;291.0062137799414;294.215914587624;302.9378977309652;307.92455848317167;308.962924449066;5027.321311622939;5219.608529360295;5307.814226502073;5317.6971641947775;5327.200919862018;5043.268726034723;5129.666571672848;5160.509751573594;5174.715390653512;5264.631475796696;3516.7714098583638;3971.7021223408215;4007.519097708279;4017.879463616096;4020.437138800563;3339.3989081965237;3467.653234676525;3633.148862206057;3994.3423479256076;4036.777977211252;3694;3958.4656071430422;3969.7221194516396;3980.1840622672285;3992.2215168042244;3215.774895757298;3433.7081348085444;3889.2610404023426;3935.6654684351865;4015.217032678629;2872.9082948479654;3379.9522148134156;3441.5698037745283;3447.1899103710607;3449.223924616966;4395.494518130424;4587.128445595326;4766.428028636551;4778.163821331288;5052.646314757969;4462.665300102505;4494.910101797946;4502.459704835408;4513.961788788597;4534.161180181644;5494.780208791643;5496.395396506381;5562;5584.581156413245;5638.689872057035;3162.652108268089;3561.8041007744564;3712.461693054492;3751.0434839116124;3774.735768496206;4967.379077615298;4980.975095124573;5646.745896434671;5712.828615141552;5769.855753606152;2968.85155742212;3699.557172702648;3779.8866034019024;3790.450384694204;3815.771053736785;3208.53476245943;3265.951010734841;3791.976166435047;3844.3464611015634;3896.532416110085;4362.847300344536;4412.836453100731;4456;4475.082608065339;4484.663650226246;5177.896442071137;5208.348956380452;5419.458054194549;5477.561795056386;5514.476124768141;1237.6472705279132;1258.3519487463964;1277.2591896699892;1288.96238527984;1294.9935250323688;789.984200316002;846.5047946951103;863.2317237658489;873.7156380121212;885.9911400886037;4910.017996400734;4916.70499770015;4947.554720075139;4967.254911763264;4989.276554899519;4300.333448315516;4767.69010014348;4819.012102518976;5008.899822003539;5551.694656793915;3783.621637836194;4151.294279972412;4544.500104988449;4753.765730106844;4926.4088309403105;2214.472014310153;2227.175944900365;2255.5226326756;2402;2413.5398084158833;4105.173197926893;4280.871573852789;4541.409616749867;4697;4717.787699553528;3658.853645854136;4452.910941781146;4629.662020679535;4738.644601654821;4772.809087636456;4216.135692183095;4458.550970934394;4761.000379840406;4794.082367053206;4834.685745426606;3812.9618703813717;4312.331588603646;4620.676552641417;4622.497688251265;4662.969070104324;4019.9649264806053;4290;4455.799489023067;4580.450345958507;4581.518940511199;3759.496201519414;4250.959539421034;4390.275604525217;4715.693479923932;4761.35790572143;2784.568391899259;3232.515122731515;3234.6765323467466;3246.5617141686516;3285.6057273127376;4340.435743353344;4398.318260669601;4566.520515345974;4572.611328037154;4605.447346318463;4769.373707503854;5016.774245159049;5205.453427390221;5269.736513174249;5413.133898576209;5162.870928226675;5167.819126330561;5514.172874068921;5586.770910399706;5604.355499117653;4531.184386810406;4658.836940707059;5288.68267903927;5402.6758394496455;5409.459054094559;5515.420880807457;5542;5546.944530554804;5569.582281328835;5626.465485778845;4842.5157484251295;5195;5457.918131228114;5458.8908221834545;5554 05:04:22 INFO - PROCESS | 2252 | |5;yui.html;655.5542231282727;704.6476761619191;721.9025431566737;792.5522080024789;810.5015415519456;14987.250637468123;16299.103549304798;16317.83682163178;17387.5653108672;17942.013189274585;16349.264283107259;16692;16729.414470493535;16732.83267167328;16856.578585535368;836;852.8933883264592;853.1042405474227;853.1468531468531;858.1289990659454;668.408458514216;672.4620303756999;679.9830004249884;680.727708916435;687.5084314714978;873.3929918706501;894.6466145872377;894.9015608283083;907.0068275238604;908.8227795579865;894.8612964990405;894.9194572488442;895.2256298301954;895.7671005538607;896.4979611417627;503.7204351584869;661.7253839656537;661.9271880093186;662.2979641579892;663.349917081263;14832.703345933021;15351.232438378149;15384.384624615002;15420.845791542053;15431.151286679227;14328.140311581234;14739.336729847075;15062.246887655574;15186;15299;11877.524899004029;11920.22518536301;12056.63830085099;12105.757884842342;12131;3905.4922860028014;3906.667933225679;3919.4164779133607;3942.8817135485983;3993.1813978134414;117859;119384.40307798405;127593.36203319016;127748;129280.35359823235;11464.713382165346;11694.415279236004;11774.116941229271;12009.43877295946;12187.51249949992;23381.76618233796;23738.64392034121;23857.642135367983;23864.522709545712;23922.162724304566;8315.667373305121;8407.201315874981;8407.495550267004;8514.446560973516;8562.871556926651;4376.693631445832;4451.109778044404;4466.920348531086;4535.523770004168;4594.540545945379;3446.9310613787584;3798.4682144499793;3800.904977375588;3801.885943421702;3820.255050265227;670.1756839087949;671.4225765841372;679.6228093408206;696.989545156823;700.3276854220006;607.2136583124864;653.3988730367978;665.7203974330793;674.0933444517117;684.7579246567467;6829.52193346461;8511.361647876434;9416.399212133954;9715.266779856163;10075.458925655994;658.6969993802809;661.4443867151616;668.5587512241995;699.192432740186;699.9825004374932;3451.775634583744;4330.133973205371;4674.766261686902;4700.247960326331;4732.952670473252;82881;136463;148237;148662.25668871586;149028;109175;124604.63883764025;128487;129961.70038299685;134097;73005.6349718248;100010;109333.45333273282;110486;114311.42844285726;9030.63877444895;9050.502222377832;9093.40892841963;9131.315151363808;9135.954320228622;54246;62154.68922655358;62568;63339.36660633519;65067.023994641066;28830.990915317863;60344;90110.03294489365;92817;93156.5342173312;11594.956453919187;13187.340632968506;13437.992150588549;13485;13516.053876228569;12415.889946668069;14964;15061.472848450252;15296.847031529542;15303.158326292161;12931.870681293067;13869.653258668613;14105.858941410455;14315.856841431452;14706.485273015393;10888.237823352289;13942.58172254834;14066.859331406555;14200.147991120566;14434.566962991126;13711.108777929403;13909;14036.508722194674;14136.293185340486;14478.710425791636;9132.543372831466;9660.661876834558;11526.308421494738;11600.245984011011;11828.290302581872;9686.757831053998;10522.459728918955;11622.394442808656;11692.47383867745;12126.151169418055 05:04:22 INFO - PROCESS | 2252 | __end_tp_report 05:04:22 INFO - PROCESS | 2252 | __start_cc_report 05:04:22 INFO - PROCESS | 2252 | _x_x_mozilla_cycle_collect,1364 05:04:22 INFO - PROCESS | 2252 | __end_cc_report 05:04:22 INFO - PROCESS | 2252 | __startTimestamp1471521862393__endTimestamp 05:04:22 INFO - PROCESS | 2252 | 05:04:22 INFO - PROCESS | 2252 | ------- Summary: start ------- 05:04:22 INFO - PROCESS | 2252 | Number of tests: 6 05:04:22 INFO - PROCESS | 2252 | 05:04:22 INFO - PROCESS | 2252 | [#0] dojo.html Cycles:165 Average:5758.43 Median:5988.97 stddev:658.53 (11.0%) stddev-sans-first:631.19 05:04:22 INFO - PROCESS | 2252 | Values: 3279.7 3338.5 3339.2 3341.7 3358.2 5559.5 5640.2 5652.9 5733.9 5744.7 4975.2 5675.0 5730.0 5759.5 5786.8 5163.4 5191.0 5223.2 5236.6 5331.7 4670.8 5309.1 5319.5 5324.1 5364.8 5133.6 5140.1 5197.4 5240.8 5335.4 5138.1 5167.0 5173.4 5195.0 5290.4 5185.1 5193.7 5199.9 5216.5 5270.7 5583.4 5633.6 5720.8 5779.5 5780.6 5212.3 6183.4 6249.5 6250.2 6315.5 5206.0 6318.7 6327.6 6333.6 6337.5 5729.1 5763.1 5878.4 5932.9 5934.5 6063.2 6278.6 6313.2 6329.0 6350.2 6229.6 6239.8 6240.9 6250.2 6255.2 6116.5 6225.9 6287.4 6316.1 6330.1 6146.1 6190.1 6215.9 6221.3 6272.1 6257.7 6263.6 6273.3 6275.4 6291.3 4921.0 5006.3 5021.6 5031.9 5050.7 4379.9 4546.0 4559.6 4563.1 4569.0 5689.7 5701.3 5704.1 5711.9 5729.3 6171.5 6273.6 6315.2 6319.2 6349.2 5728.0 5740.4 5756.7 5761.9 5804.1 4608.7 5467.8 5468.4 5478.9 5499.8 6235.9 6255.3 6279.2 6290.9 6325.4 6355.5 6356.7 6369.4 6386.3 6391.1 6319.7 6348.9 6351.1 6352.7 6355.2 6123.8 6146.3 6179.2 6212.9 6299.0 6169.6 6287.9 6337.2 6343.4 6344.5 6155.5 6200.4 6201.8 6203.7 6207.2 5944.3 5963.4 6021.2 6044.0 6125.5 5989.0 6056.4 6058.0 6081.7 6092.2 6159.4 6199.6 6206.7 6211.2 6217.3 5733.2 5924.1 5934.6 6016.1 6019.6 05:04:22 INFO - PROCESS | 2252 | 05:04:22 INFO - PROCESS | 2252 | [#1] ext.html Cycles:180 Average:70101.01 Median:37674.61 stddev:154805.20 (410.9%) stddev-sans-first:155151.13 05:04:22 INFO - PROCESS | 2252 | Values: 449.9 460.4 516.1 528.9 545.9 26841.9 32224.8 39861.0 41022.6 41023.6 42035.6 42196.8 42264.9 42396.4 42401.0 8945.8 9334.2 9597.7 9812.3 9839.0 8660.4 8868.2 11666.8 11976.9 11995.5 11898.6 11924.5 11963.8 11987.4 11989.6 11849.0 11949.2 11955.5 11957.5 11971.5 11815.8 11882.8 11895.7 11898.2 11921.5 39403.4 39687.8 39752.0 39765.0 39792.4 3310.6 3371.4 3405.0 3410.5 3527.3 30639.7 31644.1 31733.7 31738.4 31836.7 3200.3 3333.3 3362.5 3369.5 3401.4 460321.0 461010.7 462388.0 463463.0 466970.7 55601.7 55723.4 56113.4 56116.0 56134.4 57234.4 58051.7 58138.1 58255.4 58277.1 16033.4 16247.3 16247.4 16258.3 16259.4 10933.5 11536.3 12667.8 12672.9 12757.7 13133.3 13193.6 13210.5 13229.9 14426.5 5210.5 6522.9 7143.1 7244.5 7306.2 846.7 876.4 989.6 1012.8 1016.2 28675.6 29041.0 29650.9 29833.3 30027.4 1031.8 1038.8 1062.6 1122.5 1139.2 14461.6 15347.6 15484.0 15663.8 15831.9 625156.0 627613.0 629334.0 629525.9 891431.0 47725.0 56988.0 57945.6 58064.4 61208.0 1356.0 1376.5 1397.4 1397.5 1398.6 29302.7 30282.8 31217.8 31773.7 32202.5 48729.0 49066.8 49105.8 49146.5 49183.8 559029.0 560456.0 561630.0 562146.0 564217.0 38017.2 38453.8 38836.4 38970.4 39077.8 46288.5 46492.0 47312.3 47775.0 48157.0 33093.5 38330.8 38619.8 39496.2 40410.0 37307.4 37766.9 38349.0 38650.2 39183.0 37199.4 37582.4 38189.8 38586.2 40567.4 30409.0 32215.5 33110.5 33593.5 34355.7 24927.6 25739.4 25791.0 25820.7 25899.6 05:04:22 INFO - PROCESS | 2252 | 05:04:22 INFO - PROCESS | 2252 | [#2] jquery.html Cycles:180 Average:35103.95 Median:370.43 stddev:100505.34 (27132.4%) stddev-sans-first:100753.35 05:04:22 INFO - PROCESS | 2252 | Values: 320.2 342.1 356.6 365.2 392.2 15688.3 18715.6 21231.6 21933.2 22026.8 20343.4 20592.2 20651.5 20862.2 21389.3 5888.8 5928.7 6101.3 6173.7 6177.4 4204.5 6050.2 6134.1 6152.7 6167.5 6556.6 6847.1 6877.6 6903.2 6984.5 6614.0 6654.3 6740.2 6744.5 6871.7 5744.1 5830.1 5840.8 5846.7 5846.8 21021.5 21411.0 26509.2 26906.3 27256.3 2287.5 2325.5 2414.2 2443.0 2498.4 11938.5 15668.3 16031.9 16038.4 16040.6 1579.5 1621.8 1748.8 1839.4 2001.0 101953.5 119588.4 127741.0 128115.0 131552.0 10634.5 10830.4 11285.0 11299.5 11493.9 14133.7 14168.2 14193.8 14225.5 14260.5 8503.8 8783.6 8819.3 8931.0 8941.8 8801.5 8811.4 8812.3 9011.5 9028.2 6730.9 6856.9 6863.9 6874.1 6877.3 1631.3 1840.7 1888.6 1897.6 1919.3 375.7 731.7 780.9 961.5 968.7 10927.0 11465.5 12009.6 12042.8 12112.4 420.3 423.8 434.6 442.7 443.6 5851.2 5932.3 6109.1 6145.2 6146.2 592556.0 593370.0 599991.0 605253.0 607561.0 96276.5 137647.0 140883.0 141198.0 141916.0 438.0 450.3 450.7 452.0 452.2 11008.6 11077.5 11273.4 11294.7 11310.3 54676.0 55318.2 56220.0 56375.7 56516.4 81751.6 82687.6 83958.0 85073.6 87050.1 5417.6 7814.3 7902.3 7912.2 8278.0 7753.6 12170.7 12316.7 12594.7 13214.6 11102.2 11598.5 11627.1 11641.8 11929.6 11093.6 11207.4 11328.3 11540.8 11662.9 11260.5 11533.7 11792.5 11865.5 11923.9 8132.2 8179.9 8187.1 8191.0 8229.4 8152.6 10341.6 10880.2 11263.4 11487.7 05:04:22 INFO - PROCESS | 2252 | 05:04:22 INFO - PROCESS | 2252 | [#3] mootools.html Cycles:180 Average:5687.46 Median:4888.29 stddev:3169.79 (64.8%) stddev-sans-first:3163.29 05:04:22 INFO - PROCESS | 2252 | Values: 1530.5 1561.5 1653.4 1851.8 1859.3 8321.5 8836.4 8843.0 8851.8 8852.0 7669.3 7922.1 8371.2 8591.2 8592.7 2338.5 2365.0 2375.0 2376.7 2376.9 2327.4 2347.0 2370.5 2372.0 2372.6 2350.3 2357.6 2369.3 2369.8 2379.5 2337.5 2344.1 2350.1 2351.1 2366.9 2324.6 2343.2 2345.6 2353.1 2353.8 8578.3 8773.3 8773.7 8780.1 8796.7 5178.7 5336.3 5345.1 5345.9 5346.0 3361.6 3596.6 3661.3 3677.8 3700.1 1097.0 1100.8 1102.0 1110.8 1130.8 11448.0 11498.5 11540.0 11549.7 11555.5 4467.6 4561.9 4759.3 4768.8 4780.0 9861.4 9870.9 9873.0 9901.7 9904.2 5299.1 5307.4 5307.7 5311.9 5327.2 4329.4 4494.9 4685.2 4783.5 4865.0 3827.3 3885.6 3972.2 3990.4 4001.2 1283.2 1299.1 1300.6 1306.7 1315.2 894.7 917.9 923.6 940.7 977.4 4983.0 5688.2 5808.7 5838.7 6109.8 434.5 882.2 945.6 996.3 1006.9 3318.4 4003.6 4089.6 4102.1 4135.5 10393.9 10637.8 10640.6 10711.6 10723.6 10670.0 10683.4 10688.7 10690.1 10703.1 7673.9 8113.2 8229.6 8235.8 8250.5 5939.0 6086.4 6121.0 6136.2 6178.9 9536.6 9862.4 9956.8 10006.5 10081.3 9699.2 10070.3 10224.2 10332.2 10343.5 7294.3 7481.9 7569.5 7578.2 7606.5 8172.7 8255.4 8256.6 8267.2 8268.1 7297.6 7409.8 7446.8 7616.0 7652.6 7265.9 7371.7 7373.8 7374.9 7438.7 6680.7 6939.2 7052.0 7069.4 7076.6 4543.6 4580.4 4911.6 4975.4 5060.9 4521.0 5086.1 5088.1 5140.6 5148.2 05:04:22 INFO - PROCESS | 2252 | 05:04:22 INFO - PROCESS | 2252 | [#4] prototype.html Cycles:180 Average:4153.64 Median:4537.79 stddev:1282.85 (28.3%) stddev-sans-first:1253.26 05:04:22 INFO - PROCESS | 2252 | Values: 291.0 294.2 302.9 307.9 309.0 5027.3 5219.6 5307.8 5317.7 5327.2 5043.3 5129.7 5160.5 5174.7 5264.6 3516.8 3971.7 4007.5 4017.9 4020.4 3339.4 3467.7 3633.1 3994.3 4036.8 3694.0 3958.5 3969.7 3980.2 3992.2 3215.8 3433.7 3889.3 3935.7 4015.2 2872.9 3380.0 3441.6 3447.2 3449.2 4395.5 4587.1 4766.4 4778.2 5052.6 4462.7 4494.9 4502.5 4514.0 4534.2 5494.8 5496.4 5562.0 5584.6 5638.7 3162.7 3561.8 3712.5 3751.0 3774.7 4967.4 4981.0 5646.7 5712.8 5769.9 2968.9 3699.6 3779.9 3790.5 3815.8 3208.5 3266.0 3792.0 3844.3 3896.5 4362.8 4412.8 4456.0 4475.1 4484.7 5177.9 5208.3 5419.5 5477.6 5514.5 1237.6 1258.4 1277.3 1289.0 1295.0 790.0 846.5 863.2 873.7 886.0 4910.0 4916.7 4947.6 4967.3 4989.3 4300.3 4767.7 4819.0 5008.9 5551.7 3783.6 4151.3 4544.5 4753.8 4926.4 2214.5 2227.2 2255.5 2402.0 2413.5 4105.2 4280.9 4541.4 4697.0 4717.8 3658.9 4452.9 4629.7 4738.6 4772.8 4216.1 4458.6 4761.0 4794.1 4834.7 3813.0 4312.3 4620.7 4622.5 4663.0 4020.0 4290.0 4455.8 4580.5 4581.5 3759.5 4251.0 4390.3 4715.7 4761.4 2784.6 3232.5 3234.7 3246.6 3285.6 4340.4 4398.3 4566.5 4572.6 4605.4 4769.4 5016.8 5205.5 5269.7 5413.1 5162.9 5167.8 5514.2 5586.8 5604.4 4531.2 4658.8 5288.7 5402.7 5409.5 5515.4 5542.0 5546.9 5569.6 5626.5 4842.5 5195.0 5457.9 5458.9 5554.0 05:04:22 INFO - PROCESS | 2252 | 05:04:22 INFO - PROCESS | 2252 | [#5] yui.html Cycles:180 Average:24179.60 Median:3801.40 stddev:38191.98 (1004.7%) stddev-sans-first:38258.28 05:04:22 INFO - PROCESS | 2252 | Values: 655.6 704.6 721.9 792.6 810.5 14987.3 16299.1 16317.8 17387.6 17942.0 16349.3 16692.0 16729.4 16732.8 16856.6 836.0 852.9 853.1 853.1 858.1 668.4 672.5 680.0 680.7 687.5 873.4 894.6 894.9 907.0 908.8 894.9 894.9 895.2 895.8 896.5 503.7 661.7 661.9 662.3 663.3 14832.7 15351.2 15384.4 15420.8 15431.2 14328.1 14739.3 15062.2 15186.0 15299.0 11877.5 11920.2 12056.6 12105.8 12131.0 3905.5 3906.7 3919.4 3942.9 3993.2 117859.0 119384.4 127593.4 127748.0 129280.4 11464.7 11694.4 11774.1 12009.4 12187.5 23381.8 23738.6 23857.6 23864.5 23922.2 8315.7 8407.2 8407.5 8514.4 8562.9 4376.7 4451.1 4466.9 4535.5 4594.5 3446.9 3798.5 3800.9 3801.9 3820.3 670.2 671.4 679.6 697.0 700.3 607.2 653.4 665.7 674.1 684.8 6829.5 8511.4 9416.4 9715.3 10075.5 658.7 661.4 668.6 699.2 700.0 3451.8 4330.1 4674.8 4700.2 4733.0 82881.0 136463.0 148237.0 148662.3 149028.0 109175.0 124604.6 128487.0 129961.7 134097.0 73005.6 100010.0 109333.5 110486.0 114311.4 9030.6 9050.5 9093.4 9131.3 9136.0 54246.0 62154.7 62568.0 63339.4 65067.0 28831.0 60344.0 90110.0 92817.0 93156.5 11595.0 13187.3 13438.0 13485.0 13516.1 12415.9 14964.0 15061.5 15296.8 15303.2 12931.9 13869.7 14105.9 14315.9 14706.5 10888.2 13942.6 14066.9 14200.1 14434.6 13711.1 13909.0 14036.5 14136.3 14478.7 9132.5 9660.7 11526.3 11600.2 11828.3 9686.8 10522.5 11622.4 11692.5 12126.2 05:04:22 INFO - PROCESS | 2252 | -------- Summary: end -------- 05:04:22 INFO - PROCESS | 2252 | 05:04:23 INFO - TEST-INFO | 2252: exit 0 05:04:23 INFO - TEST-OK | dromaeo_css | took 1118585ms 05:04:23 INFO - TEST-START | kraken 05:04:23 INFO - operating with platform_type : mac_ 05:04:23 INFO - Initialising browser for kraken test... 05:04:23 INFO - TEST-INFO | started process 2254 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpwiVQST/profile http://localhost:53010/getInfo.html) 05:04:25 INFO - PROCESS | 2254 | __metrics Screen width/height:1600/1200 05:04:25 INFO - PROCESS | 2254 | colorDepth:24 05:04:25 INFO - PROCESS | 2254 | Browser inner width/height: 1024/689 05:04:25 INFO - PROCESS | 2254 | __metrics 05:04:25 INFO - PROCESS | 2254 | 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" 05:04:25 INFO - PROCESS | 2254 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:04:26 INFO - TEST-INFO | 2254: exit 0 05:04:26 INFO - Browser initialized. 05:04:26 INFO - Running cycle 1/1 for kraken test... 05:04:26 INFO - TEST-INFO | started process 2255 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s2/3x4m5lhs6f5646cpdt1xtxmr00000w/T/tmpwiVQST/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:38 INFO - PROCESS | 2255 | RSS: Main: 228225024 05:04:38 INFO - PROCESS | 2255 | 05:04:40 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53010/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:41 INFO - PROCESS | 2255 | RSS: Main: 285306880 05:04:41 INFO - PROCESS | 2255 | 05:04:44 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53010/tests/kraken/driver.html?testName=audio-dft) 05:04:44 INFO - PROCESS | 2255 | RSS: Main: 294207488 05:04:44 INFO - PROCESS | 2255 | 05:04:48 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53010/tests/kraken/driver.html?testName=audio-fft) 05:04:48 INFO - PROCESS | 2255 | RSS: Main: 389660672 05:04:48 INFO - PROCESS | 2255 | 05:04:50 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53010/tests/kraken/driver.html?testName=audio-oscillator) 05:04:51 INFO - PROCESS | 2255 | RSS: Main: 290541568 05:04:51 INFO - PROCESS | 2255 | 05:04:53 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53010/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:54 INFO - PROCESS | 2255 | RSS: Main: 295235584 05:04:54 INFO - PROCESS | 2255 | 05:04:56 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53010/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:57 INFO - PROCESS | 2255 | RSS: Main: 332144640 05:04:57 INFO - PROCESS | 2255 | 05:05:00 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53010/tests/kraken/driver.html?testName=imaging-desaturate) 05:05:01 INFO - PROCESS | 2255 | RSS: Main: 334483456 05:05:01 INFO - PROCESS | 2255 | 05:05:04 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53010/tests/kraken/driver.html?testName=json-parse-financial) 05:05:04 INFO - PROCESS | 2255 | RSS: Main: 331390976 05:05:04 INFO - PROCESS | 2255 | 05:05:06 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53010/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:05:06 INFO - PROCESS | 2255 | RSS: Main: 300990464 05:05:06 INFO - PROCESS | 2255 | 05:05:08 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53010/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:09 INFO - PROCESS | 2255 | RSS: Main: 307695616 05:05:09 INFO - PROCESS | 2255 | 05:05:11 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53010/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:12 INFO - PROCESS | 2255 | RSS: Main: 299950080 05:05:12 INFO - PROCESS | 2255 | 05:05:15 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:15 INFO - PROCESS | 2255 | RSS: Main: 313806848 05:05:15 INFO - PROCESS | 2255 | 05:05:18 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:19 INFO - PROCESS | 2255 | RSS: Main: 316399616 05:05:19 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | Cycle 1(1): loaded http://localhost:53010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53010/tests/kraken/driver.html?testName=ai-astar) 05:05:21 INFO - PROCESS | 2255 | RSS: Main: 359714816 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | __start_tp_report 05:05:21 INFO - PROCESS | 2255 | _x_x_mozilla_page_load 05:05:21 INFO - PROCESS | 2255 | _x_x_mozilla_page_load_details 05:05:21 INFO - PROCESS | 2255 | |i|pagename|runs| 05:05:21 INFO - PROCESS | 2255 | |0;ai-astar;103;112;114;114;108;114;114;112;114;113 05:05:21 INFO - PROCESS | 2255 | |1;audio-beat-detection;143;109;105;180;136;135;129;109;165;105 05:05:21 INFO - PROCESS | 2255 | |2;audio-dft;183;186;184;182;184;181;182;183;181;181 05:05:21 INFO - PROCESS | 2255 | |3;audio-fft;79;58;61;89;59;58;66;63;83;57 05:05:21 INFO - PROCESS | 2255 | |4;audio-oscillator;86;69;103;70;70;68;97;71;68;103 05:05:21 INFO - PROCESS | 2255 | |5;imaging-gaussian-blur;89;87;91;88;90;87;91;88;90;86 05:05:21 INFO - PROCESS | 2255 | |6;imaging-darkroom;94;94;95;95;94;94;95;96;94;94 05:05:21 INFO - PROCESS | 2255 | |7;imaging-desaturate;86;87;84;113;86;85;84;105;140;134 05:05:21 INFO - PROCESS | 2255 | |8;json-parse-financial;55;53;53;54;55;55;54;54;54;54 05:05:21 INFO - PROCESS | 2255 | |9;json-stringify-tinderbox;64;66;80;77;73;68;70;69;71;71 05:05:21 INFO - PROCESS | 2255 | |10;stanford-crypto-aes;87;85;83;83;73;80;100;103;110;102 05:05:21 INFO - PROCESS | 2255 | |11;stanford-crypto-ccm;141;138;139;136;138;138;143;149;226;134 05:05:21 INFO - PROCESS | 2255 | |12;stanford-crypto-pbkdf2;175;170;169;190;205;167;167;170;168;168 05:05:21 INFO - PROCESS | 2255 | |13;stanford-crypto-sha256-iterative;58;84;85;82;66;67;65;68;65;63 05:05:21 INFO - PROCESS | 2255 | __end_tp_report 05:05:21 INFO - PROCESS | 2255 | __start_cc_report 05:05:21 INFO - PROCESS | 2255 | _x_x_mozilla_cycle_collect,2028 05:05:21 INFO - PROCESS | 2255 | __end_cc_report 05:05:21 INFO - PROCESS | 2255 | __startTimestamp1471521921554__endTimestamp 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | ------- Summary: start ------- 05:05:21 INFO - PROCESS | 2255 | Number of tests: 14 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#0] ai-astar Cycles:10 Average:111.80 Median:114.00 stddev:3.61 (3.2%) stddev-sans-first:1.99 05:05:21 INFO - PROCESS | 2255 | Values: 103.0 112.0 114.0 114.0 108.0 114.0 114.0 112.0 114.0 113.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:135.50 stddev:25.95 (19.2%) stddev-sans-first:27.20 05:05:21 INFO - PROCESS | 2255 | Values: 143.0 109.0 105.0 180.0 136.0 135.0 129.0 109.0 165.0 105.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#2] audio-dft Cycles:10 Average:182.70 Median:183.00 stddev:1.64 (0.9%) stddev-sans-first:1.73 05:05:21 INFO - PROCESS | 2255 | Values: 183.0 186.0 184.0 182.0 184.0 181.0 182.0 183.0 181.0 181.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#3] audio-fft Cycles:10 Average:67.30 Median:64.50 stddev:11.84 (18.4%) stddev-sans-first:11.78 05:05:21 INFO - PROCESS | 2255 | Values: 79.0 58.0 61.0 89.0 59.0 58.0 66.0 63.0 83.0 57.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#4] audio-oscillator Cycles:10 Average:80.50 Median:70.00 stddev:15.17 (21.7%) stddev-sans-first:15.96 05:05:21 INFO - PROCESS | 2255 | Values: 86.0 69.0 103.0 70.0 70.0 68.0 97.0 71.0 68.0 103.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:89.50 stddev:1.77 (2.0%) stddev-sans-first:1.87 05:05:21 INFO - PROCESS | 2255 | Values: 89.0 87.0 91.0 88.0 90.0 87.0 91.0 88.0 90.0 86.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 05:05:21 INFO - PROCESS | 2255 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 95.0 96.0 94.0 94.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#7] imaging-desaturate Cycles:10 Average:100.40 Median:84.50 stddev:21.72 (25.7%) stddev-sans-first:22.41 05:05:21 INFO - PROCESS | 2255 | Values: 86.0 87.0 84.0 113.0 86.0 85.0 84.0 105.0 140.0 134.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 05:05:21 INFO - PROCESS | 2255 | Values: 55.0 53.0 53.0 54.0 55.0 55.0 54.0 54.0 54.0 54.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:4.82 (6.8%) stddev-sans-first:4.42 05:05:21 INFO - PROCESS | 2255 | Values: 64.0 66.0 80.0 77.0 73.0 68.0 70.0 69.0 71.0 71.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:81.50 stddev:12.16 (14.9%) stddev-sans-first:12.83 05:05:21 INFO - PROCESS | 2255 | Values: 87.0 85.0 83.0 83.0 73.0 80.0 100.0 103.0 110.0 102.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:140.00 stddev:27.65 (19.7%) stddev-sans-first:29.20 05:05:21 INFO - PROCESS | 2255 | Values: 141.0 138.0 139.0 136.0 138.0 138.0 143.0 149.0 226.0 134.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:170.00 stddev:12.64 (7.4%) stddev-sans-first:13.40 05:05:21 INFO - PROCESS | 2255 | Values: 175.0 170.0 169.0 190.0 205.0 167.0 167.0 170.0 168.0 168.0 05:05:21 INFO - PROCESS | 2255 | 05:05:21 INFO - PROCESS | 2255 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:67.50 stddev:9.64 (14.3%) stddev-sans-first:9.14 05:05:21 INFO - PROCESS | 2255 | Values: 58.0 84.0 85.0 82.0 66.0 67.0 65.0 68.0 65.0 63.0 05:05:21 INFO - PROCESS | 2255 | -------- Summary: end -------- 05:05:21 INFO - PROCESS | 2255 | 05:05:22 INFO - TEST-INFO | 2255: exit 0 05:05:22 INFO - TEST-OK | kraken | took 59455ms 05:05:22 INFO - SUITE-END | took 1178s 05:05:22 INFO - Completed test suite (00:19:38) 05:05:22 INFO - javascript benchmark 05:05:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.721223695986, 3338.482535207042, 3339.2486690494643, 3341.7159541438978, 3358.2108204571937, 5559.527440167581, 5640.153976903456, 5652.915206271904, 5733.913991290129, 5744.712764361786, 4975.228839529869, 5675.0, 5730.0, 5759.510441612458, 5786.768529258835, 5163.432022477525, 5190.974045129769, 5223.2165175223645, 5236.581073514109, 5331.706756128411, 4670.836520721776, 5309.070912590281, 5319.521243088121, 5324.068288049595, 5364.812231571896, 5133.614978876599, 5140.126178549655, 5197.402298735656, 5240.816571420001, 5335.359756829166, 5138.075146473633, 5166.974165129188, 5173.379194496647, 5195.0, 5290.365156181283, 5185.118529849935, 5193.68837869729, 5199.922001169985, 5216.4522725114075, 5270.736463176864, 5583.3858275589655, 5633.60564760467, 5720.828375148711, 5779.537636989031, 5780.595358324919, 5212.29633999409, 6183.412575805336, 6249.468795152417, 6250.15622890913, 6315.526335524854, 5206.0, 6318.684065796738, 6327.588706734094, 6333.588316759442, 6337.461315788163, 5729.1119876419225, 5763.077907534775, 5878.412828536314, 5932.9406705932815, 5934.465898069108, 6063.242094738158, 6278.560500764903, 6313.242410910629, 6329.0, 6350.206224221973, 6229.595076320024, 6239.844003899939, 6240.937590624127, 6250.218722659668, 6255.218097737783, 6116.457510225599, 6225.906611400833, 6287.371262873676, 6316.115743795872, 6330.113784070234, 6146.139540464339, 6190.071489276645, 6215.9378406216265, 6221.346758590374, 6272.059191121277, 6257.655828929453, 6263.561550691408, 6273.309935907047, 6275.435210831047, 6291.276503202191, 4920.991196804646, 5006.324146240284, 5021.573166280834, 5031.899362012739, 5050.747462626928, 4379.912401751947, 4545.954540454619, 4559.589636932626, 4563.110193512233, 4568.977155114203, 5689.715514224272, 5701.344345400249, 5704.087346024699, 5711.8857622848145, 5729.255196824386, 6171.537134714914, 6273.560850740496, 6315.242170939517, 6319.178506794179, 6349.238091429058, 5728.0, 5740.368559458456, 5756.7121643917635, 5761.949952549806, 5804.1293805929445, 4608.723476591415, 5467.808626698046, 5468.371137319259, 5478.863028424321, 5499.780008799603, 6235.906461403082, 6255.311915689271, 6279.152314437584, 6290.937090629035, 6325.399087086904, 6355.523335749745, 6356.68216589178, 6369.394907483782, 6386.329435409401, 6391.073294372383, 6319.715612797527, 6348.873022539616, 6351.07909353132, 6352.6506042166275, 6355.237371515448, 6123.8162855114415, 6146.309764814711, 6179.16581261524, 6212.9068063979985, 6298.968505157445, 6169.56813023084, 6287.874242515216, 6337.207849018872, 6343.429091381798, 6344.492440604648, 6155.507559395327, 6200.441960223421, 6201.751929922933, 6203.65879876593, 6207.224096987877, 5944.3164036136395, 5963.373845746134, 6021.187139736079, 6044.0, 6125.510168486406, 5988.970055149696, 6056.394360563909, 6057.956036093341, 6081.665508397081, 6092.208012958465, 6159.393149460502, 6199.628022318675, 6206.658633775186, 6211.192544969125, 6217.253929528486, 5733.168690539932, 5924.140999555127, 5934.554908381802, 6016.127661488972, 6019.578629495893], "value": 5716.081304708509, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.86279184848627, 460.38768437977495, 516.1071346570433, 528.931238938938, 545.8962797068559, 26841.865790671043, 32224.838875805617, 39861.0, 41022.58977410225, 41023.58976410243, 42035.57964420355, 42196.78901605495, 42264.943376415606, 42396.36405453913, 42401.0, 8945.792318037047, 9334.20659243965, 9597.712068637935, 9812.264080193978, 9839.0, 8660.437071590359, 8868.201861832435, 11666.766664666702, 11976.94011529941, 11995.520179192821, 11898.643040708792, 11924.463399147016, 11963.7607247855, 11987.40062996851, 11989.64031079069, 11849.0, 11949.163558550905, 11955.462004209832, 11957.521699132025, 11971.485987942542, 11815.822762658481, 11882.821757673642, 11895.702607434796, 11898.22661526998, 11921.463534140898, 39403.40894886579, 39687.8015609923, 39752.006199844946, 39765.0, 39792.40311395331, 3310.5696259486112, 3371.4100032494216, 3404.9829750851336, 3410.4884267360094, 3527.3298073366236, 30639.693603063908, 31644.05067847968, 31733.682663173302, 31738.365232695218, 31836.6816331836, 3200.311932934407, 3333.283344081034, 3362.495625656147, 3369.528266042756, 3401.3877502049622, 460321.0, 461010.6949465231, 462388.0, 463463.0, 466970.6651466755, 55601.721991389786, 55723.44276557264, 56113.43886561082, 56116.0, 56134.43865561292, 57234.42765572374, 58051.70974145102, 58138.127928081114, 58255.41744582585, 58277.125843112386, 16033.438829640907, 16247.268872900748, 16247.431339903047, 16258.268377923021, 16259.430919917982, 10933.453327333602, 11536.307821530734, 12667.809982850265, 12672.873271267354, 12757.744845103232, 13133.277669728257, 13193.625147473354, 13210.471581136648, 13229.867701323055, 14426.495072672406, 5210.53105220532, 6522.869542609216, 7143.069675179767, 7244.529105608224, 7306.232845551141, 846.7417437681567, 876.4346996187423, 989.5992123189975, 1012.7974405119006, 1016.2378216337746, 28675.56986645202, 29040.983565575105, 29650.851745741133, 29833.30025798761, 30027.39945201084, 1031.783325501653, 1038.7558923652934, 1062.559037999237, 1122.4790408995693, 1139.1627154041773, 14461.638459038399, 15347.61630959235, 15484.0, 15663.765043524356, 15831.920840395955, 625156.0, 627613.0, 629334.0, 629525.8523707353, 891431.0, 47725.0, 56988.0, 57945.551361216305, 58064.41935580675, 61208.0, 1356.0, 1376.5388594820847, 1397.4270549074831, 1397.4899161805665, 1398.6433459467974, 29302.70697293085, 30282.84858575693, 31217.751289948148, 31773.682263177998, 32202.516962245118, 48729.0, 49066.75466622644, 49105.75447122742, 49146.508534914195, 49183.7540812308, 559029.0, 560456.0, 561630.0, 562146.0, 564217.0, 38017.2396552073, 38453.80773096117, 38836.41745373765, 38970.415443768936, 39077.80461097676, 46288.53711462977, 46492.0, 47312.290315644605, 47775.0, 48157.03685926192, 33093.503597445575, 38330.80834595921, 38619.80690096531, 39496.210075797746, 40410.0, 37307.44038839474, 37766.866993990225, 38349.0, 38650.16872890889, 39183.0, 37199.442008369355, 37582.36264560338, 38189.809050954565, 38586.22827543377, 40567.39148912828, 30409.0, 32215.51676724898, 33110.50334245036, 33593.49609755807, 34355.65644343525, 24927.626085608368, 25739.356516087246, 25791.03050584105, 25820.741792581834, 25899.611505827805], "value": 20143.331069775617, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.2426261890629, 342.10027627340094, 356.56142944178646, 365.19838953497066, 392.23318412503556, 15688.294026768794, 18715.62568748624, 21231.57536849262, 21933.232336868212, 22026.788526631048, 20343.389698309074, 20592.176312947464, 20651.483712907186, 20862.165513379485, 21389.251376201835, 5888.793892213774, 5928.733207005674, 6101.2983506896835, 6173.691315434233, 6177.413145751147, 4204.516480604739, 6050.2437195350585, 6134.110553969672, 6152.723127459275, 6167.5065994720535, 6556.639384833832, 6847.109875716174, 6877.58734475933, 6903.171619405678, 6984.476164287698, 6614.040964060185, 6654.26803051664, 6740.191177058784, 6744.460443164535, 6871.656417179146, 5744.054903175193, 5830.125481177814, 5840.8247752567495, 5846.736896839652, 5846.801405711819, 21021.474463138544, 21411.0, 26509.204723858315, 26906.327341816417, 27256.31859203516, 2287.451011757183, 2325.5348930214027, 2414.2033129067368, 2442.995116007321, 2498.4253621667117, 11938.462769175321, 15668.294926728211, 16031.91984040084, 16038.35846566136, 16040.598985025352, 1579.5024567261275, 1621.764844097611, 1748.77265955425, 1839.350162558783, 2001.0495014867968, 101953.49023254836, 119588.40205799002, 127741.0, 128115.0, 131552.0, 10634.458003589436, 10830.350178989285, 11284.98524838531, 11299.548018079186, 11493.885061149449, 14133.71732565343, 14168.22074785876, 14193.78709319361, 14225.502107426191, 14260.50088246927, 8503.829923401498, 8783.61830695187, 8819.29445644347, 8930.955345223232, 8941.776455588662, 8801.47191168532, 8811.383203175716, 8812.325658124935, 9011.459312441275, 9028.232600229054, 6730.9326906731285, 6856.862862742817, 6863.897041544381, 6874.106366172366, 6877.277885822016, 1631.3393075804318, 1840.6778813707547, 1888.631716815208, 1897.6489349470392, 1919.2994556986878, 375.6525214176875, 731.7109741652017, 780.9297163255334, 961.4808003678075, 968.7142293023575, 10927.016568508872, 11465.484053217626, 12009.63971080869, 12042.81935770964, 12112.39438028095, 420.2771233478412, 423.78175239750936, 434.6327353386383, 442.7255101836882, 443.6450839328524, 5851.210086638334, 5932.2584676915385, 6109.083637454418, 6145.170401995673, 6146.170267013896, 592556.0, 593370.0, 599991.0, 605253.0, 607561.0, 96276.51861740787, 137647.0, 140883.0, 141198.0, 141916.0, 437.9693421460467, 450.293039927311, 450.7430764464224, 451.9977400112978, 452.16801086001914, 11008.559657613605, 11077.501512432122, 11273.436328183721, 11294.717632059264, 11310.321380717183, 54676.0, 55318.17022744742, 56220.0, 56375.71812140913, 56516.43483565112, 81751.59856616327, 82687.5865620668, 83958.0, 85073.57463212892, 87050.1294987042, 5417.593680474059, 7814.33578145864, 7902.288794008567, 7912.248336408032, 8277.95861020691, 7753.573553454388, 12170.695732606755, 12316.692082698004, 12594.685132871751, 13214.603561893158, 11102.167337449562, 11598.536058557564, 11627.127965402799, 11641.808948778602, 11929.642110736691, 11093.611723589636, 11207.383593902414, 11328.32030078198, 11540.769184616429, 11662.94168529152, 11260.493277802354, 11533.653990380302, 11792.469338879942, 11865.525378984745, 11923.940380298043, 8132.1867813218205, 8179.918200818153, 8187.099419063779, 8190.959045204736, 8229.42394032436, 8152.551609661526, 10341.638042668772, 10880.183986200907, 11263.436828158723, 11487.655370338904], "value": 8972.428779951922, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.5255370835039, 1561.5393458929616, 1653.446095557988, 1851.7592712947314, 1859.2841755923964, 8321.54231517267, 8836.425632333901, 8843.0, 8851.77870553235, 8851.955740221298, 7669.309762121408, 7922.088959769629, 8371.204735550113, 8591.18383753544, 8592.742217733477, 2338.5206032763326, 2364.9763502364926, 2375.0499800079933, 2376.691030166076, 2376.893039813204, 2327.359976006595, 2347.0142540133184, 2370.5140446208484, 2372.027468737818, 2372.6238781506772, 2350.2949115265437, 2357.6463530470396, 2369.336585755991, 2369.763023697634, 2379.5121999990047, 2337.544178885118, 2344.132670911765, 2350.059976009601, 2351.1418332308754, 2366.8816559171973, 2324.5583339165505, 2343.238447504568, 2345.64815277708, 2353.1058197884863, 2353.7528559501347, 8578.270846978014, 8773.341999350074, 8773.692920747742, 8780.121987801169, 8796.692115775917, 5178.689278643294, 5336.332958380202, 5345.1447768356875, 5345.946540534584, 5345.957538280037, 3361.6134144573443, 3596.6403359664087, 3661.340958627446, 3677.797721125337, 3700.0564855961825, 1097.025354362153, 1100.7963526747578, 1102.0412241349998, 1110.7500812317164, 1130.756887269233, 11448.026917712004, 11498.482568284448, 11540.019098376564, 11549.711257218552, 11555.53777848885, 4467.620252278528, 4561.863144105682, 4759.262314341283, 4768.809247630056, 4780.0, 9861.408315501092, 9870.851937220947, 9872.950635246778, 9901.702948911545, 9904.15814655748, 5299.072662284085, 5307.3896501902, 5307.65500242483, 5311.920321195185, 5327.227552004938, 4329.415528903621, 4494.9325760113625, 4685.180093483695, 4783.545563171493, 4865.026994601094, 3827.349350610403, 3885.630865067814, 3972.165845172546, 3990.4213888985932, 4001.15975645112, 1283.1915892987358, 1299.0711641176415, 1300.629320643631, 1306.73865226955, 1315.1648703073618, 894.6913314906346, 917.9449233046039, 923.607466826596, 940.7083804020775, 977.4477420257532, 4983.0, 5688.175214593944, 5808.709564521757, 5838.715482593822, 6109.816705498843, 434.45909842246607, 882.188386684252, 945.5792172483317, 996.3274789517047, 1006.8741407324085, 3318.369509793132, 4003.5542776130405, 4089.6114869087387, 4102.077032667686, 4135.503739551273, 10393.948030259951, 10637.840432393521, 10640.574377024832, 10711.571537138583, 10723.624673136403, 10669.986351296615, 10683.358998460117, 10688.679339619825, 10690.144788416908, 10703.1437485001, 7673.923260767432, 8113.188681131957, 8229.588520573947, 8235.794105147299, 8250.54621995784, 5938.970305148447, 6086.421789929949, 6120.969395152996, 6136.208025348366, 6178.907316390348, 9536.57085431171, 9862.358946668444, 9956.800863982824, 10006.549705263425, 10081.344712593658, 9699.224062074876, 10070.345427547187, 10224.182065434896, 10332.173426126043, 10343.534540945526, 7294.270572942663, 7481.925180748341, 7569.47013709035, 7578.204288549843, 7606.543607383574, 8172.713955011784, 8255.42212045151, 8256.628451719567, 8267.214614611603, 8268.131846156068, 7297.562146271241, 7409.777706668809, 7446.776596702108, 7615.961920190363, 7652.617369131633, 7265.891011634935, 7371.741989030358, 7373.8156546086775, 7374.889376659462, 7438.702451901863, 6680.732770689118, 6939.16729992384, 7051.964740176266, 7069.363757261871, 7076.646167691491, 4543.568361005699, 4580.3587497751005, 4911.557959783637, 4975.353204083446, 5060.8987820242655, 4521.0, 5086.059079070384, 5088.109580823415, 5140.588752899685, 5148.176291793295], "value": 4581.468265423578, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.0062137799414, 294.215914587624, 302.9378977309652, 307.92455848317167, 308.962924449066, 5027.321311622939, 5219.608529360295, 5307.814226502073, 5317.6971641947775, 5327.200919862018, 5043.268726034723, 5129.666571672848, 5160.509751573594, 5174.715390653512, 5264.631475796696, 3516.7714098583638, 3971.7021223408215, 4007.519097708279, 4017.879463616096, 4020.437138800563, 3339.3989081965237, 3467.653234676525, 3633.148862206057, 3994.3423479256076, 4036.777977211252, 3694.0, 3958.4656071430422, 3969.7221194516396, 3980.1840622672285, 3992.2215168042244, 3215.774895757298, 3433.7081348085444, 3889.2610404023426, 3935.6654684351865, 4015.217032678629, 2872.9082948479654, 3379.9522148134156, 3441.5698037745283, 3447.1899103710607, 3449.223924616966, 4395.494518130424, 4587.128445595326, 4766.428028636551, 4778.163821331288, 5052.646314757969, 4462.665300102505, 4494.910101797946, 4502.459704835408, 4513.961788788597, 4534.161180181644, 5494.780208791643, 5496.395396506381, 5562.0, 5584.581156413245, 5638.689872057035, 3162.652108268089, 3561.8041007744564, 3712.461693054492, 3751.0434839116124, 3774.735768496206, 4967.379077615298, 4980.975095124573, 5646.745896434671, 5712.828615141552, 5769.855753606152, 2968.85155742212, 3699.557172702648, 3779.8866034019024, 3790.450384694204, 3815.771053736785, 3208.53476245943, 3265.951010734841, 3791.976166435047, 3844.3464611015634, 3896.532416110085, 4362.847300344536, 4412.836453100731, 4456.0, 4475.082608065339, 4484.663650226246, 5177.896442071137, 5208.348956380452, 5419.458054194549, 5477.561795056386, 5514.476124768141, 1237.6472705279132, 1258.3519487463964, 1277.2591896699892, 1288.96238527984, 1294.9935250323688, 789.984200316002, 846.5047946951103, 863.2317237658489, 873.7156380121212, 885.9911400886037, 4910.017996400734, 4916.70499770015, 4947.554720075139, 4967.254911763264, 4989.276554899519, 4300.333448315516, 4767.69010014348, 4819.012102518976, 5008.899822003539, 5551.694656793915, 3783.621637836194, 4151.294279972412, 4544.500104988449, 4753.765730106844, 4926.4088309403105, 2214.472014310153, 2227.175944900365, 2255.5226326756, 2402.0, 2413.5398084158833, 4105.173197926893, 4280.871573852789, 4541.409616749867, 4697.0, 4717.787699553528, 3658.853645854136, 4452.910941781146, 4629.662020679535, 4738.644601654821, 4772.809087636456, 4216.135692183095, 4458.550970934394, 4761.000379840406, 4794.082367053206, 4834.685745426606, 3812.9618703813717, 4312.331588603646, 4620.676552641417, 4622.497688251265, 4662.969070104324, 4019.9649264806053, 4290.0, 4455.799489023067, 4580.450345958507, 4581.518940511199, 3759.496201519414, 4250.959539421034, 4390.275604525217, 4715.693479923932, 4761.35790572143, 2784.568391899259, 3232.515122731515, 3234.6765323467466, 3246.5617141686516, 3285.6057273127376, 4340.435743353344, 4398.318260669601, 4566.520515345974, 4572.611328037154, 4605.447346318463, 4769.373707503854, 5016.774245159049, 5205.453427390221, 5269.736513174249, 5413.133898576209, 5162.870928226675, 5167.819126330561, 5514.172874068921, 5586.770910399706, 5604.355499117653, 4531.184386810406, 4658.836940707059, 5288.68267903927, 5402.6758394496455, 5409.459054094559, 5515.420880807457, 5542.0, 5546.944530554804, 5569.582281328835, 5626.465485778845, 4842.5157484251295, 5195.0, 5457.918131228114, 5458.8908221834545, 5554.0], "value": 3755.94390847413, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.5542231282727, 704.6476761619191, 721.9025431566737, 792.5522080024789, 810.5015415519456, 14987.250637468123, 16299.103549304798, 16317.83682163178, 17387.5653108672, 17942.013189274585, 16349.264283107259, 16692.0, 16729.414470493535, 16732.83267167328, 16856.578585535368, 836.0, 852.8933883264592, 853.1042405474227, 853.1468531468531, 858.1289990659454, 668.408458514216, 672.4620303756999, 679.9830004249884, 680.727708916435, 687.5084314714978, 873.3929918706501, 894.6466145872377, 894.9015608283083, 907.0068275238604, 908.8227795579865, 894.8612964990405, 894.9194572488442, 895.2256298301954, 895.7671005538607, 896.4979611417627, 503.7204351584869, 661.7253839656537, 661.9271880093186, 662.2979641579892, 663.349917081263, 14832.703345933021, 15351.232438378149, 15384.384624615002, 15420.845791542053, 15431.151286679227, 14328.140311581234, 14739.336729847075, 15062.246887655574, 15186.0, 15299.0, 11877.524899004029, 11920.22518536301, 12056.63830085099, 12105.757884842342, 12131.0, 3905.4922860028014, 3906.667933225679, 3919.4164779133607, 3942.8817135485983, 3993.1813978134414, 117859.0, 119384.40307798405, 127593.36203319016, 127748.0, 129280.35359823235, 11464.713382165346, 11694.415279236004, 11774.116941229271, 12009.43877295946, 12187.51249949992, 23381.76618233796, 23738.64392034121, 23857.642135367983, 23864.522709545712, 23922.162724304566, 8315.667373305121, 8407.201315874981, 8407.495550267004, 8514.446560973516, 8562.871556926651, 4376.693631445832, 4451.109778044404, 4466.920348531086, 4535.523770004168, 4594.540545945379, 3446.9310613787584, 3798.4682144499793, 3800.904977375588, 3801.885943421702, 3820.255050265227, 670.1756839087949, 671.4225765841372, 679.6228093408206, 696.989545156823, 700.3276854220006, 607.2136583124864, 653.3988730367978, 665.7203974330793, 674.0933444517117, 684.7579246567467, 6829.52193346461, 8511.361647876434, 9416.399212133954, 9715.266779856163, 10075.458925655994, 658.6969993802809, 661.4443867151616, 668.5587512241995, 699.192432740186, 699.9825004374932, 3451.775634583744, 4330.133973205371, 4674.766261686902, 4700.247960326331, 4732.952670473252, 82881.0, 136463.0, 148237.0, 148662.25668871586, 149028.0, 109175.0, 124604.63883764025, 128487.0, 129961.70038299685, 134097.0, 73005.6349718248, 100010.0, 109333.45333273282, 110486.0, 114311.42844285726, 9030.63877444895, 9050.502222377832, 9093.40892841963, 9131.315151363808, 9135.954320228622, 54246.0, 62154.68922655358, 62568.0, 63339.36660633519, 65067.023994641066, 28830.990915317863, 60344.0, 90110.03294489365, 92817.0, 93156.5342173312, 11594.956453919187, 13187.340632968506, 13437.992150588549, 13485.0, 13516.053876228569, 12415.889946668069, 14964.0, 15061.472848450252, 15296.847031529542, 15303.158326292161, 12931.870681293067, 13869.653258668613, 14105.858941410455, 14315.856841431452, 14706.485273015393, 10888.237823352289, 13942.58172254834, 14066.859331406555, 14200.147991120566, 14434.566962991126, 13711.108777929403, 13909.0, 14036.508722194674, 14136.293185340486, 14478.710425791636, 9132.543372831466, 9660.661876834558, 11526.308421494738, 11600.245984011011, 11828.290302581872, 9686.757831053998, 10522.459728918955, 11622.394442808656, 11692.47383867745, 12126.151169418055], "value": 7842.378742602811, "unit": "score"}], "name": "dromaeo_css", "value": 7201.01188715276, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 114.0, 114.0, 108.0, 114.0, 114.0, 112.0, 114.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 105.0, 180.0, 136.0, 135.0, 129.0, 109.0, 165.0, 105.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 184.0, 182.0, 184.0, 181.0, 182.0, 183.0, 181.0, 181.0], "value": 182.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 61.0, 89.0, 59.0, 58.0, 66.0, 63.0, 83.0, 57.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 103.0, 70.0, 70.0, 68.0, 97.0, 71.0, 68.0, 103.0], "value": 80.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 91.0, 88.0, 90.0, 87.0, 91.0, 88.0, 90.0, 86.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 96.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 84.0, 113.0, 86.0, 85.0, 84.0, 105.0, 140.0, 134.0], "value": 100.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 80.0, 77.0, 73.0, 68.0, 70.0, 69.0, 71.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 83.0, 83.0, 73.0, 80.0, 100.0, 103.0, 110.0, 102.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 139.0, 136.0, 138.0, 138.0, 143.0, 149.0, 226.0, 134.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 170.0, 169.0, 190.0, 205.0, 167.0, 167.0, 170.0, 168.0, 168.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 84.0, 85.0, 82.0, 66.0, 67.0, 65.0, 68.0, 65.0, 63.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1466.5, "alertThreshold": 2.0}]} 05:05:22 INFO - Return code: 0 05:05:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:05:22 INFO - # TBPL SUCCESS # 05:05:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:05:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:05:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:05:22 INFO - 2016-08-18 05:05:22.854 screenresolution[2259:21793] starting screenresolution argv=screenresolution get 05:05:22 INFO - 2016-08-18 05:05:22.857 screenresolution[2259:21793] Display 0: 1600x1200x32@60 05:05:22 INFO - 2016-08-18 05:05:22.863 screenresolution[2260:21796] starting screenresolution argv=screenresolution list 05:05:22 INFO - Available Modes on Display 0 05:05:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:05:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:05:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:05:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:05:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:05:23 INFO - Intel Iris: 05:05:23 INFO - Chipset Model: Intel Iris 05:05:23 INFO - Type: GPU 05:05:23 INFO - Bus: Built-In 05:05:23 INFO - VRAM (Dynamic, Max): 1536 MB 05:05:23 INFO - Vendor: Intel (0x8086) 05:05:23 INFO - Device ID: 0x0a2e 05:05:23 INFO - Revision ID: 0x0009 05:05:23 INFO - Displays: 05:05:23 INFO - Display: 05:05:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:05:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:05:23 INFO - Display Serial Number: 1600x1200 60 05:05:23 INFO - Main Display: Yes 05:05:23 INFO - Mirror: Off 05:05:23 INFO - Online: Yes 05:05:23 INFO - Rotation: Supported 05:05:23 INFO - Return code: 0 05:05:23 INFO - Running post-action listener: _resource_record_post_action 05:05:23 INFO - [mozharness: 2016-08-18 12:05:23.102077Z] Finished run-tests step (success) 05:05:23 INFO - Running post-run listener: _resource_record_post_run 05:05:23 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 20480; Write bytes: 701939712; Read time: 1; Write time: 1948 05:05:23 INFO - TinderboxPrint: CPU usage
53.5% 05:05:23 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 1 05:05:23 INFO - TinderboxPrint: I/O write bytes / time
701,939,712 / 1,948 05:05:23 INFO - TinderboxPrint: CPU idle
2,257.9 (46.5%) 05:05:23 INFO - TinderboxPrint: CPU system
970.2 (20.0%) 05:05:23 INFO - TinderboxPrint: CPU user
1,625.6 (33.5%) 05:05:23 INFO - TinderboxPrint: Swap in / out
404,627,456 / 0 05:05:23 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388059648; Write bytes: 383035392; Read time: 29269; Write time: 774 05:05:23 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 20480; Write bytes: 293435392; Read time: 1; Write time: 1111 05:05:23 INFO - Running post-run listener: _upload_blobber_files 05:05:23 INFO - Blob upload gear active. 05:05:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:05:23 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 05:05:23 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'] 05:05:23 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 05:05:23 INFO - (blobuploader) - INFO - Open directory for files ... 05:05:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:05:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:05:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:24 INFO - (blobuploader) - INFO - Done attempting. 05:05:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:05:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:05:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:25 INFO - (blobuploader) - INFO - Done attempting. 05:05:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:05:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:05:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:28 INFO - (blobuploader) - INFO - Done attempting. 05:05:28 INFO - (blobuploader) - INFO - Iteration through files over. 05:05:28 INFO - Return code: 0 05:05:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:05:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:05:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86916446b9da2f772b5ca1688724124ca030f54d09949982966c4d2b30316135e834a566be797886188e2df953d6e00a9e5ab26ce98e7220edf2bc0ee050a1af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9a208cb7c5bd0f12c9c035c4f46d1f9f0e1963ad199e1155e735b5f8a24d4f795977e9c55a015361739c21bf3c68145036804d31619ff300b0da45a6a6af77b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4aa692c8f42fceffd487de752ea6f0603cefa017a9409830e40e7284412c72e483c9f0656be828bfc5aa3e5cd077bfc9ab76138a4c23529c6c2070192405920"} 05:05:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:05:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:05:28 INFO - Contents: 05:05:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/86916446b9da2f772b5ca1688724124ca030f54d09949982966c4d2b30316135e834a566be797886188e2df953d6e00a9e5ab26ce98e7220edf2bc0ee050a1af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9a208cb7c5bd0f12c9c035c4f46d1f9f0e1963ad199e1155e735b5f8a24d4f795977e9c55a015361739c21bf3c68145036804d31619ff300b0da45a6a6af77b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4aa692c8f42fceffd487de752ea6f0603cefa017a9409830e40e7284412c72e483c9f0656be828bfc5aa3e5cd077bfc9ab76138a4c23529c6c2070192405920"} 05:05:28 INFO - Running post-run listener: copy_logs_to_upload_dir 05:05:28 INFO - Copying logs to upload dir... 05:05:28 INFO - mkdir: /builds/slave/test/build/upload/logs 05:05:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.350851 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-08-18 05:05:28.155612) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 05:05:28.158906) ========= 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.PtAyilHf8x/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.siJWOSPIPH/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/86916446b9da2f772b5ca1688724124ca030f54d09949982966c4d2b30316135e834a566be797886188e2df953d6e00a9e5ab26ce98e7220edf2bc0ee050a1af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9a208cb7c5bd0f12c9c035c4f46d1f9f0e1963ad199e1155e735b5f8a24d4f795977e9c55a015361739c21bf3c68145036804d31619ff300b0da45a6a6af77b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4aa692c8f42fceffd487de752ea6f0603cefa017a9409830e40e7284412c72e483c9f0656be828bfc5aa3e5cd077bfc9ab76138a4c23529c6c2070192405920"} build_url:https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/D6oeb6RrT5mCk0JcSemt7w/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/86916446b9da2f772b5ca1688724124ca030f54d09949982966c4d2b30316135e834a566be797886188e2df953d6e00a9e5ab26ce98e7220edf2bc0ee050a1af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c9a208cb7c5bd0f12c9c035c4f46d1f9f0e1963ad199e1155e735b5f8a24d4f795977e9c55a015361739c21bf3c68145036804d31619ff300b0da45a6a6af77b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4aa692c8f42fceffd487de752ea6f0603cefa017a9409830e40e7284412c72e483c9f0656be828bfc5aa3e5cd077bfc9ab76138a4c23529c6c2070192405920"}' ========= master_lag: 0.72 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 05:05:28.885461) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 05:05:28.885820) ========= 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.PtAyilHf8x/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.siJWOSPIPH/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.005386 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 05:05:28.915282) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 05:05:28.915991) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 05:05:28.916699) ========= ========= Total master_lag: 0.89 =========