builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0009 starttime: 1461629814.43 results: success (0) buildid: 20160425152612 builduid: db395646daad42cdb5966a0548f0356a revision: 79de998e7307650fec99ea6188ae60ac64ebeedb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:54.434710) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:54.435126) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:54.435405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:54.455934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:54.456251) ========= 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.PO8AgswjIz/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.WR1rcEiR6m/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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-04-25 17:16:54-- 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% 218M=0s 2016-04-25 17:16:54 (218 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.079632 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:54.552066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:54.554417) ========= 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.PO8AgswjIz/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.WR1rcEiR6m/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.019803 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:54.602733) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:54.603074) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 79de998e7307650fec99ea6188ae60ac64ebeedb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 79de998e7307650fec99ea6188ae60ac64ebeedb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PO8AgswjIz/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.WR1rcEiR6m/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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-04-25 17:16:54,695 truncating revision to first 12 chars 2016-04-25 17:16:54,695 Setting DEBUG logging. 2016-04-25 17:16:54,695 attempt 1/10 2016-04-25 17:16:54,695 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/79de998e7307?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 17:16:55,424 unpacking tar archive at: mozilla-central-79de998e7307/testing/mozharness/ program finished with exit code 0 elapsedTime=0.977864 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:55.600758) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:55.601079) ========= script_repo_revision: 79de998e7307650fec99ea6188ae60ac64ebeedb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:55.604485) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:55.604753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 17:16:55.623522) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-04-25 17:16:55.623796) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PO8AgswjIz/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.WR1rcEiR6m/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 17:16:55 INFO - MultiFileLogger online at 20160425 17:16:55 in /builds/slave/test 17:16:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:16:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:16:55 INFO - {'append_to_log': False, 17:16:55 INFO - 'base_work_dir': '/builds/slave/test', 17:16:55 INFO - 'blob_upload_branch': 'Firefox', 17:16:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:16:55 INFO - 'branch': 'Firefox', 17:16:55 INFO - 'buildbot_json_path': 'buildprops.json', 17:16:55 INFO - 'config_files': ('talos/mac_config.py',), 17:16:55 INFO - 'default_actions': ('clobber', 17:16:55 INFO - 'read-buildbot-config', 17:16:55 INFO - 'download-and-extract', 17:16:55 INFO - 'populate-webroot', 17:16:55 INFO - 'create-virtualenv', 17:16:55 INFO - 'install', 17:16:55 INFO - 'run-tests'), 17:16:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:16:55 INFO - 'download_minidump_stackwalk': True, 17:16:55 INFO - 'download_symbols': 'ondemand', 17:16:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:16:55 INFO - 'tooltool.py': '/tools/tooltool.py', 17:16:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:16:55 INFO - '/tools/misc-python/virtualenv.py')}, 17:16:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:16:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:16:55 INFO - 'installer_path': 'installer.exe', 17:16:55 INFO - 'log_level': 'info', 17:16:55 INFO - 'log_name': 'talos', 17:16:55 INFO - 'log_to_console': True, 17:16:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:16:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:16:55 INFO - 'opt_config_files': (), 17:16:55 INFO - 'pip_index': False, 17:16:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:16:55 INFO - 'cmd': ('bash', 17:16:55 INFO - '-c', 17:16:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:16:55 INFO - 'enabled': True, 17:16:55 INFO - 'halt_on_failure': False, 17:16:55 INFO - 'name': 'check_screen_resolution'},), 17:16:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:16:55 INFO - 'cmd': ('bash', 17:16:55 INFO - '-c', 17:16:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:16:55 INFO - 'enabled': True, 17:16:55 INFO - 'halt_on_failure': False, 17:16:55 INFO - 'name': 'check_screen_resolution'},), 17:16:55 INFO - 'run_cmd_checks_enabled': True, 17:16:55 INFO - 'sps_profile': False, 17:16:55 INFO - 'sps_profile_interval': 0, 17:16:55 INFO - 'suite': 'dromaeojs', 17:16:55 INFO - 'system_bits': '32', 17:16:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:16:55 INFO - 'title': 't-yosemite-r7-0009', 17:16:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:16:55 INFO - 'use_talos_json': True, 17:16:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:16:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:16:55 INFO - 'work_dir': 'build'} 17:16:55 INFO - ##### 17:16:55 INFO - ##### Running clobber step. 17:16:55 INFO - ##### 17:16:55 INFO - Running pre-action listener: _resource_record_pre_action 17:16:55 INFO - Running main action method: clobber 17:16:55 INFO - rmtree: /builds/slave/test/build 17:16:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:16:56 INFO - Running post-action listener: _resource_record_post_action 17:16:56 INFO - ##### 17:16:56 INFO - ##### Running read-buildbot-config step. 17:16:56 INFO - ##### 17:16:56 INFO - Running pre-action listener: _resource_record_pre_action 17:16:56 INFO - Running main action method: read_buildbot_config 17:16:56 INFO - Using buildbot properties: 17:16:56 INFO - { 17:16:56 INFO - "project": "", 17:16:56 INFO - "product": "firefox", 17:16:56 INFO - "script_repo_revision": "production", 17:16:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:16:56 INFO - "repository": "", 17:16:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:16:56 INFO - "buildid": "20160425152612", 17:16:56 INFO - "pgo_build": "False", 17:16:56 INFO - "basedir": "/builds/slave/test", 17:16:56 INFO - "buildnumber": 228, 17:16:56 INFO - "slavename": "t-yosemite-r7-0009", 17:16:56 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:16:56 INFO - "platform": "yosemite_r7", 17:16:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:16:56 INFO - "branch": "mozilla-central", 17:16:56 INFO - "repo_path": "mozilla-central", 17:16:56 INFO - "revision": "79de998e7307650fec99ea6188ae60ac64ebeedb", 17:16:56 INFO - "stage_platform": "macosx64", 17:16:56 INFO - "builduid": "db395646daad42cdb5966a0548f0356a", 17:16:56 INFO - "slavebuilddir": "test" 17:16:56 INFO - } 17:16:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 17:16:56 INFO - Running post-action listener: _resource_record_post_action 17:16:56 INFO - ##### 17:16:56 INFO - ##### Running download-and-extract step. 17:16:56 INFO - ##### 17:16:56 INFO - Running pre-action listener: _resource_record_pre_action 17:16:56 INFO - Running main action method: download_and_extract 17:16:56 INFO - mkdir: /builds/slave/test/build/tests 17:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:56 INFO - https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:16:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 17:16:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 17:16:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 17:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 17:17:04 INFO - Downloaded 1199 bytes. 17:17:04 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 17:17:04 INFO - Using the following test package requirements: 17:17:04 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 17:17:04 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:04 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 17:17:04 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:04 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 17:17:04 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:04 INFO - u'jsshell-mac.zip'], 17:17:04 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:04 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 17:17:04 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 17:17:04 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:04 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 17:17:04 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:04 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 17:17:04 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:04 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 17:17:04 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 17:17:04 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 17:17:04 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:04 INFO - https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:17:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:17:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:17:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:17:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:17:08 INFO - Downloaded 18111452 bytes. 17:17:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:17:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:17:11 INFO - Return code: 0 17:17:11 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:17:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:11 INFO - https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:17:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:17:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:17:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 17:17:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:17:12 INFO - Downloaded 18111452 bytes. 17:17:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:17:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:17:16 INFO - Return code: 0 17:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:16 INFO - https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 17:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:17:17 INFO - Downloaded 10840145 bytes. 17:17:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:17:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:17:17 INFO - Return code: 0 17:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:17 INFO - https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:17:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:17:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:17:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 17:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 17:17:21 INFO - Downloaded 110160085 bytes. 17:17:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:17:21 INFO - mkdir: /builds/slave/test/properties 17:17:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:21 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:21 INFO - Contents: 17:17:21 INFO - build_url:https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 17:17:22 INFO - Running post-action listener: _resource_record_post_action 17:17:22 INFO - Running post-action listener: set_extra_try_arguments 17:17:22 INFO - ##### 17:17:22 INFO - ##### Running populate-webroot step. 17:17:22 INFO - ##### 17:17:22 INFO - Running pre-action listener: _resource_record_pre_action 17:17:22 INFO - Running main action method: populate_webroot 17:17:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:22 INFO - '--tppagecycles', 17:17:22 INFO - '7'], 17:17:22 INFO - 'tests': ['tsvgm']}}, 17:17:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:17:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:17:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:17:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:17:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:17:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:22 INFO - 'talos_options': ['--disable-e10s'], 17:17:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:22 INFO - 'talos_options': ['--disable-e10s'], 17:17:22 INFO - 'tests': ['damp', 'tps']}, 17:17:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:22 INFO - 'tests': ['damp', 'tps']}, 17:17:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:17:22 INFO - 'tests': ['dromaeo_dom']}, 17:17:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:17:22 INFO - 'tests': ['a11yr', 17:17:22 INFO - 'ts_paint', 17:17:22 INFO - 'tpaint', 17:17:22 INFO - 'sessionrestore', 17:17:22 INFO - 'sessionrestore_no_auto_restore', 17:17:22 INFO - 'tabpaint']}, 17:17:22 INFO - 'other-e10s': {'tests': ['a11yr', 17:17:22 INFO - 'ts_paint', 17:17:22 INFO - 'tpaint', 17:17:22 INFO - 'sessionrestore', 17:17:22 INFO - 'sessionrestore_no_auto_restore', 17:17:22 INFO - 'tabpaint']}, 17:17:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:17:22 INFO - 'ts_paint', 17:17:22 INFO - 'tpaint', 17:17:22 INFO - 'sessionrestore', 17:17:22 INFO - 'sessionrestore_no_auto_restore', 17:17:22 INFO - 'tabpaint']}, 17:17:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:17:22 INFO - 'ts_paint', 17:17:22 INFO - 'tpaint', 17:17:22 INFO - 'sessionrestore', 17:17:22 INFO - 'sessionrestore_no_auto_restore', 17:17:22 INFO - 'tabpaint']}, 17:17:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:17:22 INFO - 'tests': ['a11yr', 17:17:22 INFO - 'ts_paint', 17:17:22 INFO - 'tpaint', 17:17:22 INFO - 'sessionrestore', 17:17:22 INFO - 'sessionrestore_no_auto_restore', 17:17:22 INFO - 'tabpaint']}, 17:17:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:17:22 INFO - 'tests': ['a11yr', 17:17:22 INFO - 'ts_paint', 17:17:22 INFO - 'tpaint', 17:17:22 INFO - 'sessionrestore', 17:17:22 INFO - 'sessionrestore_no_auto_restore', 17:17:22 INFO - 'tabpaint']}, 17:17:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:17:22 INFO - 'tests': ['tsvgx', 17:17:22 INFO - 'tsvgr_opacity', 17:17:22 INFO - 'tart', 17:17:22 INFO - 'tscrollx', 17:17:22 INFO - 'cart']}, 17:17:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:17:22 INFO - 'tsvgr_opacity', 17:17:22 INFO - 'tart', 17:17:22 INFO - 'tscrollx', 17:17:22 INFO - 'cart']}, 17:17:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:22 INFO - 'talos_options': ['--disable-e10s'], 17:17:22 INFO - 'tests': ['tp5o']}, 17:17:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:22 INFO - 'tests': ['tp5o']}, 17:17:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:22 INFO - 'talos_options': ['--disable-e10s', 17:17:22 INFO - '--xperf_path', 17:17:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:22 INFO - 'tests': ['tp5n']}, 17:17:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:22 INFO - 'talos_options': ['--xperf_path', 17:17:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:22 INFO - 'tests': ['tp5n']}}, 17:17:22 INFO - 'talos.zip': {'path': '', 17:17:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:22 INFO - Running post-action listener: _resource_record_post_action 17:17:22 INFO - ##### 17:17:22 INFO - ##### Running create-virtualenv step. 17:17:22 INFO - ##### 17:17:22 INFO - Running pre-action listener: _resource_record_pre_action 17:17:22 INFO - Running main action method: create_virtualenv 17:17:22 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:22 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 17:17:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:17:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:22 INFO - Using real prefix '/tools/python27' 17:17:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:23 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:26 INFO - Installing pip.................done. 17:17:26 INFO - Return code: 0 17:17:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:26 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 0x10aea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb405b9960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad44e00>, '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 0x10ab6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3fb20>, '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.PO8AgswjIz/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.WR1rcEiR6m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 17:17:26 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 17:17:26 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 17:17:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PO8AgswjIz/Render', 17:17:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:26 INFO - 'HOME': '/Users/cltbld', 17:17:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:26 INFO - 'LOGNAME': 'cltbld', 17:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:26 INFO - 'MOZ_NO_REMOTE': '1', 17:17:26 INFO - 'NO_EM_RESTART': '1', 17:17:26 INFO - 'PAGER': '/bin/cat', 17:17:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:26 INFO - 'PWD': '/builds/slave/test', 17:17:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:26 INFO - 'SHELL': '/bin/bash', 17:17:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WR1rcEiR6m/Listeners', 17:17:26 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 17:17:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:26 INFO - 'USER': 'cltbld', 17:17:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:26 INFO - 'XPC_FLAGS': '0x0', 17:17:26 INFO - 'XPC_SERVICE_NAME': '0', 17:17:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:26 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 17:17:26 INFO - Cleaning up... 17:17:26 INFO - Return code: 0 17:17:26 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:26 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb405b9960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad44e00>, '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 0x10ab6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3fb20>, '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.PO8AgswjIz/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.WR1rcEiR6m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 17:17:26 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>=0.7.1'] in /builds/slave/test/build 17:17:26 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>=0.7.1 17:17:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PO8AgswjIz/Render', 17:17:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:26 INFO - 'HOME': '/Users/cltbld', 17:17:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:26 INFO - 'LOGNAME': 'cltbld', 17:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:26 INFO - 'MOZ_NO_REMOTE': '1', 17:17:26 INFO - 'NO_EM_RESTART': '1', 17:17:26 INFO - 'PAGER': '/bin/cat', 17:17:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:26 INFO - 'PWD': '/builds/slave/test', 17:17:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:26 INFO - 'SHELL': '/bin/bash', 17:17:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WR1rcEiR6m/Listeners', 17:17:26 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 17:17:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:26 INFO - 'USER': 'cltbld', 17:17:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:26 INFO - 'XPC_FLAGS': '0x0', 17:17:26 INFO - 'XPC_SERVICE_NAME': '0', 17:17:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:26 INFO - Downloading/unpacking psutil>=0.7.1 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:26 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 17:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:29 INFO - Installing collected packages: psutil 17:17:29 INFO - Running setup.py install for psutil 17:17:29 INFO - building 'psutil._psutil_osx' extension 17:17:29 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 17:17:30 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 17:17:30 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 17:17:30 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 17:17:30 INFO - building 'psutil._psutil_posix' extension 17:17:30 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 17:17:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:17:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:17:30 INFO - ^ 17:17:30 INFO - 1 warning generated. 17:17:30 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 17:17:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:30 INFO - Successfully installed psutil 17:17:30 INFO - Cleaning up... 17:17:30 INFO - Return code: 0 17:17:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:17: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb405b9960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad44e00>, '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 0x10ab6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3fb20>, '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.PO8AgswjIz/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.WR1rcEiR6m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 17:17: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:17: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 mozsystemmonitor==0.0.0 17:17:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PO8AgswjIz/Render', 17:17:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:30 INFO - 'HOME': '/Users/cltbld', 17:17:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:30 INFO - 'LOGNAME': 'cltbld', 17:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:30 INFO - 'MOZ_NO_REMOTE': '1', 17:17:30 INFO - 'NO_EM_RESTART': '1', 17:17:30 INFO - 'PAGER': '/bin/cat', 17:17:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:30 INFO - 'PWD': '/builds/slave/test', 17:17:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:30 INFO - 'SHELL': '/bin/bash', 17:17:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WR1rcEiR6m/Listeners', 17:17:30 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 17:17:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:30 INFO - 'USER': 'cltbld', 17:17:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:30 INFO - 'XPC_FLAGS': '0x0', 17:17:30 INFO - 'XPC_SERVICE_NAME': '0', 17:17:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:17:30 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 17:17:30 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 17:17:30 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 17:17:30 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 17:17:30 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 17:17:30 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 17:17:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:17:33 INFO - Installing collected packages: mozsystemmonitor 17:17:33 INFO - Running setup.py install for mozsystemmonitor 17:17:33 INFO - Successfully installed mozsystemmonitor 17:17:33 INFO - Cleaning up... 17:17:33 INFO - Return code: 0 17:17:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb405b9960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad44e00>, '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 0x10ab6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3fb20>, '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.PO8AgswjIz/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.WR1rcEiR6m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 17:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:17:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PO8AgswjIz/Render', 17:17:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:33 INFO - 'HOME': '/Users/cltbld', 17:17:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:33 INFO - 'LOGNAME': 'cltbld', 17:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:33 INFO - 'MOZ_NO_REMOTE': '1', 17:17:33 INFO - 'NO_EM_RESTART': '1', 17:17:33 INFO - 'PAGER': '/bin/cat', 17:17:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:33 INFO - 'PWD': '/builds/slave/test', 17:17:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:33 INFO - 'SHELL': '/bin/bash', 17:17:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WR1rcEiR6m/Listeners', 17:17:33 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 17:17:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:33 INFO - 'USER': 'cltbld', 17:17:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:33 INFO - 'XPC_FLAGS': '0x0', 17:17:33 INFO - 'XPC_SERVICE_NAME': '0', 17:17:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:34 INFO - Downloading/unpacking blobuploader==1.2.4 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:36 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17:36 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 17:17:36 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 17:17:36 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 17:17:36 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 17:17:36 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 17:17:36 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 17:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:17:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:37 INFO - Downloading docopt-0.6.1.tar.gz 17:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:37 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:37 INFO - Running setup.py install for blobuploader 17:17:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:37 INFO - Running setup.py install for requests 17:17:38 INFO - Running setup.py install for docopt 17:17:38 INFO - Successfully installed blobuploader requests docopt 17:17:38 INFO - Cleaning up... 17:17:38 INFO - Return code: 0 17:17:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:38 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 0x10aea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb405b9960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad44e00>, '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 0x10ab6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3fb20>, '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.PO8AgswjIz/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.WR1rcEiR6m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 17:17:38 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 17:17:38 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 17:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PO8AgswjIz/Render', 17:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:38 INFO - 'HOME': '/Users/cltbld', 17:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:38 INFO - 'LOGNAME': 'cltbld', 17:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:38 INFO - 'MOZ_NO_REMOTE': '1', 17:17:38 INFO - 'NO_EM_RESTART': '1', 17:17:38 INFO - 'PAGER': '/bin/cat', 17:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:38 INFO - 'PWD': '/builds/slave/test', 17:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:38 INFO - 'SHELL': '/bin/bash', 17:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WR1rcEiR6m/Listeners', 17:17:38 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 17:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:38 INFO - 'USER': 'cltbld', 17:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:38 INFO - 'XPC_FLAGS': '0x0', 17:17:38 INFO - 'XPC_SERVICE_NAME': '0', 17:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:38 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-pBODdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:38 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-sDUMIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-agtWac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-c3z1XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-H5uflP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-pqT2rF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-9mV6TD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-Gxm35H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-7zVLYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-nUNwHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:39 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-D1Ta4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-vPC6fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-QjNWUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-lkoXtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-DPiP1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-QYFYEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:40 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-aPWC_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:40 INFO - Running setup.py install for manifestparser 17:17:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:40 INFO - Running setup.py install for mozcrash 17:17:40 INFO - Running setup.py install for mozdebug 17:17:41 INFO - Running setup.py install for mozdevice 17:17:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Running setup.py install for mozfile 17:17:41 INFO - Running setup.py install for mozhttpd 17:17:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Running setup.py install for mozinfo 17:17:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Running setup.py install for mozInstall 17:17:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:41 INFO - Running setup.py install for mozleak 17:17:41 INFO - Running setup.py install for mozlog 17:17:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Running setup.py install for moznetwork 17:17:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Running setup.py install for mozprocess 17:17:42 INFO - Running setup.py install for mozprofile 17:17:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Running setup.py install for mozrunner 17:17:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:42 INFO - Running setup.py install for mozscreenshot 17:17:42 INFO - Running setup.py install for moztest 17:17:43 INFO - Running setup.py install for mozversion 17:17:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:43 INFO - Cleaning up... 17:17:43 INFO - Return code: 0 17:17:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:43 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 0x10aea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb405b9960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad44e00>, '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 0x10ab6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3fb20>, '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.PO8AgswjIz/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.WR1rcEiR6m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 17:17:43 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 17:17:43 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 17:17:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PO8AgswjIz/Render', 17:17:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:43 INFO - 'HOME': '/Users/cltbld', 17:17:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:43 INFO - 'LOGNAME': 'cltbld', 17:17:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:43 INFO - 'MOZ_NO_REMOTE': '1', 17:17:43 INFO - 'NO_EM_RESTART': '1', 17:17:43 INFO - 'PAGER': '/bin/cat', 17:17:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:43 INFO - 'PWD': '/builds/slave/test', 17:17:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:43 INFO - 'SHELL': '/bin/bash', 17:17:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WR1rcEiR6m/Listeners', 17:17:43 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 17:17:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:43 INFO - 'USER': 'cltbld', 17:17:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:43 INFO - 'XPC_FLAGS': '0x0', 17:17:43 INFO - 'XPC_SERVICE_NAME': '0', 17:17:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:43 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-maHaBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:43 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)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:43 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-5_EVka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:43 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)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:43 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-hEymjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:43 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)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:43 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-zy67wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:43 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)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:43 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-iRqMIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:43 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)) 17:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:43 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-aB2y2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:44 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)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:44 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-PSlq6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:44 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)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:44 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-YrFoXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:44 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)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:44 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-rL0XA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:44 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)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:44 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-4_QY3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:44 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-mmlOIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:44 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)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:44 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-_6WdkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:44 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-1zwNgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:44 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)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:44 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-pRol5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 17:17:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:44 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-h3sUgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17: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)) 17:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:45 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-BGg6JC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:45 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)) 17:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:45 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-RUvuaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 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)) 17:17:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:45 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 17:17:45 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 17:17:45 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 17:17:45 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 17:17:45 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 17:17:45 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 17:17:47 INFO - Downloading blessings-1.6.tar.gz 17:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:47 INFO - Installing collected packages: blessings 17:17:47 INFO - Running setup.py install for blessings 17:17:47 INFO - Successfully installed blessings 17:17:47 INFO - Cleaning up... 17:17:47 INFO - Return code: 0 17:17:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:48 INFO - Reading from file tmpfile_stdout 17:17:48 INFO - Current package versions: 17:17:48 INFO - blessings == 1.6 17:17:48 INFO - blobuploader == 1.2.4 17:17:48 INFO - docopt == 0.6.1 17:17:48 INFO - manifestparser == 1.1 17:17:48 INFO - mozInstall == 1.12 17:17:48 INFO - mozcrash == 0.17 17:17:48 INFO - mozdebug == 0.1 17:17:48 INFO - mozdevice == 0.48 17:17:48 INFO - mozfile == 1.2 17:17:48 INFO - mozhttpd == 0.7 17:17:48 INFO - mozinfo == 0.9 17:17:48 INFO - mozleak == 0.1 17:17:48 INFO - mozlog == 3.1 17:17:48 INFO - moznetwork == 0.27 17:17:48 INFO - mozprocess == 0.22 17:17:48 INFO - mozprofile == 0.28 17:17:48 INFO - mozrunner == 6.11 17:17:48 INFO - mozscreenshot == 0.1 17:17:48 INFO - mozsystemmonitor == 0.0 17:17:48 INFO - moztest == 0.7 17:17:48 INFO - mozversion == 1.4 17:17:48 INFO - psutil == 3.1.1 17:17:48 INFO - requests == 1.2.3 17:17:48 INFO - wsgiref == 0.1.2 17:17:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:48 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 0x10aea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb405b9960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad44e00>, '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 0x10ab6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3fb20>, '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.PO8AgswjIz/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.WR1rcEiR6m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 17:17:48 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 17:17:48 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 17:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PO8AgswjIz/Render', 17:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:48 INFO - 'HOME': '/Users/cltbld', 17:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:48 INFO - 'LOGNAME': 'cltbld', 17:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:48 INFO - 'MOZ_NO_REMOTE': '1', 17:17:48 INFO - 'NO_EM_RESTART': '1', 17:17:48 INFO - 'PAGER': '/bin/cat', 17:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:48 INFO - 'PWD': '/builds/slave/test', 17:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:48 INFO - 'SHELL': '/bin/bash', 17:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WR1rcEiR6m/Listeners', 17:17:48 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 17:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:48 INFO - 'USER': 'cltbld', 17:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:48 INFO - 'XPC_FLAGS': '0x0', 17:17:48 INFO - 'XPC_SERVICE_NAME': '0', 17:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:48 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)) 17:17:48 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)) 17:17:48 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)) 17:17:48 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)) 17:17:48 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)) 17:17:48 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)) 17:17:48 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)) 17:17:48 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)) 17:17:48 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)) 17:17:48 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)) 17:17:48 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)) 17:17:48 INFO - Cleaning up... 17:17:48 INFO - Return code: 0 17:17:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:48 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 0x10aea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb405b9960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad44e00>, '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 0x10ab6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3fb20>, '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.PO8AgswjIz/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.WR1rcEiR6m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 17:17:48 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 17:17:48 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 17:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PO8AgswjIz/Render', 17:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:48 INFO - 'HOME': '/Users/cltbld', 17:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:48 INFO - 'LOGNAME': 'cltbld', 17:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:48 INFO - 'MOZ_NO_REMOTE': '1', 17:17:48 INFO - 'NO_EM_RESTART': '1', 17:17:48 INFO - 'PAGER': '/bin/cat', 17:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:48 INFO - 'PWD': '/builds/slave/test', 17:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:48 INFO - 'SHELL': '/bin/bash', 17:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WR1rcEiR6m/Listeners', 17:17:48 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 17:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:48 INFO - 'USER': 'cltbld', 17:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:48 INFO - 'XPC_FLAGS': '0x0', 17:17:48 INFO - 'XPC_SERVICE_NAME': '0', 17:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:48 INFO - Downloading/unpacking jsonschema 17:17:48 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 17:17:48 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 17:17:48 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 17:17:48 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 17:17:48 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 17:17:48 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 17:17:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:17:51 INFO - Downloading/unpacking functools32 (from jsonschema) 17:17:51 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 17:17:51 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 17:17:51 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 17:17:51 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 17:17:51 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 17:17:51 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 17:17:51 INFO - Downloading functools32-3.2.3-2.tar.gz 17:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:17:51 INFO - warning: no files found matching '*.txt' 17:17:51 INFO - no previously-included directories found matching 'build' 17:17:51 INFO - no previously-included directories found matching 'dist' 17:17:51 INFO - no previously-included directories found matching '.git*' 17:17:51 INFO - Installing collected packages: jsonschema, functools32 17:17:51 INFO - Running setup.py install for functools32 17:17:51 INFO - warning: no files found matching '*.txt' 17:17:51 INFO - no previously-included directories found matching 'build' 17:17:51 INFO - no previously-included directories found matching 'dist' 17:17:51 INFO - no previously-included directories found matching '.git*' 17:17:51 INFO - Successfully installed jsonschema functools32 17:17:51 INFO - Cleaning up... 17:17:51 INFO - Return code: 0 17:17:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:52 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aea5a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aeb5420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb405b9960>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad44e00>, '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 0x10ab6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3fb20>, '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.PO8AgswjIz/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.WR1rcEiR6m/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 17:17:52 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', 'flake8'] in /builds/slave/test/build 17:17:52 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 flake8 17:17:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PO8AgswjIz/Render', 17:17:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:52 INFO - 'HOME': '/Users/cltbld', 17:17:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:52 INFO - 'LOGNAME': 'cltbld', 17:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:52 INFO - 'MOZ_NO_REMOTE': '1', 17:17:52 INFO - 'NO_EM_RESTART': '1', 17:17:52 INFO - 'PAGER': '/bin/cat', 17:17:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:52 INFO - 'PWD': '/builds/slave/test', 17:17:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:52 INFO - 'SHELL': '/bin/bash', 17:17:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WR1rcEiR6m/Listeners', 17:17:52 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 17:17:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:52 INFO - 'USER': 'cltbld', 17:17:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:52 INFO - 'XPC_FLAGS': '0x0', 17:17:52 INFO - 'XPC_SERVICE_NAME': '0', 17:17:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:52 INFO - Downloading/unpacking flake8 17:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:17:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:17:55 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 17:17:55 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 17:17:55 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 17:17:55 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 17:17:55 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 17:17:55 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 17:17:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:17:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:17:55 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 17:17:55 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 17:17:55 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 17:17:55 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 17:17:55 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 17:17:55 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 17:17:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:17:56 INFO - no previously-included directories found matching 'docs/_build' 17:17:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:17:56 INFO - Running setup.py install for pep8 17:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:17:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:17:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:17:56 INFO - no previously-included directories found matching 'docs/_build' 17:17:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:17:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:17:56 INFO - Cleaning up... 17:17:56 INFO - Return code: 0 17:17:56 INFO - Running post-action listener: _resource_record_post_action 17:17:56 INFO - Running post-action listener: _start_resource_monitoring 17:17:56 INFO - Starting resource monitoring. 17:17:56 INFO - ##### 17:17:56 INFO - ##### Running install step. 17:17:56 INFO - ##### 17:17:56 INFO - Running pre-action listener: _resource_record_pre_action 17:17:56 INFO - Running main action method: install 17:17:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:57 INFO - Reading from file tmpfile_stdout 17:17:57 INFO - Detecting whether we're running mozinstall >=1.0... 17:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:17:57 INFO - Reading from file tmpfile_stdout 17:17:57 INFO - Output received: 17:17:57 INFO - Usage: mozinstall [options] installer 17:17:57 INFO - Options: 17:17:57 INFO - -h, --help show this help message and exit 17:17:57 INFO - -d DEST, --destination=DEST 17:17:57 INFO - Directory to install application into. [default: 17:17:57 INFO - "/builds/slave/test"] 17:17:57 INFO - --app=APP Application being installed. [default: firefox] 17:17:57 INFO - mkdir: /builds/slave/test/build/application 17:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:18:30 INFO - Reading from file tmpfile_stdout 17:18:30 INFO - Output received: 17:18:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:18:30 INFO - Running post-action listener: _resource_record_post_action 17:18:30 INFO - ##### 17:18:30 INFO - ##### Running run-tests step. 17:18:30 INFO - ##### 17:18:30 INFO - Running pre-action listener: _resource_record_pre_action 17:18:30 INFO - Running main action method: run_tests 17:18:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:18:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:18:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:18:30 INFO - 2016-04-25 17:18:30.866 screenresolution[2077:13125] starting screenresolution argv=screenresolution get 17:18:30 INFO - 2016-04-25 17:18:30.869 screenresolution[2077:13125] Display 0: 1600x1200x32@60 17:18:30 INFO - 2016-04-25 17:18:30.875 screenresolution[2078:13127] starting screenresolution argv=screenresolution list 17:18:30 INFO - Available Modes on Display 0 17:18:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:18:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:18:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:18:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:18:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:18:31 INFO - Intel Iris: 17:18:31 INFO - Chipset Model: Intel Iris 17:18:31 INFO - Type: GPU 17:18:31 INFO - Bus: Built-In 17:18:31 INFO - VRAM (Dynamic, Max): 1536 MB 17:18:31 INFO - Vendor: Intel (0x8086) 17:18:31 INFO - Device ID: 0x0a2e 17:18:31 INFO - Revision ID: 0x0009 17:18:31 INFO - Displays: 17:18:31 INFO - Display: 17:18:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:18:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:18:31 INFO - Display Serial Number: 1600x1200 60 17:18:31 INFO - Main Display: Yes 17:18:31 INFO - Mirror: Off 17:18:31 INFO - Online: Yes 17:18:31 INFO - Rotation: Supported 17:18:31 INFO - Return code: 0 17:18:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:18:31 INFO - Python 2.7.3 17:18:31 INFO - Return code: 0 17:18:31 INFO - grabbing minidump binary from tooltool 17:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:31 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad44e00>, '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 0x10ab6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ad3fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:18:31 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 17:18:31 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 17:18:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:31 INFO - Return code: 0 17:18:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:18:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:18:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:18:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:18:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:18:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:18:32 INFO - Return code: 0 17:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:18:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PO8AgswjIz/Render', 17:18:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:32 INFO - 'HOME': '/Users/cltbld', 17:18:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:32 INFO - 'LOGNAME': 'cltbld', 17:18:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:32 INFO - 'MOZ_NO_REMOTE': '1', 17:18:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:32 INFO - 'NO_EM_RESTART': '1', 17:18:32 INFO - 'PAGER': '/bin/cat', 17:18:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:32 INFO - 'PWD': '/builds/slave/test', 17:18:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:32 INFO - 'SHELL': '/bin/bash', 17:18:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WR1rcEiR6m/Listeners', 17:18:32 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 17:18:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:32 INFO - 'USER': 'cltbld', 17:18:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:32 INFO - 'XPC_FLAGS': '0x0', 17:18:32 INFO - 'XPC_SERVICE_NAME': '0', 17:18:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:18:32 INFO - mozversion application_buildid: 20160425152612 17:18:32 INFO - mozversion application_changeset: 79de998e7307650fec99ea6188ae60ac64ebeedb 17:18:32 INFO - mozversion application_display_name: Nightly 17:18:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:32 INFO - mozversion application_name: Firefox 17:18:32 INFO - mozversion application_remotingname: firefox 17:18:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:18:32 INFO - mozversion application_vendor: Mozilla 17:18:32 INFO - mozversion application_version: 49.0a1 17:18:32 INFO - mozversion platform_buildid: 20160425152612 17:18:32 INFO - mozversion platform_changeset: 79de998e7307650fec99ea6188ae60ac64ebeedb 17:18:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:18:32 INFO - mozversion platform_version: 49.0a1 17:18:32 INFO - using testdate: 1461629912 17:18:32 INFO - actual date: 1461629912 17:18:32 INFO - starting webserver on 'localhost:49357' 17:18:32 INFO - SUITE-START | Running 2 tests 17:18:32 INFO - TEST-START | dromaeo_css 17:18:32 INFO - operating with platform_type : mac_ 17:18:32 INFO - Initialising browser for dromaeo_css test... 17:18:32 INFO - TEST-INFO | started process 2096 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpJBzNLy/profile http://localhost:49357/getInfo.html) 17:18:34 INFO - PROCESS | 2096 | __metrics Screen width/height:1600/1200 17:18:34 INFO - PROCESS | 2096 | colorDepth:24 17:18:34 INFO - PROCESS | 2096 | Browser inner width/height: 1024/689 17:18:34 INFO - PROCESS | 2096 | __metrics 17:18:34 INFO - PROCESS | 2096 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:18:34 ERROR - PROCESS | 2096 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:18:35 INFO - TEST-INFO | 2096: exit 0 17:18:35 INFO - Browser initialized. 17:18:35 INFO - Running cycle 1/1 for dromaeo_css test... 17:18:35 INFO - TEST-INFO | started process 2099 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpJBzNLy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:47 INFO - PROCESS | 2099 | RSS: Main: 239296512 17:18:47 INFO - PROCESS | 2099 | 17:19:38 INFO - PROCESS | 2099 | 1461629978843 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] 17:21:49 INFO - PROCESS | 2099 | Cycle 1(1): loaded http://localhost:49357/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49357/tests/dromaeo/cssquery-ext.html) 17:21:50 INFO - PROCESS | 2099 | RSS: Main: 346116096 17:21:50 INFO - PROCESS | 2099 | 17:24:53 INFO - PROCESS | 2099 | Cycle 1(1): loaded http://localhost:49357/tests/dromaeo/cssquery-ext.html (next: http://localhost:49357/tests/dromaeo/cssquery-jquery.html) 17:24:54 INFO - PROCESS | 2099 | RSS: Main: 372506624 17:24:54 INFO - PROCESS | 2099 | 17:27:56 INFO - PROCESS | 2099 | Cycle 1(1): loaded http://localhost:49357/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49357/tests/dromaeo/cssquery-mootools.html) 17:27:56 INFO - PROCESS | 2099 | RSS: Main: 377360384 17:27:56 INFO - PROCESS | 2099 | 17:30:59 INFO - PROCESS | 2099 | Cycle 1(1): loaded http://localhost:49357/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49357/tests/dromaeo/cssquery-prototype.html) 17:30:59 INFO - PROCESS | 2099 | RSS: Main: 375689216 17:30:59 INFO - PROCESS | 2099 | 17:34:03 INFO - PROCESS | 2099 | Cycle 1(1): loaded http://localhost:49357/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49357/tests/dromaeo/cssquery-yui.html) 17:34:03 INFO - PROCESS | 2099 | RSS: Main: 337772544 17:34:03 INFO - PROCESS | 2099 | 17:37:07 INFO - PROCESS | 2099 | Cycle 1(1): loaded http://localhost:49357/tests/dromaeo/cssquery-yui.html (next: http://localhost:49357/tests/dromaeo/cssquery-dojo.html) 17:37:07 INFO - PROCESS | 2099 | RSS: Main: 386428928 17:37:07 INFO - PROCESS | 2099 | 17:37:07 INFO - PROCESS | 2099 | __start_tp_report 17:37:07 INFO - PROCESS | 2099 | _x_x_mozilla_page_load 17:37:07 INFO - PROCESS | 2099 | _x_x_mozilla_page_load_details 17:37:07 INFO - PROCESS | 2099 | |i|pagename|runs| 17:37:07 INFO - PROCESS | 2099 | |0;dojo.html;3254.9349013019737;3462.221000274937;3473.947890781637;3486.564179477565;3529.17064489845;5606.383297837245;5719.857003574903;5731.197632331477;5737.7991770288045;5790.9999999999945;5742.655440673562;5749.396313387087;5779.104238842986;5878.118282257664;5884.6763428011545;5107.080725469414;5117.02776472469;5167.715775632339;5179.792808287664;5232.424433312332;5213.4004589472315;5226.085435048852;5234.031704134728;5250.238715386266;5292.391374991887;5080.034793389263;5104.234364845266;5190.558802501773;5195.870103247449;5246.396664383607;5195.5324020837925;5196.45437229093;5215.687058776485;5227.085260079509;5228.895422091537;5141.76862041209;5184.922226166611;5202.3497062867145;5209.583233341362;5228.869278268074;5504.697241651707;5588.077967135418;5625.606207565472;5632.5212356949705;5637.267155269788;6269.592476489013;6281.434670879597;6316.957701979168;6318.7472501100365;6319.052142178664;6317.05244213367;6362.936370636281;6380.330065343165;6390.808275751689;6395.296517383084;5694.288213973254;5824.563157763142;5834.095715164156;5841.591088623755;5849.532037437038;5368.8389348319615;6256.749730010749;6294.9685251574365;6327.715252813635;6339.985602303609;6115.938840611537;6137.815865524041;6174.845628859314;6228.968855155696;6239.251289845157;6131.804871721949;6243.406876346739;6314.968425157845;6335.239771227482;6353.5234857385885;6128.778133444945;6193.566450348432;6205.565610407319;6212.06818977157;6218.720157592919;6291;6298.968505157445;6303.401176888188;6316.62100273985;6326.114343991845;4844.079624871263;4946.010797840374;4950.950490495121;4967.552920237196;4977.104121258209;4397.186520493655;4409.470863496401;4438.1567502174485;4463.375127482155;4500.617447516932;5708.1723150143;5726.914096288559;5734.627249228787;5735.369109397963;5747.885042299215;6179.598326108879;6185.628862268279;6288.968555157287;6383.234011918599;6393.296737358887;5752.769889204469;5776.913346299809;5793.8841223175305;5809.128630705428;5831.446012628793;5413.972930135403;5426.593005524602;5427.701476418835;5450.345958485007;5452.291202143696;6254.6247225166635;6338.936610633927;6346.4605508532295;6370.617762934239;6375.203099612549;5244.396894357198;6231.657258850807;6315.08431277453;6345.904811427925;6356.396142366468;6349.6507692077375;6376.968115159394;6397.296297407189;6397.712102955285;6398.90401643985;5770.769169233352;6174.228221472316;6283.2460104787715;6318.62088274705;6415.262244841903;6124.441964285778;6214.2853571838;6316.62100273985;6329.683515824098;6378.425941665272;6127.724252408741;6164.753409863555;6165.722542485689;6167.044108163242;6177.84555386119;6116.204893363834;6142.232220972379;6142.969285153546;6153.261608606996;6159.72281247336;5762.30852297727;5901.675407852609;5937;6007.849803754941;6009.90985135232;6118.112873633388;6123.877522449615;6132.172156758959;6145.72344244519;6168.568200225941;5843.678597677169;5867.266591676041;6010.429009244115;6029.035354343459;6032.426919442646 17:37:07 INFO - PROCESS | 2099 | |1;ext.html;508.41278323536307;541.3693047599546;579.2932622200914;588.7615515716134;604.8760004199139;25322.873385633047;30493.237669058286;30933.381332373338;30964.84517577409;38417.42373864394;43213.783931080376;43868.78065609668;44022.339664904976;44046;44074;8287.502749835;9377.578008989612;9554.856677149848;9640.758981025496;9668.661596844111;8278.83442331153;8486.32109431244;9483.620655173785;9681.951590242039;11015.559377624886;11303.773924521505;11425.714357141096;11463.36951467669;11469.885301146966;11472.426378681033;11243;11364.431778411088;11375.886241137565;11389.829152562717;11393.145514086395;8260.256576908047;10915.563377464892;11170.609028683957;11179;11192.664220073411;38529.422058669144;39207.41188882169;39279;39280.60719392798;39346.606533934864;3229.7730134962258;3256.8860089896975;3282.458394364927;3298.993806888898;3455.844486998066;27785.027524036763;28532.7160277788;28569.714302857123;28570;29190.27024324388;2615.882285297166;2682.0746842339363;2708.0251109600526;2773.514634938898;2810.5784132380104;407791;412488.9375553133;413420;414104;415024;63500.68249658722;65427.34572654308;65528;65630.34369656337;65642.37430502726;68830.65584672044;69047.8928448221;69098.65450672715;69144.61710765857;69193.65403172951;16558.00651960862;17260.964342139512;17280.827191728175;17303.3943811966;17306.740398894028;11634.88365116338;13231.404586793617;13306;13327.200367977952;13334.333283335794;16722.41471548514;17142.914285428495;17414.303427862742;17440;17471.650566988843;5869;7883.211678832071;7910.564918929399;7969.920300797034;7981.321587664997;931.487681775021;937.634322614181;956.6508224498148;1016.2632091733434;1067.5836423794726;28863.567046494318;28961.42077158445;29261.268468288465;29607;29608.851955740512;1052.8368102944055;1099.455769394155;1106.7454485468227;1114.8717897441736;1170.988290117105;13206.877415419605;15303.92348038275;15512.534623961299;15807.288672009787;15850.841491585166;649995;658078.7096064489;660485;661113;661494;60359;61152.694236528536;61385.693071534355;61389.69305153446;61420.385796142364;1434.1968497641353;1490.7540255857662;1494.2528735632184;1503.2859391789032;1506.9623259418602;29156.18922877786;29172.27069323284;29361.85319073391;29901.551476727433;30022;51704;52135.95728085493;52638.210426844395;52667.47332526779;52669.73665131803;555349;560223;560304;560412;563022;22379.77620223777;25179.866905989642;25708.485830282916;27195;27610.44779104447;42567.148657027305;43099.56900430955;43350.78324608357;43726.56273437225;44152.77923610361;35470.46794298139;35619.64380356163;35707;36354;36517.81741091277;34981.82509087438;35032;35486.75796347115;35851.64148358483;35875;36183;36538.90383288506;36783.08042298857;37091.44362834613;37176.44235336418;32175.195620109684;32348.514772278904;32545.511817322287;32682.83658581692;32892.83553582217;24250.393740156636;24345.26964191077;24645.01419943254;24742.50514989654;24751.752482474945 17:37:07 INFO - PROCESS | 2099 | |2;jquery.html;397.7732692365352;400.58539411708887;400.91179940413116;400.9158076803871;411.60280329482043;14374.712505749905;19610.90194549027;20488.643805962318;20620.587588248243;20966.37100886976;15995.360185592592;17831.286748530074;19812.50468738282;20322.59354812903;20630.071646775894;5681.403452637465;5884.852878678024;5911.142884281777;5916.881662366772;5917.5561832862495;5594.971620433302;5749;5795.623284486495;5840.737166827503;5853.912191317134;5776.451237132486;5776.740046697909;5781.075027995522;5804.158397032428;5810.680412577307;5436.456354364552;5645.503941455518;5795.4784069433745;5832.212651292064;5855.355910849803;5109.770060347293;5129.384473863123;5132.692038477703;5141.2545180948555;5141.922871156936;24362.756372436226;24692.876535617208;25824.483510329876;25841.870790646113;26001.089961851245;2113.7991890770504;2177.2379667116384;2205.5368372641765;2403.807695384365;2862.6831657437397;14050.508232211925;14324.212168330738;14603.92698036503;14631.487897923627;15029.323680434407;1675.8240384759547;1705.2241230240336;1842.253887175696;1882.105999650169;1909.3508207209616;119246;125985.37007314997;126931.36534317362;126973;128360.73114150846;11398.430078496041;11593.188476806712;11595.594154204562;11624.418779061014;11761.88238117608;14959.401623935139;14979.251037448084;15048.946573739733;15051.397944082333;15068.171250581323;7452.06849143857;7767.495112817649;7886.171951945078;8309.459885107448;8450.323974082059;8357.414980951397;8369.414141010193;8448.619812108469;8452.661893524313;8495.150484951579;4470.083632855257;4556.88607784808;4557.134144512598;4565.086982603492;4622.098690755271;1915.913783879701;1939.41817454763;1951.9902400487906;1964.8112891700316;1978.2482656590691;730.9423971520154;826.6652005937605;954.1412728544227;979.5151400057017;1053.3474309144074;17310;18637.627247454973;20315.492112697302;20528.586353933977;20678.483037924172;908.9500077495801;945.394947233771;953.4946478366477;975.702315919825;988.6786794291884;10469.790604188025;10720.874308197683;10736.570537178426;10744.785104297871;10762.408067556204;580726;589671;600498;606579;608610;119502;131316;137227;137471;141288.29355853156;997.7827050997771;1028.953697083618;1042.7132538551807;1050.7635781949152;1051.2903789941759;14398.496052638107;16290.592735181715;17258.395956141474;17466.388676396775;17480.825191748427;47351;50406.747966259936;50468.74765626148;51168.488315116374;53136.202956954905;53092;67580.66209669117;68150;68833.31166688469;69027;7658.349040331635;7736.419768517271;7865.882011769942;8124.268815806369;8335;11975.401229938643;12103.81844272319;12475.251484910934;12558.372081395712;12617.558385456465;5263.947360526499;5412.594055445936;10414.417656231233;11153.55385784592;11391.088712903114;4515.232410490159;8726.607302671267;10865.293755905841;10894.202456594574;11112.722181945515;10926.617568385387;11336.773264534499;11420.657380278604;11421.828672570084;11427.771444570895;6803.625800581016;8192.631331590212;8241.340692744687;8346.87479687793;8649.437786543855;10388.428636424767;11116.49975751077;11396.430178491208;11445.713857153638;11472.311661300015 17:37:07 INFO - PROCESS | 2099 | |3;mootools.html;1370.6299299189225;1600.4638446120548;1602.6794641071788;1862.6647203503373;2009.4072248686637;7809.219078092188;8487.872681909768;8758.299336053116;8779.20987111159;8788.91211087889;8385.91614083859;8625.48247105174;8628.741137765861;8628.784280392993;8650.956745216281;2149.6990421341025;2230.408941630469;2231.241377931503;2406.073661640268;2449.8775061246956;2242.8093612042994;2414.7705967933107;2493.9625905611338;2495.3886297857052;2498.537770512461;2078.8440866934966;2396.4967356854995;2431.598786200275;2442.963355549668;2446.00936620668;1785.366195000769;2405.927822165338;2420.721617014031;2422.0069771393732;2422.648715936197;2366.171839856054;2442.9755702443103;2444.022391043579;2445.2419749877595;2447.449323902126;7445.292697193758;8530.232279094911;8609.225169734691;8624.913750862474;8633.481991080555;5051.1413059779925;5239.764210610531;5250.842474725764;5259.605529585297;5275.024120537674;3237.7895436796766;3252.47960326349;3346.5984081910083;3437.914052148691;3551.786892786441;965.7151140413595;1012.5797793915516;1014.5028935821468;1016.552716804611;1031.1699082238795;9607;11478.540858365655;11496.252743571724;11497.482613282338;11510.769784604261;4726.26742854858;4782.904341913142;4856.053069651454;4856.077345304381;4891.2174052152195;9844.064813842673;9868.21054315653;9909.45497997617;9913.702588922344;9933.25500587459;5440.510354068153;5449.4005659377435;5451.4276001019325;5452.127659574449;5462.399136095027;4847.709137451764;4865.318855360252;4892.657513974059;4952.752362381939;4989.600831933437;3966.7024973126554;3992.5608183099835;4033.9798301008896;4068.145689405258;4085.7548547086676;1327.2832670357898;1329.926854023038;1332.0808642036964;1346.4748747988292;1350.3585796746468;812.3420029775782;885.3536918049859;904.8597467392433;946.2146418472652;970.4322971061866;5200.583953283728;5834.445727655866;5852.765889364463;5930.2883653960935;6040.516758659297;461.420916749484;466.4612372709526;470.1912710138556;982.2436723722693;995.7809281957958;3797.6582107610448;3852.3065848147603;3897.142628621699;3993.9201215975518;4000.979995100064;10160.593576256866;10644.361338319726;10666.78666426667;10674.946625266824;10682.78634427307;10002.699919002442;10560.102391296827;10733.463326833627;10749.731256718489;10761.83857242142;7748.535087894745;8015.318697910627;8097.39269554774;8269.29710974562;8369;5924.140999555127;5956.642601443928;5994.0109881869;6012.789552365646;6072.332043475126;9751.902480975383;10079.748006299902;10187.898121018992;10194.286399951932;10212.285140040423;8961.865572016555;9943.25425593069;10149.594016239564;10342.069213770797;10378.377297362182;5726.455986681259;6502.837429064311;7514.436417268836;7521.924780752122;7523.3229009389415;8077.151899050515;8295.336373090018;8300.54347010896;8312.16878312188;8312.6674933002;7272.23641517633;7327.120745510573;7564.50830696003;7575.886361704689;7606.201348858512;6676.9332306676315;7044.908039253924;7280.672369743268;7312.012878261579;7464.992226049631;6827.351401616838;6833.214180369122;6898.068760717239;6920.238773734784;6931.6880740367815;4599.321247744482;4712.528747125397;4924.72913989734;4952;5016.473270306711;4994.2781184253945;5014.6991180529285;5064.898067302029;5085.957378737424;5097.745112744422 17:37:07 INFO - PROCESS | 2099 | |4;prototype.html;320.6120594081162;322.1655911190018;326.7908538535337;328.2122905027933;332.81528751542885;4811.855644330667;4855.85432437027;5066.9493305066935;5081.339425874636;5430.212619170218;4663.883402914928;5306.761195746191;5334.546108789961;5350.705711185883;5363.517283444489;3522.806245656488;3915.4714113594587;4023.4970628671417;4024.9597504025023;4034.6685593754137;3537.734669899755;4075.755454672714;4096.508418989711;4116.188876894157;4136.648384887289;3669.871554495593;3792.127810603563;4012.8595499157536;4065.87802365928;4092.669882288253;3817.331966905794;3882.602263185251;3931.410288456726;4066.2274167908004;4115.9176816463805;3591.2637909228806;3604.5849280981806;3617.5297211362617;3618.0773902654655;3644.671979521829;5168.638195326329;5183;5188.495336352454;5196.194589838581;5199.610029247784;4329.372241025065;4687;4687.812487500496;4707.45864225615;4707.529247075299;5564.582656300794;5582.134769110794;5593.3847276799515;5632.324121105453;5677.372941053029;3534.876279330211;3869.496965394481;3875.5543112541854;3875.7093218008763;3882.835149455152;5129.384473863161;5454.91817622736;5501.257330260403;5593.52455041322;5679.261695979496;3830.3488406970323;3920.5687374388795;3921.254961557295;3924.4309575111447;3929.6659783918685;3979.9204015919518;3996.7002474814503;3998.2403343364667;4013.478247827822;4017.372963949547;4582.885427864263;4590.62281315604;4611.677182597186;4630.236011058205;4666.3700400445505;5332.30680011596;5673.971630141823;5693.111335284269;5693.971530142323;5713.771449142071;1256.4722816417127;1296.8054791781308;1449.521657852927;1454.7672372420361;1461.444651032622;863.5552690364467;869.4739682492128;948.6158105967095;968.6754937096151;977.3695966101967;5484.012877681976;5647.6329038613185;5753.913691294634;5787.392323806024;5811.360750317462;6342.207224096988;6356.188486281388;6368.840778980562;6374.394432528902;6376.808695739135;5517.917231241535;5776.249087618667;5790.160426738184;5806.390329015477;5825.863636817822;2904.3029672878356;3346.297277571737;3355.983220083884;3364.2934983653217;3372.544706464645;5799.9130013049835;6278.246610406781;6288.937110628835;6626.204855417381;6633.369829866155;5147.1507201312115;5827.3298570664065;6111.54163437735;6126.549380247848;6153;5297.152455607084;5438.945610543844;5740.942590574125;5867.618604790589;5908.675022873783;4999.925001125059;5369.067135831176;5881.118252056547;5920.407959204217;5959.344472107978;5033.421156567042;5639;5717.8570535736935;5829.948186010682;5847.327557330961;6033.366496517978;6111.174991376108;6123.663198524124;6132.386761323832;6143.84640383994;3898.200868821828;3950.881473555798;3972.7616343019513;3981.482407287034;3983.322835117979;5674.546036317167;5884.352721200579;5894.911576326273;5938.940610593839;5951.791687290924;5296.3379577552805;5690.516306113861;5698.230738850368;5708.549339246625;5714.657120572612;5168.3539557555305;5182.429932707324;5319.46805319465;5705.2297939779255;5710.885782284414;4336.913261734685;5250.875728941274;5358.758855851574;5580.218769372373;5627.943720562742;5171.991461665089;5653.321601407857;5686.004949133968;5707.259285917668;5718.285214348207;4978;5321.966479106872;5624.7187640616985;5649.265595472562;5660.37735849048 17:37:07 INFO - PROCESS | 2099 | |5;yui.html;654.9541532092752;718.3534818663203;753.9509931854426;765.1468612497066;798.6964953317738;14394.136351818885;14661.120332780041;14669.706605867876;14694.779578306321;14695.265236738147;11729.824052639216;13599.864001359983;13713.245771482565;13728.656783580416;13737.24445155516;886.2112719679475;930.2372054914939;930.4091901642472;930.6044930904372;934.2432629570036;920.8940971788263;933.1321870660283;938.2869019545161;939.3002213351064;940.8541676040225;981.5730157381562;987.8814542254903;989.4063561862861;989.9059589339038;990.9702708918708;746.6863917154781;888.595688961521;976.6386437018277;980.294188184506;981.5681100315838;729.9306565876233;730.6638946084807;731.0861423220974;731.104397113537;734.8456824066952;14675.926620366936;14739.55781326562;14756.557303280919;14771.335289911873;14808.111513309128;9539.284553658503;12223.633291001284;12386.938065309705;12390.504379824886;12703.110782245247;9710.223182145412;9918.107370336704;9932.751681207956;10296.485175741183;10657.147428205724;3079.5226739855357;3457.2739724657854;3496.4580490024086;3531.311394278091;3558.768680035789;72229.6388518054;75587.62206188934;75740;75791.62104189499;76117.61941190314;9431.811363772686;9498.667546635972;9708.223342132613;9723.367981081348;9744.853827192455;21287.254946077122;21529.677054843876;21532.4616884576;21542.03060862265;21547.461313467287;7226.710931562784;7355.485116041933;7432.182459929403;7590.8861367079535;7592.506487078323;4059.817308221078;4124.010237542968;4146.087860670647;4162.500499940026;4218.325067989168;3357.1439282982683;3461.3250416169108;3463.1342164458883;3465.462853257749;3466.878659246914;494.29069285575315;611.7736437518147;615.4799194680488;626.370497649859;641.4066988036049;560.4773995438729;588.3381196154327;589.4429763873185;596.9164316995624;613.1018058544254;6499.967500162564;7957.681692732342;7979.760607181794;8082.474639148437;8208.835823283502;482.27176962786444;535.563515734675;577.3677822784044;610.1457958857546;612.091044798474;3774.037620406779;3871.4386413969814;3916.4516967624554;3927.8232479538487;3999.8200080996426;93398.5330073359;94861;97638;97906;97908;68603;71565.92651110237;72729;72893;73280.63359683275;65949.34050659432;67002.66498667476;67084.66457667778;67106.32893671001;68431.65784171048;7331.0469638948725;7423.480356375002;7706;7736.7292144774665;7767.741935483871;33653.831730841186;43769.78115109532;44147.117057658026;44387.778061109486;44459.33311000402;60487.39512604818;60624.696876515336;60711.69644151751;60877;61836.38163618486;8383.455075420079;10467.424291664032;10561.260711750103;10570.735731606464;10814.188787048899;10872;11141.665750027512;11568.88431115678;11997.278762929378;12325.322107284186;10386;10733.409662468639;10766.46167691628;10807.35155890649;10886.346819190874;10671.35971841692;10866.239363244496;10891.237613366988;10919.399433030942;10923.78152436931;10388.844167337345;10525.684229473129;10529.947350263199;10542.8418573723;10578.889216632142;8580;8918.420302680304;8952.328575357005;9010.053944336012;9118.22495087925;8041.758747237593;8537.829243414973;8553.44402613828;8589.226969572768;8615 17:37:07 INFO - PROCESS | 2099 | __end_tp_report 17:37:07 INFO - PROCESS | 2099 | __start_cc_report 17:37:07 INFO - PROCESS | 2099 | _x_x_mozilla_cycle_collect,1122 17:37:07 INFO - PROCESS | 2099 | __end_cc_report 17:37:07 INFO - PROCESS | 2099 | __startTimestamp1461631027299__endTimestamp 17:37:07 INFO - PROCESS | 2099 | 17:37:07 INFO - PROCESS | 2099 | ------- Summary: start ------- 17:37:07 INFO - PROCESS | 2099 | Number of tests: 6 17:37:07 INFO - PROCESS | 2099 | 17:37:07 INFO - PROCESS | 2099 | [#0] dojo.html Cycles:165 Average:5767.18 Median:5937.00 stddev:648.37 (10.9%) stddev-sans-first:619.69 17:37:07 INFO - PROCESS | 2099 | Values: 3254.9 3462.2 3473.9 3486.6 3529.2 5606.4 5719.9 5731.2 5737.8 5791.0 5742.7 5749.4 5779.1 5878.1 5884.7 5107.1 5117.0 5167.7 5179.8 5232.4 5213.4 5226.1 5234.0 5250.2 5292.4 5080.0 5104.2 5190.6 5195.9 5246.4 5195.5 5196.5 5215.7 5227.1 5228.9 5141.8 5184.9 5202.3 5209.6 5228.9 5504.7 5588.1 5625.6 5632.5 5637.3 6269.6 6281.4 6317.0 6318.7 6319.1 6317.1 6362.9 6380.3 6390.8 6395.3 5694.3 5824.6 5834.1 5841.6 5849.5 5368.8 6256.7 6295.0 6327.7 6340.0 6115.9 6137.8 6174.8 6229.0 6239.3 6131.8 6243.4 6315.0 6335.2 6353.5 6128.8 6193.6 6205.6 6212.1 6218.7 6291.0 6299.0 6303.4 6316.6 6326.1 4844.1 4946.0 4951.0 4967.6 4977.1 4397.2 4409.5 4438.2 4463.4 4500.6 5708.2 5726.9 5734.6 5735.4 5747.9 6179.6 6185.6 6289.0 6383.2 6393.3 5752.8 5776.9 5793.9 5809.1 5831.4 5414.0 5426.6 5427.7 5450.3 5452.3 6254.6 6338.9 6346.5 6370.6 6375.2 5244.4 6231.7 6315.1 6345.9 6356.4 6349.7 6377.0 6397.3 6397.7 6398.9 5770.8 6174.2 6283.2 6318.6 6415.3 6124.4 6214.3 6316.6 6329.7 6378.4 6127.7 6164.8 6165.7 6167.0 6177.8 6116.2 6142.2 6143.0 6153.3 6159.7 5762.3 5901.7 5937.0 6007.8 6009.9 6118.1 6123.9 6132.2 6145.7 6168.6 5843.7 5867.3 6010.4 6029.0 6032.4 17:37:07 INFO - PROCESS | 2099 | 17:37:07 INFO - PROCESS | 2099 | [#1] ext.html Cycles:180 Average:67952.22 Median:19218.83 stddev:147883.59 (769.5%) stddev-sans-first:148211.75 17:37:07 INFO - PROCESS | 2099 | Values: 508.4 541.4 579.3 588.8 604.9 25322.9 30493.2 30933.4 30964.8 38417.4 43213.8 43868.8 44022.3 44046.0 44074.0 8287.5 9377.6 9554.9 9640.8 9668.7 8278.8 8486.3 9483.6 9682.0 11015.6 11303.8 11425.7 11463.4 11469.9 11472.4 11243.0 11364.4 11375.9 11389.8 11393.1 8260.3 10915.6 11170.6 11179.0 11192.7 38529.4 39207.4 39279.0 39280.6 39346.6 3229.8 3256.9 3282.5 3299.0 3455.8 27785.0 28532.7 28569.7 28570.0 29190.3 2615.9 2682.1 2708.0 2773.5 2810.6 407791.0 412488.9 413420.0 414104.0 415024.0 63500.7 65427.3 65528.0 65630.3 65642.4 68830.7 69047.9 69098.7 69144.6 69193.7 16558.0 17261.0 17280.8 17303.4 17306.7 11634.9 13231.4 13306.0 13327.2 13334.3 16722.4 17142.9 17414.3 17440.0 17471.7 5869.0 7883.2 7910.6 7969.9 7981.3 931.5 937.6 956.7 1016.3 1067.6 28863.6 28961.4 29261.3 29607.0 29608.9 1052.8 1099.5 1106.7 1114.9 1171.0 13206.9 15303.9 15512.5 15807.3 15850.8 649995.0 658078.7 660485.0 661113.0 661494.0 60359.0 61152.7 61385.7 61389.7 61420.4 1434.2 1490.8 1494.3 1503.3 1507.0 29156.2 29172.3 29361.9 29901.6 30022.0 51704.0 52136.0 52638.2 52667.5 52669.7 555349.0 560223.0 560304.0 560412.0 563022.0 22379.8 25179.9 25708.5 27195.0 27610.4 42567.1 43099.6 43350.8 43726.6 44152.8 35470.5 35619.6 35707.0 36354.0 36517.8 34981.8 35032.0 35486.8 35851.6 35875.0 36183.0 36538.9 36783.1 37091.4 37176.4 32175.2 32348.5 32545.5 32682.8 32892.8 24250.4 24345.3 24645.0 24742.5 24751.8 17:37:07 INFO - PROCESS | 2099 | 17:37:07 INFO - PROCESS | 2099 | [#2] jquery.html Cycles:180 Average:34741.03 Median:24527.82 stddev:99938.06 (407.4%) stddev-sans-first:100185.14 17:37:07 INFO - PROCESS | 2099 | Values: 397.8 400.6 400.9 400.9 411.6 14374.7 19610.9 20488.6 20620.6 20966.4 15995.4 17831.3 19812.5 20322.6 20630.1 5681.4 5884.9 5911.1 5916.9 5917.6 5595.0 5749.0 5795.6 5840.7 5853.9 5776.5 5776.7 5781.1 5804.2 5810.7 5436.5 5645.5 5795.5 5832.2 5855.4 5109.8 5129.4 5132.7 5141.3 5141.9 24362.8 24692.9 25824.5 25841.9 26001.1 2113.8 2177.2 2205.5 2403.8 2862.7 14050.5 14324.2 14603.9 14631.5 15029.3 1675.8 1705.2 1842.3 1882.1 1909.4 119246.0 125985.4 126931.4 126973.0 128360.7 11398.4 11593.2 11595.6 11624.4 11761.9 14959.4 14979.3 15048.9 15051.4 15068.2 7452.1 7767.5 7886.2 8309.5 8450.3 8357.4 8369.4 8448.6 8452.7 8495.2 4470.1 4556.9 4557.1 4565.1 4622.1 1915.9 1939.4 1952.0 1964.8 1978.2 730.9 826.7 954.1 979.5 1053.3 17310.0 18637.6 20315.5 20528.6 20678.5 909.0 945.4 953.5 975.7 988.7 10469.8 10720.9 10736.6 10744.8 10762.4 580726.0 589671.0 600498.0 606579.0 608610.0 119502.0 131316.0 137227.0 137471.0 141288.3 997.8 1029.0 1042.7 1050.8 1051.3 14398.5 16290.6 17258.4 17466.4 17480.8 47351.0 50406.7 50468.7 51168.5 53136.2 53092.0 67580.7 68150.0 68833.3 69027.0 7658.3 7736.4 7865.9 8124.3 8335.0 11975.4 12103.8 12475.3 12558.4 12617.6 5263.9 5412.6 10414.4 11153.6 11391.1 4515.2 8726.6 10865.3 10894.2 11112.7 10926.6 11336.8 11420.7 11421.8 11427.8 6803.6 8192.6 8241.3 8346.9 8649.4 10388.4 11116.5 11396.4 11445.7 11472.3 17:37:07 INFO - PROCESS | 2099 | 17:37:07 INFO - PROCESS | 2099 | [#3] mootools.html Cycles:180 Average:5645.97 Median:4971.18 stddev:3142.02 (63.2%) stddev-sans-first:3134.41 17:37:07 INFO - PROCESS | 2099 | Values: 1370.6 1600.5 1602.7 1862.7 2009.4 7809.2 8487.9 8758.3 8779.2 8788.9 8385.9 8625.5 8628.7 8628.8 8651.0 2149.7 2230.4 2231.2 2406.1 2449.9 2242.8 2414.8 2494.0 2495.4 2498.5 2078.8 2396.5 2431.6 2443.0 2446.0 1785.4 2405.9 2420.7 2422.0 2422.6 2366.2 2443.0 2444.0 2445.2 2447.4 7445.3 8530.2 8609.2 8624.9 8633.5 5051.1 5239.8 5250.8 5259.6 5275.0 3237.8 3252.5 3346.6 3437.9 3551.8 965.7 1012.6 1014.5 1016.6 1031.2 9607.0 11478.5 11496.3 11497.5 11510.8 4726.3 4782.9 4856.1 4856.1 4891.2 9844.1 9868.2 9909.5 9913.7 9933.3 5440.5 5449.4 5451.4 5452.1 5462.4 4847.7 4865.3 4892.7 4952.8 4989.6 3966.7 3992.6 4034.0 4068.1 4085.8 1327.3 1329.9 1332.1 1346.5 1350.4 812.3 885.4 904.9 946.2 970.4 5200.6 5834.4 5852.8 5930.3 6040.5 461.4 466.5 470.2 982.2 995.8 3797.7 3852.3 3897.1 3993.9 4001.0 10160.6 10644.4 10666.8 10674.9 10682.8 10002.7 10560.1 10733.5 10749.7 10761.8 7748.5 8015.3 8097.4 8269.3 8369.0 5924.1 5956.6 5994.0 6012.8 6072.3 9751.9 10079.7 10187.9 10194.3 10212.3 8961.9 9943.3 10149.6 10342.1 10378.4 5726.5 6502.8 7514.4 7521.9 7523.3 8077.2 8295.3 8300.5 8312.2 8312.7 7272.2 7327.1 7564.5 7575.9 7606.2 6676.9 7044.9 7280.7 7312.0 7465.0 6827.4 6833.2 6898.1 6920.2 6931.7 4599.3 4712.5 4924.7 4952.0 5016.5 4994.3 5014.7 5064.9 5086.0 5097.7 17:37:07 INFO - PROCESS | 2099 | 17:37:07 INFO - PROCESS | 2099 | [#4] prototype.html Cycles:180 Average:4681.53 Median:5296.75 stddev:1441.82 (27.2%) stddev-sans-first:1408.22 17:37:07 INFO - PROCESS | 2099 | Values: 320.6 322.2 326.8 328.2 332.8 4811.9 4855.9 5066.9 5081.3 5430.2 4663.9 5306.8 5334.5 5350.7 5363.5 3522.8 3915.5 4023.5 4025.0 4034.7 3537.7 4075.8 4096.5 4116.2 4136.6 3669.9 3792.1 4012.9 4065.9 4092.7 3817.3 3882.6 3931.4 4066.2 4115.9 3591.3 3604.6 3617.5 3618.1 3644.7 5168.6 5183.0 5188.5 5196.2 5199.6 4329.4 4687.0 4687.8 4707.5 4707.5 5564.6 5582.1 5593.4 5632.3 5677.4 3534.9 3869.5 3875.6 3875.7 3882.8 5129.4 5454.9 5501.3 5593.5 5679.3 3830.3 3920.6 3921.3 3924.4 3929.7 3979.9 3996.7 3998.2 4013.5 4017.4 4582.9 4590.6 4611.7 4630.2 4666.4 5332.3 5674.0 5693.1 5694.0 5713.8 1256.5 1296.8 1449.5 1454.8 1461.4 863.6 869.5 948.6 968.7 977.4 5484.0 5647.6 5753.9 5787.4 5811.4 6342.2 6356.2 6368.8 6374.4 6376.8 5517.9 5776.2 5790.2 5806.4 5825.9 2904.3 3346.3 3356.0 3364.3 3372.5 5799.9 6278.2 6288.9 6626.2 6633.4 5147.2 5827.3 6111.5 6126.5 6153.0 5297.2 5438.9 5740.9 5867.6 5908.7 4999.9 5369.1 5881.1 5920.4 5959.3 5033.4 5639.0 5717.9 5829.9 5847.3 6033.4 6111.2 6123.7 6132.4 6143.8 3898.2 3950.9 3972.8 3981.5 3983.3 5674.5 5884.4 5894.9 5938.9 5951.8 5296.3 5690.5 5698.2 5708.5 5714.7 5168.4 5182.4 5319.5 5705.2 5710.9 4336.9 5250.9 5358.8 5580.2 5627.9 5172.0 5653.3 5686.0 5707.3 5718.3 4978.0 5322.0 5624.7 5649.3 5660.4 17:37:07 INFO - PROCESS | 2099 | 17:37:07 INFO - PROCESS | 2099 | [#5] yui.html Cycles:180 Average:17360.14 Median:614.29 stddev:24572.42 (4000.1%) stddev-sans-first:24609.33 17:37:07 INFO - PROCESS | 2099 | Values: 655.0 718.4 754.0 765.1 798.7 14394.1 14661.1 14669.7 14694.8 14695.3 11729.8 13599.9 13713.2 13728.7 13737.2 886.2 930.2 930.4 930.6 934.2 920.9 933.1 938.3 939.3 940.9 981.6 987.9 989.4 989.9 991.0 746.7 888.6 976.6 980.3 981.6 729.9 730.7 731.1 731.1 734.8 14675.9 14739.6 14756.6 14771.3 14808.1 9539.3 12223.6 12386.9 12390.5 12703.1 9710.2 9918.1 9932.8 10296.5 10657.1 3079.5 3457.3 3496.5 3531.3 3558.8 72229.6 75587.6 75740.0 75791.6 76117.6 9431.8 9498.7 9708.2 9723.4 9744.9 21287.3 21529.7 21532.5 21542.0 21547.5 7226.7 7355.5 7432.2 7590.9 7592.5 4059.8 4124.0 4146.1 4162.5 4218.3 3357.1 3461.3 3463.1 3465.5 3466.9 494.3 611.8 615.5 626.4 641.4 560.5 588.3 589.4 596.9 613.1 6500.0 7957.7 7979.8 8082.5 8208.8 482.3 535.6 577.4 610.1 612.1 3774.0 3871.4 3916.5 3927.8 3999.8 93398.5 94861.0 97638.0 97906.0 97908.0 68603.0 71565.9 72729.0 72893.0 73280.6 65949.3 67002.7 67084.7 67106.3 68431.7 7331.0 7423.5 7706.0 7736.7 7767.7 33653.8 43769.8 44147.1 44387.8 44459.3 60487.4 60624.7 60711.7 60877.0 61836.4 8383.5 10467.4 10561.3 10570.7 10814.2 10872.0 11141.7 11568.9 11997.3 12325.3 10386.0 10733.4 10766.5 10807.4 10886.3 10671.4 10866.2 10891.2 10919.4 10923.8 10388.8 10525.7 10529.9 10542.8 10578.9 8580.0 8918.4 8952.3 9010.1 9118.2 8041.8 8537.8 8553.4 8589.2 8615.0 17:37:07 INFO - PROCESS | 2099 | -------- Summary: end -------- 17:37:07 INFO - PROCESS | 2099 | 17:37:07 INFO - TEST-INFO | 2099: exit 0 17:37:07 INFO - TEST-OK | dromaeo_css | took 1115302ms 17:37:07 INFO - TEST-START | kraken 17:37:07 INFO - operating with platform_type : mac_ 17:37:07 INFO - Initialising browser for kraken test... 17:37:07 INFO - TEST-INFO | started process 2104 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpEIXn9w/profile http://localhost:49357/getInfo.html) 17:37:09 INFO - PROCESS | 2104 | __metrics Screen width/height:1600/1200 17:37:09 INFO - PROCESS | 2104 | colorDepth:24 17:37:09 INFO - PROCESS | 2104 | Browser inner width/height: 1024/689 17:37:09 INFO - PROCESS | 2104 | __metrics 17:37:10 INFO - PROCESS | 2104 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:37:10 ERROR - PROCESS | 2104 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:37:10 INFO - TEST-INFO | 2104: exit 0 17:37:10 INFO - Browser initialized. 17:37:10 INFO - Running cycle 1/1 for kraken test... 17:37:10 INFO - TEST-INFO | started process 2106 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpEIXn9w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:22 INFO - PROCESS | 2106 | RSS: Main: 239550464 17:37:22 INFO - PROCESS | 2106 | 17:37:25 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49357/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:26 INFO - PROCESS | 2106 | RSS: Main: 287113216 17:37:26 INFO - PROCESS | 2106 | 17:37:29 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49357/tests/kraken/driver.html?testName=audio-dft) 17:37:30 INFO - PROCESS | 2106 | RSS: Main: 299368448 17:37:30 INFO - PROCESS | 2106 | 17:37:33 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49357/tests/kraken/driver.html?testName=audio-fft) 17:37:34 INFO - PROCESS | 2106 | RSS: Main: 387436544 17:37:34 INFO - PROCESS | 2106 | 17:37:36 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49357/tests/kraken/driver.html?testName=audio-oscillator) 17:37:36 INFO - PROCESS | 2106 | RSS: Main: 287731712 17:37:36 INFO - PROCESS | 2106 | 17:37:39 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49357/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:39 INFO - PROCESS | 2106 | RSS: Main: 291553280 17:37:39 INFO - PROCESS | 2106 | 17:37:42 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49357/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:42 INFO - PROCESS | 2106 | RSS: Main: 328863744 17:37:42 INFO - PROCESS | 2106 | 17:37:45 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49357/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:46 INFO - PROCESS | 2106 | RSS: Main: 330391552 17:37:46 INFO - PROCESS | 2106 | 17:37:49 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49357/tests/kraken/driver.html?testName=json-parse-financial) 17:37:49 INFO - PROCESS | 2106 | RSS: Main: 330334208 17:37:49 INFO - PROCESS | 2106 | 17:37:51 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49357/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:52 INFO - PROCESS | 2106 | RSS: Main: 321564672 17:37:52 INFO - PROCESS | 2106 | 17:37:53 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:54 INFO - PROCESS | 2106 | RSS: Main: 327835648 17:37:54 INFO - PROCESS | 2106 | 17:37:56 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:57 INFO - PROCESS | 2106 | RSS: Main: 330215424 17:37:57 INFO - PROCESS | 2106 | 17:38:00 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:38:00 INFO - PROCESS | 2106 | RSS: Main: 327766016 17:38:00 INFO - PROCESS | 2106 | 17:38:03 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:38:04 INFO - PROCESS | 2106 | RSS: Main: 328572928 17:38:04 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49357/tests/kraken/driver.html?testName=ai-astar) 17:38:06 INFO - PROCESS | 2106 | RSS: Main: 393936896 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | __start_tp_report 17:38:06 INFO - PROCESS | 2106 | _x_x_mozilla_page_load 17:38:06 INFO - PROCESS | 2106 | _x_x_mozilla_page_load_details 17:38:06 INFO - PROCESS | 2106 | |i|pagename|runs| 17:38:06 INFO - PROCESS | 2106 | |0;ai-astar;112;112;108;111;112;118;154;160;106;113 17:38:06 INFO - PROCESS | 2106 | |1;audio-beat-detection;159;123;148;172;120;142;140;119;162;135 17:38:06 INFO - PROCESS | 2106 | |2;audio-dft;186;185;188;185;181;181;188;179;185;185 17:38:06 INFO - PROCESS | 2106 | |3;audio-fft;79;74;81;147;56;56;60;66;137;58 17:38:06 INFO - PROCESS | 2106 | |4;audio-oscillator;97;98;134;78;81;85;128;78;78;125 17:38:06 INFO - PROCESS | 2106 | |5;imaging-gaussian-blur;87;84;87;85;86;84;87;84;87;83 17:38:06 INFO - PROCESS | 2106 | |6;imaging-darkroom;92;92;92;93;93;91;92;93;92;93 17:38:06 INFO - PROCESS | 2106 | |7;imaging-desaturate;86;86;84;85;86;83;84;84;84;84 17:38:06 INFO - PROCESS | 2106 | |8;json-parse-financial;58;59;59;59;59;59;58;80;58;57 17:38:06 INFO - PROCESS | 2106 | |9;json-stringify-tinderbox;62;66;63;73;72;68;66;68;67;66 17:38:06 INFO - PROCESS | 2106 | |10;stanford-crypto-aes;84;84;83;81;82;82;81;82;82;83 17:38:06 INFO - PROCESS | 2106 | |11;stanford-crypto-ccm;137;136;139;137;134;135;134;143;190;155 17:38:06 INFO - PROCESS | 2106 | |12;stanford-crypto-pbkdf2;162;147;183;197;156;221;217;180;170;170 17:38:06 INFO - PROCESS | 2106 | |13;stanford-crypto-sha256-iterative;69;69;69;69;67;68;58;65;64;66 17:38:06 INFO - PROCESS | 2106 | __end_tp_report 17:38:06 INFO - PROCESS | 2106 | __start_cc_report 17:38:06 INFO - PROCESS | 2106 | _x_x_mozilla_cycle_collect,2036 17:38:06 INFO - PROCESS | 2106 | __end_cc_report 17:38:06 INFO - PROCESS | 2106 | __startTimestamp1461631086405__endTimestamp 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | ------- Summary: start ------- 17:38:06 INFO - PROCESS | 2106 | Number of tests: 14 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#0] ai-astar Cycles:10 Average:120.60 Median:112.50 stddev:19.49 (17.3%) stddev-sans-first:20.42 17:38:06 INFO - PROCESS | 2106 | Values: 112.0 112.0 108.0 111.0 112.0 118.0 154.0 160.0 106.0 113.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:145.00 stddev:18.41 (12.7%) stddev-sans-first:18.48 17:38:06 INFO - PROCESS | 2106 | Values: 159.0 123.0 148.0 172.0 120.0 142.0 140.0 119.0 162.0 135.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:3.02 (1.6%) stddev-sans-first:3.14 17:38:06 INFO - PROCESS | 2106 | Values: 186.0 185.0 188.0 185.0 181.0 181.0 188.0 179.0 185.0 185.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#3] audio-fft Cycles:10 Average:81.40 Median:63.00 stddev:33.31 (52.9%) stddev-sans-first:35.32 17:38:06 INFO - PROCESS | 2106 | Values: 79.0 74.0 81.0 147.0 56.0 56.0 60.0 66.0 137.0 58.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:79.50 stddev:22.57 (28.4%) stddev-sans-first:23.93 17:38:06 INFO - PROCESS | 2106 | Values: 97.0 98.0 134.0 78.0 81.0 85.0 128.0 78.0 78.0 125.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.50 stddev:1.58 (1.8%) stddev-sans-first:1.56 17:38:06 INFO - PROCESS | 2106 | Values: 87.0 84.0 87.0 85.0 86.0 84.0 87.0 84.0 87.0 83.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#6] imaging-darkroom Cycles:10 Average:92.30 Median:92.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 17:38:06 INFO - PROCESS | 2106 | Values: 92.0 92.0 92.0 93.0 93.0 91.0 92.0 93.0 92.0 93.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.50 stddev:1.07 (1.3%) stddev-sans-first:1.01 17:38:06 INFO - PROCESS | 2106 | Values: 86.0 86.0 84.0 85.0 86.0 83.0 84.0 84.0 84.0 84.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:59.00 stddev:6.85 (11.6%) stddev-sans-first:7.20 17:38:06 INFO - PROCESS | 2106 | Values: 58.0 59.0 59.0 59.0 59.0 59.0 58.0 80.0 58.0 57.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.50 stddev:3.45 (5.1%) stddev-sans-first:3.12 17:38:06 INFO - PROCESS | 2106 | Values: 62.0 66.0 63.0 73.0 72.0 68.0 66.0 68.0 67.0 66.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.07 (1.3%) stddev-sans-first:0.97 17:38:06 INFO - PROCESS | 2106 | Values: 84.0 84.0 83.0 81.0 82.0 82.0 81.0 82.0 82.0 83.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#11] stanford-crypto-ccm Cycles:10 Average:144.00 Median:138.00 stddev:17.34 (12.6%) stddev-sans-first:18.21 17:38:06 INFO - PROCESS | 2106 | Values: 137.0 136.0 139.0 137.0 134.0 135.0 134.0 143.0 190.0 155.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:181.50 stddev:24.80 (13.7%) stddev-sans-first:25.41 17:38:06 INFO - PROCESS | 2106 | Values: 162.0 147.0 183.0 197.0 156.0 221.0 217.0 180.0 170.0 170.0 17:38:06 INFO - PROCESS | 2106 | 17:38:06 INFO - PROCESS | 2106 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:68.50 stddev:3.47 (5.1%) stddev-sans-first:3.55 17:38:06 INFO - PROCESS | 2106 | Values: 69.0 69.0 69.0 69.0 67.0 68.0 58.0 65.0 64.0 66.0 17:38:06 INFO - PROCESS | 2106 | -------- Summary: end -------- 17:38:06 INFO - PROCESS | 2106 | 17:38:07 INFO - TEST-INFO | 2106: exit 0 17:38:07 INFO - TEST-OK | kraken | took 59395ms 17:38:07 INFO - SUITE-END | took 1174s 17:38:07 INFO - Completed test suite (00:19:35) 17:38:07 INFO - javascript benchmark 17:38:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3254.9349013019737, 3462.221000274937, 3473.947890781637, 3486.564179477565, 3529.17064489845, 5606.383297837245, 5719.857003574903, 5731.197632331477, 5737.7991770288045, 5790.9999999999945, 5742.655440673562, 5749.396313387087, 5779.104238842986, 5878.118282257664, 5884.6763428011545, 5107.080725469414, 5117.02776472469, 5167.715775632339, 5179.792808287664, 5232.424433312332, 5213.4004589472315, 5226.085435048852, 5234.031704134728, 5250.238715386266, 5292.391374991887, 5080.034793389263, 5104.234364845266, 5190.558802501773, 5195.870103247449, 5246.396664383607, 5195.5324020837925, 5196.45437229093, 5215.687058776485, 5227.085260079509, 5228.895422091537, 5141.76862041209, 5184.922226166611, 5202.3497062867145, 5209.583233341362, 5228.869278268074, 5504.697241651707, 5588.077967135418, 5625.606207565472, 5632.5212356949705, 5637.267155269788, 6269.592476489013, 6281.434670879597, 6316.957701979168, 6318.7472501100365, 6319.052142178664, 6317.05244213367, 6362.936370636281, 6380.330065343165, 6390.808275751689, 6395.296517383084, 5694.288213973254, 5824.563157763142, 5834.095715164156, 5841.591088623755, 5849.532037437038, 5368.8389348319615, 6256.749730010749, 6294.9685251574365, 6327.715252813635, 6339.985602303609, 6115.938840611537, 6137.815865524041, 6174.845628859314, 6228.968855155696, 6239.251289845157, 6131.804871721949, 6243.406876346739, 6314.968425157845, 6335.239771227482, 6353.5234857385885, 6128.778133444945, 6193.566450348432, 6205.565610407319, 6212.06818977157, 6218.720157592919, 6291.0, 6298.968505157445, 6303.401176888188, 6316.62100273985, 6326.114343991845, 4844.079624871263, 4946.010797840374, 4950.950490495121, 4967.552920237196, 4977.104121258209, 4397.186520493655, 4409.470863496401, 4438.1567502174485, 4463.375127482155, 4500.617447516932, 5708.1723150143, 5726.914096288559, 5734.627249228787, 5735.369109397963, 5747.885042299215, 6179.598326108879, 6185.628862268279, 6288.968555157287, 6383.234011918599, 6393.296737358887, 5752.769889204469, 5776.913346299809, 5793.8841223175305, 5809.128630705428, 5831.446012628793, 5413.972930135403, 5426.593005524602, 5427.701476418835, 5450.345958485007, 5452.291202143696, 6254.6247225166635, 6338.936610633927, 6346.4605508532295, 6370.617762934239, 6375.203099612549, 5244.396894357198, 6231.657258850807, 6315.08431277453, 6345.904811427925, 6356.396142366468, 6349.6507692077375, 6376.968115159394, 6397.296297407189, 6397.712102955285, 6398.90401643985, 5770.769169233352, 6174.228221472316, 6283.2460104787715, 6318.62088274705, 6415.262244841903, 6124.441964285778, 6214.2853571838, 6316.62100273985, 6329.683515824098, 6378.425941665272, 6127.724252408741, 6164.753409863555, 6165.722542485689, 6167.044108163242, 6177.84555386119, 6116.204893363834, 6142.232220972379, 6142.969285153546, 6153.261608606996, 6159.72281247336, 5762.30852297727, 5901.675407852609, 5937.0, 6007.849803754941, 6009.90985135232, 6118.112873633388, 6123.877522449615, 6132.172156758959, 6145.72344244519, 6168.568200225941, 5843.678597677169, 5867.266591676041, 6010.429009244115, 6029.035354343459, 6032.426919442646], "value": 5725.916565099679, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.41278323536307, 541.3693047599546, 579.2932622200914, 588.7615515716134, 604.8760004199139, 25322.873385633047, 30493.237669058286, 30933.381332373338, 30964.84517577409, 38417.42373864394, 43213.783931080376, 43868.78065609668, 44022.339664904976, 44046.0, 44074.0, 8287.502749835, 9377.578008989612, 9554.856677149848, 9640.758981025496, 9668.661596844111, 8278.83442331153, 8486.32109431244, 9483.620655173785, 9681.951590242039, 11015.559377624886, 11303.773924521505, 11425.714357141096, 11463.36951467669, 11469.885301146966, 11472.426378681033, 11243.0, 11364.431778411088, 11375.886241137565, 11389.829152562717, 11393.145514086395, 8260.256576908047, 10915.563377464892, 11170.609028683957, 11179.0, 11192.664220073411, 38529.422058669144, 39207.41188882169, 39279.0, 39280.60719392798, 39346.606533934864, 3229.7730134962258, 3256.8860089896975, 3282.458394364927, 3298.993806888898, 3455.844486998066, 27785.027524036763, 28532.7160277788, 28569.714302857123, 28570.0, 29190.27024324388, 2615.882285297166, 2682.0746842339363, 2708.0251109600526, 2773.514634938898, 2810.5784132380104, 407791.0, 412488.9375553133, 413420.0, 414104.0, 415024.0, 63500.68249658722, 65427.34572654308, 65528.0, 65630.34369656337, 65642.37430502726, 68830.65584672044, 69047.8928448221, 69098.65450672715, 69144.61710765857, 69193.65403172951, 16558.00651960862, 17260.964342139512, 17280.827191728175, 17303.3943811966, 17306.740398894028, 11634.88365116338, 13231.404586793617, 13306.0, 13327.200367977952, 13334.333283335794, 16722.41471548514, 17142.914285428495, 17414.303427862742, 17440.0, 17471.650566988843, 5869.0, 7883.211678832071, 7910.564918929399, 7969.920300797034, 7981.321587664997, 931.487681775021, 937.634322614181, 956.6508224498148, 1016.2632091733434, 1067.5836423794726, 28863.567046494318, 28961.42077158445, 29261.268468288465, 29607.0, 29608.851955740512, 1052.8368102944055, 1099.455769394155, 1106.7454485468227, 1114.8717897441736, 1170.988290117105, 13206.877415419605, 15303.92348038275, 15512.534623961299, 15807.288672009787, 15850.841491585166, 649995.0, 658078.7096064489, 660485.0, 661113.0, 661494.0, 60359.0, 61152.694236528536, 61385.693071534355, 61389.69305153446, 61420.385796142364, 1434.1968497641353, 1490.7540255857662, 1494.2528735632184, 1503.2859391789032, 1506.9623259418602, 29156.18922877786, 29172.27069323284, 29361.85319073391, 29901.551476727433, 30022.0, 51704.0, 52135.95728085493, 52638.210426844395, 52667.47332526779, 52669.73665131803, 555349.0, 560223.0, 560304.0, 560412.0, 563022.0, 22379.77620223777, 25179.866905989642, 25708.485830282916, 27195.0, 27610.44779104447, 42567.148657027305, 43099.56900430955, 43350.78324608357, 43726.56273437225, 44152.77923610361, 35470.46794298139, 35619.64380356163, 35707.0, 36354.0, 36517.81741091277, 34981.82509087438, 35032.0, 35486.75796347115, 35851.64148358483, 35875.0, 36183.0, 36538.90383288506, 36783.08042298857, 37091.44362834613, 37176.44235336418, 32175.195620109684, 32348.514772278904, 32545.511817322287, 32682.83658581692, 32892.83553582217, 24250.393740156636, 24345.26964191077, 24645.01419943254, 24742.50514989654, 24751.752482474945], "value": 19841.665569367193, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.7732692365352, 400.58539411708887, 400.91179940413116, 400.9158076803871, 411.60280329482043, 14374.712505749905, 19610.90194549027, 20488.643805962318, 20620.587588248243, 20966.37100886976, 15995.360185592592, 17831.286748530074, 19812.50468738282, 20322.59354812903, 20630.071646775894, 5681.403452637465, 5884.852878678024, 5911.142884281777, 5916.881662366772, 5917.5561832862495, 5594.971620433302, 5749.0, 5795.623284486495, 5840.737166827503, 5853.912191317134, 5776.451237132486, 5776.740046697909, 5781.075027995522, 5804.158397032428, 5810.680412577307, 5436.456354364552, 5645.503941455518, 5795.4784069433745, 5832.212651292064, 5855.355910849803, 5109.770060347293, 5129.384473863123, 5132.692038477703, 5141.2545180948555, 5141.922871156936, 24362.756372436226, 24692.876535617208, 25824.483510329876, 25841.870790646113, 26001.089961851245, 2113.7991890770504, 2177.2379667116384, 2205.5368372641765, 2403.807695384365, 2862.6831657437397, 14050.508232211925, 14324.212168330738, 14603.92698036503, 14631.487897923627, 15029.323680434407, 1675.8240384759547, 1705.2241230240336, 1842.253887175696, 1882.105999650169, 1909.3508207209616, 119246.0, 125985.37007314997, 126931.36534317362, 126973.0, 128360.73114150846, 11398.430078496041, 11593.188476806712, 11595.594154204562, 11624.418779061014, 11761.88238117608, 14959.401623935139, 14979.251037448084, 15048.946573739733, 15051.397944082333, 15068.171250581323, 7452.06849143857, 7767.495112817649, 7886.171951945078, 8309.459885107448, 8450.323974082059, 8357.414980951397, 8369.414141010193, 8448.619812108469, 8452.661893524313, 8495.150484951579, 4470.083632855257, 4556.88607784808, 4557.134144512598, 4565.086982603492, 4622.098690755271, 1915.913783879701, 1939.41817454763, 1951.9902400487906, 1964.8112891700316, 1978.2482656590691, 730.9423971520154, 826.6652005937605, 954.1412728544227, 979.5151400057017, 1053.3474309144074, 17310.0, 18637.627247454973, 20315.492112697302, 20528.586353933977, 20678.483037924172, 908.9500077495801, 945.394947233771, 953.4946478366477, 975.702315919825, 988.6786794291884, 10469.790604188025, 10720.874308197683, 10736.570537178426, 10744.785104297871, 10762.408067556204, 580726.0, 589671.0, 600498.0, 606579.0, 608610.0, 119502.0, 131316.0, 137227.0, 137471.0, 141288.29355853156, 997.7827050997771, 1028.953697083618, 1042.7132538551807, 1050.7635781949152, 1051.2903789941759, 14398.496052638107, 16290.592735181715, 17258.395956141474, 17466.388676396775, 17480.825191748427, 47351.0, 50406.747966259936, 50468.74765626148, 51168.488315116374, 53136.202956954905, 53092.0, 67580.66209669117, 68150.0, 68833.31166688469, 69027.0, 7658.349040331635, 7736.419768517271, 7865.882011769942, 8124.268815806369, 8335.0, 11975.401229938643, 12103.81844272319, 12475.251484910934, 12558.372081395712, 12617.558385456465, 5263.947360526499, 5412.594055445936, 10414.417656231233, 11153.55385784592, 11391.088712903114, 4515.232410490159, 8726.607302671267, 10865.293755905841, 10894.202456594574, 11112.722181945515, 10926.617568385387, 11336.773264534499, 11420.657380278604, 11421.828672570084, 11427.771444570895, 6803.625800581016, 8192.631331590212, 8241.340692744687, 8346.87479687793, 8649.437786543855, 10388.428636424767, 11116.49975751077, 11396.430178491208, 11445.713857153638, 11472.311661300015], "value": 9410.62513857814, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.6299299189225, 1600.4638446120548, 1602.6794641071788, 1862.6647203503373, 2009.4072248686637, 7809.219078092188, 8487.872681909768, 8758.299336053116, 8779.20987111159, 8788.91211087889, 8385.91614083859, 8625.48247105174, 8628.741137765861, 8628.784280392993, 8650.956745216281, 2149.6990421341025, 2230.408941630469, 2231.241377931503, 2406.073661640268, 2449.8775061246956, 2242.8093612042994, 2414.7705967933107, 2493.9625905611338, 2495.3886297857052, 2498.537770512461, 2078.8440866934966, 2396.4967356854995, 2431.598786200275, 2442.963355549668, 2446.00936620668, 1785.366195000769, 2405.927822165338, 2420.721617014031, 2422.0069771393732, 2422.648715936197, 2366.171839856054, 2442.9755702443103, 2444.022391043579, 2445.2419749877595, 2447.449323902126, 7445.292697193758, 8530.232279094911, 8609.225169734691, 8624.913750862474, 8633.481991080555, 5051.1413059779925, 5239.764210610531, 5250.842474725764, 5259.605529585297, 5275.024120537674, 3237.7895436796766, 3252.47960326349, 3346.5984081910083, 3437.914052148691, 3551.786892786441, 965.7151140413595, 1012.5797793915516, 1014.5028935821468, 1016.552716804611, 1031.1699082238795, 9607.0, 11478.540858365655, 11496.252743571724, 11497.482613282338, 11510.769784604261, 4726.26742854858, 4782.904341913142, 4856.053069651454, 4856.077345304381, 4891.2174052152195, 9844.064813842673, 9868.21054315653, 9909.45497997617, 9913.702588922344, 9933.25500587459, 5440.510354068153, 5449.4005659377435, 5451.4276001019325, 5452.127659574449, 5462.399136095027, 4847.709137451764, 4865.318855360252, 4892.657513974059, 4952.752362381939, 4989.600831933437, 3966.7024973126554, 3992.5608183099835, 4033.9798301008896, 4068.145689405258, 4085.7548547086676, 1327.2832670357898, 1329.926854023038, 1332.0808642036964, 1346.4748747988292, 1350.3585796746468, 812.3420029775782, 885.3536918049859, 904.8597467392433, 946.2146418472652, 970.4322971061866, 5200.583953283728, 5834.445727655866, 5852.765889364463, 5930.2883653960935, 6040.516758659297, 461.420916749484, 466.4612372709526, 470.1912710138556, 982.2436723722693, 995.7809281957958, 3797.6582107610448, 3852.3065848147603, 3897.142628621699, 3993.9201215975518, 4000.979995100064, 10160.593576256866, 10644.361338319726, 10666.78666426667, 10674.946625266824, 10682.78634427307, 10002.699919002442, 10560.102391296827, 10733.463326833627, 10749.731256718489, 10761.83857242142, 7748.535087894745, 8015.318697910627, 8097.39269554774, 8269.29710974562, 8369.0, 5924.140999555127, 5956.642601443928, 5994.0109881869, 6012.789552365646, 6072.332043475126, 9751.902480975383, 10079.748006299902, 10187.898121018992, 10194.286399951932, 10212.285140040423, 8961.865572016555, 9943.25425593069, 10149.594016239564, 10342.069213770797, 10378.377297362182, 5726.455986681259, 6502.837429064311, 7514.436417268836, 7521.924780752122, 7523.3229009389415, 8077.151899050515, 8295.336373090018, 8300.54347010896, 8312.16878312188, 8312.6674933002, 7272.23641517633, 7327.120745510573, 7564.50830696003, 7575.886361704689, 7606.201348858512, 6676.9332306676315, 7044.908039253924, 7280.672369743268, 7312.012878261579, 7464.992226049631, 6827.351401616838, 6833.214180369122, 6898.068760717239, 6920.238773734784, 6931.6880740367815, 4599.321247744482, 4712.528747125397, 4924.72913989734, 4952.0, 5016.473270306711, 4994.2781184253945, 5014.6991180529285, 5064.898067302029, 5085.957378737424, 5097.745112744422], "value": 4524.187709429213, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.6120594081162, 322.1655911190018, 326.7908538535337, 328.2122905027933, 332.81528751542885, 4811.855644330667, 4855.85432437027, 5066.9493305066935, 5081.339425874636, 5430.212619170218, 4663.883402914928, 5306.761195746191, 5334.546108789961, 5350.705711185883, 5363.517283444489, 3522.806245656488, 3915.4714113594587, 4023.4970628671417, 4024.9597504025023, 4034.6685593754137, 3537.734669899755, 4075.755454672714, 4096.508418989711, 4116.188876894157, 4136.648384887289, 3669.871554495593, 3792.127810603563, 4012.8595499157536, 4065.87802365928, 4092.669882288253, 3817.331966905794, 3882.602263185251, 3931.410288456726, 4066.2274167908004, 4115.9176816463805, 3591.2637909228806, 3604.5849280981806, 3617.5297211362617, 3618.0773902654655, 3644.671979521829, 5168.638195326329, 5183.0, 5188.495336352454, 5196.194589838581, 5199.610029247784, 4329.372241025065, 4687.0, 4687.812487500496, 4707.45864225615, 4707.529247075299, 5564.582656300794, 5582.134769110794, 5593.3847276799515, 5632.324121105453, 5677.372941053029, 3534.876279330211, 3869.496965394481, 3875.5543112541854, 3875.7093218008763, 3882.835149455152, 5129.384473863161, 5454.91817622736, 5501.257330260403, 5593.52455041322, 5679.261695979496, 3830.3488406970323, 3920.5687374388795, 3921.254961557295, 3924.4309575111447, 3929.6659783918685, 3979.9204015919518, 3996.7002474814503, 3998.2403343364667, 4013.478247827822, 4017.372963949547, 4582.885427864263, 4590.62281315604, 4611.677182597186, 4630.236011058205, 4666.3700400445505, 5332.30680011596, 5673.971630141823, 5693.111335284269, 5693.971530142323, 5713.771449142071, 1256.4722816417127, 1296.8054791781308, 1449.521657852927, 1454.7672372420361, 1461.444651032622, 863.5552690364467, 869.4739682492128, 948.6158105967095, 968.6754937096151, 977.3695966101967, 5484.012877681976, 5647.6329038613185, 5753.913691294634, 5787.392323806024, 5811.360750317462, 6342.207224096988, 6356.188486281388, 6368.840778980562, 6374.394432528902, 6376.808695739135, 5517.917231241535, 5776.249087618667, 5790.160426738184, 5806.390329015477, 5825.863636817822, 2904.3029672878356, 3346.297277571737, 3355.983220083884, 3364.2934983653217, 3372.544706464645, 5799.9130013049835, 6278.246610406781, 6288.937110628835, 6626.204855417381, 6633.369829866155, 5147.1507201312115, 5827.3298570664065, 6111.54163437735, 6126.549380247848, 6153.0, 5297.152455607084, 5438.945610543844, 5740.942590574125, 5867.618604790589, 5908.675022873783, 4999.925001125059, 5369.067135831176, 5881.118252056547, 5920.407959204217, 5959.344472107978, 5033.421156567042, 5639.0, 5717.8570535736935, 5829.948186010682, 5847.327557330961, 6033.366496517978, 6111.174991376108, 6123.663198524124, 6132.386761323832, 6143.84640383994, 3898.200868821828, 3950.881473555798, 3972.7616343019513, 3981.482407287034, 3983.322835117979, 5674.546036317167, 5884.352721200579, 5894.911576326273, 5938.940610593839, 5951.791687290924, 5296.3379577552805, 5690.516306113861, 5698.230738850368, 5708.549339246625, 5714.657120572612, 5168.3539557555305, 5182.429932707324, 5319.46805319465, 5705.2297939779255, 5710.885782284414, 4336.913261734685, 5250.875728941274, 5358.758855851574, 5580.218769372373, 5627.943720562742, 5171.991461665089, 5653.321601407857, 5686.004949133968, 5707.259285917668, 5718.285214348207, 4978.0, 5321.966479106872, 5624.7187640616985, 5649.265595472562, 5660.37735849048], "value": 4225.665966389304, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.9541532092752, 718.3534818663203, 753.9509931854426, 765.1468612497066, 798.6964953317738, 14394.136351818885, 14661.120332780041, 14669.706605867876, 14694.779578306321, 14695.265236738147, 11729.824052639216, 13599.864001359983, 13713.245771482565, 13728.656783580416, 13737.24445155516, 886.2112719679475, 930.2372054914939, 930.4091901642472, 930.6044930904372, 934.2432629570036, 920.8940971788263, 933.1321870660283, 938.2869019545161, 939.3002213351064, 940.8541676040225, 981.5730157381562, 987.8814542254903, 989.4063561862861, 989.9059589339038, 990.9702708918708, 746.6863917154781, 888.595688961521, 976.6386437018277, 980.294188184506, 981.5681100315838, 729.9306565876233, 730.6638946084807, 731.0861423220974, 731.104397113537, 734.8456824066952, 14675.926620366936, 14739.55781326562, 14756.557303280919, 14771.335289911873, 14808.111513309128, 9539.284553658503, 12223.633291001284, 12386.938065309705, 12390.504379824886, 12703.110782245247, 9710.223182145412, 9918.107370336704, 9932.751681207956, 10296.485175741183, 10657.147428205724, 3079.5226739855357, 3457.2739724657854, 3496.4580490024086, 3531.311394278091, 3558.768680035789, 72229.6388518054, 75587.62206188934, 75740.0, 75791.62104189499, 76117.61941190314, 9431.811363772686, 9498.667546635972, 9708.223342132613, 9723.367981081348, 9744.853827192455, 21287.254946077122, 21529.677054843876, 21532.4616884576, 21542.03060862265, 21547.461313467287, 7226.710931562784, 7355.485116041933, 7432.182459929403, 7590.8861367079535, 7592.506487078323, 4059.817308221078, 4124.010237542968, 4146.087860670647, 4162.500499940026, 4218.325067989168, 3357.1439282982683, 3461.3250416169108, 3463.1342164458883, 3465.462853257749, 3466.878659246914, 494.29069285575315, 611.7736437518147, 615.4799194680488, 626.370497649859, 641.4066988036049, 560.4773995438729, 588.3381196154327, 589.4429763873185, 596.9164316995624, 613.1018058544254, 6499.967500162564, 7957.681692732342, 7979.760607181794, 8082.474639148437, 8208.835823283502, 482.27176962786444, 535.563515734675, 577.3677822784044, 610.1457958857546, 612.091044798474, 3774.037620406779, 3871.4386413969814, 3916.4516967624554, 3927.8232479538487, 3999.8200080996426, 93398.5330073359, 94861.0, 97638.0, 97906.0, 97908.0, 68603.0, 71565.92651110237, 72729.0, 72893.0, 73280.63359683275, 65949.34050659432, 67002.66498667476, 67084.66457667778, 67106.32893671001, 68431.65784171048, 7331.0469638948725, 7423.480356375002, 7706.0, 7736.7292144774665, 7767.741935483871, 33653.831730841186, 43769.78115109532, 44147.117057658026, 44387.778061109486, 44459.33311000402, 60487.39512604818, 60624.696876515336, 60711.69644151751, 60877.0, 61836.38163618486, 8383.455075420079, 10467.424291664032, 10561.260711750103, 10570.735731606464, 10814.188787048899, 10872.0, 11141.665750027512, 11568.88431115678, 11997.278762929378, 12325.322107284186, 10386.0, 10733.409662468639, 10766.46167691628, 10807.35155890649, 10886.346819190874, 10671.35971841692, 10866.239363244496, 10891.237613366988, 10919.399433030942, 10923.78152436931, 10388.844167337345, 10525.684229473129, 10529.947350263199, 10542.8418573723, 10578.889216632142, 8580.0, 8918.420302680304, 8952.328575357005, 9010.053944336012, 9118.22495087925, 8041.758747237593, 8537.829243414973, 8553.44402613828, 8589.226969572768, 8615.0], "value": 6677.109307151133, "unit": "score"}], "name": "dromaeo_css", "value": 7175.492849744031, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 112.0, 108.0, 111.0, 112.0, 118.0, 154.0, 160.0, 106.0, 113.0], "value": 120.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 123.0, 148.0, 172.0, 120.0, 142.0, 140.0, 119.0, 162.0, 135.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 188.0, 185.0, 181.0, 181.0, 188.0, 179.0, 185.0, 185.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 81.0, 147.0, 56.0, 56.0, 60.0, 66.0, 137.0, 58.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 134.0, 78.0, 81.0, 85.0, 128.0, 78.0, 78.0, 125.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 86.0, 84.0, 87.0, 84.0, 87.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 92.0, 93.0, 93.0, 91.0, 92.0, 93.0, 92.0, 93.0], "value": 92.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 84.0, 85.0, 86.0, 83.0, 84.0, 84.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 59.0, 59.0, 59.0, 59.0, 58.0, 80.0, 58.0, 57.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 63.0, 73.0, 72.0, 68.0, 66.0, 68.0, 67.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 81.0, 82.0, 82.0, 81.0, 82.0, 82.0, 83.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 139.0, 137.0, 134.0, 135.0, 134.0, 143.0, 190.0, 155.0], "value": 144.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 147.0, 183.0, 197.0, 156.0, 221.0, 217.0, 180.0, 170.0, 170.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 69.0, 67.0, 68.0, 58.0, 65.0, 64.0, 66.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1489.6000000000001, "alertThreshold": 2.0}]} 17:38:07 INFO - Return code: 0 17:38:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:38:07 ERROR - # TBPL SUCCESS # 17:38:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:38:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:38:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:38:07 INFO - 2016-04-25 17:38:07.728 screenresolution[2110:15406] starting screenresolution argv=screenresolution get 17:38:07 INFO - 2016-04-25 17:38:07.731 screenresolution[2110:15406] Display 0: 1600x1200x32@60 17:38:07 INFO - 2016-04-25 17:38:07.737 screenresolution[2111:15409] starting screenresolution argv=screenresolution list 17:38:07 INFO - Available Modes on Display 0 17:38:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:38:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:38:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:38:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:38:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:38:07 INFO - Intel Iris: 17:38:07 INFO - Chipset Model: Intel Iris 17:38:07 INFO - Type: GPU 17:38:07 INFO - Bus: Built-In 17:38:07 INFO - VRAM (Dynamic, Max): 1536 MB 17:38:07 INFO - Vendor: Intel (0x8086) 17:38:07 INFO - Device ID: 0x0a2e 17:38:07 INFO - Revision ID: 0x0009 17:38:07 INFO - Displays: 17:38:07 INFO - Display: 17:38:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:38:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:38:07 INFO - Display Serial Number: 1600x1200 60 17:38:07 INFO - Main Display: Yes 17:38:07 INFO - Mirror: Off 17:38:07 INFO - Online: Yes 17:38:07 INFO - Rotation: Supported 17:38:07 INFO - Return code: 0 17:38:07 INFO - Running post-action listener: _resource_record_post_action 17:38:07 INFO - Running post-run listener: _resource_record_post_run 17:38:09 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 30522880; Write bytes: 695019008; Read time: 301; Write time: 2001 17:38:09 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 376080896; Write bytes: 370223104; Read time: 28203; Write time: 843 17:38:09 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30522880; Write bytes: 297401856; Read time: 301; Write time: 1104 17:38:09 INFO - Running post-run listener: _upload_blobber_files 17:38:09 INFO - Blob upload gear active. 17:38:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:38:09 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 17:38:09 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:38:09 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:38:09 INFO - (blobuploader) - INFO - Open directory for files ... 17:38:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:38:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:38:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:10 INFO - (blobuploader) - INFO - Done attempting. 17:38:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:38:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:38:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:11 INFO - (blobuploader) - INFO - Done attempting. 17:38:11 INFO - (blobuploader) - INFO - Iteration through files over. 17:38:11 INFO - Return code: 0 17:38:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:38:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:38:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0301c5f09787e2972904829147cef824fea562afbd602781e56f6a7a896db30e239be6075f442896fe731324b398639e8420ab16c452867f7eeaed5117c48ba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/665d1297a83a3688fd53fdc4ac71cfae524f336ca1edf869b88fba4153c43b4d3155809503fbfc21b064122e1c57c1c508e4c689d928c3250b72c741cc01580c"} 17:38:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:38:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:38:11 INFO - Contents: 17:38:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0301c5f09787e2972904829147cef824fea562afbd602781e56f6a7a896db30e239be6075f442896fe731324b398639e8420ab16c452867f7eeaed5117c48ba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/665d1297a83a3688fd53fdc4ac71cfae524f336ca1edf869b88fba4153c43b4d3155809503fbfc21b064122e1c57c1c508e4c689d928c3250b72c741cc01580c"} 17:38:11 INFO - Running post-run listener: copy_logs_to_upload_dir 17:38:11 INFO - Copying logs to upload dir... 17:38:11 INFO - mkdir: /builds/slave/test/build/upload/logs 17:38:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.882864 ========= master_lag: 1.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-04-25 17:38:13.364950) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 17:38:13.370525) ========= 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.PO8AgswjIz/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.WR1rcEiR6m/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0301c5f09787e2972904829147cef824fea562afbd602781e56f6a7a896db30e239be6075f442896fe731324b398639e8420ab16c452867f7eeaed5117c48ba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/665d1297a83a3688fd53fdc4ac71cfae524f336ca1edf869b88fba4153c43b4d3155809503fbfc21b064122e1c57c1c508e4c689d928c3250b72c741cc01580c"} build_url:https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010966 build_url: 'https://queue.taskcluster.net/v1/task/Y4mrR7rzTAaxhf6dAwTvqg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0301c5f09787e2972904829147cef824fea562afbd602781e56f6a7a896db30e239be6075f442896fe731324b398639e8420ab16c452867f7eeaed5117c48ba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/665d1297a83a3688fd53fdc4ac71cfae524f336ca1edf869b88fba4153c43b4d3155809503fbfc21b064122e1c57c1c508e4c689d928c3250b72c741cc01580c"}' ========= master_lag: 0.57 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 17:38:13.956079) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:38:13.956428) ========= 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.PO8AgswjIz/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.WR1rcEiR6m/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005099 ========= master_lag: 0.89 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 17:38:14.850838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 17:38:14.854188) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 17:38:14.855394) ========= ========= Total master_lag: 3.39 =========