builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0124 starttime: 1472589173.54 results: success (0) buildid: 20160830105821 builduid: 757e98ebeca14cd6bef503f522e65144 revision: 2fdf533335f70653529001917f44804c8966ffff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 13:32:53.542766) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-30 13:32:53.543679) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 13:32:53.544367) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-30 13:32:53.581025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 13:32:53.581632) ========= 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.iv7QWjsiwa/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.vBaoEWvoye/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-30 13:32:53-- 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% 30.8M=0s 2016-08-30 13:32:53 (30.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088134 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 13:32:53.694781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 13:32:53.695157) ========= 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.iv7QWjsiwa/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.vBaoEWvoye/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.027804 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 13:32:53.746235) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 13:32:53.746960) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 2fdf533335f70653529001917f44804c8966ffff --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 2fdf533335f70653529001917f44804c8966ffff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iv7QWjsiwa/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.vBaoEWvoye/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-30 13:32:53,827 truncating revision to first 12 chars 2016-08-30 13:32:53,827 Setting DEBUG logging. 2016-08-30 13:32:53,827 attempt 1/10 2016-08-30 13:32:53,828 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/2fdf533335f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-30 13:32:54,900 unpacking tar archive at: autoland-2fdf533335f7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323691 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-30 13:32:55.093614) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 13:32:55.093992) ========= script_repo_revision: 2fdf533335f70653529001917f44804c8966ffff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-30 13:32:55.094466) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 13:32:55.094791) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-30 13:32:55.113532) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-30 13:32:55.113855) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.iv7QWjsiwa/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.vBaoEWvoye/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 13:32:55 INFO - MultiFileLogger online at 20160830 13:32:55 in /builds/slave/test 13:32:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 13:32:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:32:55 INFO - {'append_to_log': False, 13:32:55 INFO - 'base_work_dir': '/builds/slave/test', 13:32:55 INFO - 'blob_upload_branch': 'Autoland', 13:32:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:32:55 INFO - 'branch': 'Autoland', 13:32:55 INFO - 'buildbot_json_path': 'buildprops.json', 13:32:55 INFO - 'config_files': ('talos/mac_config.py',), 13:32:55 INFO - 'default_actions': ('clobber', 13:32:55 INFO - 'read-buildbot-config', 13:32:55 INFO - 'download-and-extract', 13:32:55 INFO - 'populate-webroot', 13:32:55 INFO - 'create-virtualenv', 13:32:55 INFO - 'install', 13:32:55 INFO - 'run-tests'), 13:32:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:32:55 INFO - 'download_minidump_stackwalk': True, 13:32:55 INFO - 'download_symbols': 'ondemand', 13:32:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:32:55 INFO - 'tooltool.py': '/tools/tooltool.py', 13:32:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:32:55 INFO - '/tools/misc-python/virtualenv.py')}, 13:32:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:32:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:32:55 INFO - 'installer_path': 'installer.exe', 13:32:55 INFO - 'log_level': 'info', 13:32:55 INFO - 'log_name': 'talos', 13:32:55 INFO - 'log_to_console': True, 13:32:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:32:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:32:55 INFO - 'opt_config_files': (), 13:32:55 INFO - 'pip_index': False, 13:32:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:32:55 INFO - 'cmd': ('bash', 13:32:55 INFO - '-c', 13:32:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:32:55 INFO - 'enabled': True, 13:32:55 INFO - 'halt_on_failure': False, 13:32:55 INFO - 'name': 'check_screen_resolution'},), 13:32:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:32:55 INFO - 'cmd': ('bash', 13:32:55 INFO - '-c', 13:32:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:32:55 INFO - 'enabled': True, 13:32:55 INFO - 'halt_on_failure': False, 13:32:55 INFO - 'name': 'check_screen_resolution'},), 13:32:55 INFO - 'run_cmd_checks_enabled': True, 13:32:55 INFO - 'sps_profile': False, 13:32:55 INFO - 'sps_profile_interval': 0, 13:32:55 INFO - 'suite': 'dromaeojs-e10s', 13:32:55 INFO - 'system_bits': '32', 13:32:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:32:55 INFO - 'title': 't-yosemite-r7-0124', 13:32:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:32:55 INFO - 'use_talos_json': True, 13:32:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:32:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:32:55 INFO - 'work_dir': 'build'} 13:32:55 INFO - [mozharness: 2016-08-30 20:32:55.313134Z] Running clobber step. 13:32:55 INFO - Running pre-action listener: _resource_record_pre_action 13:32:55 INFO - Running main action method: clobber 13:32:55 INFO - rmtree: /builds/slave/test/build 13:32:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:32:57 INFO - Running post-action listener: _resource_record_post_action 13:32:57 INFO - [mozharness: 2016-08-30 20:32:57.523992Z] Finished clobber step (success) 13:32:57 INFO - [mozharness: 2016-08-30 20:32:57.524122Z] Running read-buildbot-config step. 13:32:57 INFO - Running pre-action listener: _resource_record_pre_action 13:32:57 INFO - Running main action method: read_buildbot_config 13:32:57 INFO - Using buildbot properties: 13:32:57 INFO - { 13:32:57 INFO - "project": "", 13:32:57 INFO - "product": "firefox", 13:32:57 INFO - "script_repo_revision": "production", 13:32:57 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 13:32:57 INFO - "repository": "", 13:32:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 13:32:57 INFO - "buildid": "20160830105821", 13:32:57 INFO - "pgo_build": "False", 13:32:57 INFO - "basedir": "/builds/slave/test", 13:32:57 INFO - "buildnumber": 157, 13:32:57 INFO - "slavename": "t-yosemite-r7-0124", 13:32:57 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 13:32:57 INFO - "platform": "yosemite_r7", 13:32:57 INFO - "scheduler": "tests-autoland-macosx64-talos-7-3600", 13:32:57 INFO - "branch": "autoland", 13:32:57 INFO - "repo_path": "integration/autoland", 13:32:57 INFO - "revision": "2fdf533335f70653529001917f44804c8966ffff", 13:32:57 INFO - "stage_platform": "macosx64", 13:32:57 INFO - "builduid": "757e98ebeca14cd6bef503f522e65144", 13:32:57 INFO - "slavebuilddir": "test" 13:32:57 INFO - } 13:32:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 13:32:57 INFO - Running post-action listener: _resource_record_post_action 13:32:57 INFO - [mozharness: 2016-08-30 20:32:57.527410Z] Finished read-buildbot-config step (success) 13:32:57 INFO - [mozharness: 2016-08-30 20:32:57.527501Z] Running download-and-extract step. 13:32:57 INFO - Running pre-action listener: _resource_record_pre_action 13:32:57 INFO - Running main action method: download_and_extract 13:32:57 INFO - mkdir: /builds/slave/test/build/tests 13:32:57 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')]} 13:32:57 INFO - trying https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 13:32:57 INFO - Downloading https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/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 13:32:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/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 13:32:58 INFO - Downloaded 1199 bytes. 13:32:58 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 13:32:58 INFO - Using the following test package requirements: 13:32:58 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:32:58 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:32:58 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 13:32:58 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:32:58 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 13:32:58 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:32:58 INFO - u'jsshell-mac.zip'], 13:32:58 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:32:58 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 13:32:58 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 13:32:58 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:32:58 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 13:32:58 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:32:58 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 13:32:58 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:32:58 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 13:32:58 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 13:32:58 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 13:32:58 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:32: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')]} 13:32:58 INFO - trying https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:32:58 INFO - Downloading https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/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 13:32:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/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 13:32:59 INFO - Downloaded 16380352 bytes. 13:32:59 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:33:06 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 13:33: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')]} 13:33:06 INFO - trying https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 13:33:06 INFO - Downloading https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/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 13:33:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/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 13:33:07 INFO - Downloaded 16380352 bytes. 13:33:07 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 13:33: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')]} 13:33:14 INFO - trying https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 13:33:14 INFO - Downloading https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/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 13:33:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/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 13:33:15 INFO - Downloaded 14413998 bytes. 13:33:15 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 13:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:15 INFO - trying https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:33:15 INFO - Downloading https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 13:33:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/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 13:33:18 INFO - Downloaded 111563949 bytes. 13:33:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:33:18 INFO - mkdir: /builds/slave/test/properties 13:33:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:33:18 INFO - Writing to file /builds/slave/test/properties/build_url 13:33:18 INFO - Contents: 13:33:18 INFO - build_url:https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 13:33:19 INFO - Running post-action listener: _resource_record_post_action 13:33:19 INFO - Running post-action listener: set_extra_try_arguments 13:33:19 INFO - [mozharness: 2016-08-30 20:33:19.266775Z] Finished download-and-extract step (success) 13:33:19 INFO - [mozharness: 2016-08-30 20:33:19.266906Z] Running populate-webroot step. 13:33:19 INFO - Running pre-action listener: _resource_record_pre_action 13:33:19 INFO - Running main action method: populate_webroot 13:33:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:33:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:33:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:33:19 INFO - '--tppagecycles', 13:33:19 INFO - '7'], 13:33:19 INFO - 'tests': ['tsvgm']}}, 13:33:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:33:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:33:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:33:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:33:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:33:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:33:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:19 INFO - 'talos_options': ['--disable-e10s'], 13:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:33:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:19 INFO - 'talos_options': ['--disable-e10s'], 13:33:19 INFO - 'tests': ['damp', 'tps']}, 13:33:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:19 INFO - 'tests': ['damp', 'tps']}, 13:33:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:33:19 INFO - 'tests': ['dromaeo_dom']}, 13:33:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:33:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:33:19 INFO - 'tests': ['basic_compositor_video']}, 13:33:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:33:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:33:19 INFO - 'tests': ['a11yr', 13:33:19 INFO - 'ts_paint', 13:33:19 INFO - 'tpaint', 13:33:19 INFO - 'sessionrestore', 13:33:19 INFO - 'sessionrestore_no_auto_restore', 13:33:19 INFO - 'tabpaint']}, 13:33:19 INFO - 'other-e10s': {'tests': ['a11yr', 13:33:19 INFO - 'ts_paint', 13:33:19 INFO - 'tpaint', 13:33:19 INFO - 'sessionrestore', 13:33:19 INFO - 'sessionrestore_no_auto_restore', 13:33:19 INFO - 'tabpaint']}, 13:33:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:33:19 INFO - 'ts_paint', 13:33:19 INFO - 'tpaint', 13:33:19 INFO - 'sessionrestore', 13:33:19 INFO - 'sessionrestore_no_auto_restore', 13:33:19 INFO - 'tabpaint']}, 13:33:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:33:19 INFO - 'ts_paint', 13:33:19 INFO - 'tpaint', 13:33:19 INFO - 'sessionrestore', 13:33:19 INFO - 'sessionrestore_no_auto_restore', 13:33:19 INFO - 'tabpaint']}, 13:33:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:33:19 INFO - 'tests': ['a11yr', 13:33:19 INFO - 'ts_paint', 13:33:19 INFO - 'tpaint', 13:33:19 INFO - 'sessionrestore', 13:33:19 INFO - 'sessionrestore_no_auto_restore', 13:33:19 INFO - 'tabpaint']}, 13:33:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:33:19 INFO - 'tests': ['a11yr', 13:33:19 INFO - 'ts_paint', 13:33:19 INFO - 'tpaint', 13:33:19 INFO - 'sessionrestore', 13:33:19 INFO - 'sessionrestore_no_auto_restore', 13:33:19 INFO - 'tabpaint']}, 13:33:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:33:19 INFO - 'tests': ['tsvgx', 13:33:19 INFO - 'tsvgr_opacity', 13:33:19 INFO - 'tart', 13:33:19 INFO - 'tscrollx', 13:33:19 INFO - 'cart']}, 13:33:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:33:19 INFO - 'tsvgr_opacity', 13:33:19 INFO - 'tart', 13:33:19 INFO - 'tscrollx', 13:33:19 INFO - 'cart']}, 13:33:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:19 INFO - 'talos_options': ['--disable-e10s'], 13:33:19 INFO - 'tests': ['tp5o']}, 13:33:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:19 INFO - 'tests': ['tp5o']}, 13:33:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:19 INFO - 'talos_options': ['--disable-e10s', 13:33:19 INFO - '--xperf_path', 13:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:19 INFO - 'tests': ['tp5n']}, 13:33:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:33:19 INFO - 'talos_options': ['--xperf_path', 13:33:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:33:19 INFO - 'tests': ['tp5n']}}, 13:33:19 INFO - 'talos.zip': {'path': '', 13:33:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:33:19 INFO - Running post-action listener: _resource_record_post_action 13:33:19 INFO - [mozharness: 2016-08-30 20:33:19.285428Z] Finished populate-webroot step (success) 13:33:19 INFO - [mozharness: 2016-08-30 20:33:19.285527Z] Running create-virtualenv step. 13:33:19 INFO - Running pre-action listener: _resource_record_pre_action 13:33:19 INFO - Running main action method: create_virtualenv 13:33:19 INFO - Creating virtualenv /builds/slave/test/build/venv 13:33:19 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 13:33:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:33:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:33:19 INFO - Using real prefix '/tools/python27' 13:33:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:33:20 INFO - Installing distribute.............................................................................................................................................................................................done. 13:33:23 INFO - Installing pip.................done. 13:33:23 INFO - Return code: 0 13:33:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:23 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 0x108b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b98618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8230c95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a67d30>, '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 0x1087ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fb20>, '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.iv7QWjsiwa/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.vBaoEWvoye/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 13:33:23 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 13:33:23 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 13:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv7QWjsiwa/Render', 13:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:23 INFO - 'HOME': '/Users/cltbld', 13:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:23 INFO - 'LOGNAME': 'cltbld', 13:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:23 INFO - 'MOZ_NO_REMOTE': '1', 13:33:23 INFO - 'NO_EM_RESTART': '1', 13:33:23 INFO - 'PAGER': '/bin/cat', 13:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:23 INFO - 'PWD': '/builds/slave/test', 13:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:23 INFO - 'SHELL': '/bin/bash', 13:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vBaoEWvoye/Listeners', 13:33:23 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 13:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:23 INFO - 'USER': 'cltbld', 13:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:23 INFO - 'XPC_FLAGS': '0x0', 13:33:23 INFO - 'XPC_SERVICE_NAME': '0', 13:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:23 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 13:33:23 INFO - Cleaning up... 13:33:23 INFO - Return code: 0 13:33:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:23 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 0x108b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b98618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8230c95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a67d30>, '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 0x1087ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fb20>, '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.iv7QWjsiwa/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.vBaoEWvoye/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 13:33:23 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 13:33:23 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 13:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv7QWjsiwa/Render', 13:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:23 INFO - 'HOME': '/Users/cltbld', 13:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:23 INFO - 'LOGNAME': 'cltbld', 13:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:23 INFO - 'MOZ_NO_REMOTE': '1', 13:33:23 INFO - 'NO_EM_RESTART': '1', 13:33:23 INFO - 'PAGER': '/bin/cat', 13:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:23 INFO - 'PWD': '/builds/slave/test', 13:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:23 INFO - 'SHELL': '/bin/bash', 13:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vBaoEWvoye/Listeners', 13:33:23 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 13:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:23 INFO - 'USER': 'cltbld', 13:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:23 INFO - 'XPC_FLAGS': '0x0', 13:33:23 INFO - 'XPC_SERVICE_NAME': '0', 13:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:23 INFO - Downloading/unpacking psutil>=3.1.1 13:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:33:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:26 INFO - Installing collected packages: psutil 13:33:26 INFO - Running setup.py install for psutil 13:33:26 INFO - building 'psutil._psutil_osx' extension 13:33:26 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 13:33:27 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 13:33:27 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 13:33:27 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 13:33:27 INFO - building 'psutil._psutil_posix' extension 13:33:27 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 13:33:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:33:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:33:27 INFO - ^ 13:33:27 INFO - 1 warning generated. 13:33:27 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 13:33:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:33:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:33:27 INFO - Successfully installed psutil 13:33:27 INFO - Cleaning up... 13:33:27 INFO - Return code: 0 13:33:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:27 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 0x108b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b98618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8230c95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a67d30>, '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 0x1087ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fb20>, '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.iv7QWjsiwa/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.vBaoEWvoye/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 13:33:27 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 13:33:27 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 13:33:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv7QWjsiwa/Render', 13:33:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:27 INFO - 'HOME': '/Users/cltbld', 13:33:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:27 INFO - 'LOGNAME': 'cltbld', 13:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:27 INFO - 'MOZ_NO_REMOTE': '1', 13:33:27 INFO - 'NO_EM_RESTART': '1', 13:33:27 INFO - 'PAGER': '/bin/cat', 13:33:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:27 INFO - 'PWD': '/builds/slave/test', 13:33:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:27 INFO - 'SHELL': '/bin/bash', 13:33:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vBaoEWvoye/Listeners', 13:33:27 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 13:33:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:27 INFO - 'USER': 'cltbld', 13:33:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:27 INFO - 'XPC_FLAGS': '0x0', 13:33:27 INFO - 'XPC_SERVICE_NAME': '0', 13:33:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:33:28 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 13:33:28 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 13:33:28 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 13:33:28 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 13:33:28 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 13:33:28 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 13:33:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:33:30 INFO - Installing collected packages: mozsystemmonitor 13:33:30 INFO - Running setup.py install for mozsystemmonitor 13:33:30 INFO - Successfully installed mozsystemmonitor 13:33:30 INFO - Cleaning up... 13:33:30 INFO - Return code: 0 13:33:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:33:30 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')]} 13:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:30 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')]} 13:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:30 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 0x108b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b98618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8230c95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a67d30>, '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 0x1087ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fb20>, '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.iv7QWjsiwa/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.vBaoEWvoye/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 13:33:30 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 13:33:30 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 13:33:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv7QWjsiwa/Render', 13:33:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:30 INFO - 'HOME': '/Users/cltbld', 13:33:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:30 INFO - 'LOGNAME': 'cltbld', 13:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:30 INFO - 'MOZ_NO_REMOTE': '1', 13:33:30 INFO - 'NO_EM_RESTART': '1', 13:33:30 INFO - 'PAGER': '/bin/cat', 13:33:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:30 INFO - 'PWD': '/builds/slave/test', 13:33:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:30 INFO - 'SHELL': '/bin/bash', 13:33:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vBaoEWvoye/Listeners', 13:33:30 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 13:33:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:30 INFO - 'USER': 'cltbld', 13:33:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:30 INFO - 'XPC_FLAGS': '0x0', 13:33:30 INFO - 'XPC_SERVICE_NAME': '0', 13:33:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:31 INFO - Downloading/unpacking jsonschema==2.5.1 13:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:33:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:33:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:33:33 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 13:33:33 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 13:33:33 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 13:33:33 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 13:33:33 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 13:33:33 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 13:33:34 INFO - Downloading functools32-3.2.3-2.tar.gz 13:33:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:33:34 INFO - warning: no files found matching '*.txt' 13:33:34 INFO - no previously-included directories found matching 'build' 13:33:34 INFO - no previously-included directories found matching 'dist' 13:33:34 INFO - no previously-included directories found matching '.git*' 13:33:34 INFO - Installing collected packages: jsonschema, functools32 13:33:34 INFO - Running setup.py install for functools32 13:33:34 INFO - warning: no files found matching '*.txt' 13:33:34 INFO - no previously-included directories found matching 'build' 13:33:34 INFO - no previously-included directories found matching 'dist' 13:33:34 INFO - no previously-included directories found matching '.git*' 13:33:34 INFO - Successfully installed jsonschema functools32 13:33:34 INFO - Cleaning up... 13:33:34 INFO - Return code: 0 13:33:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b98618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8230c95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a67d30>, '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 0x1087ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fb20>, '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.iv7QWjsiwa/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.vBaoEWvoye/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 13:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:33:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv7QWjsiwa/Render', 13:33:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:34 INFO - 'HOME': '/Users/cltbld', 13:33:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:34 INFO - 'LOGNAME': 'cltbld', 13:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:34 INFO - 'MOZ_NO_REMOTE': '1', 13:33:34 INFO - 'NO_EM_RESTART': '1', 13:33:34 INFO - 'PAGER': '/bin/cat', 13:33:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:34 INFO - 'PWD': '/builds/slave/test', 13:33:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:34 INFO - 'SHELL': '/bin/bash', 13:33:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vBaoEWvoye/Listeners', 13:33:34 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 13:33:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:34 INFO - 'USER': 'cltbld', 13:33:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:34 INFO - 'XPC_FLAGS': '0x0', 13:33:34 INFO - 'XPC_SERVICE_NAME': '0', 13:33:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:33:34 INFO - Cleaning up... 13:33:34 INFO - Return code: 0 13:33:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b98618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8230c95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a67d30>, '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 0x1087ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fb20>, '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.iv7QWjsiwa/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.vBaoEWvoye/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 13:33:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:33:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv7QWjsiwa/Render', 13:33:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:34 INFO - 'HOME': '/Users/cltbld', 13:33:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:34 INFO - 'LOGNAME': 'cltbld', 13:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:34 INFO - 'MOZ_NO_REMOTE': '1', 13:33:34 INFO - 'NO_EM_RESTART': '1', 13:33:34 INFO - 'PAGER': '/bin/cat', 13:33:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:34 INFO - 'PWD': '/builds/slave/test', 13:33:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:34 INFO - 'SHELL': '/bin/bash', 13:33:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vBaoEWvoye/Listeners', 13:33:34 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 13:33:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:34 INFO - 'USER': 'cltbld', 13:33:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:34 INFO - 'XPC_FLAGS': '0x0', 13:33:34 INFO - 'XPC_SERVICE_NAME': '0', 13:33:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:34 INFO - Downloading/unpacking blobuploader==1.2.4 13:33:34 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 13:33:34 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 13:33:34 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 13:33:34 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 13:33:34 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 13:33:34 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 13:33:37 INFO - Downloading blobuploader-1.2.4.tar.gz 13:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:33:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:33:37 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 13:33:37 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 13:33:37 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 13:33:37 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 13:33:37 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 13:33:37 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 13:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:33:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:33:38 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 13:33:38 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 13:33:38 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 13:33:38 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 13:33:38 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 13:33:38 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 13:33:38 INFO - Downloading docopt-0.6.1.tar.gz 13:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:33:38 INFO - Installing collected packages: blobuploader, requests, docopt 13:33:38 INFO - Running setup.py install for blobuploader 13:33:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:33:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:33:38 INFO - Running setup.py install for requests 13:33:39 INFO - Running setup.py install for docopt 13:33:39 INFO - Successfully installed blobuploader requests docopt 13:33:39 INFO - Cleaning up... 13:33:39 INFO - Return code: 0 13:33:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33:39 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')]} 13:33:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:39 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')]} 13:33:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:39 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 0x108b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b98618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8230c95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a67d30>, '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 0x1087ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fb20>, '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.iv7QWjsiwa/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.vBaoEWvoye/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 13:33:39 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 13:33:39 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 13:33:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv7QWjsiwa/Render', 13:33:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:39 INFO - 'HOME': '/Users/cltbld', 13:33:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:39 INFO - 'LOGNAME': 'cltbld', 13:33:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:39 INFO - 'MOZ_NO_REMOTE': '1', 13:33:39 INFO - 'NO_EM_RESTART': '1', 13:33:39 INFO - 'PAGER': '/bin/cat', 13:33:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:39 INFO - 'PWD': '/builds/slave/test', 13:33:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:39 INFO - 'SHELL': '/bin/bash', 13:33:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vBaoEWvoye/Listeners', 13:33:39 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 13:33:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:39 INFO - 'USER': 'cltbld', 13:33:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:39 INFO - 'XPC_FLAGS': '0x0', 13:33:39 INFO - 'XPC_SERVICE_NAME': '0', 13:33:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:33:39 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-9tsqtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:33:39 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-RtL04B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:33:39 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-0IDn_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:33:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-QnF74w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:33:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-edx8m0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:33:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-ZlR9Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:33:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-n7Ol60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:33:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-eDCbDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:33:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-2O2t4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:33:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-k60GAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:33:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-389GQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:33:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:33:40 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-DvkT2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:33:41 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-C8ahLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:33:41 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-RxWJ77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:41 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-oMlI7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:33:41 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-F4ov_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:33:41 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-S_1WEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:33:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:33:41 INFO - Running setup.py install for manifestparser 13:33:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:33:41 INFO - Running setup.py install for mozcrash 13:33:41 INFO - Running setup.py install for mozdebug 13:33:41 INFO - Running setup.py install for mozdevice 13:33:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:33:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:33:42 INFO - Running setup.py install for mozfile 13:33:42 INFO - Running setup.py install for mozhttpd 13:33:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:33:42 INFO - Running setup.py install for mozinfo 13:33:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:33:42 INFO - Running setup.py install for mozInstall 13:33:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:33:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:33:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:33:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:33:42 INFO - Running setup.py install for mozleak 13:33:42 INFO - Running setup.py install for mozlog 13:33:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:33:43 INFO - Running setup.py install for moznetwork 13:33:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:33:43 INFO - Running setup.py install for mozprocess 13:33:43 INFO - Running setup.py install for mozprofile 13:33:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:33:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:33:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:33:43 INFO - Running setup.py install for mozrunner 13:33:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:33:43 INFO - Running setup.py install for mozscreenshot 13:33:43 INFO - Running setup.py install for moztest 13:33:43 INFO - Running setup.py install for mozversion 13:33:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:33:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:33:44 INFO - Cleaning up... 13:33:44 INFO - Return code: 0 13:33:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:44 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 0x108b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b98618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8230c95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a67d30>, '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 0x1087ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fb20>, '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.iv7QWjsiwa/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.vBaoEWvoye/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 13:33:44 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 13:33:44 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 13:33:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv7QWjsiwa/Render', 13:33:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:44 INFO - 'HOME': '/Users/cltbld', 13:33:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:44 INFO - 'LOGNAME': 'cltbld', 13:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:44 INFO - 'MOZ_NO_REMOTE': '1', 13:33:44 INFO - 'NO_EM_RESTART': '1', 13:33:44 INFO - 'PAGER': '/bin/cat', 13:33:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:44 INFO - 'PWD': '/builds/slave/test', 13:33:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:44 INFO - 'SHELL': '/bin/bash', 13:33:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vBaoEWvoye/Listeners', 13:33:44 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 13:33:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:44 INFO - 'USER': 'cltbld', 13:33:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:44 INFO - 'XPC_FLAGS': '0x0', 13:33:44 INFO - 'XPC_SERVICE_NAME': '0', 13:33:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:33:44 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-JBG7Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:33:44 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)) 13:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:33:44 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-qE3wG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:33:44 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)) 13:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:33:44 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-LjyvTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:33:44 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)) 13:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:33:44 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-wgHDzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:33:44 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)) 13:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:33:44 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-AjNlbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:33:44 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)) 13:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:33:44 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-zIyKz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:33:45 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)) 13:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:33:45 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-HScnNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:33:45 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)) 13:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:33:45 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-eoy7nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:33:45 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)) 13:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:33:45 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-2SknMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:33:45 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)) 13:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:33:45 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-FdH6Eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:33:45 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)) 13:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:33:45 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-xgC7lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:33:45 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)) 13:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:33:45 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-WXJiqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:33:45 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)) 13:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:33:45 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-xL9B76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:33:45 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)) 13:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:33:45 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-A3vjnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:33:45 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)) 13:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:45 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-NbdlFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:33:45 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)) 13:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:33:45 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-oK19Dq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:33:46 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)) 13:33:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:33:46 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-gQcKVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:33:46 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)) 13:33:46 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)) 13:33:46 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)) 13:33:46 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)) 13:33:46 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)) 13:33:46 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)) 13:33:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:33:46 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 13:33:46 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 13:33:46 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 13:33:46 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 13:33:46 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 13:33:46 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 13:33:48 INFO - Downloading blessings-1.6.tar.gz 13:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:33:48 INFO - Installing collected packages: blessings 13:33:48 INFO - Running setup.py install for blessings 13:33:48 INFO - Successfully installed blessings 13:33:48 INFO - Cleaning up... 13:33:48 INFO - Return code: 0 13:33:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:33:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:33:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:33:49 INFO - Reading from file tmpfile_stdout 13:33:49 INFO - Current package versions: 13:33:49 INFO - blessings == 1.6 13:33:49 INFO - blobuploader == 1.2.4 13:33:49 INFO - docopt == 0.6.1 13:33:49 INFO - functools32 == 3.2.3-2 13:33:49 INFO - jsonschema == 2.5.1 13:33:49 INFO - manifestparser == 1.1 13:33:49 INFO - mozInstall == 1.12 13:33:49 INFO - mozcrash == 0.17 13:33:49 INFO - mozdebug == 0.1 13:33:49 INFO - mozdevice == 0.48 13:33:49 INFO - mozfile == 1.2 13:33:49 INFO - mozhttpd == 0.7 13:33:49 INFO - mozinfo == 0.9 13:33:49 INFO - mozleak == 0.1 13:33:49 INFO - mozlog == 3.3 13:33:49 INFO - moznetwork == 0.27 13:33:49 INFO - mozprocess == 0.23 13:33:49 INFO - mozprofile == 0.28 13:33:49 INFO - mozrunner == 6.12 13:33:49 INFO - mozscreenshot == 0.1 13:33:49 INFO - mozsystemmonitor == 0.3 13:33:49 INFO - moztest == 0.7 13:33:49 INFO - mozversion == 1.4 13:33:49 INFO - psutil == 3.1.1 13:33:49 INFO - requests == 1.2.3 13:33:49 INFO - wsgiref == 0.1.2 13:33:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:49 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 0x108b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b98618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8230c95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a67d30>, '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 0x1087ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fb20>, '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.iv7QWjsiwa/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.vBaoEWvoye/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 13:33:49 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 13:33:49 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 13:33:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv7QWjsiwa/Render', 13:33:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:49 INFO - 'HOME': '/Users/cltbld', 13:33:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:49 INFO - 'LOGNAME': 'cltbld', 13:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:49 INFO - 'MOZ_NO_REMOTE': '1', 13:33:49 INFO - 'NO_EM_RESTART': '1', 13:33:49 INFO - 'PAGER': '/bin/cat', 13:33:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:49 INFO - 'PWD': '/builds/slave/test', 13:33:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:49 INFO - 'SHELL': '/bin/bash', 13:33:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vBaoEWvoye/Listeners', 13:33:49 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 13:33:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:49 INFO - 'USER': 'cltbld', 13:33:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:49 INFO - 'XPC_FLAGS': '0x0', 13:33:49 INFO - 'XPC_SERVICE_NAME': '0', 13:33:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:49 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)) 13:33:49 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)) 13:33:49 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)) 13:33:49 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)) 13:33:49 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)) 13:33:49 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)) 13:33:49 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)) 13:33:49 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)) 13:33:49 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)) 13:33:49 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)) 13:33:49 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)) 13:33:49 INFO - Cleaning up... 13:33:49 INFO - Return code: 0 13:33:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:33: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')]} 13:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33: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')]} 13:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:33:49 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 0x108b03a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108b98618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8230c95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a67d30>, '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 0x1087ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fb20>, '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.iv7QWjsiwa/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.vBaoEWvoye/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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 13:33:49 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 13:33:49 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 13:33:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv7QWjsiwa/Render', 13:33:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:33:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:33:49 INFO - 'HOME': '/Users/cltbld', 13:33:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:33:49 INFO - 'LOGNAME': 'cltbld', 13:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:33:49 INFO - 'MOZ_NO_REMOTE': '1', 13:33:49 INFO - 'NO_EM_RESTART': '1', 13:33:49 INFO - 'PAGER': '/bin/cat', 13:33:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:33:49 INFO - 'PWD': '/builds/slave/test', 13:33:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:33:49 INFO - 'SHELL': '/bin/bash', 13:33:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vBaoEWvoye/Listeners', 13:33:49 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 13:33:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:33:49 INFO - 'USER': 'cltbld', 13:33:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:33:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:33:49 INFO - 'XPC_FLAGS': '0x0', 13:33:49 INFO - 'XPC_SERVICE_NAME': '0', 13:33:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:33:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:33:50 INFO - Cleaning up... 13:33:50 INFO - Return code: 0 13:33:50 INFO - Running post-action listener: _resource_record_post_action 13:33:50 INFO - Running post-action listener: _start_resource_monitoring 13:33:50 INFO - Starting resource monitoring. 13:33:50 INFO - [mozharness: 2016-08-30 20:33:50.184568Z] Finished create-virtualenv step (success) 13:33:50 INFO - [mozharness: 2016-08-30 20:33:50.185556Z] Running install step. 13:33:50 INFO - Running pre-action listener: _resource_record_pre_action 13:33:50 INFO - Running main action method: install 13:33:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:33:50 INFO - Reading from file tmpfile_stdout 13:33:50 INFO - Detecting whether we're running mozinstall >=1.0... 13:33:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:33:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:33:50 INFO - Reading from file tmpfile_stdout 13:33:50 INFO - Output received: 13:33:50 INFO - Usage: mozinstall [options] installer 13:33:50 INFO - Options: 13:33:50 INFO - -h, --help show this help message and exit 13:33:50 INFO - -d DEST, --destination=DEST 13:33:50 INFO - Directory to install application into. [default: 13:33:50 INFO - "/builds/slave/test"] 13:33:50 INFO - --app=APP Application being installed. [default: firefox] 13:33:50 INFO - mkdir: /builds/slave/test/build/application 13:33:50 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'] 13:33:50 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 13:34:24 INFO - Reading from file tmpfile_stdout 13:34:24 INFO - Output received: 13:34:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:34:24 INFO - Running post-action listener: _resource_record_post_action 13:34:24 INFO - [mozharness: 2016-08-30 20:34:24.834634Z] Finished install step (success) 13:34:24 INFO - [mozharness: 2016-08-30 20:34:24.834809Z] Running run-tests step. 13:34:24 INFO - Running pre-action listener: _resource_record_pre_action 13:34:24 INFO - Running main action method: run_tests 13:34:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:34:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:34:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:34:24 INFO - 2016-08-30 13:34:24.849 screenresolution[1632:7387] starting screenresolution argv=screenresolution get 13:34:24 INFO - 2016-08-30 13:34:24.852 screenresolution[1632:7387] Display 0: 1600x1200x32@60 13:34:24 INFO - 2016-08-30 13:34:24.858 screenresolution[1633:7389] starting screenresolution argv=screenresolution list 13:34:24 INFO - Available Modes on Display 0 13:34:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:34:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:34:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:34:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:34:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:34:25 INFO - Intel Iris: 13:34:25 INFO - Chipset Model: Intel Iris 13:34:25 INFO - Type: GPU 13:34:25 INFO - Bus: Built-In 13:34:25 INFO - VRAM (Dynamic, Max): 1536 MB 13:34:25 INFO - Vendor: Intel (0x8086) 13:34:25 INFO - Device ID: 0x0a2e 13:34:25 INFO - Revision ID: 0x0009 13:34:25 INFO - Displays: 13:34:25 INFO - Display: 13:34:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:34:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:34:25 INFO - Display Serial Number: 1600x1200 60 13:34:25 INFO - Main Display: Yes 13:34:25 INFO - Mirror: Off 13:34:25 INFO - Online: Yes 13:34:25 INFO - Rotation: Supported 13:34:25 INFO - Return code: 0 13:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:34:25 INFO - Python 2.7.3 13:34:25 INFO - Return code: 0 13:34:25 INFO - grabbing minidump binary from tooltool 13:34:25 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')]} 13:34:25 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 0x108a67d30>, '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 0x1087ccdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a5fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:34:25 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 13:34:25 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 13:34:25 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 13:34:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:34:25 INFO - Return code: 0 13:34:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:34:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:34:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:34:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:34:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0124 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:34:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iv7QWjsiwa/Render', 13:34:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:34:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:34:25 INFO - 'HOME': '/Users/cltbld', 13:34:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:34:25 INFO - 'LOGNAME': 'cltbld', 13:34:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:34:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:34:25 INFO - 'MOZ_NO_REMOTE': '1', 13:34:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:34:25 INFO - 'NO_EM_RESTART': '1', 13:34:25 INFO - 'PAGER': '/bin/cat', 13:34:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:34:25 INFO - 'PWD': '/builds/slave/test', 13:34:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:34:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:34:25 INFO - 'SHELL': '/bin/bash', 13:34:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vBaoEWvoye/Listeners', 13:34:25 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 13:34:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:34:25 INFO - 'USER': 'cltbld', 13:34:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:34:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:34:25 INFO - 'XPC_FLAGS': '0x0', 13:34:25 INFO - 'XPC_SERVICE_NAME': '0', 13:34:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:34:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:34:25 INFO - mozversion application_buildid: 20160830105821 13:34:25 INFO - mozversion application_changeset: 2fdf533335f70653529001917f44804c8966ffff 13:34:25 INFO - mozversion application_display_name: Nightly 13:34:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:34:25 INFO - mozversion application_name: Firefox 13:34:25 INFO - mozversion application_remotingname: firefox 13:34:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 13:34:25 INFO - mozversion application_vendor: Mozilla 13:34:25 INFO - mozversion application_version: 51.0a1 13:34:25 INFO - mozversion platform_buildid: 20160830105821 13:34:25 INFO - mozversion platform_changeset: 2fdf533335f70653529001917f44804c8966ffff 13:34:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 13:34:25 INFO - mozversion platform_version: 51.0a1 13:34:25 INFO - using testdate: 1472589265 13:34:25 INFO - actual date: 1472589265 13:34:25 INFO - starting webserver on 'localhost:49262' 13:34:25 INFO - SUITE-START | Running 2 tests 13:34:25 INFO - TEST-START | dromaeo_css 13:34:25 INFO - operating with platform_type : mac_ 13:34:25 INFO - Initialising browser for dromaeo_css test... 13:34:25 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpkuQxvX/profile http://localhost:49262/getInfo.html) 13:34:28 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 13:34:28 INFO - PROCESS | 1643 | colorDepth:24 13:34:28 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 13:34:28 INFO - PROCESS | 1643 | __metrics 13:34:28 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 13:34:29 INFO - TEST-INFO | 1643: exit 0 13:34:29 INFO - Browser initialized. 13:34:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:34:29 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpkuQxvX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:34:41 INFO - PROCESS | 1646 | RSS: Main: 243888128 13:34:41 INFO - PROCESS | 1646 | 13:35:30 INFO - PROCESS | 1646 | 1472589330823 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:37:42 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49262/tests/dromaeo/cssquery-ext.html) 13:37:44 INFO - PROCESS | 1646 | RSS: Main: 266493952 13:37:44 INFO - PROCESS | 1646 | 13:40:46 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-ext.html (next: http://localhost:49262/tests/dromaeo/cssquery-jquery.html) 13:40:47 INFO - PROCESS | 1646 | RSS: Main: 272814080 13:40:47 INFO - PROCESS | 1646 | 13:43:48 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49262/tests/dromaeo/cssquery-mootools.html) 13:43:49 INFO - PROCESS | 1646 | RSS: Main: 275308544 13:43:49 INFO - PROCESS | 1646 | 13:46:51 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49262/tests/dromaeo/cssquery-prototype.html) 13:46:51 INFO - PROCESS | 1646 | RSS: Main: 270479360 13:46:51 INFO - PROCESS | 1646 | 13:49:54 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49262/tests/dromaeo/cssquery-yui.html) 13:49:55 INFO - PROCESS | 1646 | RSS: Main: 275693568 13:49:55 INFO - PROCESS | 1646 | 13:52:58 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49262/tests/dromaeo/cssquery-yui.html (next: http://localhost:49262/tests/dromaeo/cssquery-dojo.html) 13:52:58 INFO - PROCESS | 1646 | RSS: Main: 277942272 13:52:58 INFO - PROCESS | 1646 | 13:52:58 INFO - PROCESS | 1646 | __start_tp_report 13:52:58 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 13:52:58 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 13:52:58 INFO - PROCESS | 1646 | |i|pagename|runs| 13:52:58 INFO - PROCESS | 1646 | |0;dojo.html;3368.107451525346;3389.4407422775244;3403.8767206821753;3422.0418282880787;3446.190145315851;5633.492985631292;5664.40523745006;5707.172459993304;5717.599768016241;5791.044477661191;5690.914636280449;5753.827385178441;5781.855453613662;5784.623999440044;5891.293044834626;4657.347971284023;4960.107180707471;5187.429382767911;5259.947400525984;5385.084535628953;5331.946680533184;5356.9732151339185;5385.434529374418;5415;5418.810341638044;5144.279800827887;5231.476852314776;5262.158054711228;5282.577393808525;5315.495027972336;5057.721825299607;5240.79036838526;5251.028559716427;5270.49930256625;5319.228711836762;4295.828166873322;5215.6349055566125;5242.449542797989;5244.5542128918705;5245.895082098375;4827.493113223096;5540.445955404468;5681.204631351614;5793.652380857162;5805.158252053428;6228.750849965996;6237.220347456568;6275.309715931244;6282.089097080898;6311.779087731953;6254.437100660963;6279.529035322369;6287.182666253358;6298.968505157445;6313.621182729005;5729.255196824386;5790.507806836382;5889.204957330749;5893.703385255237;5895.823125306248;6338.746450141943;6351.587146835441;6353.110564520971;6362.331955144736;6369.458596019297;6136;6184.536159787944;6212.844678882973;6217;6220.440160385587;6112.898653789679;6175.62946223228;6189.164462797555;6272.968635156795;6292;5183.766730497061;6258.780942666985;6261;6297.27581328144;6300.747970081237;5024.32171656829;5841.1238314253205;6216.191895053705;6260.280067792171;6268.153799237045;4853.102176097434;4903.338049363361;4948.356713627206;4952.579030782352;4972.129877271463;4446.244138496463;4453.688241823106;4459.10817836434;4462.397576327219;4503;5744;5820.301563812285;5836.1245813127525;5869.4717475427415;5872.941270587239;6132.264128304632;6212.689365531705;6222.408871157233;6265.749370025239;6271.372862713783;5813.6221145625395;5858.970705146447;5875.089361149029;5875.294964604275;5902.58681892272;4525.683202175882;5461.0716178249795;5461.590380721462;5470.91793623096;5483.75323110461;6218.751249950042;6265.655388953652;6305.4009869062365;6335.239771227482;6447.387498187664;6230.376962303733;6260.74957001733;6282.497400207881;6293.653849038347;6298.1812364392335;6358.332375100733;6361.077643741539;6364.4908407326375;6369.172007638977;6373.681315934277;6097.969510152421;6133.028644417115;6171.722272497658;6183;6202.81391558254;6215.9378406215355;6258.217722784652;6284.622922624657;6297.527685423704;6311.147995020797;6171.876562468636;6224.595401298901;6224.751009959551;6231.283402408781;6238;4733.857984260478;5909.409059094056;6013.5189184865985;6096.390360963868;6191.938080619136;5893.5874488787085;5966.3735307793795;6047.365026672136;6053.757849685963;6073.878522429615;6099.176611157437;6142.14010038586;6143.078538219303;6200.875982480416;6203.534734894991;5885.293764748258;6040.9730345840435;6048.576599637983;6055.576109672281;6063.242094738158 13:52:58 INFO - PROCESS | 1646 | |1;ext.html;453.9182947069526;469.96372997540425;477.41993477924314;521.2754271562528;545.430025623224;36623.450648240265;41719.374209386886;41768.164636707246;41838.74483765492;41931;42895.14209715804;43415.99999999992;43437.7828110859;43457.78271108648;43602.563974360324;9099.727008189731;9123.270138388913;9710.368826026302;9977.650782222623;9985.251106167067;9742.415455072683;9828.312018158731;9882.752931176743;9883.308168428213;9917.603295868194;9827.901720982805;9877.407355558653;9877.901220987806;9878.703638890845;9912.405255684645;9794.6082156714;9817.361871478366;9818.65634702782;9841.065098815601;9852.42361222201;9825.1157395834;9842.311038227326;9918.3057185997;9918.3553069051;9935.801283974351;40415.797921010504;41145.38281925744;41173;41364.58635413637;41484.96287592804;3403.064157356722;3421.1105112670634;3423.828808559587;3432.3821712091813;3462.3248466549035;30662.84668576665;31231.219219519466;31241.53137702936;31699;32026.199345016328;3211.1811488070393;3231.418344697953;3235.3205826776407;3265.2000259936467;3331.5002749587516;477122;479598;482844;483294;484557;62031;62518.74962500724;62985.685071575266;63045.68477157585;63088.684556576925;34606.30787384238;35379.469307960404;35594.64405355965;36308.00305983143;65569.67215163894;16813.243404046847;16980.660386792442;17019.063951482538;17034.74447883283;17075;11266.605668801552;12341.876581234252;12910;12918.41867115982;13001.674958126123;16709.331626734795;18535.35126270574;18699.22357376047;19261.266486016044;19517.024148792505;7445;7494.288042635941;7651.69393224276;7759.961200193963;7761.146273909865;708.9790701389982;868.5396739727954;949.4920217683645;1063.8723353197665;1106.751683808026;25592.16225096304;30893;31120.844395778327;31360.68639313623;31388.686113139032;1092.355510248957;1100.805625895896;1116.8827273136367;1175.5826681528106;1204.873488283735;14537.418503259963;15417.845821541865;15969.68060638804;15977.68044639124;16215.729977711217;179792.20207797753;182611;183067;183163;183737;58846.41153588495;58887.70556147192;59267.70366148141;59449.40550594525;59936;1314.415085287038;1325.2181213084327;1362.8228330316995;1367.9931600342134;1368.8973327000515;24059.278221653378;29337.55993660054;30452.23869403194;30523.2369190772;32211.838940805144;38474.6152538471;41755.58244417517;43156.70529884109;51429.742851285504;53119;549961;554467;554497;555653.2217338887;557191;22055.66916496286;27152.592711108955;27423;27516.449671006867;27564;38318.80840595779;47219;47566.76216618895;47623.5237647633;48552.02895942132;32717;36527.99096049636;37471;40420.595794042856;41846.37230441485;40210.39684404678;40738.1852362957;41306;41584;41920.580794191665;38365.23269534538;38929.221415572094;39583.80208098941;39816.40275395929;39882;33994.15014624654;35478;35685.82157089198;35776;36019.91940241797;25893.48213035691;26193;26315.73684263133;26443.86778066174;26508 13:52:58 INFO - PROCESS | 1646 | |2;jquery.html;292.71021688528356;337.66739761335094;341.9504171895075;361.5570925616121;368.44916849310266;19732.70400943987;19990.900045499788;20956.476088097785;21234.46913827155;21251;20185.77956424792;20592.588148237028;20986.845723485203;21021.36935891922;21142.942852857374;5448.346198456191;5498.367687715914;5691.260136182291;5696.401877802833;5696.601237913348;5460.945390546103;5618.775248990056;5621.325440947092;5623.297087864017;5631.8592035199035;5603.047481928062;5604.523615492688;5609.382967873531;5617.466340697627;5691.715414229272;6024.1566180734735;6049.879002419927;6164.445199932027;6169.290531588857;6190.752369905198;5183.403908550527;5281.102212623825;5335.973320133413;5394.514493695587;5431;20862.5827483451;25750.969961201718;26050;26260.949562017497;26710.86644566784;2073.40907841266;2127.287358734826;2166.784607257843;2380.47629521505;2394.772496612819;9860.802783944353;10203.94898025505;10211.132053775438;10326.7418314542;10411.167106631452;1531.9770203446958;1641.6880792649479;1754.5437287051716;1820.836124748779;1964.3615824856836;87954;93578;112419;118471;132184.33907830497;9340;10253.641122560824;10556.313839600401;11699.707507312385;11795.41022948849;12120.939395303143;14494.550544945421;14638.853611463963;14645.707085858223;14716.484923027643;7216.7113315466795;8458.957705211558;8700.173483519056;8777.51723655205;8894.955525222462;8718.215360617574;8782.912170878337;8798.340124490689;8923.196912277926;8955.552222388986;3719.386301260316;4439.578240067189;4496.482904465963;4528.524504926935;4561.087782443525;1906.2470324221854;1909.8663093583316;1929.922803087889;1948.814862588052;1978.3075923426686;765.8162041110205;806.6329819931917;988.5452691761726;990.6881266176782;1015.4871789746131;16927.915360423118;21220.681689774665;21748.782512174676;21822.563548728936;21972.340829775134;754.7886591754318;939.7039932421266;945.9574319155655;952.61419125253;969.5782334684435;8153;8955.686550970815;11192.944035279934;11516.424178791027;11516.905893940062;543832;554246;558014;566557;571670;99496;134486.32756836154;135787;136364;138552;954.1317401165045;968.1577027985556;998.4658207858761;1000.6197644895038;1000.7248006798043;19392.806071939664;19573.510662232988;19583.60832783365;19622.509437264183;19683.409497715093;51809.740951295;51865.7406712964;51893.96212075813;51910.740446297525;52936;67837.66081169562;75835;78606;79291;80640;7041.964790176016;7368.889466657897;7432.479726419315;7946.562939038408;8362.581870906308;13229.80155297652;13343.532976345781;13444.46222151103;13689.315534223448;13832.792508112587;11439.256448330832;11464.4267786612;11636.592719255124;11696.298222106701;11766.764664706829;11335.546578137111;11401.714957125807;11715.707107322385;11745.588904388305;11792.469338879942;10985.725356865823;11722.94138529302;11966.22219555726;11968.341741204318;12085.395730213279;7315.268473152642;7527.6988920444755;7535.73624923125;7660.93154848199;7688.961990131261;10284.640037598649;10505;10915.399653018843;11578.594749183738;11795.941020294844 13:52:58 INFO - PROCESS | 1646 | |3;mootools.html;1184.2894263441935;1191.8617720077327;1584.3820909845163;1732.7227643577023;1870.279942222244;8016.398770092252;8576.271016963557;8712.73861784146;9148.313876459275;9168.220701240394;8757.91242087579;8978.102189781019;9001.234895033913;9027.729168124966;9049.909500904989;2370.928872133839;2402.2072716003677;2407.0251548123038;2407.0612461140167;2409.0484258717797;2375.2517956843626;2402.1352313167245;2408.6387041943763;2420.6732091167733;2422.8061755059553;2387.55830171418;2388.8088952883813;2396.993262829607;2398.412388964706;2413.4328432818274;2365.44412063165;2380.8571485710827;2391.270662447953;2392.868392238426;2402.5915594349003;1929.7105434184843;2295.7589453107516;2317.9188728394424;2318.7681231876845;2331.4870728439714;8969.14793094655;8979.416337938079;8982.416142950753;9025.684101056431;9050.275977921816;5227.686338819683;5366.9463305366835;5410.648307859977;5427.317531565227;5432.1580155075635;3629.1834337274167;3648.671619554253;3671.3575124353397;3709.9629003710156;3718.6467285607823;1110.2561283939779;1111.0889070961814;1113.87190473095;1118.2619471149003;1123.584273818684;11618.94190529042;11731.882681173165;11789.58736444229;11789.646310610695;11800.704982375424;4579.885502862455;4692.249240121564;4848.466668666444;4872.220444728897;4878.853634390974;8670.696525621574;9575.377600455948;9968.800623987625;9978.501074946224;10001.849972250422;5304.204369344552;5346.705931173745;5367.624266301322;5384.353877534721;5386.13821788512;4390.670699697472;4725.716457012591;4840.201366774513;4884.169691152512;4903.362562866804;3573.5711714594413;3903.8048097595006;4001.099752555652;4052.49343832021;4104.281750693616;1313.934303284832;1320.6236222676491;1322.8081928120369;1323.245749922554;1325.7613629546775;798.0503201190564;864.6368525219423;930.2697382554798;934.3179478980383;945.8533927241289;5651.689157096399;5926;6045.969770151121;6113.877722445526;6219.906701399483;442;446.8078726147723;447.25531989238203;453.9659525535598;465.2393336894202;3926.547177544327;4026.416169655384;4094.549599544048;4101.118259574206;4263.531011588722;10909.727256818644;10974.780504390028;11074.944625276983;11083;11116.61091861781;11017.83473247902;11041.061509771598;11047.060999814945;11050.778984420427;11064;8077.7576672699915;8140.430169888169;8232.62953167109;8288.958555207306;8359.205875441701;4923.876903077452;5998.220231369894;6153.692315384303;6212.596181248205;6267.122602835698;7431.739889103856;7936.6428510718315;8434.873476897728;10127.949360253446;10177.033181847713;8621.482711037357;9825.656102036395;10149.746256343651;10279.691609251735;10340.224483163642;6577.539572230089;7474.887876681963;7547.622618869144;7631.732889348847;7641;8263.173682631688;8341.708040218564;8353.540555269276;8362.205590468895;8412;7476.364509016795;7509.66206520697;7535.58554279498;7597.6581053853815;7735.806604834924;7289.161746399232;7322.267773222635;7346.59593722329;7374.557526548424;7490.913817496324;6922.653867306715;6946.340097690711;7032.648367581703;7042.647867606702;7060.858782824417;4670.859874203779;4933.421305182307;5127.53852153308;5137.280780690781;5149.0474262261605;5088.796448142033;5096.949030509648;5191.402988656353;5204.765785539584;5265.104932161618 13:52:58 INFO - PROCESS | 1646 | |4;prototype.html;247.71512760325624;258.6249937590493;296.4116229284869;308.7545401405883;310.34981713310606;5462.672239665623;5546.750396232169;5652.547796176306;5738.913916291253;5781.369476888011;5421.593380496469;5531.446855314466;5534.596223322657;5547.833564993047;5583.804566840161;4047.291723948312;4206.179794939981;4217.683673724468;4222.894427639303;4267.807948642303;3527.6119626841028;3842.058695619577;4005.9799701001452;4146.357314616239;4183.100633363826;3523.5511319632865;4026.375911733686;4189.183109293689;4211.831526738927;4212.599803018708;3463.29002554477;4020.075382661975;4209.5790420957965;4211.789410529492;4212.831486740527;3525.4183059795105;3700.5937743657237;3726.5155529781227;3727.7949712765785;3744.494493243432;5301.125314323132;5429.782808687648;5441.014029879105;5455.581548797301;5460.645058071253;3993.0416699991792;4838.903221935577;4845.394325709286;4864.659473836833;4880.731559764212;5534.861628459281;5610.915836262459;5915.822525324247;5928.822135335947;5989.520838332923;3528.1477224457108;3762.4168253920684;3805.46723458716;4035.535913369941;4049.311617025113;5130.53825155734;5408.675479471244;6240.1263823064355;6258.4014191839415;6269.686515674198;3241.497567876983;3541.8052007139854;3820.675242604354;4143.990164770084;4160.375943608423;3290.983545082307;4215.78921053946;4217.768022758716;4244.448221731155;4271.765052922119;4909.993451342466;4925.13810083234;4927.704337739747;4938.209886418156;4945.23348880924;4870.829520966749;5860.150278209636;6044.760824031151;6116.48009919153;6139.263288405331;1221.1451983611507;1381.9654508637364;1419.6025112968384;1434.6413396650837;1445.197915157077;955.7371722776293;966.9758256043515;987.5062468765617;988.2588058955783;990.6631745206664;5390.191471279261;5484.489926447077;5512.070775228638;5513.365962914316;5546.195801608744;5118.692878427306;6080.726367313481;6093.908591371133;6108.694565271719;6133.515926049957;4545.772711364419;5212.530872221442;5440.483154100354;5506.614536982373;5520.641158324696;2345.970735313975;2415.4565222825076;2706.376174295446;2723.169433322816;2738.5755207942802;4404.7357158570585;5293.57651387888;5294.523492885659;5345.1447768356875;5349.438308977579;4585.747783871919;4762.4285085789925;5011.223260394645;5277.261183434322;5301.787928482818;5121.615878809104;5171.948280517222;5268.894622107537;5344.706041167696;5367.430658611979;4431.98064445173;4971.693823607261;5049.626675462527;5120.667156634807;5167.715775632376;4239.587132358358;4537.666528465374;4568.588827005586;4807.005092886413;5092.796288148433;4636.6058884995155;5380.058489764354;5389.51494365509;5413.998410294108;5438.607012914305;3276.672332766704;3538.5399898013093;3660.8834305537066;3682.429223470366;3697.556293244828;4209.831606735819;4228.873133805991;4836.975815120902;5066.746662666778;5193.636445448782;5013.866333541537;5027.32131162303;5031.496850314939;5043.899122017612;5082.1106306395495;4408.977955110204;4544.318352247189;4782.378290822171;4965.939135258972;5028.472010438852;4028.5165780106577;4483.843065492692;4561.009117022605;4898.608111351155;4974.751262436791;4389.4321821733365;4469.5530446955045;4575.124199078362;4957.82647607332;5007.1487847065355;4211.410402543585;4215.747055176699;4249.32010878258;4306.956930430781;4943.319271447581 13:52:58 INFO - PROCESS | 1646 | |5;yui.html;627.7081157261874;716.9103862017248;724.2359310926973;726.1286456252495;808.1474044882654;15218.010829296089;15724.60688482787;15932.44236451723;17027.978321300732;17700.734488982675;16335.83664163358;16494.17529123542;16661.416850410238;16668.249928753205;16677.499675009738;856.9828603427927;871.263782104121;873.9737807865743;875.7504111328273;876.1326286975911;695.9060526828889;715.5313269808258;770.9768706938772;836.5148214035845;853.1979938857485;766.9539827610333;866.995665021674;877.4384393987852;901.4411065139623;923.2798417234568;902.5036230073433;912.5163663258484;913.1462082952461;915.0209276074603;915.9313051521096;659.3077268867718;680.4216416046371;680.6630717794724;680.7311112110689;680.938715515606;15392.230388480531;15416.691666166726;15426.3829446822;15455.92272038644;15472.845271547252;12816.974642028616;13050.673733156653;14257.572272831832;14333;14402.423903043971;11898.821517677155;11942.820857687142;12011.579594714143;12075;12280.754384912341;3358.236925614048;3614.8915532534065;3781.546214454283;3804.5054142961517;3941.1526521797664;65968.68062638768;86686;90273.54863225708;98871.01128988763;107227.46386268096;11034.889651103385;11064.336139831636;11074.889251107546;11096.223264371416;11298.943505282585;21454.57090858174;21567.67648485274;21781.782182178293;21848.89075554644;21892;8008.039035315799;8076.8384632307025;8154.306883914934;8155.877661835078;8275.917240827635;4457.77711114443;4522.525134860858;4524.864254072383;4541.750203738826;4593.931091033637;3587.0494319005484;3668.248009158116;3693.9841543575194;3717.7583457075743;3736.215394767075;632.4750457120579;679.8266442057244;686.5503095472474;693.784926672733;698.664640972326;514.6731825290892;531.3968645587287;565.5588640860136;591.3583761618606;664.2361284522838;7837.333826624801;8278.296344810638;9371.765705857408;9425.670101546413;9607.471589062528;625.2150111431797;666.6000399760105;668.391763495217;672.3377473188905;687.4466054825913;4614.554286228305;4963.219793356253;5119.360079990001;5152.948470515322;5230.7384630769075;156917.2154139222;159446;160645;161515;167228.1638591799;139606;140643;142408;142599;142995;73264.26735732681;73570.89643655349;76356.61821690857;82062.9999999988;94204;9861.556229969525;9899.267628164898;9991.650292239738;10013.499325033574;10021.599136034478;41292.587074128875;54818.90362192654;55596.44403555913;56414.15378769404;57464.71267643635;87391.56304218438;88481;88842;89382;90856;12916.870831291566;13048.217106973612;13244.933775331447;13284.734305313646;14023.615985282322;13418.329083545588;14562.490312839;15093.24533773285;15150.3182356792;15237.847621523642;13865.376058077209;14073.085249458753;14164.645883852987;14361.928190358982;14558.636034099232;11070.501827417624;13811;13894.583162505141;14211.857881421467;14539.8313962188;13585.86414135846;13609.52366667162;13874.861251387358;14149.36327865228;14271.928640356731;10893.891061089287;11035.668929932115;11049.613263535737;11174.106071514421;11414.201005929504;9449.905500944902;9747.805043899225;9824.901750982399;9967.950160249153;11634.301941883514 13:52:58 INFO - PROCESS | 1646 | __end_tp_report 13:52:58 INFO - PROCESS | 1646 | __start_cc_report 13:52:58 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,377 13:52:58 INFO - PROCESS | 1646 | __end_cc_report 13:52:58 INFO - PROCESS | 1646 | __startTimestamp1472590378455__endTimestamp 13:52:58 INFO - PROCESS | 1646 | 13:52:58 INFO - PROCESS | 1646 | ------- Summary: start ------- 13:52:58 INFO - PROCESS | 1646 | Number of tests: 6 13:52:58 INFO - PROCESS | 1646 | 13:52:58 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5748.74 Median:5966.37 stddev:666.60 (11.2%) stddev-sans-first:641.95 13:52:58 INFO - PROCESS | 1646 | Values: 3368.1 3389.4 3403.9 3422.0 3446.2 5633.5 5664.4 5707.2 5717.6 5791.0 5690.9 5753.8 5781.9 5784.6 5891.3 4657.3 4960.1 5187.4 5259.9 5385.1 5331.9 5357.0 5385.4 5415.0 5418.8 5144.3 5231.5 5262.2 5282.6 5315.5 5057.7 5240.8 5251.0 5270.5 5319.2 4295.8 5215.6 5242.4 5244.6 5245.9 4827.5 5540.4 5681.2 5793.7 5805.2 6228.8 6237.2 6275.3 6282.1 6311.8 6254.4 6279.5 6287.2 6299.0 6313.6 5729.3 5790.5 5889.2 5893.7 5895.8 6338.7 6351.6 6353.1 6362.3 6369.5 6136.0 6184.5 6212.8 6217.0 6220.4 6112.9 6175.6 6189.2 6273.0 6292.0 5183.8 6258.8 6261.0 6297.3 6300.7 5024.3 5841.1 6216.2 6260.3 6268.2 4853.1 4903.3 4948.4 4952.6 4972.1 4446.2 4453.7 4459.1 4462.4 4503.0 5744.0 5820.3 5836.1 5869.5 5872.9 6132.3 6212.7 6222.4 6265.7 6271.4 5813.6 5859.0 5875.1 5875.3 5902.6 4525.7 5461.1 5461.6 5470.9 5483.8 6218.8 6265.7 6305.4 6335.2 6447.4 6230.4 6260.7 6282.5 6293.7 6298.2 6358.3 6361.1 6364.5 6369.2 6373.7 6098.0 6133.0 6171.7 6183.0 6202.8 6215.9 6258.2 6284.6 6297.5 6311.1 6171.9 6224.6 6224.8 6231.3 6238.0 4733.9 5909.4 6013.5 6096.4 6191.9 5893.6 5966.4 6047.4 6053.8 6073.9 6099.2 6142.1 6143.1 6200.9 6203.5 5885.3 6041.0 6048.6 6055.6 6063.2 13:52:58 INFO - PROCESS | 1646 | 13:52:58 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:56289.52 Median:39849.20 stddev:116853.89 (293.2%) stddev-sans-first:117106.50 13:52:58 INFO - PROCESS | 1646 | Values: 453.9 470.0 477.4 521.3 545.4 36623.5 41719.4 41768.2 41838.7 41931.0 42895.1 43416.0 43437.8 43457.8 43602.6 9099.7 9123.3 9710.4 9977.7 9985.3 9742.4 9828.3 9882.8 9883.3 9917.6 9827.9 9877.4 9877.9 9878.7 9912.4 9794.6 9817.4 9818.7 9841.1 9852.4 9825.1 9842.3 9918.3 9918.4 9935.8 40415.8 41145.4 41173.0 41364.6 41485.0 3403.1 3421.1 3423.8 3432.4 3462.3 30662.8 31231.2 31241.5 31699.0 32026.2 3211.2 3231.4 3235.3 3265.2 3331.5 477122.0 479598.0 482844.0 483294.0 484557.0 62031.0 62518.7 62985.7 63045.7 63088.7 34606.3 35379.5 35594.6 36308.0 65569.7 16813.2 16980.7 17019.1 17034.7 17075.0 11266.6 12341.9 12910.0 12918.4 13001.7 16709.3 18535.4 18699.2 19261.3 19517.0 7445.0 7494.3 7651.7 7760.0 7761.1 709.0 868.5 949.5 1063.9 1106.8 25592.2 30893.0 31120.8 31360.7 31388.7 1092.4 1100.8 1116.9 1175.6 1204.9 14537.4 15417.8 15969.7 15977.7 16215.7 179792.2 182611.0 183067.0 183163.0 183737.0 58846.4 58887.7 59267.7 59449.4 59936.0 1314.4 1325.2 1362.8 1368.0 1368.9 24059.3 29337.6 30452.2 30523.2 32211.8 38474.6 41755.6 43156.7 51429.7 53119.0 549961.0 554467.0 554497.0 555653.2 557191.0 22055.7 27152.6 27423.0 27516.4 27564.0 38318.8 47219.0 47566.8 47623.5 48552.0 32717.0 36528.0 37471.0 40420.6 41846.4 40210.4 40738.2 41306.0 41584.0 41920.6 38365.2 38929.2 39583.8 39816.4 39882.0 33994.2 35478.0 35685.8 35776.0 36019.9 25893.5 26193.0 26315.7 26443.9 26508.0 13:52:58 INFO - PROCESS | 1646 | 13:52:58 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:33638.57 Median:13501.79 stddev:93540.56 (692.8%) stddev-sans-first:93769.46 13:52:58 INFO - PROCESS | 1646 | Values: 292.7 337.7 342.0 361.6 368.4 19732.7 19990.9 20956.5 21234.5 21251.0 20185.8 20592.6 20986.8 21021.4 21142.9 5448.3 5498.4 5691.3 5696.4 5696.6 5460.9 5618.8 5621.3 5623.3 5631.9 5603.0 5604.5 5609.4 5617.5 5691.7 6024.2 6049.9 6164.4 6169.3 6190.8 5183.4 5281.1 5336.0 5394.5 5431.0 20862.6 25751.0 26050.0 26260.9 26710.9 2073.4 2127.3 2166.8 2380.5 2394.8 9860.8 10203.9 10211.1 10326.7 10411.2 1532.0 1641.7 1754.5 1820.8 1964.4 87954.0 93578.0 112419.0 118471.0 132184.3 9340.0 10253.6 10556.3 11699.7 11795.4 12120.9 14494.6 14638.9 14645.7 14716.5 7216.7 8459.0 8700.2 8777.5 8895.0 8718.2 8782.9 8798.3 8923.2 8955.6 3719.4 4439.6 4496.5 4528.5 4561.1 1906.2 1909.9 1929.9 1948.8 1978.3 765.8 806.6 988.5 990.7 1015.5 16927.9 21220.7 21748.8 21822.6 21972.3 754.8 939.7 946.0 952.6 969.6 8153.0 8955.7 11192.9 11516.4 11516.9 543832.0 554246.0 558014.0 566557.0 571670.0 99496.0 134486.3 135787.0 136364.0 138552.0 954.1 968.2 998.5 1000.6 1000.7 19392.8 19573.5 19583.6 19622.5 19683.4 51809.7 51865.7 51894.0 51910.7 52936.0 67837.7 75835.0 78606.0 79291.0 80640.0 7042.0 7368.9 7432.5 7946.6 8362.6 13229.8 13343.5 13444.5 13689.3 13832.8 11439.3 11464.4 11636.6 11696.3 11766.8 11335.5 11401.7 11715.7 11745.6 11792.5 10985.7 11722.9 11966.2 11968.3 12085.4 7315.3 7527.7 7535.7 7660.9 7689.0 10284.6 10505.0 10915.4 11578.6 11795.9 13:52:58 INFO - PROCESS | 1646 | 13:52:58 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5717.49 Median:4893.77 stddev:3216.49 (65.7%) stddev-sans-first:3207.46 13:52:58 INFO - PROCESS | 1646 | Values: 1184.3 1191.9 1584.4 1732.7 1870.3 8016.4 8576.3 8712.7 9148.3 9168.2 8757.9 8978.1 9001.2 9027.7 9049.9 2370.9 2402.2 2407.0 2407.1 2409.0 2375.3 2402.1 2408.6 2420.7 2422.8 2387.6 2388.8 2397.0 2398.4 2413.4 2365.4 2380.9 2391.3 2392.9 2402.6 1929.7 2295.8 2317.9 2318.8 2331.5 8969.1 8979.4 8982.4 9025.7 9050.3 5227.7 5366.9 5410.6 5427.3 5432.2 3629.2 3648.7 3671.4 3710.0 3718.6 1110.3 1111.1 1113.9 1118.3 1123.6 11618.9 11731.9 11789.6 11789.6 11800.7 4579.9 4692.2 4848.5 4872.2 4878.9 8670.7 9575.4 9968.8 9978.5 10001.8 5304.2 5346.7 5367.6 5384.4 5386.1 4390.7 4725.7 4840.2 4884.2 4903.4 3573.6 3903.8 4001.1 4052.5 4104.3 1313.9 1320.6 1322.8 1323.2 1325.8 798.1 864.6 930.3 934.3 945.9 5651.7 5926.0 6046.0 6113.9 6219.9 442.0 446.8 447.3 454.0 465.2 3926.5 4026.4 4094.5 4101.1 4263.5 10909.7 10974.8 11074.9 11083.0 11116.6 11017.8 11041.1 11047.1 11050.8 11064.0 8077.8 8140.4 8232.6 8289.0 8359.2 4923.9 5998.2 6153.7 6212.6 6267.1 7431.7 7936.6 8434.9 10127.9 10177.0 8621.5 9825.7 10149.7 10279.7 10340.2 6577.5 7474.9 7547.6 7631.7 7641.0 8263.2 8341.7 8353.5 8362.2 8412.0 7476.4 7509.7 7535.6 7597.7 7735.8 7289.2 7322.3 7346.6 7374.6 7490.9 6922.7 6946.3 7032.6 7042.6 7060.9 4670.9 4933.4 5127.5 5137.3 5149.0 5088.8 5096.9 5191.4 5204.8 5265.1 13:52:58 INFO - PROCESS | 1646 | 13:52:58 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4417.06 Median:4875.78 stddev:1336.58 (27.4%) stddev-sans-first:1303.18 13:52:58 INFO - PROCESS | 1646 | Values: 247.7 258.6 296.4 308.8 310.3 5462.7 5546.8 5652.5 5738.9 5781.4 5421.6 5531.4 5534.6 5547.8 5583.8 4047.3 4206.2 4217.7 4222.9 4267.8 3527.6 3842.1 4006.0 4146.4 4183.1 3523.6 4026.4 4189.2 4211.8 4212.6 3463.3 4020.1 4209.6 4211.8 4212.8 3525.4 3700.6 3726.5 3727.8 3744.5 5301.1 5429.8 5441.0 5455.6 5460.6 3993.0 4838.9 4845.4 4864.7 4880.7 5534.9 5610.9 5915.8 5928.8 5989.5 3528.1 3762.4 3805.5 4035.5 4049.3 5130.5 5408.7 6240.1 6258.4 6269.7 3241.5 3541.8 3820.7 4144.0 4160.4 3291.0 4215.8 4217.8 4244.4 4271.8 4910.0 4925.1 4927.7 4938.2 4945.2 4870.8 5860.2 6044.8 6116.5 6139.3 1221.1 1382.0 1419.6 1434.6 1445.2 955.7 967.0 987.5 988.3 990.7 5390.2 5484.5 5512.1 5513.4 5546.2 5118.7 6080.7 6093.9 6108.7 6133.5 4545.8 5212.5 5440.5 5506.6 5520.6 2346.0 2415.5 2706.4 2723.2 2738.6 4404.7 5293.6 5294.5 5345.1 5349.4 4585.7 4762.4 5011.2 5277.3 5301.8 5121.6 5171.9 5268.9 5344.7 5367.4 4432.0 4971.7 5049.6 5120.7 5167.7 4239.6 4537.7 4568.6 4807.0 5092.8 4636.6 5380.1 5389.5 5414.0 5438.6 3276.7 3538.5 3660.9 3682.4 3697.6 4209.8 4228.9 4837.0 5066.7 5193.6 5013.9 5027.3 5031.5 5043.9 5082.1 4409.0 4544.3 4782.4 4965.9 5028.5 4028.5 4483.8 4561.0 4898.6 4974.8 4389.4 4469.6 4575.1 4957.8 5007.1 4211.4 4215.7 4249.3 4307.0 4943.3 13:52:58 INFO - PROCESS | 1646 | 13:52:58 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:23974.01 Median:4490.15 stddev:38862.36 (865.5%) stddev-sans-first:38931.84 13:52:58 INFO - PROCESS | 1646 | Values: 627.7 716.9 724.2 726.1 808.1 15218.0 15724.6 15932.4 17028.0 17700.7 16335.8 16494.2 16661.4 16668.2 16677.5 857.0 871.3 874.0 875.8 876.1 695.9 715.5 771.0 836.5 853.2 767.0 867.0 877.4 901.4 923.3 902.5 912.5 913.1 915.0 915.9 659.3 680.4 680.7 680.7 680.9 15392.2 15416.7 15426.4 15455.9 15472.8 12817.0 13050.7 14257.6 14333.0 14402.4 11898.8 11942.8 12011.6 12075.0 12280.8 3358.2 3614.9 3781.5 3804.5 3941.2 65968.7 86686.0 90273.5 98871.0 107227.5 11034.9 11064.3 11074.9 11096.2 11298.9 21454.6 21567.7 21781.8 21848.9 21892.0 8008.0 8076.8 8154.3 8155.9 8275.9 4457.8 4522.5 4524.9 4541.8 4593.9 3587.0 3668.2 3694.0 3717.8 3736.2 632.5 679.8 686.6 693.8 698.7 514.7 531.4 565.6 591.4 664.2 7837.3 8278.3 9371.8 9425.7 9607.5 625.2 666.6 668.4 672.3 687.4 4614.6 4963.2 5119.4 5152.9 5230.7 156917.2 159446.0 160645.0 161515.0 167228.2 139606.0 140643.0 142408.0 142599.0 142995.0 73264.3 73570.9 76356.6 82063.0 94204.0 9861.6 9899.3 9991.7 10013.5 10021.6 41292.6 54818.9 55596.4 56414.2 57464.7 87391.6 88481.0 88842.0 89382.0 90856.0 12916.9 13048.2 13244.9 13284.7 14023.6 13418.3 14562.5 15093.2 15150.3 15237.8 13865.4 14073.1 14164.6 14361.9 14558.6 11070.5 13811.0 13894.6 14211.9 14539.8 13585.9 13609.5 13874.9 14149.4 14271.9 10893.9 11035.7 11049.6 11174.1 11414.2 9449.9 9747.8 9824.9 9968.0 11634.3 13:52:58 INFO - PROCESS | 1646 | -------- Summary: end -------- 13:52:58 INFO - PROCESS | 1646 | 13:52:59 INFO - TEST-INFO | 1646: exit 0 13:52:59 INFO - TEST-OK | dromaeo_css | took 1113688ms 13:52:59 INFO - TEST-START | kraken 13:52:59 INFO - operating with platform_type : mac_ 13:52:59 INFO - Initialising browser for kraken test... 13:52:59 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpYZmoQs/profile http://localhost:49262/getInfo.html) 13:53:01 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 13:53:01 INFO - PROCESS | 1657 | colorDepth:24 13:53:01 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 13:53:01 INFO - PROCESS | 1657 | __metrics 13:53:01 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2991: TypeError: this.tabs is undefined 13:53:02 INFO - TEST-INFO | 1657: exit 0 13:53:02 INFO - Browser initialized. 13:53:02 INFO - Running cycle 1/1 for kraken test... 13:53:02 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmpYZmoQs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:53:14 INFO - PROCESS | 1659 | RSS: Main: 243879936 13:53:14 INFO - PROCESS | 1659 | 13:53:17 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection) 13:53:18 INFO - PROCESS | 1659 | RSS: Main: 256741376 13:53:18 INFO - PROCESS | 1659 | 13:53:21 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-dft) 13:53:22 INFO - PROCESS | 1659 | RSS: Main: 265351168 13:53:22 INFO - PROCESS | 1659 | 13:53:25 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-fft) 13:53:26 INFO - PROCESS | 1659 | RSS: Main: 265252864 13:53:26 INFO - PROCESS | 1659 | 13:53:28 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator) 13:53:28 INFO - PROCESS | 1659 | RSS: Main: 267579392 13:53:28 INFO - PROCESS | 1659 | 13:53:30 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:53:31 INFO - PROCESS | 1659 | RSS: Main: 267907072 13:53:31 INFO - PROCESS | 1659 | 13:53:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom) 13:53:34 INFO - PROCESS | 1659 | RSS: Main: 267952128 13:53:34 INFO - PROCESS | 1659 | 13:53:37 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate) 13:53:38 INFO - PROCESS | 1659 | RSS: Main: 268398592 13:53:38 INFO - PROCESS | 1659 | 13:53:41 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial) 13:53:42 INFO - PROCESS | 1659 | RSS: Main: 268701696 13:53:42 INFO - PROCESS | 1659 | 13:53:43 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:53:44 INFO - PROCESS | 1659 | RSS: Main: 268279808 13:53:44 INFO - PROCESS | 1659 | 13:53:46 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:53:46 INFO - PROCESS | 1659 | RSS: Main: 268324864 13:53:46 INFO - PROCESS | 1659 | 13:53:49 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:53:50 INFO - PROCESS | 1659 | RSS: Main: 268374016 13:53:50 INFO - PROCESS | 1659 | 13:53:52 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:53:53 INFO - PROCESS | 1659 | RSS: Main: 268509184 13:53:53 INFO - PROCESS | 1659 | 13:53:56 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:53:57 INFO - PROCESS | 1659 | RSS: Main: 268423168 13:53:57 INFO - PROCESS | 1659 | 13:53:58 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49262/tests/kraken/driver.html?testName=ai-astar) 13:53:59 INFO - PROCESS | 1659 | RSS: Main: 270229504 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | __start_tp_report 13:53:59 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 13:53:59 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 13:53:59 INFO - PROCESS | 1659 | |i|pagename|runs| 13:53:59 INFO - PROCESS | 1659 | |0;ai-astar;117;142;157;134;168;145;115;174;171;148 13:53:59 INFO - PROCESS | 1659 | |1;audio-beat-detection;148;125;169;170;112;154;157;144;203;110 13:53:59 INFO - PROCESS | 1659 | |2;audio-dft;207;225;200;201;194;197;198;202;195;193 13:53:59 INFO - PROCESS | 1659 | |3;audio-fft;70;82;75;138;58;77;83;92;155;60 13:53:59 INFO - PROCESS | 1659 | |4;audio-oscillator;70;72;116;73;69;75;109;68;74;111 13:53:59 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;89;88;89;87;89;86;90;88;91;86 13:53:59 INFO - PROCESS | 1659 | |6;imaging-darkroom;95;96;144;98;140;95;141;151;105;151 13:53:59 INFO - PROCESS | 1659 | |7;imaging-desaturate;93;96;108;130;91;93;91;91;91;88 13:53:59 INFO - PROCESS | 1659 | |8;json-parse-financial;56;60;56;58;58;73;83;88;87;85 13:53:59 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;69;71;69;76;79;82;75;71;71;71 13:53:59 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;108;113;77;103;109;106;85;85;96;109 13:53:59 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;139;142;137;135;143;143;153;142;192;163 13:53:59 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;172;172;173;170;173;171;169;174;174;173 13:53:59 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;67;67;94;85;69;62;65;68;66;68 13:53:59 INFO - PROCESS | 1659 | __end_tp_report 13:53:59 INFO - PROCESS | 1659 | __start_cc_report 13:53:59 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,970 13:53:59 INFO - PROCESS | 1659 | __end_cc_report 13:53:59 INFO - PROCESS | 1659 | __startTimestamp1472590439023__endTimestamp 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | ------- Summary: start ------- 13:53:59 INFO - PROCESS | 1659 | Number of tests: 14 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:147.10 Median:152.50 stddev:21.00 (13.8%) stddev-sans-first:19.24 13:53:59 INFO - PROCESS | 1659 | Values: 117.0 142.0 157.0 134.0 168.0 145.0 115.0 174.0 171.0 148.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:155.50 stddev:28.55 (18.4%) stddev-sans-first:30.28 13:53:59 INFO - PROCESS | 1659 | Values: 148.0 125.0 169.0 170.0 112.0 154.0 157.0 144.0 203.0 110.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:201.20 Median:200.50 stddev:9.35 (4.7%) stddev-sans-first:9.68 13:53:59 INFO - PROCESS | 1659 | Values: 207.0 225.0 200.0 201.0 194.0 197.0 198.0 202.0 195.0 193.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:89.00 Median:76.00 stddev:32.24 (42.4%) stddev-sans-first:33.45 13:53:59 INFO - PROCESS | 1659 | Values: 70.0 82.0 75.0 138.0 58.0 77.0 83.0 92.0 155.0 60.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:83.70 Median:71.00 stddev:19.72 (27.8%) stddev-sans-first:20.28 13:53:59 INFO - PROCESS | 1659 | Values: 70.0 72.0 116.0 73.0 69.0 75.0 109.0 68.0 74.0 111.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.00 stddev:1.64 (1.8%) stddev-sans-first:1.72 13:53:59 INFO - PROCESS | 1659 | Values: 89.0 88.0 89.0 87.0 89.0 86.0 90.0 88.0 91.0 86.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:121.60 Median:123.00 stddev:25.49 (20.7%) stddev-sans-first:25.16 13:53:59 INFO - PROCESS | 1659 | Values: 95.0 96.0 144.0 98.0 140.0 95.0 141.0 151.0 105.0 151.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:91.00 stddev:12.77 (14.0%) stddev-sans-first:13.45 13:53:59 INFO - PROCESS | 1659 | Values: 93.0 96.0 108.0 130.0 91.0 93.0 91.0 91.0 91.0 88.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:70.40 Median:78.00 stddev:14.12 (18.1%) stddev-sans-first:13.98 13:53:59 INFO - PROCESS | 1659 | Values: 56.0 60.0 56.0 58.0 58.0 73.0 83.0 88.0 87.0 85.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:73.00 stddev:4.43 (6.1%) stddev-sans-first:4.40 13:53:59 INFO - PROCESS | 1659 | Values: 69.0 71.0 69.0 76.0 79.0 82.0 75.0 71.0 71.0 71.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:99.10 Median:95.00 stddev:12.59 (13.3%) stddev-sans-first:12.94 13:53:59 INFO - PROCESS | 1659 | Values: 108.0 113.0 77.0 103.0 109.0 106.0 85.0 85.0 96.0 109.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:148.90 Median:143.00 stddev:17.23 (12.0%) stddev-sans-first:17.90 13:53:59 INFO - PROCESS | 1659 | Values: 139.0 142.0 137.0 135.0 143.0 143.0 153.0 142.0 192.0 163.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:173.00 stddev:1.66 (1.0%) stddev-sans-first:1.76 13:53:59 INFO - PROCESS | 1659 | Values: 172.0 172.0 173.0 170.0 173.0 171.0 169.0 174.0 174.0 173.0 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:68.00 stddev:10.12 (14.9%) stddev-sans-first:10.62 13:53:59 INFO - PROCESS | 1659 | Values: 67.0 67.0 94.0 85.0 69.0 62.0 65.0 68.0 66.0 68.0 13:53:59 INFO - PROCESS | 1659 | -------- Summary: end -------- 13:53:59 INFO - PROCESS | 1659 | 13:53:59 INFO - TEST-INFO | 1659: exit 0 13:53:59 INFO - TEST-OK | kraken | took 60734ms 13:53:59 INFO - SUITE-END | took 1174s 13:54:00 INFO - Completed test suite (00:19:34) 13:54:00 INFO - javascript benchmark 13:54:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7248.907954244273, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3368.107451525346, 3389.4407422775244, 3403.8767206821753, 3422.0418282880787, 3446.190145315851, 5633.492985631292, 5664.40523745006, 5707.172459993304, 5717.599768016241, 5791.044477661191, 5690.914636280449, 5753.827385178441, 5781.855453613662, 5784.623999440044, 5891.293044834626, 4657.347971284023, 4960.107180707471, 5187.429382767911, 5259.947400525984, 5385.084535628953, 5331.946680533184, 5356.9732151339185, 5385.434529374418, 5415.0, 5418.810341638044, 5144.279800827887, 5231.476852314776, 5262.158054711228, 5282.577393808525, 5315.495027972336, 5057.721825299607, 5240.79036838526, 5251.028559716427, 5270.49930256625, 5319.228711836762, 4295.828166873322, 5215.6349055566125, 5242.449542797989, 5244.5542128918705, 5245.895082098375, 4827.493113223096, 5540.445955404468, 5681.204631351614, 5793.652380857162, 5805.158252053428, 6228.750849965996, 6237.220347456568, 6275.309715931244, 6282.089097080898, 6311.779087731953, 6254.437100660963, 6279.529035322369, 6287.182666253358, 6298.968505157445, 6313.621182729005, 5729.255196824386, 5790.507806836382, 5889.204957330749, 5893.703385255237, 5895.823125306248, 6338.746450141943, 6351.587146835441, 6353.110564520971, 6362.331955144736, 6369.458596019297, 6136.0, 6184.536159787944, 6212.844678882973, 6217.0, 6220.440160385587, 6112.898653789679, 6175.62946223228, 6189.164462797555, 6272.968635156795, 6292.0, 5183.766730497061, 6258.780942666985, 6261.0, 6297.27581328144, 6300.747970081237, 5024.32171656829, 5841.1238314253205, 6216.191895053705, 6260.280067792171, 6268.153799237045, 4853.102176097434, 4903.338049363361, 4948.356713627206, 4952.579030782352, 4972.129877271463, 4446.244138496463, 4453.688241823106, 4459.10817836434, 4462.397576327219, 4503.0, 5744.0, 5820.301563812285, 5836.1245813127525, 5869.4717475427415, 5872.941270587239, 6132.264128304632, 6212.689365531705, 6222.408871157233, 6265.749370025239, 6271.372862713783, 5813.6221145625395, 5858.970705146447, 5875.089361149029, 5875.294964604275, 5902.58681892272, 4525.683202175882, 5461.0716178249795, 5461.590380721462, 5470.91793623096, 5483.75323110461, 6218.751249950042, 6265.655388953652, 6305.4009869062365, 6335.239771227482, 6447.387498187664, 6230.376962303733, 6260.74957001733, 6282.497400207881, 6293.653849038347, 6298.1812364392335, 6358.332375100733, 6361.077643741539, 6364.4908407326375, 6369.172007638977, 6373.681315934277, 6097.969510152421, 6133.028644417115, 6171.722272497658, 6183.0, 6202.81391558254, 6215.9378406215355, 6258.217722784652, 6284.622922624657, 6297.527685423704, 6311.147995020797, 6171.876562468636, 6224.595401298901, 6224.751009959551, 6231.283402408781, 6238.0, 4733.857984260478, 5909.409059094056, 6013.5189184865985, 6096.390360963868, 6191.938080619136, 5893.5874488787085, 5966.3735307793795, 6047.365026672136, 6053.757849685963, 6073.878522429615, 6099.176611157437, 6142.14010038586, 6143.078538219303, 6200.875982480416, 6203.534734894991, 5885.293764748258, 6040.9730345840435, 6048.576599637983, 6055.576109672281, 6063.242094738158], "value": 5707.254420754679, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.9182947069526, 469.96372997540425, 477.41993477924314, 521.2754271562528, 545.430025623224, 36623.450648240265, 41719.374209386886, 41768.164636707246, 41838.74483765492, 41931.0, 42895.14209715804, 43415.99999999992, 43437.7828110859, 43457.78271108648, 43602.563974360324, 9099.727008189731, 9123.270138388913, 9710.368826026302, 9977.650782222623, 9985.251106167067, 9742.415455072683, 9828.312018158731, 9882.752931176743, 9883.308168428213, 9917.603295868194, 9827.901720982805, 9877.407355558653, 9877.901220987806, 9878.703638890845, 9912.405255684645, 9794.6082156714, 9817.361871478366, 9818.65634702782, 9841.065098815601, 9852.42361222201, 9825.1157395834, 9842.311038227326, 9918.3057185997, 9918.3553069051, 9935.801283974351, 40415.797921010504, 41145.38281925744, 41173.0, 41364.58635413637, 41484.96287592804, 3403.064157356722, 3421.1105112670634, 3423.828808559587, 3432.3821712091813, 3462.3248466549035, 30662.84668576665, 31231.219219519466, 31241.53137702936, 31699.0, 32026.199345016328, 3211.1811488070393, 3231.418344697953, 3235.3205826776407, 3265.2000259936467, 3331.5002749587516, 477122.0, 479598.0, 482844.0, 483294.0, 484557.0, 62031.0, 62518.74962500724, 62985.685071575266, 63045.68477157585, 63088.684556576925, 34606.30787384238, 35379.469307960404, 35594.64405355965, 36308.00305983143, 65569.67215163894, 16813.243404046847, 16980.660386792442, 17019.063951482538, 17034.74447883283, 17075.0, 11266.605668801552, 12341.876581234252, 12910.0, 12918.41867115982, 13001.674958126123, 16709.331626734795, 18535.35126270574, 18699.22357376047, 19261.266486016044, 19517.024148792505, 7445.0, 7494.288042635941, 7651.69393224276, 7759.961200193963, 7761.146273909865, 708.9790701389982, 868.5396739727954, 949.4920217683645, 1063.8723353197665, 1106.751683808026, 25592.16225096304, 30893.0, 31120.844395778327, 31360.68639313623, 31388.686113139032, 1092.355510248957, 1100.805625895896, 1116.8827273136367, 1175.5826681528106, 1204.873488283735, 14537.418503259963, 15417.845821541865, 15969.68060638804, 15977.68044639124, 16215.729977711217, 179792.20207797753, 182611.0, 183067.0, 183163.0, 183737.0, 58846.41153588495, 58887.70556147192, 59267.70366148141, 59449.40550594525, 59936.0, 1314.415085287038, 1325.2181213084327, 1362.8228330316995, 1367.9931600342134, 1368.8973327000515, 24059.278221653378, 29337.55993660054, 30452.23869403194, 30523.2369190772, 32211.838940805144, 38474.6152538471, 41755.58244417517, 43156.70529884109, 51429.742851285504, 53119.0, 549961.0, 554467.0, 554497.0, 555653.2217338887, 557191.0, 22055.66916496286, 27152.592711108955, 27423.0, 27516.449671006867, 27564.0, 38318.80840595779, 47219.0, 47566.76216618895, 47623.5237647633, 48552.02895942132, 32717.0, 36527.99096049636, 37471.0, 40420.595794042856, 41846.37230441485, 40210.39684404678, 40738.1852362957, 41306.0, 41584.0, 41920.580794191665, 38365.23269534538, 38929.221415572094, 39583.80208098941, 39816.40275395929, 39882.0, 33994.15014624654, 35478.0, 35685.82157089198, 35776.0, 36019.91940241797, 25893.48213035691, 26193.0, 26315.73684263133, 26443.86778066174, 26508.0], "value": 19206.53773178689, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.71021688528356, 337.66739761335094, 341.9504171895075, 361.5570925616121, 368.44916849310266, 19732.70400943987, 19990.900045499788, 20956.476088097785, 21234.46913827155, 21251.0, 20185.77956424792, 20592.588148237028, 20986.845723485203, 21021.36935891922, 21142.942852857374, 5448.346198456191, 5498.367687715914, 5691.260136182291, 5696.401877802833, 5696.601237913348, 5460.945390546103, 5618.775248990056, 5621.325440947092, 5623.297087864017, 5631.8592035199035, 5603.047481928062, 5604.523615492688, 5609.382967873531, 5617.466340697627, 5691.715414229272, 6024.1566180734735, 6049.879002419927, 6164.445199932027, 6169.290531588857, 6190.752369905198, 5183.403908550527, 5281.102212623825, 5335.973320133413, 5394.514493695587, 5431.0, 20862.5827483451, 25750.969961201718, 26050.0, 26260.949562017497, 26710.86644566784, 2073.40907841266, 2127.287358734826, 2166.784607257843, 2380.47629521505, 2394.772496612819, 9860.802783944353, 10203.94898025505, 10211.132053775438, 10326.7418314542, 10411.167106631452, 1531.9770203446958, 1641.6880792649479, 1754.5437287051716, 1820.836124748779, 1964.3615824856836, 87954.0, 93578.0, 112419.0, 118471.0, 132184.33907830497, 9340.0, 10253.641122560824, 10556.313839600401, 11699.707507312385, 11795.41022948849, 12120.939395303143, 14494.550544945421, 14638.853611463963, 14645.707085858223, 14716.484923027643, 7216.7113315466795, 8458.957705211558, 8700.173483519056, 8777.51723655205, 8894.955525222462, 8718.215360617574, 8782.912170878337, 8798.340124490689, 8923.196912277926, 8955.552222388986, 3719.386301260316, 4439.578240067189, 4496.482904465963, 4528.524504926935, 4561.087782443525, 1906.2470324221854, 1909.8663093583316, 1929.922803087889, 1948.814862588052, 1978.3075923426686, 765.8162041110205, 806.6329819931917, 988.5452691761726, 990.6881266176782, 1015.4871789746131, 16927.915360423118, 21220.681689774665, 21748.782512174676, 21822.563548728936, 21972.340829775134, 754.7886591754318, 939.7039932421266, 945.9574319155655, 952.61419125253, 969.5782334684435, 8153.0, 8955.686550970815, 11192.944035279934, 11516.424178791027, 11516.905893940062, 543832.0, 554246.0, 558014.0, 566557.0, 571670.0, 99496.0, 134486.32756836154, 135787.0, 136364.0, 138552.0, 954.1317401165045, 968.1577027985556, 998.4658207858761, 1000.6197644895038, 1000.7248006798043, 19392.806071939664, 19573.510662232988, 19583.60832783365, 19622.509437264183, 19683.409497715093, 51809.740951295, 51865.7406712964, 51893.96212075813, 51910.740446297525, 52936.0, 67837.66081169562, 75835.0, 78606.0, 79291.0, 80640.0, 7041.964790176016, 7368.889466657897, 7432.479726419315, 7946.562939038408, 8362.581870906308, 13229.80155297652, 13343.532976345781, 13444.46222151103, 13689.315534223448, 13832.792508112587, 11439.256448330832, 11464.4267786612, 11636.592719255124, 11696.298222106701, 11766.764664706829, 11335.546578137111, 11401.714957125807, 11715.707107322385, 11745.588904388305, 11792.469338879942, 10985.725356865823, 11722.94138529302, 11966.22219555726, 11968.341741204318, 12085.395730213279, 7315.268473152642, 7527.6988920444755, 7535.73624923125, 7660.93154848199, 7688.961990131261, 10284.640037598649, 10505.0, 10915.399653018843, 11578.594749183738, 11795.941020294844], "value": 9417.459006410762, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1184.2894263441935, 1191.8617720077327, 1584.3820909845163, 1732.7227643577023, 1870.279942222244, 8016.398770092252, 8576.271016963557, 8712.73861784146, 9148.313876459275, 9168.220701240394, 8757.91242087579, 8978.102189781019, 9001.234895033913, 9027.729168124966, 9049.909500904989, 2370.928872133839, 2402.2072716003677, 2407.0251548123038, 2407.0612461140167, 2409.0484258717797, 2375.2517956843626, 2402.1352313167245, 2408.6387041943763, 2420.6732091167733, 2422.8061755059553, 2387.55830171418, 2388.8088952883813, 2396.993262829607, 2398.412388964706, 2413.4328432818274, 2365.44412063165, 2380.8571485710827, 2391.270662447953, 2392.868392238426, 2402.5915594349003, 1929.7105434184843, 2295.7589453107516, 2317.9188728394424, 2318.7681231876845, 2331.4870728439714, 8969.14793094655, 8979.416337938079, 8982.416142950753, 9025.684101056431, 9050.275977921816, 5227.686338819683, 5366.9463305366835, 5410.648307859977, 5427.317531565227, 5432.1580155075635, 3629.1834337274167, 3648.671619554253, 3671.3575124353397, 3709.9629003710156, 3718.6467285607823, 1110.2561283939779, 1111.0889070961814, 1113.87190473095, 1118.2619471149003, 1123.584273818684, 11618.94190529042, 11731.882681173165, 11789.58736444229, 11789.646310610695, 11800.704982375424, 4579.885502862455, 4692.249240121564, 4848.466668666444, 4872.220444728897, 4878.853634390974, 8670.696525621574, 9575.377600455948, 9968.800623987625, 9978.501074946224, 10001.849972250422, 5304.204369344552, 5346.705931173745, 5367.624266301322, 5384.353877534721, 5386.13821788512, 4390.670699697472, 4725.716457012591, 4840.201366774513, 4884.169691152512, 4903.362562866804, 3573.5711714594413, 3903.8048097595006, 4001.099752555652, 4052.49343832021, 4104.281750693616, 1313.934303284832, 1320.6236222676491, 1322.8081928120369, 1323.245749922554, 1325.7613629546775, 798.0503201190564, 864.6368525219423, 930.2697382554798, 934.3179478980383, 945.8533927241289, 5651.689157096399, 5926.0, 6045.969770151121, 6113.877722445526, 6219.906701399483, 442.0, 446.8078726147723, 447.25531989238203, 453.9659525535598, 465.2393336894202, 3926.547177544327, 4026.416169655384, 4094.549599544048, 4101.118259574206, 4263.531011588722, 10909.727256818644, 10974.780504390028, 11074.944625276983, 11083.0, 11116.61091861781, 11017.83473247902, 11041.061509771598, 11047.060999814945, 11050.778984420427, 11064.0, 8077.7576672699915, 8140.430169888169, 8232.62953167109, 8288.958555207306, 8359.205875441701, 4923.876903077452, 5998.220231369894, 6153.692315384303, 6212.596181248205, 6267.122602835698, 7431.739889103856, 7936.6428510718315, 8434.873476897728, 10127.949360253446, 10177.033181847713, 8621.482711037357, 9825.656102036395, 10149.746256343651, 10279.691609251735, 10340.224483163642, 6577.539572230089, 7474.887876681963, 7547.622618869144, 7631.732889348847, 7641.0, 8263.173682631688, 8341.708040218564, 8353.540555269276, 8362.205590468895, 8412.0, 7476.364509016795, 7509.66206520697, 7535.58554279498, 7597.6581053853815, 7735.806604834924, 7289.161746399232, 7322.267773222635, 7346.59593722329, 7374.557526548424, 7490.913817496324, 6922.653867306715, 6946.340097690711, 7032.648367581703, 7042.647867606702, 7060.858782824417, 4670.859874203779, 4933.421305182307, 5127.53852153308, 5137.280780690781, 5149.0474262261605, 5088.796448142033, 5096.949030509648, 5191.402988656353, 5204.765785539584, 5265.104932161618], "value": 4522.296866491421, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [247.71512760325624, 258.6249937590493, 296.4116229284869, 308.7545401405883, 310.34981713310606, 5462.672239665623, 5546.750396232169, 5652.547796176306, 5738.913916291253, 5781.369476888011, 5421.593380496469, 5531.446855314466, 5534.596223322657, 5547.833564993047, 5583.804566840161, 4047.291723948312, 4206.179794939981, 4217.683673724468, 4222.894427639303, 4267.807948642303, 3527.6119626841028, 3842.058695619577, 4005.9799701001452, 4146.357314616239, 4183.100633363826, 3523.5511319632865, 4026.375911733686, 4189.183109293689, 4211.831526738927, 4212.599803018708, 3463.29002554477, 4020.075382661975, 4209.5790420957965, 4211.789410529492, 4212.831486740527, 3525.4183059795105, 3700.5937743657237, 3726.5155529781227, 3727.7949712765785, 3744.494493243432, 5301.125314323132, 5429.782808687648, 5441.014029879105, 5455.581548797301, 5460.645058071253, 3993.0416699991792, 4838.903221935577, 4845.394325709286, 4864.659473836833, 4880.731559764212, 5534.861628459281, 5610.915836262459, 5915.822525324247, 5928.822135335947, 5989.520838332923, 3528.1477224457108, 3762.4168253920684, 3805.46723458716, 4035.535913369941, 4049.311617025113, 5130.53825155734, 5408.675479471244, 6240.1263823064355, 6258.4014191839415, 6269.686515674198, 3241.497567876983, 3541.8052007139854, 3820.675242604354, 4143.990164770084, 4160.375943608423, 3290.983545082307, 4215.78921053946, 4217.768022758716, 4244.448221731155, 4271.765052922119, 4909.993451342466, 4925.13810083234, 4927.704337739747, 4938.209886418156, 4945.23348880924, 4870.829520966749, 5860.150278209636, 6044.760824031151, 6116.48009919153, 6139.263288405331, 1221.1451983611507, 1381.9654508637364, 1419.6025112968384, 1434.6413396650837, 1445.197915157077, 955.7371722776293, 966.9758256043515, 987.5062468765617, 988.2588058955783, 990.6631745206664, 5390.191471279261, 5484.489926447077, 5512.070775228638, 5513.365962914316, 5546.195801608744, 5118.692878427306, 6080.726367313481, 6093.908591371133, 6108.694565271719, 6133.515926049957, 4545.772711364419, 5212.530872221442, 5440.483154100354, 5506.614536982373, 5520.641158324696, 2345.970735313975, 2415.4565222825076, 2706.376174295446, 2723.169433322816, 2738.5755207942802, 4404.7357158570585, 5293.57651387888, 5294.523492885659, 5345.1447768356875, 5349.438308977579, 4585.747783871919, 4762.4285085789925, 5011.223260394645, 5277.261183434322, 5301.787928482818, 5121.615878809104, 5171.948280517222, 5268.894622107537, 5344.706041167696, 5367.430658611979, 4431.98064445173, 4971.693823607261, 5049.626675462527, 5120.667156634807, 5167.715775632376, 4239.587132358358, 4537.666528465374, 4568.588827005586, 4807.005092886413, 5092.796288148433, 4636.6058884995155, 5380.058489764354, 5389.51494365509, 5413.998410294108, 5438.607012914305, 3276.672332766704, 3538.5399898013093, 3660.8834305537066, 3682.429223470366, 3697.556293244828, 4209.831606735819, 4228.873133805991, 4836.975815120902, 5066.746662666778, 5193.636445448782, 5013.866333541537, 5027.32131162303, 5031.496850314939, 5043.899122017612, 5082.1106306395495, 4408.977955110204, 4544.318352247189, 4782.378290822171, 4965.939135258972, 5028.472010438852, 4028.5165780106577, 4483.843065492692, 4561.009117022605, 4898.608111351155, 4974.751262436791, 4389.4321821733365, 4469.5530446955045, 4575.124199078362, 4957.82647607332, 5007.1487847065355, 4211.410402543585, 4215.747055176699, 4249.32010878258, 4306.956930430781, 4943.319271447581], "value": 3998.3436632714324, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.7081157261874, 716.9103862017248, 724.2359310926973, 726.1286456252495, 808.1474044882654, 15218.010829296089, 15724.60688482787, 15932.44236451723, 17027.978321300732, 17700.734488982675, 16335.83664163358, 16494.17529123542, 16661.416850410238, 16668.249928753205, 16677.499675009738, 856.9828603427927, 871.263782104121, 873.9737807865743, 875.7504111328273, 876.1326286975911, 695.9060526828889, 715.5313269808258, 770.9768706938772, 836.5148214035845, 853.1979938857485, 766.9539827610333, 866.995665021674, 877.4384393987852, 901.4411065139623, 923.2798417234568, 902.5036230073433, 912.5163663258484, 913.1462082952461, 915.0209276074603, 915.9313051521096, 659.3077268867718, 680.4216416046371, 680.6630717794724, 680.7311112110689, 680.938715515606, 15392.230388480531, 15416.691666166726, 15426.3829446822, 15455.92272038644, 15472.845271547252, 12816.974642028616, 13050.673733156653, 14257.572272831832, 14333.0, 14402.423903043971, 11898.821517677155, 11942.820857687142, 12011.579594714143, 12075.0, 12280.754384912341, 3358.236925614048, 3614.8915532534065, 3781.546214454283, 3804.5054142961517, 3941.1526521797664, 65968.68062638768, 86686.0, 90273.54863225708, 98871.01128988763, 107227.46386268096, 11034.889651103385, 11064.336139831636, 11074.889251107546, 11096.223264371416, 11298.943505282585, 21454.57090858174, 21567.67648485274, 21781.782182178293, 21848.89075554644, 21892.0, 8008.039035315799, 8076.8384632307025, 8154.306883914934, 8155.877661835078, 8275.917240827635, 4457.77711114443, 4522.525134860858, 4524.864254072383, 4541.750203738826, 4593.931091033637, 3587.0494319005484, 3668.248009158116, 3693.9841543575194, 3717.7583457075743, 3736.215394767075, 632.4750457120579, 679.8266442057244, 686.5503095472474, 693.784926672733, 698.664640972326, 514.6731825290892, 531.3968645587287, 565.5588640860136, 591.3583761618606, 664.2361284522838, 7837.333826624801, 8278.296344810638, 9371.765705857408, 9425.670101546413, 9607.471589062528, 625.2150111431797, 666.6000399760105, 668.391763495217, 672.3377473188905, 687.4466054825913, 4614.554286228305, 4963.219793356253, 5119.360079990001, 5152.948470515322, 5230.7384630769075, 156917.2154139222, 159446.0, 160645.0, 161515.0, 167228.1638591799, 139606.0, 140643.0, 142408.0, 142599.0, 142995.0, 73264.26735732681, 73570.89643655349, 76356.61821690857, 82062.9999999988, 94204.0, 9861.556229969525, 9899.267628164898, 9991.650292239738, 10013.499325033574, 10021.599136034478, 41292.587074128875, 54818.90362192654, 55596.44403555913, 56414.15378769404, 57464.71267643635, 87391.56304218438, 88481.0, 88842.0, 89382.0, 90856.0, 12916.870831291566, 13048.217106973612, 13244.933775331447, 13284.734305313646, 14023.615985282322, 13418.329083545588, 14562.490312839, 15093.24533773285, 15150.3182356792, 15237.847621523642, 13865.376058077209, 14073.085249458753, 14164.645883852987, 14361.928190358982, 14558.636034099232, 11070.501827417624, 13811.0, 13894.583162505141, 14211.857881421467, 14539.8313962188, 13585.86414135846, 13609.52366667162, 13874.861251387358, 14149.36327865228, 14271.928640356731, 10893.891061089287, 11035.668929932115, 11049.613263535737, 11174.106071514421, 11414.201005929504, 9449.905500944902, 9747.805043899225, 9824.901750982399, 9967.950160249153, 11634.301941883514], "value": 7772.136096642814, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1612.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 142.0, 157.0, 134.0, 168.0, 145.0, 115.0, 174.0, 171.0, 148.0], "value": 147.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 169.0, 170.0, 112.0, 154.0, 157.0, 144.0, 203.0, 110.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 225.0, 200.0, 201.0, 194.0, 197.0, 198.0, 202.0, 195.0, 193.0], "value": 201.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 82.0, 75.0, 138.0, 58.0, 77.0, 83.0, 92.0, 155.0, 60.0], "value": 89.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 116.0, 73.0, 69.0, 75.0, 109.0, 68.0, 74.0, 111.0], "value": 83.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 87.0, 89.0, 86.0, 90.0, 88.0, 91.0, 86.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 144.0, 98.0, 140.0, 95.0, 141.0, 151.0, 105.0, 151.0], "value": 121.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 108.0, 130.0, 91.0, 93.0, 91.0, 91.0, 91.0, 88.0], "value": 97.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 60.0, 56.0, 58.0, 58.0, 73.0, 83.0, 88.0, 87.0, 85.0], "value": 70.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 69.0, 76.0, 79.0, 82.0, 75.0, 71.0, 71.0, 71.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 77.0, 103.0, 109.0, 106.0, 85.0, 85.0, 96.0, 109.0], "value": 99.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 142.0, 137.0, 135.0, 143.0, 143.0, 153.0, 142.0, 192.0, 163.0], "value": 148.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 173.0, 170.0, 173.0, 171.0, 169.0, 174.0, 174.0, 173.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 94.0, 85.0, 69.0, 62.0, 65.0, 68.0, 66.0, 68.0], "value": 71.1, "unit": "score"}]}]} 13:54:00 INFO - Return code: 0 13:54:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:54:00 ERROR - # TBPL SUCCESS # 13:54:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:54:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:54:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:54:00 INFO - 2016-08-30 13:54:00.373 screenresolution[1664:10354] starting screenresolution argv=screenresolution get 13:54:00 INFO - 2016-08-30 13:54:00.376 screenresolution[1664:10354] Display 0: 1600x1200x32@60 13:54:00 INFO - 2016-08-30 13:54:00.382 screenresolution[1665:10357] starting screenresolution argv=screenresolution list 13:54:00 INFO - Available Modes on Display 0 13:54:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:54:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:54:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:54:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:54:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:54:00 INFO - Intel Iris: 13:54:00 INFO - Chipset Model: Intel Iris 13:54:00 INFO - Type: GPU 13:54:00 INFO - Bus: Built-In 13:54:00 INFO - VRAM (Dynamic, Max): 1536 MB 13:54:00 INFO - Vendor: Intel (0x8086) 13:54:00 INFO - Device ID: 0x0a2e 13:54:00 INFO - Revision ID: 0x0009 13:54:00 INFO - Displays: 13:54:00 INFO - Display: 13:54:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:54:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:54:00 INFO - Display Serial Number: 1600x1200 60 13:54:00 INFO - Main Display: Yes 13:54:00 INFO - Mirror: Off 13:54:00 INFO - Online: Yes 13:54:00 INFO - Rotation: Supported 13:54:00 INFO - Return code: 0 13:54:00 INFO - Running post-action listener: _resource_record_post_action 13:54:00 INFO - [mozharness: 2016-08-30 20:54:00.619207Z] Finished run-tests step (success) 13:54:00 INFO - Running post-run listener: _resource_record_post_run 13:54:00 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 38134784; Write bytes: 705370112; Read time: 394; Write time: 2046 13:54:00 INFO - TinderboxPrint: CPU usage
54.6% 13:54:00 INFO - TinderboxPrint: I/O read bytes / time
38,134,784 / 394 13:54:00 INFO - TinderboxPrint: I/O write bytes / time
705,370,112 / 2,046 13:54:00 INFO - TinderboxPrint: CPU idle
2,194.2 (45.4%) 13:54:00 INFO - TinderboxPrint: CPU system
975.9 (20.2%) 13:54:00 INFO - TinderboxPrint: CPU user
1,667.7 (34.5%) 13:54:00 INFO - TinderboxPrint: Swap in / out
443,768,832 / 0 13:54:00 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394568192; Write bytes: 389109760; Read time: 29330; Write time: 717 13:54:00 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 36332544; Write bytes: 295485440; Read time: 352; Write time: 1285 13:54:01 INFO - Running post-run listener: _upload_blobber_files 13:54:01 INFO - Blob upload gear active. 13:54:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:54:01 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:54:01 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:54:01 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:54:01 INFO - (blobuploader) - INFO - Open directory for files ... 13:54:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:54:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:54:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:02 INFO - (blobuploader) - INFO - Done attempting. 13:54:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:54:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:54:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:03 INFO - (blobuploader) - INFO - Done attempting. 13:54:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:54:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:54:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:54:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:54:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:54:06 INFO - (blobuploader) - INFO - Done attempting. 13:54:06 INFO - (blobuploader) - INFO - Iteration through files over. 13:54:06 INFO - Return code: 0 13:54:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:54:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:54:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4078326a121a7153e9942d9cc34d60430fc9e402d2b5e59e970314263e2c8aff8da8107cf7a0e6a9d1f3efbf0e419bf2845cfde03d1808f0925113f8f748db1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/01b81c758d3f17d5dfbbb65097c389f9f88e045509ea3f7f807381a91e54a8f6c4595c54363d7d19ecc59d4d67919abb4a0aa64cbcb3aa3649ed17830b8bf581", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9498884a9e3c1422ba98abd883467648b149f1bbf5b1339c9fe0b7507505071a6310d5f070093f2cac02defeb29b6b2165e18057e7d98d58c00500a5e1972b56"} 13:54:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:54:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:54:06 INFO - Contents: 13:54:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4078326a121a7153e9942d9cc34d60430fc9e402d2b5e59e970314263e2c8aff8da8107cf7a0e6a9d1f3efbf0e419bf2845cfde03d1808f0925113f8f748db1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/01b81c758d3f17d5dfbbb65097c389f9f88e045509ea3f7f807381a91e54a8f6c4595c54363d7d19ecc59d4d67919abb4a0aa64cbcb3aa3649ed17830b8bf581", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9498884a9e3c1422ba98abd883467648b149f1bbf5b1339c9fe0b7507505071a6310d5f070093f2cac02defeb29b6b2165e18057e7d98d58c00500a5e1972b56"} 13:54:06 INFO - Running post-run listener: copy_logs_to_upload_dir 13:54:06 INFO - Copying logs to upload dir... 13:54:06 INFO - mkdir: /builds/slave/test/build/upload/logs 13:54:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.872666 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-30 13:54:07.031196) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 13:54:07.035175) ========= 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.iv7QWjsiwa/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.vBaoEWvoye/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4078326a121a7153e9942d9cc34d60430fc9e402d2b5e59e970314263e2c8aff8da8107cf7a0e6a9d1f3efbf0e419bf2845cfde03d1808f0925113f8f748db1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/01b81c758d3f17d5dfbbb65097c389f9f88e045509ea3f7f807381a91e54a8f6c4595c54363d7d19ecc59d4d67919abb4a0aa64cbcb3aa3649ed17830b8bf581", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9498884a9e3c1422ba98abd883467648b149f1bbf5b1339c9fe0b7507505071a6310d5f070093f2cac02defeb29b6b2165e18057e7d98d58c00500a5e1972b56"} build_url:https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010867 build_url: 'https://queue.taskcluster.net/v1/task/QvmD60t1S8qqL1Ah_N1GIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4078326a121a7153e9942d9cc34d60430fc9e402d2b5e59e970314263e2c8aff8da8107cf7a0e6a9d1f3efbf0e419bf2845cfde03d1808f0925113f8f748db1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/01b81c758d3f17d5dfbbb65097c389f9f88e045509ea3f7f807381a91e54a8f6c4595c54363d7d19ecc59d4d67919abb4a0aa64cbcb3aa3649ed17830b8bf581", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9498884a9e3c1422ba98abd883467648b149f1bbf5b1339c9fe0b7507505071a6310d5f070093f2cac02defeb29b6b2165e18057e7d98d58c00500a5e1972b56"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-30 13:54:07.071871) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 13:54:07.072643) ========= 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.iv7QWjsiwa/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.vBaoEWvoye/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005372 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-30 13:54:07.124562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 13:54:07.125191) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-30 13:54:07.125814) ========= ========= Total master_lag: 0.19 =========