builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0214 starttime: 1471895796.24 results: success (0) buildid: 20160822103614 builduid: b9c782d165b449e8b0df27e4faa74058 revision: 23e3bb6e8e935305529ebeb2bf3c7771c4e51491 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 12:56:36.239161) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 12:56:36.239616) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 12:56:36.239892) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 12:56:36.265139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 12:56:36.265543) ========= 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.NT2EQpWHkI/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.ynbDE3djf9/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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-22 12:56:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.4M=0.001s 2016-08-22 12:56:36 (15.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128582 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 12:56:36.417472) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 12:56:36.417889) ========= 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.NT2EQpWHkI/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.ynbDE3djf9/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.027247 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 12:56:36.466935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 12:56:36.467397) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 23e3bb6e8e935305529ebeb2bf3c7771c4e51491 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 23e3bb6e8e935305529ebeb2bf3c7771c4e51491 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NT2EQpWHkI/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.ynbDE3djf9/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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-22 12:56:36,577 truncating revision to first 12 chars 2016-08-22 12:56:36,577 Setting DEBUG logging. 2016-08-22 12:56:36,577 attempt 1/10 2016-08-22 12:56:36,577 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/23e3bb6e8e93?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 12:56:38,007 unpacking tar archive at: autoland-23e3bb6e8e93/testing/mozharness/ program finished with exit code 0 elapsedTime=1.716630 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 12:56:38.337496) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 12:56:38.337851) ========= script_repo_revision: 23e3bb6e8e935305529ebeb2bf3c7771c4e51491 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 12:56:38.338275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 12:56:38.341657) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 12:56:38.362795) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-22 12:56:38.363245) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NT2EQpWHkI/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.ynbDE3djf9/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 12:56:38 INFO - MultiFileLogger online at 20160822 12:56:38 in /builds/slave/test 12:56:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 12:56:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:56:38 INFO - {'append_to_log': False, 12:56:38 INFO - 'base_work_dir': '/builds/slave/test', 12:56:38 INFO - 'blob_upload_branch': 'Autoland', 12:56:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:56:38 INFO - 'branch': 'Autoland', 12:56:38 INFO - 'buildbot_json_path': 'buildprops.json', 12:56:38 INFO - 'config_files': ('talos/mac_config.py',), 12:56:38 INFO - 'default_actions': ('clobber', 12:56:38 INFO - 'read-buildbot-config', 12:56:38 INFO - 'download-and-extract', 12:56:38 INFO - 'populate-webroot', 12:56:38 INFO - 'create-virtualenv', 12:56:38 INFO - 'install', 12:56:38 INFO - 'run-tests'), 12:56:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:56:38 INFO - 'download_minidump_stackwalk': True, 12:56:38 INFO - 'download_symbols': 'ondemand', 12:56:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:56:38 INFO - 'tooltool.py': '/tools/tooltool.py', 12:56:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:56:38 INFO - '/tools/misc-python/virtualenv.py')}, 12:56:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:56:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:56:38 INFO - 'installer_path': 'installer.exe', 12:56:38 INFO - 'log_level': 'info', 12:56:38 INFO - 'log_name': 'talos', 12:56:38 INFO - 'log_to_console': True, 12:56:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:56:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:56:38 INFO - 'opt_config_files': (), 12:56:38 INFO - 'pip_index': False, 12:56:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:56:38 INFO - 'cmd': ('bash', 12:56:38 INFO - '-c', 12:56:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:56:38 INFO - 'enabled': True, 12:56:38 INFO - 'halt_on_failure': False, 12:56:38 INFO - 'name': 'check_screen_resolution'},), 12:56:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:56:38 INFO - 'cmd': ('bash', 12:56:38 INFO - '-c', 12:56:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:56:38 INFO - 'enabled': True, 12:56:38 INFO - 'halt_on_failure': False, 12:56:38 INFO - 'name': 'check_screen_resolution'},), 12:56:38 INFO - 'run_cmd_checks_enabled': True, 12:56:38 INFO - 'sps_profile': False, 12:56:38 INFO - 'sps_profile_interval': 0, 12:56:38 INFO - 'suite': 'dromaeojs', 12:56:38 INFO - 'system_bits': '32', 12:56:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:56:38 INFO - 'title': 't-yosemite-r7-0214', 12:56:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:56:38 INFO - 'use_talos_json': True, 12:56:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:56:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:56:38 INFO - 'work_dir': 'build'} 12:56:38 INFO - [mozharness: 2016-08-22 19:56:38.600849Z] Running clobber step. 12:56:38 INFO - Running pre-action listener: _resource_record_pre_action 12:56:38 INFO - Running main action method: clobber 12:56:38 INFO - rmtree: /builds/slave/test/build 12:56:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:56:40 INFO - Running post-action listener: _resource_record_post_action 12:56:40 INFO - [mozharness: 2016-08-22 19:56:40.738672Z] Finished clobber step (success) 12:56:40 INFO - [mozharness: 2016-08-22 19:56:40.738796Z] Running read-buildbot-config step. 12:56:40 INFO - Running pre-action listener: _resource_record_pre_action 12:56:40 INFO - Running main action method: read_buildbot_config 12:56:40 INFO - Using buildbot properties: 12:56:40 INFO - { 12:56:40 INFO - "project": "", 12:56:40 INFO - "product": "firefox", 12:56:40 INFO - "script_repo_revision": "production", 12:56:40 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 12:56:40 INFO - "repository": "", 12:56:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 12:56:40 INFO - "buildid": "20160822103614", 12:56:40 INFO - "pgo_build": "False", 12:56:40 INFO - "basedir": "/builds/slave/test", 12:56:40 INFO - "buildnumber": 184, 12:56:40 INFO - "slavename": "t-yosemite-r7-0214", 12:56:40 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:56:40 INFO - "platform": "yosemite_r7", 12:56:40 INFO - "scheduler": "tests-autoland-macosx64-talos", 12:56:40 INFO - "branch": "autoland", 12:56:40 INFO - "repo_path": "integration/autoland", 12:56:40 INFO - "revision": "23e3bb6e8e935305529ebeb2bf3c7771c4e51491", 12:56:40 INFO - "stage_platform": "macosx64", 12:56:40 INFO - "builduid": "b9c782d165b449e8b0df27e4faa74058", 12:56:40 INFO - "slavebuilddir": "test" 12:56:40 INFO - } 12:56:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 12:56:40 INFO - Running post-action listener: _resource_record_post_action 12:56:40 INFO - [mozharness: 2016-08-22 19:56:40.742122Z] Finished read-buildbot-config step (success) 12:56:40 INFO - [mozharness: 2016-08-22 19:56:40.742214Z] Running download-and-extract step. 12:56:40 INFO - Running pre-action listener: _resource_record_pre_action 12:56:40 INFO - Running main action method: download_and_extract 12:56:40 INFO - mkdir: /builds/slave/test/build/tests 12:56:40 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')]} 12:56:40 INFO - trying https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 12:56:40 INFO - Downloading https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/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 12:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/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 12:56:41 INFO - Downloaded 1199 bytes. 12:56:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 12:56:41 INFO - Using the following test package requirements: 12:56:41 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 12:56:41 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:56:41 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 12:56:41 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:56:41 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 12:56:41 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:56:41 INFO - u'jsshell-mac.zip'], 12:56:41 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:56:41 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 12:56:41 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 12:56:41 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:56:41 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 12:56:41 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:56:41 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 12:56:41 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:56:41 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 12:56:41 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 12:56:41 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 12:56:41 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:56:41 INFO - trying https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:56:41 INFO - Downloading https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/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 12:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/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 12:56:42 INFO - Downloaded 16352719 bytes. 12:56:42 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 12:56:49 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 12:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:56:49 INFO - trying https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 12:56:49 INFO - Downloading https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/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 12:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/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 12:56:50 INFO - Downloaded 16352719 bytes. 12:56:50 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 12:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:56:56 INFO - trying https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 12:56:56 INFO - Downloading https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/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 12:56:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/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 12:56:58 INFO - Downloaded 14413981 bytes. 12:56:58 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 12:56: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')]} 12:56:58 INFO - trying https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:56:58 INFO - Downloading https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 12:56:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/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 12:57:01 INFO - Downloaded 111467796 bytes. 12:57:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:57:01 INFO - mkdir: /builds/slave/test/properties 12:57:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:57:01 INFO - Writing to file /builds/slave/test/properties/build_url 12:57:01 INFO - Contents: 12:57:01 INFO - build_url:https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 12:57:02 INFO - Running post-action listener: _resource_record_post_action 12:57:02 INFO - Running post-action listener: set_extra_try_arguments 12:57:02 INFO - [mozharness: 2016-08-22 19:57:02.711227Z] Finished download-and-extract step (success) 12:57:02 INFO - [mozharness: 2016-08-22 19:57:02.711363Z] Running populate-webroot step. 12:57:02 INFO - Running pre-action listener: _resource_record_pre_action 12:57:02 INFO - Running main action method: populate_webroot 12:57:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:57:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:57:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:57:02 INFO - '--tppagecycles', 12:57:02 INFO - '7'], 12:57:02 INFO - 'tests': ['tsvgm']}}, 12:57:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:57:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:57:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:57:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:57:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:57:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:57:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:02 INFO - 'talos_options': ['--disable-e10s'], 12:57:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:57:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:57:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:02 INFO - 'talos_options': ['--disable-e10s'], 12:57:02 INFO - 'tests': ['damp', 'tps']}, 12:57:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:02 INFO - 'tests': ['damp', 'tps']}, 12:57:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:57:02 INFO - 'tests': ['dromaeo_dom']}, 12:57:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:57:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:57:02 INFO - 'tests': ['basic_compositor_video']}, 12:57:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:57:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:57:02 INFO - 'tests': ['a11yr', 12:57:02 INFO - 'ts_paint', 12:57:02 INFO - 'tpaint', 12:57:02 INFO - 'sessionrestore', 12:57:02 INFO - 'sessionrestore_no_auto_restore', 12:57:02 INFO - 'tabpaint']}, 12:57:02 INFO - 'other-e10s': {'tests': ['a11yr', 12:57:02 INFO - 'ts_paint', 12:57:02 INFO - 'tpaint', 12:57:02 INFO - 'sessionrestore', 12:57:02 INFO - 'sessionrestore_no_auto_restore', 12:57:02 INFO - 'tabpaint']}, 12:57:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:57:02 INFO - 'ts_paint', 12:57:02 INFO - 'tpaint', 12:57:02 INFO - 'sessionrestore', 12:57:02 INFO - 'sessionrestore_no_auto_restore', 12:57:02 INFO - 'tabpaint']}, 12:57:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:57:02 INFO - 'ts_paint', 12:57:02 INFO - 'tpaint', 12:57:02 INFO - 'sessionrestore', 12:57:02 INFO - 'sessionrestore_no_auto_restore', 12:57:02 INFO - 'tabpaint']}, 12:57:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:57:02 INFO - 'tests': ['a11yr', 12:57:02 INFO - 'ts_paint', 12:57:02 INFO - 'tpaint', 12:57:02 INFO - 'sessionrestore', 12:57:02 INFO - 'sessionrestore_no_auto_restore', 12:57:02 INFO - 'tabpaint']}, 12:57:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:57:02 INFO - 'tests': ['a11yr', 12:57:02 INFO - 'ts_paint', 12:57:02 INFO - 'tpaint', 12:57:02 INFO - 'sessionrestore', 12:57:02 INFO - 'sessionrestore_no_auto_restore', 12:57:02 INFO - 'tabpaint']}, 12:57:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:57:02 INFO - 'tests': ['tsvgx', 12:57:02 INFO - 'tsvgr_opacity', 12:57:02 INFO - 'tart', 12:57:02 INFO - 'tscrollx', 12:57:02 INFO - 'cart']}, 12:57:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:57:02 INFO - 'tsvgr_opacity', 12:57:02 INFO - 'tart', 12:57:02 INFO - 'tscrollx', 12:57:02 INFO - 'cart']}, 12:57:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:02 INFO - 'talos_options': ['--disable-e10s'], 12:57:02 INFO - 'tests': ['tp5o']}, 12:57:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:02 INFO - 'tests': ['tp5o']}, 12:57:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:02 INFO - 'talos_options': ['--disable-e10s', 12:57:02 INFO - '--xperf_path', 12:57:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:57:02 INFO - 'tests': ['tp5n']}, 12:57:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:57:02 INFO - 'talos_options': ['--xperf_path', 12:57:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:57:02 INFO - 'tests': ['tp5n']}}, 12:57:02 INFO - 'talos.zip': {'path': '', 12:57:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:57:02 INFO - Running post-action listener: _resource_record_post_action 12:57:02 INFO - [mozharness: 2016-08-22 19:57:02.730346Z] Finished populate-webroot step (success) 12:57:02 INFO - [mozharness: 2016-08-22 19:57:02.730460Z] Running create-virtualenv step. 12:57:02 INFO - Running pre-action listener: _resource_record_pre_action 12:57:02 INFO - Running main action method: create_virtualenv 12:57:02 INFO - Creating virtualenv /builds/slave/test/build/venv 12:57:02 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 12:57:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:57:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:57:02 INFO - Using real prefix '/tools/python27' 12:57:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:57:03 INFO - Installing distribute.............................................................................................................................................................................................done. 12:57:06 INFO - Installing pip.................done. 12:57:06 INFO - Return code: 0 12:57:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:06 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 0x104ee2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f77618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf0ca1cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e46d30>, '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 0x104babdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e3eb20>, '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.NT2EQpWHkI/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.ynbDE3djf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 12:57:06 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 12:57:06 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 12:57:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NT2EQpWHkI/Render', 12:57:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:06 INFO - 'HOME': '/Users/cltbld', 12:57:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:06 INFO - 'LOGNAME': 'cltbld', 12:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:06 INFO - 'MOZ_NO_REMOTE': '1', 12:57:06 INFO - 'NO_EM_RESTART': '1', 12:57:06 INFO - 'PAGER': '/bin/cat', 12:57:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:06 INFO - 'PWD': '/builds/slave/test', 12:57:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:06 INFO - 'SHELL': '/bin/bash', 12:57:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynbDE3djf9/Listeners', 12:57:06 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 12:57:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:06 INFO - 'USER': 'cltbld', 12:57:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:06 INFO - 'XPC_FLAGS': '0x0', 12:57:06 INFO - 'XPC_SERVICE_NAME': '0', 12:57:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:06 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 12:57:06 INFO - Cleaning up... 12:57:06 INFO - Return code: 0 12:57:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:06 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 0x104ee2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f77618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf0ca1cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e46d30>, '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 0x104babdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e3eb20>, '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.NT2EQpWHkI/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.ynbDE3djf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 12:57:06 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 12:57:06 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 12:57:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NT2EQpWHkI/Render', 12:57:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:06 INFO - 'HOME': '/Users/cltbld', 12:57:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:06 INFO - 'LOGNAME': 'cltbld', 12:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:06 INFO - 'MOZ_NO_REMOTE': '1', 12:57:06 INFO - 'NO_EM_RESTART': '1', 12:57:06 INFO - 'PAGER': '/bin/cat', 12:57:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:06 INFO - 'PWD': '/builds/slave/test', 12:57:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:06 INFO - 'SHELL': '/bin/bash', 12:57:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynbDE3djf9/Listeners', 12:57:06 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 12:57:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:06 INFO - 'USER': 'cltbld', 12:57:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:06 INFO - 'XPC_FLAGS': '0x0', 12:57:06 INFO - 'XPC_SERVICE_NAME': '0', 12:57:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:06 INFO - Downloading/unpacking psutil>=3.1.1 12:57:06 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 12:57:06 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 12:57:06 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 12:57:06 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 12:57:06 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 12:57:06 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 12:57:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:57:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:10 INFO - Installing collected packages: psutil 12:57:10 INFO - Running setup.py install for psutil 12:57:10 INFO - building 'psutil._psutil_osx' extension 12:57:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:57:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:57:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:57:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:57:11 INFO - building 'psutil._psutil_posix' extension 12:57:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:57:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:57:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:57:11 INFO - ^ 12:57:11 INFO - 1 warning generated. 12:57:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:57:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:11 INFO - Successfully installed psutil 12:57:11 INFO - Cleaning up... 12:57:11 INFO - Return code: 0 12:57:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ee2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f77618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf0ca1cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e46d30>, '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 0x104babdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e3eb20>, '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.NT2EQpWHkI/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.ynbDE3djf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 12:57:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:57:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NT2EQpWHkI/Render', 12:57:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:11 INFO - 'HOME': '/Users/cltbld', 12:57:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:11 INFO - 'LOGNAME': 'cltbld', 12:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:11 INFO - 'MOZ_NO_REMOTE': '1', 12:57:11 INFO - 'NO_EM_RESTART': '1', 12:57:11 INFO - 'PAGER': '/bin/cat', 12:57:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:11 INFO - 'PWD': '/builds/slave/test', 12:57:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:11 INFO - 'SHELL': '/bin/bash', 12:57:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynbDE3djf9/Listeners', 12:57:11 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 12:57:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:11 INFO - 'USER': 'cltbld', 12:57:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:11 INFO - 'XPC_FLAGS': '0x0', 12:57:11 INFO - 'XPC_SERVICE_NAME': '0', 12:57:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:57:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:57:14 INFO - Installing collected packages: mozsystemmonitor 12:57:14 INFO - Running setup.py install for mozsystemmonitor 12:57:14 INFO - Successfully installed mozsystemmonitor 12:57:14 INFO - Cleaning up... 12:57:14 INFO - Return code: 0 12:57:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ee2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f77618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf0ca1cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e46d30>, '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 0x104babdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e3eb20>, '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.NT2EQpWHkI/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.ynbDE3djf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 12:57:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:57:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NT2EQpWHkI/Render', 12:57:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:14 INFO - 'HOME': '/Users/cltbld', 12:57:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:14 INFO - 'LOGNAME': 'cltbld', 12:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:14 INFO - 'MOZ_NO_REMOTE': '1', 12:57:14 INFO - 'NO_EM_RESTART': '1', 12:57:14 INFO - 'PAGER': '/bin/cat', 12:57:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:14 INFO - 'PWD': '/builds/slave/test', 12:57:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:14 INFO - 'SHELL': '/bin/bash', 12:57:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynbDE3djf9/Listeners', 12:57:14 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 12:57:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:14 INFO - 'USER': 'cltbld', 12:57:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:14 INFO - 'XPC_FLAGS': '0x0', 12:57:14 INFO - 'XPC_SERVICE_NAME': '0', 12:57:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:14 INFO - Downloading/unpacking jsonschema==2.5.1 12:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:57:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:17 INFO - Downloading functools32-3.2.3-2.tar.gz 12:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:57:17 INFO - warning: no files found matching '*.txt' 12:57:17 INFO - no previously-included directories found matching 'build' 12:57:17 INFO - no previously-included directories found matching 'dist' 12:57:17 INFO - no previously-included directories found matching '.git*' 12:57:17 INFO - Installing collected packages: jsonschema, functools32 12:57:17 INFO - Running setup.py install for functools32 12:57:17 INFO - warning: no files found matching '*.txt' 12:57:17 INFO - no previously-included directories found matching 'build' 12:57:17 INFO - no previously-included directories found matching 'dist' 12:57:17 INFO - no previously-included directories found matching '.git*' 12:57:17 INFO - Successfully installed jsonschema functools32 12:57:17 INFO - Cleaning up... 12:57:17 INFO - Return code: 0 12:57:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104ee2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f77618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf0ca1cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e46d30>, '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 0x104babdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e3eb20>, '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.NT2EQpWHkI/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.ynbDE3djf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 12:57:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NT2EQpWHkI/Render', 12:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:17 INFO - 'HOME': '/Users/cltbld', 12:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:17 INFO - 'LOGNAME': 'cltbld', 12:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:17 INFO - 'MOZ_NO_REMOTE': '1', 12:57:17 INFO - 'NO_EM_RESTART': '1', 12:57:17 INFO - 'PAGER': '/bin/cat', 12:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:17 INFO - 'PWD': '/builds/slave/test', 12:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:17 INFO - 'SHELL': '/bin/bash', 12:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynbDE3djf9/Listeners', 12:57:17 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 12:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:17 INFO - 'USER': 'cltbld', 12:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:17 INFO - 'XPC_FLAGS': '0x0', 12:57:17 INFO - 'XPC_SERVICE_NAME': '0', 12:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:57:18 INFO - Cleaning up... 12:57:18 INFO - Return code: 0 12:57:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:57: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')]} 12:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ee2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f77618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf0ca1cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e46d30>, '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 0x104babdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e3eb20>, '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.NT2EQpWHkI/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.ynbDE3djf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 12:57:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:57:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:57:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NT2EQpWHkI/Render', 12:57:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:18 INFO - 'HOME': '/Users/cltbld', 12:57:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:18 INFO - 'LOGNAME': 'cltbld', 12:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:18 INFO - 'MOZ_NO_REMOTE': '1', 12:57:18 INFO - 'NO_EM_RESTART': '1', 12:57:18 INFO - 'PAGER': '/bin/cat', 12:57:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:18 INFO - 'PWD': '/builds/slave/test', 12:57:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:18 INFO - 'SHELL': '/bin/bash', 12:57:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynbDE3djf9/Listeners', 12:57:18 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 12:57:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:18 INFO - 'USER': 'cltbld', 12:57:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:18 INFO - 'XPC_FLAGS': '0x0', 12:57:18 INFO - 'XPC_SERVICE_NAME': '0', 12:57:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:18 INFO - Downloading/unpacking blobuploader==1.2.4 12:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:20 INFO - Downloading blobuploader-1.2.4.tar.gz 12:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:57:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:57:20 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 12:57:20 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 12:57:20 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 12:57:20 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 12:57:20 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 12:57:20 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 12:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:57:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:22 INFO - Downloading docopt-0.6.1.tar.gz 12:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:57:22 INFO - Installing collected packages: blobuploader, requests, docopt 12:57:22 INFO - Running setup.py install for blobuploader 12:57:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:57:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:57:22 INFO - Running setup.py install for requests 12:57:22 INFO - Running setup.py install for docopt 12:57:22 INFO - Successfully installed blobuploader requests docopt 12:57:22 INFO - Cleaning up... 12:57:23 INFO - Return code: 0 12:57:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ee2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f77618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf0ca1cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e46d30>, '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 0x104babdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e3eb20>, '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.NT2EQpWHkI/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.ynbDE3djf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 12:57:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:57:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:57:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NT2EQpWHkI/Render', 12:57:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:23 INFO - 'HOME': '/Users/cltbld', 12:57:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:23 INFO - 'LOGNAME': 'cltbld', 12:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:23 INFO - 'MOZ_NO_REMOTE': '1', 12:57:23 INFO - 'NO_EM_RESTART': '1', 12:57:23 INFO - 'PAGER': '/bin/cat', 12:57:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:23 INFO - 'PWD': '/builds/slave/test', 12:57:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:23 INFO - 'SHELL': '/bin/bash', 12:57:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynbDE3djf9/Listeners', 12:57:23 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 12:57:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:23 INFO - 'USER': 'cltbld', 12:57:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:23 INFO - 'XPC_FLAGS': '0x0', 12:57:23 INFO - 'XPC_SERVICE_NAME': '0', 12:57:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:23 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-x029yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:23 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-3SIcTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:23 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-wDDELE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:23 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Z8SNQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:23 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-jpjo6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:23 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-li2bjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:23 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-yrnz0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-lkN9jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-j6jL2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-isEscL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-uJ6dpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-QS9RVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-oF1Nr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-oyucUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-qZxc_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:24 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-zbbpPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:25 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-lQex_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:57:25 INFO - Running setup.py install for manifestparser 12:57:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:57:25 INFO - Running setup.py install for mozcrash 12:57:25 INFO - Running setup.py install for mozdebug 12:57:25 INFO - Running setup.py install for mozdevice 12:57:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:57:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:57:25 INFO - Running setup.py install for mozfile 12:57:25 INFO - Running setup.py install for mozhttpd 12:57:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:57:25 INFO - Running setup.py install for mozinfo 12:57:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:57:26 INFO - Running setup.py install for mozInstall 12:57:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:57:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:57:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:57:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:57:26 INFO - Running setup.py install for mozleak 12:57:26 INFO - Running setup.py install for mozlog 12:57:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:57:26 INFO - Running setup.py install for moznetwork 12:57:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:57:26 INFO - Running setup.py install for mozprocess 12:57:26 INFO - Running setup.py install for mozprofile 12:57:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:57:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:57:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:57:27 INFO - Running setup.py install for mozrunner 12:57:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:57:27 INFO - Running setup.py install for mozscreenshot 12:57:27 INFO - Running setup.py install for moztest 12:57:27 INFO - Running setup.py install for mozversion 12:57:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:57:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:57:27 INFO - Cleaning up... 12:57:27 INFO - Return code: 0 12:57:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ee2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f77618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf0ca1cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e46d30>, '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 0x104babdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e3eb20>, '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.NT2EQpWHkI/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.ynbDE3djf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 12:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NT2EQpWHkI/Render', 12:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:27 INFO - 'HOME': '/Users/cltbld', 12:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:27 INFO - 'LOGNAME': 'cltbld', 12:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:27 INFO - 'MOZ_NO_REMOTE': '1', 12:57:27 INFO - 'NO_EM_RESTART': '1', 12:57:27 INFO - 'PAGER': '/bin/cat', 12:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:27 INFO - 'PWD': '/builds/slave/test', 12:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:27 INFO - 'SHELL': '/bin/bash', 12:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynbDE3djf9/Listeners', 12:57:27 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 12:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:27 INFO - 'USER': 'cltbld', 12:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:27 INFO - 'XPC_FLAGS': '0x0', 12:57:27 INFO - 'XPC_SERVICE_NAME': '0', 12:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:57:27 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-EiGYeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:57:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-KKpXoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:57:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-K80UpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:57:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-rEPtkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:57:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-KMIhvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:57:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-N6s3JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:57:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-SKrfwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:57:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-eJWS1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:57:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-8fu1sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:57:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:57:28 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-qkCWk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:57:29 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)) 12:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:57:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-qLJ9YF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:57:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Gx0JYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:57:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-zZRsv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:57:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-yohWbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-Spb0bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:57:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-LFlwYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:57:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:57:29 INFO - Running setup.py (path:/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/pip-S0sxM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:57:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:32 INFO - Downloading blessings-1.6.tar.gz 12:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:57:32 INFO - Installing collected packages: blessings 12:57:32 INFO - Running setup.py install for blessings 12:57:32 INFO - Successfully installed blessings 12:57:32 INFO - Cleaning up... 12:57:32 INFO - Return code: 0 12:57:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:57:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:32 INFO - Reading from file tmpfile_stdout 12:57:32 INFO - Current package versions: 12:57:32 INFO - blessings == 1.6 12:57:32 INFO - blobuploader == 1.2.4 12:57:32 INFO - docopt == 0.6.1 12:57:32 INFO - functools32 == 3.2.3-2 12:57:32 INFO - jsonschema == 2.5.1 12:57:32 INFO - manifestparser == 1.1 12:57:32 INFO - mozInstall == 1.12 12:57:32 INFO - mozcrash == 0.17 12:57:32 INFO - mozdebug == 0.1 12:57:32 INFO - mozdevice == 0.48 12:57:32 INFO - mozfile == 1.2 12:57:32 INFO - mozhttpd == 0.7 12:57:32 INFO - mozinfo == 0.9 12:57:32 INFO - mozleak == 0.1 12:57:32 INFO - mozlog == 3.3 12:57:32 INFO - moznetwork == 0.27 12:57:32 INFO - mozprocess == 0.23 12:57:32 INFO - mozprofile == 0.28 12:57:32 INFO - mozrunner == 6.12 12:57:32 INFO - mozscreenshot == 0.1 12:57:32 INFO - mozsystemmonitor == 0.3 12:57:32 INFO - moztest == 0.7 12:57:32 INFO - mozversion == 1.4 12:57:32 INFO - psutil == 3.1.1 12:57:32 INFO - requests == 1.2.3 12:57:32 INFO - wsgiref == 0.1.2 12:57:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:33 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 0x104ee2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f77618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf0ca1cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e46d30>, '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 0x104babdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e3eb20>, '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.NT2EQpWHkI/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.ynbDE3djf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 12:57:33 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 12:57:33 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 12:57:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NT2EQpWHkI/Render', 12:57:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:33 INFO - 'HOME': '/Users/cltbld', 12:57:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:33 INFO - 'LOGNAME': 'cltbld', 12:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:33 INFO - 'MOZ_NO_REMOTE': '1', 12:57:33 INFO - 'NO_EM_RESTART': '1', 12:57:33 INFO - 'PAGER': '/bin/cat', 12:57:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:33 INFO - 'PWD': '/builds/slave/test', 12:57:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:33 INFO - 'SHELL': '/bin/bash', 12:57:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynbDE3djf9/Listeners', 12:57:33 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 12:57:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:33 INFO - 'USER': 'cltbld', 12:57:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:33 INFO - 'XPC_FLAGS': '0x0', 12:57:33 INFO - 'XPC_SERVICE_NAME': '0', 12:57:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:57:33 INFO - Cleaning up... 12:57:33 INFO - Return code: 0 12:57:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:57: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')]} 12:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ee2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f77618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fabf0ca1cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e46d30>, '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 0x104babdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e3eb20>, '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.NT2EQpWHkI/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.ynbDE3djf9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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 12:57:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:57:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NT2EQpWHkI/Render', 12:57:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:57:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:57:33 INFO - 'HOME': '/Users/cltbld', 12:57:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:57:33 INFO - 'LOGNAME': 'cltbld', 12:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:33 INFO - 'MOZ_NO_REMOTE': '1', 12:57:33 INFO - 'NO_EM_RESTART': '1', 12:57:33 INFO - 'PAGER': '/bin/cat', 12:57:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:57:33 INFO - 'PWD': '/builds/slave/test', 12:57:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:57:33 INFO - 'SHELL': '/bin/bash', 12:57:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynbDE3djf9/Listeners', 12:57:33 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 12:57:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:57:33 INFO - 'USER': 'cltbld', 12:57:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:57:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:33 INFO - 'XPC_FLAGS': '0x0', 12:57:33 INFO - 'XPC_SERVICE_NAME': '0', 12:57:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:57:33 INFO - Cleaning up... 12:57:33 INFO - Return code: 0 12:57:33 INFO - Running post-action listener: _resource_record_post_action 12:57:33 INFO - Running post-action listener: _start_resource_monitoring 12:57:33 INFO - Starting resource monitoring. 12:57:33 INFO - [mozharness: 2016-08-22 19:57:33.752922Z] Finished create-virtualenv step (success) 12:57:33 INFO - [mozharness: 2016-08-22 19:57:33.753901Z] Running install step. 12:57:33 INFO - Running pre-action listener: _resource_record_pre_action 12:57:33 INFO - Running main action method: install 12:57:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:57:34 INFO - Reading from file tmpfile_stdout 12:57:34 INFO - Detecting whether we're running mozinstall >=1.0... 12:57:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:57:34 INFO - Reading from file tmpfile_stdout 12:57:34 INFO - Output received: 12:57:34 INFO - Usage: mozinstall [options] installer 12:57:34 INFO - Options: 12:57:34 INFO - -h, --help show this help message and exit 12:57:34 INFO - -d DEST, --destination=DEST 12:57:34 INFO - Directory to install application into. [default: 12:57:34 INFO - "/builds/slave/test"] 12:57:34 INFO - --app=APP Application being installed. [default: firefox] 12:57:34 INFO - mkdir: /builds/slave/test/build/application 12:57:34 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'] 12:57:34 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 12:58:08 INFO - Reading from file tmpfile_stdout 12:58:08 INFO - Output received: 12:58:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:58:08 INFO - Running post-action listener: _resource_record_post_action 12:58:08 INFO - [mozharness: 2016-08-22 19:58:08.175888Z] Finished install step (success) 12:58:08 INFO - [mozharness: 2016-08-22 19:58:08.176025Z] Running run-tests step. 12:58:08 INFO - Running pre-action listener: _resource_record_pre_action 12:58:08 INFO - Running main action method: run_tests 12:58:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:58:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:58:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:58:08 INFO - 2016-08-22 12:58:08.190 screenresolution[1637:7349] starting screenresolution argv=screenresolution get 12:58:08 INFO - 2016-08-22 12:58:08.193 screenresolution[1637:7349] Display 0: 1600x1200x32@60 12:58:08 INFO - 2016-08-22 12:58:08.198 screenresolution[1638:7351] starting screenresolution argv=screenresolution list 12:58:08 INFO - Available Modes on Display 0 12:58:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:58:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:58:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:58:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:58:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:58:08 INFO - Intel Iris: 12:58:08 INFO - Chipset Model: Intel Iris 12:58:08 INFO - Type: GPU 12:58:08 INFO - Bus: Built-In 12:58:08 INFO - VRAM (Dynamic, Max): 1536 MB 12:58:08 INFO - Vendor: Intel (0x8086) 12:58:08 INFO - Device ID: 0x0a2e 12:58:08 INFO - Revision ID: 0x0009 12:58:08 INFO - Displays: 12:58:08 INFO - Display: 12:58:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:58:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:58:08 INFO - Display Serial Number: 1600x1200 60 12:58:08 INFO - Main Display: Yes 12:58:08 INFO - Mirror: Off 12:58:08 INFO - Online: Yes 12:58:08 INFO - Rotation: Supported 12:58:08 INFO - Return code: 0 12:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:58:08 INFO - Python 2.7.3 12:58:08 INFO - Return code: 0 12:58:08 INFO - grabbing minidump binary from tooltool 12:58: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')]} 12:58:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e46d30>, '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 0x104babdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e3eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:58:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:58:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:58:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:58:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:58:08 INFO - Return code: 0 12:58:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:58:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:58:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:58:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:58:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 12:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0214 --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 12:58:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NT2EQpWHkI/Render', 12:58:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:08 INFO - 'HOME': '/Users/cltbld', 12:58:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:08 INFO - 'LOGNAME': 'cltbld', 12:58:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:58:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:08 INFO - 'MOZ_NO_REMOTE': '1', 12:58:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:58:08 INFO - 'NO_EM_RESTART': '1', 12:58:08 INFO - 'PAGER': '/bin/cat', 12:58:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:08 INFO - 'PWD': '/builds/slave/test', 12:58:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:58:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:08 INFO - 'SHELL': '/bin/bash', 12:58:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ynbDE3djf9/Listeners', 12:58:08 INFO - 'TMPDIR': '/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/', 12:58:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:08 INFO - 'USER': 'cltbld', 12:58:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:08 INFO - 'XPC_FLAGS': '0x0', 12:58:08 INFO - 'XPC_SERVICE_NAME': '0', 12:58:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0214', '--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 12:58:08 INFO - mozversion application_buildid: 20160822103614 12:58:08 INFO - mozversion application_changeset: 23e3bb6e8e935305529ebeb2bf3c7771c4e51491 12:58:08 INFO - mozversion application_display_name: Nightly 12:58:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:58:08 INFO - mozversion application_name: Firefox 12:58:08 INFO - mozversion application_remotingname: firefox 12:58:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:58:08 INFO - mozversion application_vendor: Mozilla 12:58:08 INFO - mozversion application_version: 51.0a1 12:58:08 INFO - mozversion platform_buildid: 20160822103614 12:58:08 INFO - mozversion platform_changeset: 23e3bb6e8e935305529ebeb2bf3c7771c4e51491 12:58:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:58:08 INFO - mozversion platform_version: 51.0a1 12:58:08 INFO - using testdate: 1471895888 12:58:08 INFO - actual date: 1471895888 12:58:08 INFO - starting webserver on 'localhost:49270' 12:58:08 INFO - SUITE-START | Running 2 tests 12:58:08 INFO - TEST-START | dromaeo_css 12:58:08 INFO - operating with platform_type : mac_ 12:58:08 INFO - Initialising browser for dromaeo_css test... 12:58:08 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpPQNwHX/profile http://localhost:49270/getInfo.html) 12:58:11 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 12:58:11 INFO - PROCESS | 1648 | colorDepth:24 12:58:11 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 12:58:11 INFO - PROCESS | 1648 | __metrics 12:58:11 INFO - PROCESS | 1648 | 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" 12:58:11 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:58:11 INFO - TEST-INFO | 1648: exit 0 12:58:11 INFO - Browser initialized. 12:58:11 INFO - Running cycle 1/1 for dromaeo_css test... 12:58:11 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmpPQNwHX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:23 INFO - PROCESS | 1650 | RSS: Main: 228548608 12:58:23 INFO - PROCESS | 1650 | 12:59:14 INFO - PROCESS | 1650 | 1471895954637 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] 13:01:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 13:01:28 INFO - PROCESS | 1650 | RSS: Main: 347332608 13:01:28 INFO - PROCESS | 1650 | 13:04:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 13:04:32 INFO - PROCESS | 1650 | RSS: Main: 372035584 13:04:32 INFO - PROCESS | 1650 | 13:07:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 13:07:35 INFO - PROCESS | 1650 | RSS: Main: 347668480 13:07:35 INFO - PROCESS | 1650 | 13:10:37 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 13:10:38 INFO - PROCESS | 1650 | RSS: Main: 344391680 13:10:38 INFO - PROCESS | 1650 | 13:13:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 13:13:42 INFO - PROCESS | 1650 | RSS: Main: 332840960 13:13:42 INFO - PROCESS | 1650 | 13:16:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 13:16:46 INFO - PROCESS | 1650 | RSS: Main: 391806976 13:16:46 INFO - PROCESS | 1650 | 13:16:46 INFO - PROCESS | 1650 | __start_tp_report 13:16:46 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 13:16:46 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 13:16:46 INFO - PROCESS | 1650 | |i|pagename|runs| 13:16:46 INFO - PROCESS | 1650 | |0;dojo.html;3267.9836600816993;3320.236345640504;3337.883174088906;3340.665933406658;3368.8209126805605;5491.752871120799;5625.718714064295;5628.634138780986;5680.943190568093;5702.230198923144;5581.776728930848;5661.122526008455;5694.544436445085;5715.457031581993;5753.65478071316;4241.893952651193;5139.614528910347;5230.189320655286;5234.18870075139;5277.050130976423;5329.626926115174;5331.973340133313;5334.306540149775;5343.732813359316;5354.544863686572;4394;5033.270175824485;5213.556847667953;5256.8685782855355;5296.973515132419;5095.79616815327;5145.33110695611;5148.922766158511;5149.510796474329;5152.845414637567;5078.035173317058;5078.949210507922;5138.563222126124;5157.045946499872;5177.119889618773;5682.346530149044;5686.459786320293;5719.456651618089;5727.284089488814;5730.19777231188;6019.367966363557;6092.08618707193;6247.156633854463;6265.592736472115;6282.994720844688;6244.937550624481;6259.029850373199;6335.239771227436;6337.302896681362;6344.49244060474;5794.942050579524;5802.651840889475;5807.157962095514;5819.82540523785;5828.242328497268;6223.657698826608;6251.218597675291;6284.685765711696;6330.335314791881;6350.936490635035;5984.940150598525;6051.152838602599;6074.51403887688;6138.294096178907;6153.876922461525;6233.657148856766;6243.8126856194385;6266.154069200691;6267.592606480655;6283.874322513524;6131.693415329305;6145.600535965148;6176.042713379434;6212.1303017577575;6217.626942383471;5962.284525856839;6015.699215039231;6020.247469066367;6103.786367477206;6139.754409823557;4862.07620552094;4893.804247830047;4943.233798761198;4943.901121977612;4949.802007919715;4368.388425620416;4423.248047831877;4438.312061630452;4443.155800397914;4451.688381813242;5586.832395028075;5621.578381621394;5659.886802264014;5660.773569057274;5673.914891276634;6110.5722599418505;6179.3202747697715;6204.069389591597;6266.624002559861;6267.4986001119805;5646.858828529237;5651.321841378978;5655.321361436654;5670.234518339971;5674.631148975303;5407.324084489439;5416.485433883775;5422.43064478232;5424.674519528841;5425.321834770653;5272.499112584298;6246.750129994749;6248.218972628512;6270.529710271657;6344.048392741126;6202.906956395748;6260.467860231931;6303.873922521432;6316.84207894788;6325.557210995186;6311.96844015777;6319.58922670025;6333.841653958688;6334.262784956897;6334.524910631813;5952.523798096228;6115.755369785159;6157.415045570664;6157.4458298753325;6187.226596675416;5894.38108998549;6107.603005804608;6150.384961503813;6195.845103872439;6225.470834979077;5982.0727787193055;6057.697595017093;6059.151718759465;6059.484943779828;6073.848153796191;5849.239598852122;6019.441737261559;6048.546359023003;6051.848703782441;6075.787347442818;5805.709714514173;5808.041673123887;5884.676342801187;5950.583459157818;5971.283445986335;6120.204373431426;6134.38656134383;6147.354527774698;6148.4773794227995;6148.877022459616;5718.399568045295;5730.74211660468;5783.392743761844;5921.644701317935;5927.555433342603 13:16:46 INFO - PROCESS | 1650 | |1;ext.html;476.77829809138746;486.56938609330734;537.2451705353978;538.768329618264;554.0249161475801;30003.399932001346;30962.690373096262;39905.40141897874;39920.80237592873;39928.20143597126;41226.58773412265;41491.17017659645;41567.96080097999;41628.95927601811;41653.58346416535;9687.660931867385;9863.95068024659;9870.802583948316;9883.406995580252;9884.703458896245;8714.389992700513;8924.419912705653;8929.866052009225;8938.597763100675;8940.687075952343;11763.941180294087;12019.93990030053;12023.699407514838;12214.450349734283;12220.144589878711;11930.403479826018;12066.457009434596;12067.275963442178;12081.335526546036;12111.818322725167;11785.292882427082;11877.287362758176;11882.346470944181;11882.940585297105;11899.226550274205;39561.40657890134;39845.20309593821;39877.80061099705;39981.80009099936;40026.79986600077;3309.9172520687175;3501;3680.907977300562;3824.9235015299537;3929.1159489115007;30938.53592196119;31134.221644458845;31604.525932111035;31724.524132138038;32507;3229.8869539566235;3238.5951756030495;3243.1081452600724;3246.9188270293193;3248.382807266612;444999;447405;447893;448195;448248;55591.72204139034;55922.440775592535;55944.44055559474;56020.439795601524;56106;34838.12904677403;35445.75939842093;35473.82263088668;49221.75389123031;58750;16354.427595034354;16500.504984850235;16501.422450214184;16506;16539.007659540464;12715.491380344683;12840.03699722506;12841;12856.807147892789;12861.614151575468;16022.839771602368;16314.265858036417;18280.360187393377;18343.147938932707;18558.44324670262;7231.5299505531975;7519.872019197164;7715.421343399267;7952.602369881599;7968.203179681986;847.212092753745;929.4980710416435;935.3499317974079;962.4177372689562;1074.237291523012;26279.080232192166;27931.58102628462;28585;30131.945381911526;30423.391532169677;1013.159077965287;1023.5291765787821;1094.5238821112682;1101.5043230546287;1127.425013243252;13790.931045344709;15539.378424863105;15675.981061231212;15723.977941434;15976.281067351765;674942;680806;681327.59336203;681369;681759;49721.502784972414;50325.74837125864;50529.49470505248;52164.21753673698;57068.714656426455;1372.7323171981368;1400.0899415380084;1412.3291436567754;1414.5119933622884;1415.2238940130276;28829.423411532072;30216.366324369188;30899.0730278092;31619.20951976219;31730.365392692478;48590.757046214545;48895;49008;49083;49167.262491063375;573585;576330;745191;881728;885444;25236.747632524173;42437.78781106075;42550;42784;43039.35440968451;44072.33891491566;45173.64479065633;45563.93758967365;46046.53953460423;46086.539134609564;30367.696323036485;35209.119772005906;37139.442908356934;38276.6172338273;38432;37206.81396593;37448.438273426465;37935;38066.80966595149;38404;36296.09259768527;36617;36908.44637330389;37197.25605487821;38277;32374;33455.68067344278;33539.32921341608;33886.983390498324;33968.66031339754;20992.98434970328;25312.367190820376;25551.872240638677;25705.357366065997;25769.871150644125 13:16:46 INFO - PROCESS | 1650 | |2;jquery.html;350.7930321110544;365.7622545345526;372.6515707813193;379.25665695237336;402.9657479114275;13428.865711342884;15971.84028159718;21420;21634.026468808883;22093.226737064208;21682.34952951414;21865.781342186572;21939.451513712163;21952.45118872029;21970.90145492723;5881.67650779207;5956.7319470623925;6045.697715114248;6145.170401995718;6149.877002459948;6011.887800756852;6054.061620448838;6080.604760690563;6083.057126145454;6096.055111457731;5774.191613174138;6026.9095963560585;6053.031514957607;6094.8171554853425;6095.573309868311;5757.107648314518;6004.909926351108;6043.4560889519935;6050.727717252734;6055.939440605625;5175.120229560946;5188.558972487343;5236.7119808410525;5240.68555886648;5263.157894736823;26905.192844214704;27132.59301110485;27215.50314732689;27262.5910611341;27406.5889011663;2475.3811547113223;2493.5012997400413;2666.6666666666665;2717.660292463442;2963.037012970793;15290.923545382313;15661.608459788482;16011.199440027953;16078.356865725356;16516.50450486487;1544.9845501544953;1565.1861032263273;1568.6627375114406;1778.1731494854826;1855.7216417537343;113451.43274283658;119297;121815.3909230457;123434;123476.38261808723;10690.30513016667;10759.677209683721;11188.66434006981;11227;11399.145064120225;11753.88246117545;14001.789973150411;14017.948653851003;14032.298385080909;14084.929575352058;8402.051036013065;8712.39013269065;8733.432326898732;8888.066752990842;8913.24237439812;8835.33734969867;8837.425567338103;8841.60212790426;9012.63949442015;9016.909830901739;6678.4991125665765;6757.087793147961;6778.627175505395;6783.796486105425;6807.965960170168;1787.642471505704;1823.1157888424104;1825.5892424204712;1850.5651171974575;1866.8319851213455;958.9808203835884;961.927855410847;987.5161171026145;1018.0226982097122;1046.7278507588082;18354.724679129824;21574.08749818786;21858.562828743336;22907.19824806157;22961.655575166387;947.2469386837481;956.6077908057663;971.2327261463506;971.8007808399261;1000.309786247487;11660.475278612483;11913.04695624348;12300.645059163466;12345.259284442782;12361.62915112548;531837;551137.2443137759;556897;568289;571437.1428142916;71990;72256;81061.59469202616;99840;119669.80330196761;874.2350443362059;953.3326671329958;984.9803003939882;986.5708416838698;1010.6917390196061;21108.989292034465;21124.155033798477;21399.46501337479;21542.6768598468;21609.783902160776;56004.71997639986;56047.15929260983;57389.13916291176;57420.1386979204;57545;75371.62314188395;77792.61103694445;78779.60610197141;79451.20548794437;79574.80637790322;5499.285092937893;5616.747246374005;7672.194419585863;7874.89751434811;8386.622601982803;13248.602541923758;13392.531261405804;13464.394102265618;13674.247916364298;13680.521181758591;11665.650030499099;11765.235259708092;11808.822867657163;11966.760664786829;12003.339816310187;5257.421683614876;9200.159968006292;10209.642662506776;11564.95915367621;11758.941205293919;11783.469743861375;11978.221415607957;12132.696682583006;12167.817482737943;12186.451609677408;7878.448508604342;7975.72084977023;8221.342292616457;8335.49987000782;8371.83256334882;11397.772044559228;11645.301281923112;12047.939760301493;12079.456424460745;12090.395480225778 13:16:46 INFO - PROCESS | 1650 | |3;mootools.html;1511.3425659837967;1552.6584151486672;1718.2010365180188;1871.167330537911;1891.650044741723;8369.707060252893;8890.199882010618;8897.288216942638;8898;8908.8663670045;7786.961065194666;8013.559254241014;8444.535550544717;8660.826783464343;8670;2366.3965688749386;2408.4460574067975;2411.240459255329;2412.7225369082603;2414.034386245507;2366.7041619797524;2388.2715771689627;2405.530921470314;2408.6748288981025;2410.20463247128;2380.8928598213033;2388.152205966883;2390.34265576966;2408.9397765055837;2410.602250628653;2349.259983105316;2363.9645405318934;2381.5951288281035;2382.9642555361684;2388.534235824015;2353.988230058856;2366.822488313366;2372.991478621579;2374.014783864694;2377.6552399901916;8771.736847894574;8830.24942879856;8876.156765107304;8892.555372231363;8900.931888173396;5161.483851614846;5311.203319502067;5312.203169524563;5312.229726689647;5323.547498462635;3575.606683264839;3589.4974703541525;3642.071271825694;3658.5426821647293;3664.3404187246283;958.5159494455255;1070.3684825952726;1072.3030030480172;1083.3066837224183;1106.5076041161685;9735.65925192622;11459.427028648617;11475.655730328104;11491;11510.654680359603;4017.055991841915;4486.932696009562;4609.124266389443;4766.618670506351;4774.618030557547;9854.260930430246;9859.211263098934;9860.852087218698;9862.112409883002;9882.308238423386;5295.046891559557;5312.601554883322;5320.813771517978;5321.175217841163;5329.866753331198;3956.485656864589;4239.47006624172;4324.113556720865;4494.07871386365;4865.829695960624;3819.6180381962135;3822.522184726909;3951.8221680024467;3982.900427489336;3989.7207195496035;1154.96535103947;1232.1990706041145;1263.109507797001;1265.202922159034;1294.3981048812348;898.142274128219;926.6285896872666;928.4986107502008;933.1741408853214;975.302658599105;5487.835364939058;5634.830955071355;5736.713164341766;6071.451779796212;6101.450869421773;752.9322360987428;916.1571354354011;928.5914197752967;964.3346091197052;973.6640858903667;3911.0732942852574;4021.560113789466;4097.487814023247;4121.732087414309;4148.045949431647;10487.790244195226;10750.623728169476;10869.67390978272;10884.945575272073;10893.291936024134;10612.787744245226;10669.413182274895;10821.296615719953;10835.079018283377;10840.186985976083;7692.076950765832;8068.233517815916;8165.510069395856;8313.293370063491;8318.584070796436;5983;6053.848653783691;6071.423214794588;6142.508599312134;6209.751609935552;9890.950545247228;10138.290319677846;10178.745531361776;10184.236182286506;10191.694249172537;9874.160696340892;10046.995300469895;10154.644587439405;10349.27555071168;10409.219308552041;6917.827054323481;7134.108236470442;7376.151742549676;7594.962025189839;7610.048743907012;7881.527108373516;7953.085395179628;7965.4822436541435;7973.242541958504;8143.552104634302;7254.709811607477;7513.549187048795;7566.772996810105;7618.69525218985;7633.847323053619;7330.890036649348;7345.77962661121;7387.445941554298;7389.7413590524075;7456.4034877208605;7007.124109486314;7026.051483049723;7096.574205547684;7104.11198600175;7112.110986126734;4619.821945403901;4990.72551009698;5018.698878067327;5057.418396884258;5147.2279158126585;4148.875533733993;5006.148954677641;5115.6699258193885;5166.638335316492;5181.974090129676 13:16:46 INFO - PROCESS | 1650 | |4;prototype.html;294.18657412255106;299.71377334645416;308.3324602236159;309.12363449620324;311.3989999301349;4630.791614377361;5405.243265942766;5413.539849112825;5425.91861122083;5464.153056276274;4035.3341698619693;4327.826886924519;4935.259711043345;5120.667156634816;5311.865999060554;3976.3637817949134;4084.65280451162;4103.5280942691525;4125.2780763366445;4159.315477231711;3249.9675003250018;3648.726345524083;3990.8426556298637;4157.667386609064;4172.80927513055;3682.7606205596685;3840.639440489572;4039.596040395966;4068.4304197412384;4096.97951510242;3452.913677158066;3986.362182050858;3990.4812374391436;4016.819243134066;4025.939610905839;3438.8452519636426;3479.739019573542;3495.720342372604;3503.1767534629344;3511.7006707518126;4857.927131093036;5142.51146141116;5144.897102057937;5157.948420515821;5190.143626301656;3879.2931110311374;4553.704009239422;4583.518730533279;4637.25803871379;4652.95347046532;5610.607257491977;5639;5647.519960803336;5666.858328541778;5670.206171136044;3715.8229713594756;3849.711271654637;3856.2865869814173;3864.3816989281863;3877.631624995649;4953.6037117030555;5179.507946745053;5357.776522743057;5905.4980326672285;6018.007028840236;3217.613886333655;3892;3905.3946638271113;3909.257241124177;3931.5478719947;3502.7898326100517;3954.703397245218;3965.5439624442984;3980.5621381647998;3982.8406863725704;4044.211378781168;4184.560621134737;4428.180786554498;4582.816687332469;4605.792739326738;4230.598093181143;4514.645606318091;5329.973350133225;5639.774409023593;5647.37878833328;1145.5017067575632;1201.7716633839543;1304.7018216874271;1312.9934350328188;1340.5241139395569;739.8483310921248;808.5957021489255;834.2783492279256;858.1675774498726;898.4878619187132;4437.871300732975;4940.728259945666;5167.560757335594;5180.32655754757;5225.111731005738;5818.44724751148;5825.941740582624;5844.970775146097;5870.5010074144175;5895.204147440127;4411.492678341968;4522.570355816192;4969.186247019812;5121.61587880903;5188.169892817206;2982.835944023056;2997.355568552728;3001.4897467430587;3005.3170224674254;3010.554933631869;4725.64557658177;5629.577781666391;5840.240768700127;5886.115163991745;5947.791827286024;5846.532277417797;5856.707164641751;5861.794837180678;5897;5959.433853783884;5009.674371165863;5267.446918073624;5630;5917.408259174048;5917.964356237555;4843.733594652187;5380.704061276668;5630.74661640219;5724.942750572441;5809.257222833217;5559.27729395176;5594.776208951596;5596.580256480699;5608.298962629671;5650.745716442688;5007.24891266313;5815.244018277597;5892.558058145571;5897.321807992136;5900.321463031806;3443.810590417551;3542.982285088558;3829.636184562462;3928.508936382952;3962.5641179470813;5154.381474222967;5870.324912635102;5883.676397797991;5897.166841553025;5915.349311575637;5379.54273886724;5726.255586773693;5729.713514324184;5736.340320863154;5753.654780713171;4832.420109586872;5636.013697602985;5656.208130861765;5686.800961966312;5696.401877802771;5266.578673706018;5505.256790333254;5523.337199536081;5547.667139971453;5549.528290095387;4579.473360563577;4797.64017698681;5299.252796442816;5526.005319042611;5558.583106266965;4703.529647035269;5562.471565201299;5586.38549759518;5626.774929002794;5661.631993920382 13:16:46 INFO - PROCESS | 1650 | |5;yui.html;691.8858388365919;708.3412426443409;750.3397010630648;754.6717178027557;817.7219745286601;15022.173780442072;16049.91975040126;16070;16071.839281607181;16115.194240287983;13846.930765346184;14597.562073137822;14926.328315225814;14953.327100280487;15004.624884377896;829.3116713128089;833.8123922117536;835.1022650650544;836.4521238588734;838.3209600223807;672.3948446398232;696.8606278744246;828.3828547731948;861.1904809479101;865.2213008292524;889.3729920406098;890.0031964200105;890.9376343655947;891.4383938119008;893.9731808045769;887.1128871128872;887.1970866365917;889.7375274294099;889.8754174415619;890.5725251879135;490.4384479770678;565.5786439102853;647.5499527828161;668.204836244867;673.4679603113534;13663.590092297247;13665.726685466236;13714.794278085838;13805.447782088704;13829.51596694121;13682.726345473135;13924.721505569933;13973;13983.580492585239;14266.215358155298;12451.813222801666;12521.74956500874;12699.492020319176;13142.934285328607;13227.404766785517;4466.12910482456;4488.820447182109;4533.705309154927;4717.386739723848;4737.28940658904;121448;121816.39091804484;123790.38104809419;125020;125870;10885.455727213766;10945.343279403261;11037.83443248352;11082.833757493645;11241.437928103562;21393.67909481359;21431.357059288246;21439.356819295444;21444.785552144593;21466.785332146792;7851.646675899598;8042.517448953082;8108.2297181767635;8193.221643943816;8203.958980205061;4289.828406863753;4426.623736982328;4457.108578284357;4501.6848820582245;4567.360569520203;3279.672032796749;3453.671901169385;3548.840302186408;3571.321448924748;3587.838547265327;575.2291928815407;658.5127006015514;682.7405585877335;683.1938312790954;687.3367200651295;513.2737176894652;554.8002719021149;557.8995780759421;615.8645098078416;623.769205393998;7336.816579585553;8469.21367928279;9093.545322733837;9117.407368521024;9305.395149315273;514.920187370958;569.9484451187552;625.2590680044162;627.5575719118011;631.5475894940741;4320.200762858881;4461.308497182942;4467.2182368086105;4487.910241795146;4519.367288579601;163122;163333;164866;169044;171150.14424927795;143052;144999.55000450072;145445;149137;150671;117941;119142;122995.3850230761;124286;124898.37550812188;8620.13798620133;8685.218330350299;8699.56502174876;8747.606357714045;8895.955520222358;53615;54639.180412293055;64411;65923.01115483367;68453.65773171102;84380.57809710912;88613.55693221492;88931;89920.66705658314;91643.16713665823;11491.885081149081;11565;11598.710032248924;11637.650870473899;11912.642620721392;12131.090168237593;12164.148509604243;12210.938945305217;12383.69040773988;12773.87226127764;11339.262947908359;11371.488283027118;11642.592509262135;11981.101417393556;12363.443645035815;11728;11765.529378825093;11812.114091443003;11922.284662920252;12120.818187727367;11531.481083351102;11829.940850295694;11980.04159667207;12009.75980480368;12219.749280010226;9374.67188648394;9416;9718.757031073997;9924.503774811375;10032.64885728996;8215.774645087753;8501.489910605384;9427.292953028687;10007.09936105754;10040.899591003996 13:16:46 INFO - PROCESS | 1650 | __end_tp_report 13:16:46 INFO - PROCESS | 1650 | __start_cc_report 13:16:46 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1154 13:16:46 INFO - PROCESS | 1650 | __end_cc_report 13:16:46 INFO - PROCESS | 1650 | __startTimestamp1471897006040__endTimestamp 13:16:46 INFO - PROCESS | 1650 | 13:16:46 INFO - PROCESS | 1650 | ------- Summary: start ------- 13:16:46 INFO - PROCESS | 1650 | Number of tests: 6 13:16:46 INFO - PROCESS | 1650 | 13:16:46 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5704.17 Median:5884.68 stddev:649.40 (11.0%) stddev-sans-first:622.63 13:16:46 INFO - PROCESS | 1650 | Values: 3268.0 3320.2 3337.9 3340.7 3368.8 5491.8 5625.7 5628.6 5680.9 5702.2 5581.8 5661.1 5694.5 5715.5 5753.7 4241.9 5139.6 5230.2 5234.2 5277.1 5329.6 5332.0 5334.3 5343.7 5354.5 4394.0 5033.3 5213.6 5256.9 5297.0 5095.8 5145.3 5148.9 5149.5 5152.8 5078.0 5078.9 5138.6 5157.0 5177.1 5682.3 5686.5 5719.5 5727.3 5730.2 6019.4 6092.1 6247.2 6265.6 6283.0 6244.9 6259.0 6335.2 6337.3 6344.5 5794.9 5802.7 5807.2 5819.8 5828.2 6223.7 6251.2 6284.7 6330.3 6350.9 5984.9 6051.2 6074.5 6138.3 6153.9 6233.7 6243.8 6266.2 6267.6 6283.9 6131.7 6145.6 6176.0 6212.1 6217.6 5962.3 6015.7 6020.2 6103.8 6139.8 4862.1 4893.8 4943.2 4943.9 4949.8 4368.4 4423.2 4438.3 4443.2 4451.7 5586.8 5621.6 5659.9 5660.8 5673.9 6110.6 6179.3 6204.1 6266.6 6267.5 5646.9 5651.3 5655.3 5670.2 5674.6 5407.3 5416.5 5422.4 5424.7 5425.3 5272.5 6246.8 6248.2 6270.5 6344.0 6202.9 6260.5 6303.9 6316.8 6325.6 6312.0 6319.6 6333.8 6334.3 6334.5 5952.5 6115.8 6157.4 6157.4 6187.2 5894.4 6107.6 6150.4 6195.8 6225.5 5982.1 6057.7 6059.2 6059.5 6073.8 5849.2 6019.4 6048.5 6051.8 6075.8 5805.7 5808.0 5884.7 5950.6 5971.3 6120.2 6134.4 6147.4 6148.5 6148.9 5718.4 5730.7 5783.4 5921.6 5927.6 13:16:46 INFO - PROCESS | 1650 | 13:16:46 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:73796.22 Median:37168.35 stddev:171325.89 (460.9%) stddev-sans-first:171718.06 13:16:46 INFO - PROCESS | 1650 | Values: 476.8 486.6 537.2 538.8 554.0 30003.4 30962.7 39905.4 39920.8 39928.2 41226.6 41491.2 41568.0 41629.0 41653.6 9687.7 9864.0 9870.8 9883.4 9884.7 8714.4 8924.4 8929.9 8938.6 8940.7 11763.9 12019.9 12023.7 12214.5 12220.1 11930.4 12066.5 12067.3 12081.3 12111.8 11785.3 11877.3 11882.3 11882.9 11899.2 39561.4 39845.2 39877.8 39981.8 40026.8 3309.9 3501.0 3680.9 3824.9 3929.1 30938.5 31134.2 31604.5 31724.5 32507.0 3229.9 3238.6 3243.1 3246.9 3248.4 444999.0 447405.0 447893.0 448195.0 448248.0 55591.7 55922.4 55944.4 56020.4 56106.0 34838.1 35445.8 35473.8 49221.8 58750.0 16354.4 16500.5 16501.4 16506.0 16539.0 12715.5 12840.0 12841.0 12856.8 12861.6 16022.8 16314.3 18280.4 18343.1 18558.4 7231.5 7519.9 7715.4 7952.6 7968.2 847.2 929.5 935.3 962.4 1074.2 26279.1 27931.6 28585.0 30131.9 30423.4 1013.2 1023.5 1094.5 1101.5 1127.4 13790.9 15539.4 15676.0 15724.0 15976.3 674942.0 680806.0 681327.6 681369.0 681759.0 49721.5 50325.7 50529.5 52164.2 57068.7 1372.7 1400.1 1412.3 1414.5 1415.2 28829.4 30216.4 30899.1 31619.2 31730.4 48590.8 48895.0 49008.0 49083.0 49167.3 573585.0 576330.0 745191.0 881728.0 885444.0 25236.7 42437.8 42550.0 42784.0 43039.4 44072.3 45173.6 45563.9 46046.5 46086.5 30367.7 35209.1 37139.4 38276.6 38432.0 37206.8 37448.4 37935.0 38066.8 38404.0 36296.1 36617.0 36908.4 37197.3 38277.0 32374.0 33455.7 33539.3 33887.0 33968.7 20993.0 25312.4 25551.9 25705.4 25769.9 13:16:46 INFO - PROCESS | 1650 | 13:16:46 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:33359.64 Median:27334.59 stddev:92407.92 (338.1%) stddev-sans-first:92633.91 13:16:46 INFO - PROCESS | 1650 | Values: 350.8 365.8 372.7 379.3 403.0 13428.9 15971.8 21420.0 21634.0 22093.2 21682.3 21865.8 21939.5 21952.5 21970.9 5881.7 5956.7 6045.7 6145.2 6149.9 6011.9 6054.1 6080.6 6083.1 6096.1 5774.2 6026.9 6053.0 6094.8 6095.6 5757.1 6004.9 6043.5 6050.7 6055.9 5175.1 5188.6 5236.7 5240.7 5263.2 26905.2 27132.6 27215.5 27262.6 27406.6 2475.4 2493.5 2666.7 2717.7 2963.0 15290.9 15661.6 16011.2 16078.4 16516.5 1545.0 1565.2 1568.7 1778.2 1855.7 113451.4 119297.0 121815.4 123434.0 123476.4 10690.3 10759.7 11188.7 11227.0 11399.1 11753.9 14001.8 14017.9 14032.3 14084.9 8402.1 8712.4 8733.4 8888.1 8913.2 8835.3 8837.4 8841.6 9012.6 9016.9 6678.5 6757.1 6778.6 6783.8 6808.0 1787.6 1823.1 1825.6 1850.6 1866.8 959.0 961.9 987.5 1018.0 1046.7 18354.7 21574.1 21858.6 22907.2 22961.7 947.2 956.6 971.2 971.8 1000.3 11660.5 11913.0 12300.6 12345.3 12361.6 531837.0 551137.2 556897.0 568289.0 571437.1 71990.0 72256.0 81061.6 99840.0 119669.8 874.2 953.3 985.0 986.6 1010.7 21109.0 21124.2 21399.5 21542.7 21609.8 56004.7 56047.2 57389.1 57420.1 57545.0 75371.6 77792.6 78779.6 79451.2 79574.8 5499.3 5616.7 7672.2 7874.9 8386.6 13248.6 13392.5 13464.4 13674.2 13680.5 11665.7 11765.2 11808.8 11966.8 12003.3 5257.4 9200.2 10209.6 11565.0 11758.9 11783.5 11978.2 12132.7 12167.8 12186.5 7878.4 7975.7 8221.3 8335.5 8371.8 11397.8 11645.3 12047.9 12079.5 12090.4 13:16:46 INFO - PROCESS | 1650 | 13:16:46 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5690.23 Median:5038.06 stddev:3170.79 (62.9%) stddev-sans-first:3164.14 13:16:46 INFO - PROCESS | 1650 | Values: 1511.3 1552.7 1718.2 1871.2 1891.7 8369.7 8890.2 8897.3 8898.0 8908.9 7787.0 8013.6 8444.5 8660.8 8670.0 2366.4 2408.4 2411.2 2412.7 2414.0 2366.7 2388.3 2405.5 2408.7 2410.2 2380.9 2388.2 2390.3 2408.9 2410.6 2349.3 2364.0 2381.6 2383.0 2388.5 2354.0 2366.8 2373.0 2374.0 2377.7 8771.7 8830.2 8876.2 8892.6 8900.9 5161.5 5311.2 5312.2 5312.2 5323.5 3575.6 3589.5 3642.1 3658.5 3664.3 958.5 1070.4 1072.3 1083.3 1106.5 9735.7 11459.4 11475.7 11491.0 11510.7 4017.1 4486.9 4609.1 4766.6 4774.6 9854.3 9859.2 9860.9 9862.1 9882.3 5295.0 5312.6 5320.8 5321.2 5329.9 3956.5 4239.5 4324.1 4494.1 4865.8 3819.6 3822.5 3951.8 3982.9 3989.7 1155.0 1232.2 1263.1 1265.2 1294.4 898.1 926.6 928.5 933.2 975.3 5487.8 5634.8 5736.7 6071.5 6101.5 752.9 916.2 928.6 964.3 973.7 3911.1 4021.6 4097.5 4121.7 4148.0 10487.8 10750.6 10869.7 10884.9 10893.3 10612.8 10669.4 10821.3 10835.1 10840.2 7692.1 8068.2 8165.5 8313.3 8318.6 5983.0 6053.8 6071.4 6142.5 6209.8 9891.0 10138.3 10178.7 10184.2 10191.7 9874.2 10047.0 10154.6 10349.3 10409.2 6917.8 7134.1 7376.2 7595.0 7610.0 7881.5 7953.1 7965.5 7973.2 8143.6 7254.7 7513.5 7566.8 7618.7 7633.8 7330.9 7345.8 7387.4 7389.7 7456.4 7007.1 7026.1 7096.6 7104.1 7112.1 4619.8 4990.7 5018.7 5057.4 5147.2 4148.9 5006.1 5115.7 5166.6 5182.0 13:16:46 INFO - PROCESS | 1650 | 13:16:46 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4513.77 Median:5065.17 stddev:1403.84 (27.7%) stddev-sans-first:1371.58 13:16:46 INFO - PROCESS | 1650 | Values: 294.2 299.7 308.3 309.1 311.4 4630.8 5405.2 5413.5 5425.9 5464.2 4035.3 4327.8 4935.3 5120.7 5311.9 3976.4 4084.7 4103.5 4125.3 4159.3 3250.0 3648.7 3990.8 4157.7 4172.8 3682.8 3840.6 4039.6 4068.4 4097.0 3452.9 3986.4 3990.5 4016.8 4025.9 3438.8 3479.7 3495.7 3503.2 3511.7 4857.9 5142.5 5144.9 5157.9 5190.1 3879.3 4553.7 4583.5 4637.3 4653.0 5610.6 5639.0 5647.5 5666.9 5670.2 3715.8 3849.7 3856.3 3864.4 3877.6 4953.6 5179.5 5357.8 5905.5 6018.0 3217.6 3892.0 3905.4 3909.3 3931.5 3502.8 3954.7 3965.5 3980.6 3982.8 4044.2 4184.6 4428.2 4582.8 4605.8 4230.6 4514.6 5330.0 5639.8 5647.4 1145.5 1201.8 1304.7 1313.0 1340.5 739.8 808.6 834.3 858.2 898.5 4437.9 4940.7 5167.6 5180.3 5225.1 5818.4 5825.9 5845.0 5870.5 5895.2 4411.5 4522.6 4969.2 5121.6 5188.2 2982.8 2997.4 3001.5 3005.3 3010.6 4725.6 5629.6 5840.2 5886.1 5947.8 5846.5 5856.7 5861.8 5897.0 5959.4 5009.7 5267.4 5630.0 5917.4 5918.0 4843.7 5380.7 5630.7 5724.9 5809.3 5559.3 5594.8 5596.6 5608.3 5650.7 5007.2 5815.2 5892.6 5897.3 5900.3 3443.8 3543.0 3829.6 3928.5 3962.6 5154.4 5870.3 5883.7 5897.2 5915.3 5379.5 5726.3 5729.7 5736.3 5753.7 4832.4 5636.0 5656.2 5686.8 5696.4 5266.6 5505.3 5523.3 5547.7 5549.5 4579.5 4797.6 5299.3 5526.0 5558.6 4703.5 5562.5 5586.4 5626.8 5661.6 13:16:46 INFO - PROCESS | 1650 | 13:16:46 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:26096.81 Median:4441.87 stddev:43984.84 (990.2%) stddev-sans-first:44066.86 13:16:46 INFO - PROCESS | 1650 | Values: 691.9 708.3 750.3 754.7 817.7 15022.2 16049.9 16070.0 16071.8 16115.2 13846.9 14597.6 14926.3 14953.3 15004.6 829.3 833.8 835.1 836.5 838.3 672.4 696.9 828.4 861.2 865.2 889.4 890.0 890.9 891.4 894.0 887.1 887.2 889.7 889.9 890.6 490.4 565.6 647.5 668.2 673.5 13663.6 13665.7 13714.8 13805.4 13829.5 13682.7 13924.7 13973.0 13983.6 14266.2 12451.8 12521.7 12699.5 13142.9 13227.4 4466.1 4488.8 4533.7 4717.4 4737.3 121448.0 121816.4 123790.4 125020.0 125870.0 10885.5 10945.3 11037.8 11082.8 11241.4 21393.7 21431.4 21439.4 21444.8 21466.8 7851.6 8042.5 8108.2 8193.2 8204.0 4289.8 4426.6 4457.1 4501.7 4567.4 3279.7 3453.7 3548.8 3571.3 3587.8 575.2 658.5 682.7 683.2 687.3 513.3 554.8 557.9 615.9 623.8 7336.8 8469.2 9093.5 9117.4 9305.4 514.9 569.9 625.3 627.6 631.5 4320.2 4461.3 4467.2 4487.9 4519.4 163122.0 163333.0 164866.0 169044.0 171150.1 143052.0 144999.6 145445.0 149137.0 150671.0 117941.0 119142.0 122995.4 124286.0 124898.4 8620.1 8685.2 8699.6 8747.6 8896.0 53615.0 54639.2 64411.0 65923.0 68453.7 84380.6 88613.6 88931.0 89920.7 91643.2 11491.9 11565.0 11598.7 11637.7 11912.6 12131.1 12164.1 12210.9 12383.7 12773.9 11339.3 11371.5 11642.6 11981.1 12363.4 11728.0 11765.5 11812.1 11922.3 12120.8 11531.5 11829.9 11980.0 12009.8 12219.7 9374.7 9416.0 9718.8 9924.5 10032.6 8215.8 8501.5 9427.3 10007.1 10040.9 13:16:46 INFO - PROCESS | 1650 | -------- Summary: end -------- 13:16:46 INFO - PROCESS | 1650 | 13:16:46 INFO - TEST-INFO | 1650: exit 0 13:16:46 INFO - TEST-OK | dromaeo_css | took 1117860ms 13:16:46 INFO - TEST-START | kraken 13:16:46 INFO - operating with platform_type : mac_ 13:16:46 INFO - Initialising browser for kraken test... 13:16:46 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmp27ilDe/profile http://localhost:49270/getInfo.html) 13:16:48 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 13:16:48 INFO - PROCESS | 1659 | colorDepth:24 13:16:48 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 13:16:48 INFO - PROCESS | 1659 | __metrics 13:16:49 INFO - PROCESS | 1659 | 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" 13:16:49 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:16:49 INFO - TEST-INFO | 1659: exit 0 13:16:49 INFO - Browser initialized. 13:16:49 INFO - Running cycle 1/1 for kraken test... 13:16:49 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/T/tmp27ilDe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:01 INFO - PROCESS | 1660 | RSS: Main: 228454400 13:17:01 INFO - PROCESS | 1660 | 13:17:04 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 13:17:05 INFO - PROCESS | 1660 | RSS: Main: 293498880 13:17:05 INFO - PROCESS | 1660 | 13:17:07 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 13:17:08 INFO - PROCESS | 1660 | RSS: Main: 294637568 13:17:08 INFO - PROCESS | 1660 | 13:17:11 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 13:17:12 INFO - PROCESS | 1660 | RSS: Main: 380215296 13:17:12 INFO - PROCESS | 1660 | 13:17:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 13:17:15 INFO - PROCESS | 1660 | RSS: Main: 282013696 13:17:15 INFO - PROCESS | 1660 | 13:17:17 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:17:17 INFO - PROCESS | 1660 | RSS: Main: 286183424 13:17:17 INFO - PROCESS | 1660 | 13:17:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 13:17:21 INFO - PROCESS | 1660 | RSS: Main: 324485120 13:17:21 INFO - PROCESS | 1660 | 13:17:24 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 13:17:24 INFO - PROCESS | 1660 | RSS: Main: 324427776 13:17:24 INFO - PROCESS | 1660 | 13:17:27 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 13:17:28 INFO - PROCESS | 1660 | RSS: Main: 324415488 13:17:28 INFO - PROCESS | 1660 | 13:17:30 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:17:30 INFO - PROCESS | 1660 | RSS: Main: 302075904 13:17:30 INFO - PROCESS | 1660 | 13:17:32 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:17:33 INFO - PROCESS | 1660 | RSS: Main: 303271936 13:17:33 INFO - PROCESS | 1660 | 13:17:35 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:17:36 INFO - PROCESS | 1660 | RSS: Main: 308363264 13:17:36 INFO - PROCESS | 1660 | 13:17:39 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:17:39 INFO - PROCESS | 1660 | RSS: Main: 316940288 13:17:39 INFO - PROCESS | 1660 | 13:17:43 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:17:43 INFO - PROCESS | 1660 | RSS: Main: 319471616 13:17:43 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 13:17:45 INFO - PROCESS | 1660 | RSS: Main: 362835968 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | __start_tp_report 13:17:45 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 13:17:45 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 13:17:45 INFO - PROCESS | 1660 | |i|pagename|runs| 13:17:45 INFO - PROCESS | 1660 | |0;ai-astar;97;112;105;113;113;111;114;112;111;112 13:17:45 INFO - PROCESS | 1660 | |1;audio-beat-detection;148;114;131;162;100;131;130;107;158;108 13:17:45 INFO - PROCESS | 1660 | |2;audio-dft;184;182;180;183;185;183;179;183;182;182 13:17:45 INFO - PROCESS | 1660 | |3;audio-fft;74;75;104;101;50;51;84;111;114;80 13:17:45 INFO - PROCESS | 1660 | |4;audio-oscillator;84;87;136;70;72;78;120;71;69;122 13:17:45 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;89;85;89;86;88;86;89;87;89;84 13:17:45 INFO - PROCESS | 1660 | |6;imaging-darkroom;93;93;94;102;93;93;93;95;93;94 13:17:45 INFO - PROCESS | 1660 | |7;imaging-desaturate;92;132;133;84;87;84;105;136;141;84 13:17:45 INFO - PROCESS | 1660 | |8;json-parse-financial;55;53;56;56;54;56;54;55;54;54 13:17:45 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;64;65;75;82;74;74;70;70;70;71 13:17:45 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;86;87;86;89;87;87;90;85;104;77 13:17:45 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;141;138;140;138;138;137;142;158;183;143 13:17:45 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;197;237;183;169;170;169;175;232;208;169 13:17:45 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;69;67;68;67;67;66;66;75;77;81 13:17:45 INFO - PROCESS | 1660 | __end_tp_report 13:17:45 INFO - PROCESS | 1660 | __start_cc_report 13:17:45 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,2214 13:17:45 INFO - PROCESS | 1660 | __end_cc_report 13:17:45 INFO - PROCESS | 1660 | __startTimestamp1471897065748__endTimestamp 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | ------- Summary: start ------- 13:17:45 INFO - PROCESS | 1660 | Number of tests: 14 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:110.00 Median:112.50 stddev:5.19 (4.6%) stddev-sans-first:2.60 13:17:45 INFO - PROCESS | 1660 | Values: 97.0 112.0 105.0 113.0 113.0 111.0 114.0 112.0 111.0 112.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:131.00 stddev:21.83 (16.7%) stddev-sans-first:22.04 13:17:45 INFO - PROCESS | 1660 | Values: 148.0 114.0 131.0 162.0 100.0 131.0 130.0 107.0 158.0 108.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:182.30 Median:183.00 stddev:1.77 (1.0%) stddev-sans-first:1.76 13:17:45 INFO - PROCESS | 1660 | Values: 184.0 182.0 180.0 183.0 185.0 183.0 179.0 183.0 182.0 182.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:84.40 Median:62.50 stddev:22.99 (36.8%) stddev-sans-first:24.08 13:17:45 INFO - PROCESS | 1660 | Values: 74.0 75.0 104.0 101.0 50.0 51.0 84.0 111.0 114.0 80.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:71.50 stddev:25.27 (35.3%) stddev-sans-first:26.68 13:17:45 INFO - PROCESS | 1660 | Values: 84.0 87.0 136.0 70.0 72.0 78.0 120.0 71.0 69.0 122.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.50 stddev:1.87 (2.1%) stddev-sans-first:1.87 13:17:45 INFO - PROCESS | 1660 | Values: 89.0 85.0 89.0 86.0 88.0 86.0 89.0 87.0 89.0 84.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:93.00 stddev:2.79 (3.0%) stddev-sans-first:2.92 13:17:45 INFO - PROCESS | 1660 | Values: 93.0 93.0 94.0 102.0 93.0 93.0 93.0 95.0 93.0 94.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:107.80 Median:84.00 stddev:24.74 (29.4%) stddev-sans-first:25.57 13:17:45 INFO - PROCESS | 1660 | Values: 92.0 132.0 133.0 84.0 87.0 84.0 105.0 136.0 141.0 84.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.12 13:17:45 INFO - PROCESS | 1660 | Values: 55.0 53.0 56.0 56.0 54.0 56.0 54.0 55.0 54.0 54.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.50 stddev:5.17 (7.1%) stddev-sans-first:4.72 13:17:45 INFO - PROCESS | 1660 | Values: 64.0 65.0 75.0 82.0 74.0 74.0 70.0 70.0 70.0 71.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.00 stddev:6.68 (7.7%) stddev-sans-first:7.05 13:17:45 INFO - PROCESS | 1660 | Values: 86.0 87.0 86.0 89.0 87.0 87.0 90.0 85.0 104.0 77.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:145.80 Median:141.50 stddev:14.42 (10.2%) stddev-sans-first:15.19 13:17:45 INFO - PROCESS | 1660 | Values: 141.0 138.0 140.0 138.0 138.0 137.0 142.0 158.0 183.0 143.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.90 Median:190.00 stddev:26.53 (14.0%) stddev-sans-first:28.05 13:17:45 INFO - PROCESS | 1660 | Values: 197.0 237.0 183.0 169.0 170.0 169.0 175.0 232.0 208.0 169.0 13:17:45 INFO - PROCESS | 1660 | 13:17:45 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:68.50 stddev:5.36 (7.8%) stddev-sans-first:5.66 13:17:45 INFO - PROCESS | 1660 | Values: 69.0 67.0 68.0 67.0 67.0 66.0 66.0 75.0 77.0 81.0 13:17:45 INFO - PROCESS | 1660 | -------- Summary: end -------- 13:17:45 INFO - PROCESS | 1660 | 13:17:46 INFO - TEST-INFO | 1660: exit 0 13:17:46 INFO - TEST-OK | kraken | took 59942ms 13:17:46 INFO - SUITE-END | took 1177s 13:17:46 INFO - Completed test suite (00:19:38) 13:17:46 INFO - javascript benchmark 13:17:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3267.9836600816993, 3320.236345640504, 3337.883174088906, 3340.665933406658, 3368.8209126805605, 5491.752871120799, 5625.718714064295, 5628.634138780986, 5680.943190568093, 5702.230198923144, 5581.776728930848, 5661.122526008455, 5694.544436445085, 5715.457031581993, 5753.65478071316, 4241.893952651193, 5139.614528910347, 5230.189320655286, 5234.18870075139, 5277.050130976423, 5329.626926115174, 5331.973340133313, 5334.306540149775, 5343.732813359316, 5354.544863686572, 4394.0, 5033.270175824485, 5213.556847667953, 5256.8685782855355, 5296.973515132419, 5095.79616815327, 5145.33110695611, 5148.922766158511, 5149.510796474329, 5152.845414637567, 5078.035173317058, 5078.949210507922, 5138.563222126124, 5157.045946499872, 5177.119889618773, 5682.346530149044, 5686.459786320293, 5719.456651618089, 5727.284089488814, 5730.19777231188, 6019.367966363557, 6092.08618707193, 6247.156633854463, 6265.592736472115, 6282.994720844688, 6244.937550624481, 6259.029850373199, 6335.239771227436, 6337.302896681362, 6344.49244060474, 5794.942050579524, 5802.651840889475, 5807.157962095514, 5819.82540523785, 5828.242328497268, 6223.657698826608, 6251.218597675291, 6284.685765711696, 6330.335314791881, 6350.936490635035, 5984.940150598525, 6051.152838602599, 6074.51403887688, 6138.294096178907, 6153.876922461525, 6233.657148856766, 6243.8126856194385, 6266.154069200691, 6267.592606480655, 6283.874322513524, 6131.693415329305, 6145.600535965148, 6176.042713379434, 6212.1303017577575, 6217.626942383471, 5962.284525856839, 6015.699215039231, 6020.247469066367, 6103.786367477206, 6139.754409823557, 4862.07620552094, 4893.804247830047, 4943.233798761198, 4943.901121977612, 4949.802007919715, 4368.388425620416, 4423.248047831877, 4438.312061630452, 4443.155800397914, 4451.688381813242, 5586.832395028075, 5621.578381621394, 5659.886802264014, 5660.773569057274, 5673.914891276634, 6110.5722599418505, 6179.3202747697715, 6204.069389591597, 6266.624002559861, 6267.4986001119805, 5646.858828529237, 5651.321841378978, 5655.321361436654, 5670.234518339971, 5674.631148975303, 5407.324084489439, 5416.485433883775, 5422.43064478232, 5424.674519528841, 5425.321834770653, 5272.499112584298, 6246.750129994749, 6248.218972628512, 6270.529710271657, 6344.048392741126, 6202.906956395748, 6260.467860231931, 6303.873922521432, 6316.84207894788, 6325.557210995186, 6311.96844015777, 6319.58922670025, 6333.841653958688, 6334.262784956897, 6334.524910631813, 5952.523798096228, 6115.755369785159, 6157.415045570664, 6157.4458298753325, 6187.226596675416, 5894.38108998549, 6107.603005804608, 6150.384961503813, 6195.845103872439, 6225.470834979077, 5982.0727787193055, 6057.697595017093, 6059.151718759465, 6059.484943779828, 6073.848153796191, 5849.239598852122, 6019.441737261559, 6048.546359023003, 6051.848703782441, 6075.787347442818, 5805.709714514173, 5808.041673123887, 5884.676342801187, 5950.583459157818, 5971.283445986335, 6120.204373431426, 6134.38656134383, 6147.354527774698, 6148.4773794227995, 6148.877022459616, 5718.399568045295, 5730.74211660468, 5783.392743761844, 5921.644701317935, 5927.555433342603], "value": 5662.038554873204, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.77829809138746, 486.56938609330734, 537.2451705353978, 538.768329618264, 554.0249161475801, 30003.399932001346, 30962.690373096262, 39905.40141897874, 39920.80237592873, 39928.20143597126, 41226.58773412265, 41491.17017659645, 41567.96080097999, 41628.95927601811, 41653.58346416535, 9687.660931867385, 9863.95068024659, 9870.802583948316, 9883.406995580252, 9884.703458896245, 8714.389992700513, 8924.419912705653, 8929.866052009225, 8938.597763100675, 8940.687075952343, 11763.941180294087, 12019.93990030053, 12023.699407514838, 12214.450349734283, 12220.144589878711, 11930.403479826018, 12066.457009434596, 12067.275963442178, 12081.335526546036, 12111.818322725167, 11785.292882427082, 11877.287362758176, 11882.346470944181, 11882.940585297105, 11899.226550274205, 39561.40657890134, 39845.20309593821, 39877.80061099705, 39981.80009099936, 40026.79986600077, 3309.9172520687175, 3501.0, 3680.907977300562, 3824.9235015299537, 3929.1159489115007, 30938.53592196119, 31134.221644458845, 31604.525932111035, 31724.524132138038, 32507.0, 3229.8869539566235, 3238.5951756030495, 3243.1081452600724, 3246.9188270293193, 3248.382807266612, 444999.0, 447405.0, 447893.0, 448195.0, 448248.0, 55591.72204139034, 55922.440775592535, 55944.44055559474, 56020.439795601524, 56106.0, 34838.12904677403, 35445.75939842093, 35473.82263088668, 49221.75389123031, 58750.0, 16354.427595034354, 16500.504984850235, 16501.422450214184, 16506.0, 16539.007659540464, 12715.491380344683, 12840.03699722506, 12841.0, 12856.807147892789, 12861.614151575468, 16022.839771602368, 16314.265858036417, 18280.360187393377, 18343.147938932707, 18558.44324670262, 7231.5299505531975, 7519.872019197164, 7715.421343399267, 7952.602369881599, 7968.203179681986, 847.212092753745, 929.4980710416435, 935.3499317974079, 962.4177372689562, 1074.237291523012, 26279.080232192166, 27931.58102628462, 28585.0, 30131.945381911526, 30423.391532169677, 1013.159077965287, 1023.5291765787821, 1094.5238821112682, 1101.5043230546287, 1127.425013243252, 13790.931045344709, 15539.378424863105, 15675.981061231212, 15723.977941434, 15976.281067351765, 674942.0, 680806.0, 681327.59336203, 681369.0, 681759.0, 49721.502784972414, 50325.74837125864, 50529.49470505248, 52164.21753673698, 57068.714656426455, 1372.7323171981368, 1400.0899415380084, 1412.3291436567754, 1414.5119933622884, 1415.2238940130276, 28829.423411532072, 30216.366324369188, 30899.0730278092, 31619.20951976219, 31730.365392692478, 48590.757046214545, 48895.0, 49008.0, 49083.0, 49167.262491063375, 573585.0, 576330.0, 745191.0, 881728.0, 885444.0, 25236.747632524173, 42437.78781106075, 42550.0, 42784.0, 43039.35440968451, 44072.33891491566, 45173.64479065633, 45563.93758967365, 46046.53953460423, 46086.539134609564, 30367.696323036485, 35209.119772005906, 37139.442908356934, 38276.6172338273, 38432.0, 37206.81396593, 37448.438273426465, 37935.0, 38066.80966595149, 38404.0, 36296.09259768527, 36617.0, 36908.44637330389, 37197.25605487821, 38277.0, 32374.0, 33455.68067344278, 33539.32921341608, 33886.983390498324, 33968.66031339754, 20992.98434970328, 25312.367190820376, 25551.872240638677, 25705.357366065997, 25769.871150644125], "value": 20186.47498778642, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.7930321110544, 365.7622545345526, 372.6515707813193, 379.25665695237336, 402.9657479114275, 13428.865711342884, 15971.84028159718, 21420.0, 21634.026468808883, 22093.226737064208, 21682.34952951414, 21865.781342186572, 21939.451513712163, 21952.45118872029, 21970.90145492723, 5881.67650779207, 5956.7319470623925, 6045.697715114248, 6145.170401995718, 6149.877002459948, 6011.887800756852, 6054.061620448838, 6080.604760690563, 6083.057126145454, 6096.055111457731, 5774.191613174138, 6026.9095963560585, 6053.031514957607, 6094.8171554853425, 6095.573309868311, 5757.107648314518, 6004.909926351108, 6043.4560889519935, 6050.727717252734, 6055.939440605625, 5175.120229560946, 5188.558972487343, 5236.7119808410525, 5240.68555886648, 5263.157894736823, 26905.192844214704, 27132.59301110485, 27215.50314732689, 27262.5910611341, 27406.5889011663, 2475.3811547113223, 2493.5012997400413, 2666.6666666666665, 2717.660292463442, 2963.037012970793, 15290.923545382313, 15661.608459788482, 16011.199440027953, 16078.356865725356, 16516.50450486487, 1544.9845501544953, 1565.1861032263273, 1568.6627375114406, 1778.1731494854826, 1855.7216417537343, 113451.43274283658, 119297.0, 121815.3909230457, 123434.0, 123476.38261808723, 10690.30513016667, 10759.677209683721, 11188.66434006981, 11227.0, 11399.145064120225, 11753.88246117545, 14001.789973150411, 14017.948653851003, 14032.298385080909, 14084.929575352058, 8402.051036013065, 8712.39013269065, 8733.432326898732, 8888.066752990842, 8913.24237439812, 8835.33734969867, 8837.425567338103, 8841.60212790426, 9012.63949442015, 9016.909830901739, 6678.4991125665765, 6757.087793147961, 6778.627175505395, 6783.796486105425, 6807.965960170168, 1787.642471505704, 1823.1157888424104, 1825.5892424204712, 1850.5651171974575, 1866.8319851213455, 958.9808203835884, 961.927855410847, 987.5161171026145, 1018.0226982097122, 1046.7278507588082, 18354.724679129824, 21574.08749818786, 21858.562828743336, 22907.19824806157, 22961.655575166387, 947.2469386837481, 956.6077908057663, 971.2327261463506, 971.8007808399261, 1000.309786247487, 11660.475278612483, 11913.04695624348, 12300.645059163466, 12345.259284442782, 12361.62915112548, 531837.0, 551137.2443137759, 556897.0, 568289.0, 571437.1428142916, 71990.0, 72256.0, 81061.59469202616, 99840.0, 119669.80330196761, 874.2350443362059, 953.3326671329958, 984.9803003939882, 986.5708416838698, 1010.6917390196061, 21108.989292034465, 21124.155033798477, 21399.46501337479, 21542.6768598468, 21609.783902160776, 56004.71997639986, 56047.15929260983, 57389.13916291176, 57420.1386979204, 57545.0, 75371.62314188395, 77792.61103694445, 78779.60610197141, 79451.20548794437, 79574.80637790322, 5499.285092937893, 5616.747246374005, 7672.194419585863, 7874.89751434811, 8386.622601982803, 13248.602541923758, 13392.531261405804, 13464.394102265618, 13674.247916364298, 13680.521181758591, 11665.650030499099, 11765.235259708092, 11808.822867657163, 11966.760664786829, 12003.339816310187, 5257.421683614876, 9200.159968006292, 10209.642662506776, 11564.95915367621, 11758.941205293919, 11783.469743861375, 11978.221415607957, 12132.696682583006, 12167.817482737943, 12186.451609677408, 7878.448508604342, 7975.72084977023, 8221.342292616457, 8335.49987000782, 8371.83256334882, 11397.772044559228, 11645.301281923112, 12047.939760301493, 12079.456424460745, 12090.395480225778], "value": 9813.251235185397, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1511.3425659837967, 1552.6584151486672, 1718.2010365180188, 1871.167330537911, 1891.650044741723, 8369.707060252893, 8890.199882010618, 8897.288216942638, 8898.0, 8908.8663670045, 7786.961065194666, 8013.559254241014, 8444.535550544717, 8660.826783464343, 8670.0, 2366.3965688749386, 2408.4460574067975, 2411.240459255329, 2412.7225369082603, 2414.034386245507, 2366.7041619797524, 2388.2715771689627, 2405.530921470314, 2408.6748288981025, 2410.20463247128, 2380.8928598213033, 2388.152205966883, 2390.34265576966, 2408.9397765055837, 2410.602250628653, 2349.259983105316, 2363.9645405318934, 2381.5951288281035, 2382.9642555361684, 2388.534235824015, 2353.988230058856, 2366.822488313366, 2372.991478621579, 2374.014783864694, 2377.6552399901916, 8771.736847894574, 8830.24942879856, 8876.156765107304, 8892.555372231363, 8900.931888173396, 5161.483851614846, 5311.203319502067, 5312.203169524563, 5312.229726689647, 5323.547498462635, 3575.606683264839, 3589.4974703541525, 3642.071271825694, 3658.5426821647293, 3664.3404187246283, 958.5159494455255, 1070.3684825952726, 1072.3030030480172, 1083.3066837224183, 1106.5076041161685, 9735.65925192622, 11459.427028648617, 11475.655730328104, 11491.0, 11510.654680359603, 4017.055991841915, 4486.932696009562, 4609.124266389443, 4766.618670506351, 4774.618030557547, 9854.260930430246, 9859.211263098934, 9860.852087218698, 9862.112409883002, 9882.308238423386, 5295.046891559557, 5312.601554883322, 5320.813771517978, 5321.175217841163, 5329.866753331198, 3956.485656864589, 4239.47006624172, 4324.113556720865, 4494.07871386365, 4865.829695960624, 3819.6180381962135, 3822.522184726909, 3951.8221680024467, 3982.900427489336, 3989.7207195496035, 1154.96535103947, 1232.1990706041145, 1263.109507797001, 1265.202922159034, 1294.3981048812348, 898.142274128219, 926.6285896872666, 928.4986107502008, 933.1741408853214, 975.302658599105, 5487.835364939058, 5634.830955071355, 5736.713164341766, 6071.451779796212, 6101.450869421773, 752.9322360987428, 916.1571354354011, 928.5914197752967, 964.3346091197052, 973.6640858903667, 3911.0732942852574, 4021.560113789466, 4097.487814023247, 4121.732087414309, 4148.045949431647, 10487.790244195226, 10750.623728169476, 10869.67390978272, 10884.945575272073, 10893.291936024134, 10612.787744245226, 10669.413182274895, 10821.296615719953, 10835.079018283377, 10840.186985976083, 7692.076950765832, 8068.233517815916, 8165.510069395856, 8313.293370063491, 8318.584070796436, 5983.0, 6053.848653783691, 6071.423214794588, 6142.508599312134, 6209.751609935552, 9890.950545247228, 10138.290319677846, 10178.745531361776, 10184.236182286506, 10191.694249172537, 9874.160696340892, 10046.995300469895, 10154.644587439405, 10349.27555071168, 10409.219308552041, 6917.827054323481, 7134.108236470442, 7376.151742549676, 7594.962025189839, 7610.048743907012, 7881.527108373516, 7953.085395179628, 7965.4822436541435, 7973.242541958504, 8143.552104634302, 7254.709811607477, 7513.549187048795, 7566.772996810105, 7618.69525218985, 7633.847323053619, 7330.890036649348, 7345.77962661121, 7387.445941554298, 7389.7413590524075, 7456.4034877208605, 7007.124109486314, 7026.051483049723, 7096.574205547684, 7104.11198600175, 7112.110986126734, 4619.821945403901, 4990.72551009698, 5018.698878067327, 5057.418396884258, 5147.2279158126585, 4148.875533733993, 5006.148954677641, 5115.6699258193885, 5166.638335316492, 5181.974090129676], "value": 4585.76950169039, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.18657412255106, 299.71377334645416, 308.3324602236159, 309.12363449620324, 311.3989999301349, 4630.791614377361, 5405.243265942766, 5413.539849112825, 5425.91861122083, 5464.153056276274, 4035.3341698619693, 4327.826886924519, 4935.259711043345, 5120.667156634816, 5311.865999060554, 3976.3637817949134, 4084.65280451162, 4103.5280942691525, 4125.2780763366445, 4159.315477231711, 3249.9675003250018, 3648.726345524083, 3990.8426556298637, 4157.667386609064, 4172.80927513055, 3682.7606205596685, 3840.639440489572, 4039.596040395966, 4068.4304197412384, 4096.97951510242, 3452.913677158066, 3986.362182050858, 3990.4812374391436, 4016.819243134066, 4025.939610905839, 3438.8452519636426, 3479.739019573542, 3495.720342372604, 3503.1767534629344, 3511.7006707518126, 4857.927131093036, 5142.51146141116, 5144.897102057937, 5157.948420515821, 5190.143626301656, 3879.2931110311374, 4553.704009239422, 4583.518730533279, 4637.25803871379, 4652.95347046532, 5610.607257491977, 5639.0, 5647.519960803336, 5666.858328541778, 5670.206171136044, 3715.8229713594756, 3849.711271654637, 3856.2865869814173, 3864.3816989281863, 3877.631624995649, 4953.6037117030555, 5179.507946745053, 5357.776522743057, 5905.4980326672285, 6018.007028840236, 3217.613886333655, 3892.0, 3905.3946638271113, 3909.257241124177, 3931.5478719947, 3502.7898326100517, 3954.703397245218, 3965.5439624442984, 3980.5621381647998, 3982.8406863725704, 4044.211378781168, 4184.560621134737, 4428.180786554498, 4582.816687332469, 4605.792739326738, 4230.598093181143, 4514.645606318091, 5329.973350133225, 5639.774409023593, 5647.37878833328, 1145.5017067575632, 1201.7716633839543, 1304.7018216874271, 1312.9934350328188, 1340.5241139395569, 739.8483310921248, 808.5957021489255, 834.2783492279256, 858.1675774498726, 898.4878619187132, 4437.871300732975, 4940.728259945666, 5167.560757335594, 5180.32655754757, 5225.111731005738, 5818.44724751148, 5825.941740582624, 5844.970775146097, 5870.5010074144175, 5895.204147440127, 4411.492678341968, 4522.570355816192, 4969.186247019812, 5121.61587880903, 5188.169892817206, 2982.835944023056, 2997.355568552728, 3001.4897467430587, 3005.3170224674254, 3010.554933631869, 4725.64557658177, 5629.577781666391, 5840.240768700127, 5886.115163991745, 5947.791827286024, 5846.532277417797, 5856.707164641751, 5861.794837180678, 5897.0, 5959.433853783884, 5009.674371165863, 5267.446918073624, 5630.0, 5917.408259174048, 5917.964356237555, 4843.733594652187, 5380.704061276668, 5630.74661640219, 5724.942750572441, 5809.257222833217, 5559.27729395176, 5594.776208951596, 5596.580256480699, 5608.298962629671, 5650.745716442688, 5007.24891266313, 5815.244018277597, 5892.558058145571, 5897.321807992136, 5900.321463031806, 3443.810590417551, 3542.982285088558, 3829.636184562462, 3928.508936382952, 3962.5641179470813, 5154.381474222967, 5870.324912635102, 5883.676397797991, 5897.166841553025, 5915.349311575637, 5379.54273886724, 5726.255586773693, 5729.713514324184, 5736.340320863154, 5753.654780713171, 4832.420109586872, 5636.013697602985, 5656.208130861765, 5686.800961966312, 5696.401877802771, 5266.578673706018, 5505.256790333254, 5523.337199536081, 5547.667139971453, 5549.528290095387, 4579.473360563577, 4797.64017698681, 5299.252796442816, 5526.005319042611, 5558.583106266965, 4703.529647035269, 5562.471565201299, 5586.38549759518, 5626.774929002794, 5661.631993920382], "value": 4061.674593217768, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.8858388365919, 708.3412426443409, 750.3397010630648, 754.6717178027557, 817.7219745286601, 15022.173780442072, 16049.91975040126, 16070.0, 16071.839281607181, 16115.194240287983, 13846.930765346184, 14597.562073137822, 14926.328315225814, 14953.327100280487, 15004.624884377896, 829.3116713128089, 833.8123922117536, 835.1022650650544, 836.4521238588734, 838.3209600223807, 672.3948446398232, 696.8606278744246, 828.3828547731948, 861.1904809479101, 865.2213008292524, 889.3729920406098, 890.0031964200105, 890.9376343655947, 891.4383938119008, 893.9731808045769, 887.1128871128872, 887.1970866365917, 889.7375274294099, 889.8754174415619, 890.5725251879135, 490.4384479770678, 565.5786439102853, 647.5499527828161, 668.204836244867, 673.4679603113534, 13663.590092297247, 13665.726685466236, 13714.794278085838, 13805.447782088704, 13829.51596694121, 13682.726345473135, 13924.721505569933, 13973.0, 13983.580492585239, 14266.215358155298, 12451.813222801666, 12521.74956500874, 12699.492020319176, 13142.934285328607, 13227.404766785517, 4466.12910482456, 4488.820447182109, 4533.705309154927, 4717.386739723848, 4737.28940658904, 121448.0, 121816.39091804484, 123790.38104809419, 125020.0, 125870.0, 10885.455727213766, 10945.343279403261, 11037.83443248352, 11082.833757493645, 11241.437928103562, 21393.67909481359, 21431.357059288246, 21439.356819295444, 21444.785552144593, 21466.785332146792, 7851.646675899598, 8042.517448953082, 8108.2297181767635, 8193.221643943816, 8203.958980205061, 4289.828406863753, 4426.623736982328, 4457.108578284357, 4501.6848820582245, 4567.360569520203, 3279.672032796749, 3453.671901169385, 3548.840302186408, 3571.321448924748, 3587.838547265327, 575.2291928815407, 658.5127006015514, 682.7405585877335, 683.1938312790954, 687.3367200651295, 513.2737176894652, 554.8002719021149, 557.8995780759421, 615.8645098078416, 623.769205393998, 7336.816579585553, 8469.21367928279, 9093.545322733837, 9117.407368521024, 9305.395149315273, 514.920187370958, 569.9484451187552, 625.2590680044162, 627.5575719118011, 631.5475894940741, 4320.200762858881, 4461.308497182942, 4467.2182368086105, 4487.910241795146, 4519.367288579601, 163122.0, 163333.0, 164866.0, 169044.0, 171150.14424927795, 143052.0, 144999.55000450072, 145445.0, 149137.0, 150671.0, 117941.0, 119142.0, 122995.3850230761, 124286.0, 124898.37550812188, 8620.13798620133, 8685.218330350299, 8699.56502174876, 8747.606357714045, 8895.955520222358, 53615.0, 54639.180412293055, 64411.0, 65923.01115483367, 68453.65773171102, 84380.57809710912, 88613.55693221492, 88931.0, 89920.66705658314, 91643.16713665823, 11491.885081149081, 11565.0, 11598.710032248924, 11637.650870473899, 11912.642620721392, 12131.090168237593, 12164.148509604243, 12210.938945305217, 12383.69040773988, 12773.87226127764, 11339.262947908359, 11371.488283027118, 11642.592509262135, 11981.101417393556, 12363.443645035815, 11728.0, 11765.529378825093, 11812.114091443003, 11922.284662920252, 12120.818187727367, 11531.481083351102, 11829.940850295694, 11980.04159667207, 12009.75980480368, 12219.749280010226, 9374.67188648394, 9416.0, 9718.757031073997, 9924.503774811375, 10032.64885728996, 8215.774645087753, 8501.489910605384, 9427.292953028687, 10007.09936105754, 10040.899591003996], "value": 7631.875512431858, "unit": "score"}], "name": "dromaeo_css", "value": 7363.885015964249, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 112.0, 105.0, 113.0, 113.0, 111.0, 114.0, 112.0, 111.0, 112.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 114.0, 131.0, 162.0, 100.0, 131.0, 130.0, 107.0, 158.0, 108.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 180.0, 183.0, 185.0, 183.0, 179.0, 183.0, 182.0, 182.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 104.0, 101.0, 50.0, 51.0, 84.0, 111.0, 114.0, 80.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 136.0, 70.0, 72.0, 78.0, 120.0, 71.0, 69.0, 122.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 89.0, 86.0, 88.0, 86.0, 89.0, 87.0, 89.0, 84.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 102.0, 93.0, 93.0, 93.0, 95.0, 93.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 132.0, 133.0, 84.0, 87.0, 84.0, 105.0, 136.0, 141.0, 84.0], "value": 107.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 56.0, 56.0, 54.0, 56.0, 54.0, 55.0, 54.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 75.0, 82.0, 74.0, 74.0, 70.0, 70.0, 70.0, 71.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 89.0, 87.0, 87.0, 90.0, 85.0, 104.0, 77.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 140.0, 138.0, 138.0, 137.0, 142.0, 158.0, 183.0, 143.0], "value": 145.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 237.0, 183.0, 169.0, 170.0, 169.0, 175.0, 232.0, 208.0, 169.0], "value": 190.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 67.0, 67.0, 66.0, 66.0, 75.0, 77.0, 81.0], "value": 70.3, "unit": "score"}], "name": "kraken", "value": 1506.8, "alertThreshold": 2.0}]} 13:17:46 INFO - Return code: 0 13:17:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:17:47 INFO - # TBPL SUCCESS # 13:17:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:17:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:17:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:17:47 INFO - 2016-08-22 13:17:47.069 screenresolution[1664:9633] starting screenresolution argv=screenresolution get 13:17:47 INFO - 2016-08-22 13:17:47.071 screenresolution[1664:9633] Display 0: 1600x1200x32@60 13:17:47 INFO - 2016-08-22 13:17:47.077 screenresolution[1665:9636] starting screenresolution argv=screenresolution list 13:17:47 INFO - Available Modes on Display 0 13:17:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:17:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:17:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:17:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:17:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:17:47 INFO - Intel Iris: 13:17:47 INFO - Chipset Model: Intel Iris 13:17:47 INFO - Type: GPU 13:17:47 INFO - Bus: Built-In 13:17:47 INFO - VRAM (Dynamic, Max): 1536 MB 13:17:47 INFO - Vendor: Intel (0x8086) 13:17:47 INFO - Device ID: 0x0a2e 13:17:47 INFO - Revision ID: 0x0009 13:17:47 INFO - Displays: 13:17:47 INFO - Display: 13:17:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:17:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:17:47 INFO - Display Serial Number: 1600x1200 60 13:17:47 INFO - Main Display: Yes 13:17:47 INFO - Mirror: Off 13:17:47 INFO - Online: Yes 13:17:47 INFO - Rotation: Supported 13:17:47 INFO - Return code: 0 13:17:47 INFO - Running post-action listener: _resource_record_post_action 13:17:47 INFO - [mozharness: 2016-08-22 20:17:47.312634Z] Finished run-tests step (success) 13:17:47 INFO - Running post-run listener: _resource_record_post_run 13:17:47 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 37131264; Write bytes: 703196160; Read time: 245; Write time: 1914 13:17:47 INFO - TinderboxPrint: CPU usage
53.4% 13:17:47 INFO - TinderboxPrint: I/O read bytes / time
37,131,264 / 245 13:17:47 INFO - TinderboxPrint: I/O write bytes / time
703,196,160 / 1,914 13:17:47 INFO - TinderboxPrint: CPU idle
2,260.3 (46.6%) 13:17:47 INFO - TinderboxPrint: CPU system
970.4 (20.0%) 13:17:47 INFO - TinderboxPrint: CPU user
1,623.0 (33.4%) 13:17:47 INFO - TinderboxPrint: Swap in / out
442,777,600 / 0 13:17:47 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399632896; Write bytes: 393451520; Read time: 29460; Write time: 774 13:17:47 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 35042304; Write bytes: 293762048; Read time: 222; Write time: 1095 13:17:47 INFO - Running post-run listener: _upload_blobber_files 13:17:47 INFO - Blob upload gear active. 13:17:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:17:47 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 13:17:47 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:17:47 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:17:48 INFO - (blobuploader) - INFO - Open directory for files ... 13:17:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:17:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:17:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:49 INFO - (blobuploader) - INFO - Done attempting. 13:17:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:17:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:17:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:51 INFO - (blobuploader) - INFO - Done attempting. 13:17:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:17:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:17:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:54 INFO - (blobuploader) - INFO - Done attempting. 13:17:54 INFO - (blobuploader) - INFO - Iteration through files over. 13:17:54 INFO - Return code: 0 13:17:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:17:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:17:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ddc20c406cd231007acb6e4026ccb0052f517c65cb9b154ed72b62290b388bbe06a5aa9da8d3175b998bfaae4d2f1afce8107c9e3085ab54fd92a535ac8b336", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bd6b9efe094205372ebe6d5f014a454108ac42ee72b34dc3549fafbabc87233c18ea597d8b61047b5e267657854bc5b00e089d95f4e9de2d62daf6574d31e2d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ecb92be58221aaa683616c1cded75be37c6b0f9fddfd3bafd0ec3a8b64cbb7e12824a6820f36211ff691568ba1fd27b3af009b63d3abd06bd2f02f1007904738"} 13:17:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:17:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:17:54 INFO - Contents: 13:17:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ddc20c406cd231007acb6e4026ccb0052f517c65cb9b154ed72b62290b388bbe06a5aa9da8d3175b998bfaae4d2f1afce8107c9e3085ab54fd92a535ac8b336", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bd6b9efe094205372ebe6d5f014a454108ac42ee72b34dc3549fafbabc87233c18ea597d8b61047b5e267657854bc5b00e089d95f4e9de2d62daf6574d31e2d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ecb92be58221aaa683616c1cded75be37c6b0f9fddfd3bafd0ec3a8b64cbb7e12824a6820f36211ff691568ba1fd27b3af009b63d3abd06bd2f02f1007904738"} 13:17:54 INFO - Running post-run listener: copy_logs_to_upload_dir 13:17:54 INFO - Copying logs to upload dir... 13:17:54 INFO - mkdir: /builds/slave/test/build/upload/logs 13:17:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.418492 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-22 13:17:54.832206) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 13:17:54.835801) ========= 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.NT2EQpWHkI/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.ynbDE3djf9/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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/Autoland/sha512/5ddc20c406cd231007acb6e4026ccb0052f517c65cb9b154ed72b62290b388bbe06a5aa9da8d3175b998bfaae4d2f1afce8107c9e3085ab54fd92a535ac8b336", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bd6b9efe094205372ebe6d5f014a454108ac42ee72b34dc3549fafbabc87233c18ea597d8b61047b5e267657854bc5b00e089d95f4e9de2d62daf6574d31e2d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ecb92be58221aaa683616c1cded75be37c6b0f9fddfd3bafd0ec3a8b64cbb7e12824a6820f36211ff691568ba1fd27b3af009b63d3abd06bd2f02f1007904738"} build_url:https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010819 build_url: 'https://queue.taskcluster.net/v1/task/cX-XR59ERUSHT1e_BfNlEQ/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ddc20c406cd231007acb6e4026ccb0052f517c65cb9b154ed72b62290b388bbe06a5aa9da8d3175b998bfaae4d2f1afce8107c9e3085ab54fd92a535ac8b336", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bd6b9efe094205372ebe6d5f014a454108ac42ee72b34dc3549fafbabc87233c18ea597d8b61047b5e267657854bc5b00e089d95f4e9de2d62daf6574d31e2d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ecb92be58221aaa683616c1cded75be37c6b0f9fddfd3bafd0ec3a8b64cbb7e12824a6820f36211ff691568ba1fd27b3af009b63d3abd06bd2f02f1007904738"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 13:17:54.868384) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 13:17:54.868719) ========= 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.NT2EQpWHkI/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.ynbDE3djf9/Listeners TMPDIR=/var/folders/m5/r6dgwqsj10g93g673s3k_wyc00000w/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.005086 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 13:17:54.917159) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 13:17:54.917484) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 13:17:54.917801) ========= ========= Total master_lag: 0.31 =========