builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0148 starttime: 1465288628.72 results: success (0) buildid: 20160606120332 builduid: 394ff36afaaf47b0a5ccdc9e3ac607e3 revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:08.720320) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:08.720762) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:08.721037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:08.745164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:08.745546) ========= 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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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-06-07 01:37:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2016-06-07 01:37:08 (19.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118036 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:08.885250) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:08.885563) ========= 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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.027542 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:08.937491) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 01:37:08.937928) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QK0OVGe3Dv/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.DpsexiaJpm/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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-06-07 01:37:09,014 truncating revision to first 12 chars 2016-06-07 01:37:09,014 Setting DEBUG logging. 2016-06-07 01:37:09,014 attempt 1/10 2016-06-07 01:37:09,014 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/46d72a56c57d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 01:37:09,741 unpacking tar archive at: mozilla-beta-46d72a56c57d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.984496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 01:37:09.945302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:09.945701) ========= script_repo_revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:09.946209) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:09.946476) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:09.968241) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-07 01:37:09.968615) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QK0OVGe3Dv/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.DpsexiaJpm/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 01:37:10 INFO - MultiFileLogger online at 20160607 01:37:10 in /builds/slave/test 01:37:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 01:37:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:37:10 INFO - {'append_to_log': False, 01:37:10 INFO - 'base_work_dir': '/builds/slave/test', 01:37:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:37:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:37:10 INFO - 'branch': 'Mozilla-Beta', 01:37:10 INFO - 'buildbot_json_path': 'buildprops.json', 01:37:10 INFO - 'config_files': ('talos/mac_config.py',), 01:37:10 INFO - 'default_actions': ('clobber', 01:37:10 INFO - 'read-buildbot-config', 01:37:10 INFO - 'download-and-extract', 01:37:10 INFO - 'populate-webroot', 01:37:10 INFO - 'create-virtualenv', 01:37:10 INFO - 'install', 01:37:10 INFO - 'run-tests'), 01:37:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:37:10 INFO - 'download_minidump_stackwalk': True, 01:37:10 INFO - 'download_symbols': 'ondemand', 01:37:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:37:10 INFO - 'tooltool.py': '/tools/tooltool.py', 01:37:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:37:10 INFO - '/tools/misc-python/virtualenv.py')}, 01:37:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:37:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:37:10 INFO - 'installer_path': 'installer.exe', 01:37:10 INFO - 'log_level': 'info', 01:37:10 INFO - 'log_name': 'talos', 01:37:10 INFO - 'log_to_console': True, 01:37:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:37:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:37:10 INFO - 'opt_config_files': (), 01:37:10 INFO - 'pip_index': False, 01:37:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:37:10 INFO - 'cmd': ('bash', 01:37:10 INFO - '-c', 01:37:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:37:10 INFO - 'enabled': True, 01:37:10 INFO - 'halt_on_failure': False, 01:37:10 INFO - 'name': 'check_screen_resolution'},), 01:37:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:37:10 INFO - 'cmd': ('bash', 01:37:10 INFO - '-c', 01:37:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:37:10 INFO - 'enabled': True, 01:37:10 INFO - 'halt_on_failure': False, 01:37:10 INFO - 'name': 'check_screen_resolution'},), 01:37:10 INFO - 'run_cmd_checks_enabled': True, 01:37:10 INFO - 'sps_profile': False, 01:37:10 INFO - 'sps_profile_interval': 0, 01:37:10 INFO - 'suite': 'dromaeojs', 01:37:10 INFO - 'system_bits': '32', 01:37:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:37:10 INFO - 'title': 't-yosemite-r7-0148', 01:37:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:37:10 INFO - 'use_talos_json': True, 01:37:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:37:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:37:10 INFO - 'work_dir': 'build'} 01:37:10 INFO - ##### 01:37:10 INFO - ##### Running clobber step. 01:37:10 INFO - ##### 01:37:10 INFO - Running pre-action listener: _resource_record_pre_action 01:37:10 INFO - Running main action method: clobber 01:37:10 INFO - rmtree: /builds/slave/test/build 01:37:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:37:11 INFO - Running post-action listener: _resource_record_post_action 01:37:11 INFO - ##### 01:37:11 INFO - ##### Running read-buildbot-config step. 01:37:11 INFO - ##### 01:37:11 INFO - Running pre-action listener: _resource_record_pre_action 01:37:11 INFO - Running main action method: read_buildbot_config 01:37:11 INFO - Using buildbot properties: 01:37:11 INFO - { 01:37:11 INFO - "project": "", 01:37:11 INFO - "product": "firefox", 01:37:11 INFO - "script_repo_revision": "production", 01:37:11 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 01:37:11 INFO - "repository": "", 01:37:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 01:37:11 INFO - "buildid": "20160606120332", 01:37:11 INFO - "pgo_build": "False", 01:37:11 INFO - "basedir": "/builds/slave/test", 01:37:11 INFO - "buildnumber": 32, 01:37:11 INFO - "slavename": "t-yosemite-r7-0148", 01:37:11 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:37:11 INFO - "platform": "yosemite_r7", 01:37:11 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:37:11 INFO - "branch": "mozilla-beta", 01:37:11 INFO - "repo_path": "releases/mozilla-beta", 01:37:11 INFO - "revision": "46d72a56c57dafb4dc1061d4741a3e1181ac3d68", 01:37:11 INFO - "stage_platform": "macosx64", 01:37:11 INFO - "builduid": "394ff36afaaf47b0a5ccdc9e3ac607e3", 01:37:11 INFO - "slavebuilddir": "test" 01:37:11 INFO - } 01:37:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 01:37:11 INFO - Running post-action listener: _resource_record_post_action 01:37:11 INFO - ##### 01:37:11 INFO - ##### Running download-and-extract step. 01:37:11 INFO - ##### 01:37:11 INFO - Running pre-action listener: _resource_record_pre_action 01:37:11 INFO - Running main action method: download_and_extract 01:37:11 INFO - mkdir: /builds/slave/test/build/tests 01:37: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')]} 01:37:11 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:37:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:37:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:37:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:37:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 01:37:13 INFO - Downloaded 1165 bytes. 01:37:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:37:13 INFO - Using the following test package requirements: 01:37:13 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:37:13 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:13 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 01:37:13 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:13 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 01:37:13 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:37:13 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:13 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 01:37:13 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:37:13 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:13 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 01:37:13 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:13 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 01:37:13 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:13 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 01:37:13 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:13 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 01:37:13 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 01:37:13 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')]} 01:37:13 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:37:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:37:14 INFO - Downloaded 18292404 bytes. 01:37:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:37:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:37:17 INFO - Return code: 0 01:37:17 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 01:37: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')]} 01:37:17 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:37:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:37:18 INFO - Downloaded 18292404 bytes. 01:37:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:37:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:37:21 INFO - Return code: 0 01:37:21 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')]} 01:37:21 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:37:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 01:37:22 INFO - Downloaded 10840145 bytes. 01:37:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:37:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:37:23 INFO - Return code: 0 01:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:37:23 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 01:37:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 01:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 01:37:25 INFO - Downloaded 86246253 bytes. 01:37:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:25 INFO - mkdir: /builds/slave/test/properties 01:37:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:37:25 INFO - Writing to file /builds/slave/test/properties/build_url 01:37:25 INFO - Contents: 01:37:25 INFO - build_url:https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:27 INFO - Running post-action listener: _resource_record_post_action 01:37:27 INFO - Running post-action listener: set_extra_try_arguments 01:37:27 INFO - ##### 01:37:27 INFO - ##### Running populate-webroot step. 01:37:27 INFO - ##### 01:37:27 INFO - Running pre-action listener: _resource_record_pre_action 01:37:27 INFO - Running main action method: populate_webroot 01:37:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:37:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:37:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:37:27 INFO - '--tppagecycles', 01:37:27 INFO - '7'], 01:37:27 INFO - 'tests': ['tsvgm']}}, 01:37:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:37:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:37:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:37:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:37:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:37:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:37:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:27 INFO - 'talos_options': ['--disable-e10s'], 01:37:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:27 INFO - 'talos_options': ['--disable-e10s'], 01:37:27 INFO - 'tests': ['damp', 'tps']}, 01:37:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:27 INFO - 'tests': ['damp', 'tps']}, 01:37:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:37:27 INFO - 'tests': ['dromaeo_dom']}, 01:37:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:37:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:37:27 INFO - 'tests': ['a11yr', 01:37:27 INFO - 'ts_paint', 01:37:27 INFO - 'tpaint', 01:37:27 INFO - 'sessionrestore', 01:37:27 INFO - 'sessionrestore_no_auto_restore', 01:37:27 INFO - 'tabpaint']}, 01:37:27 INFO - 'other-e10s': {'tests': ['a11yr', 01:37:27 INFO - 'ts_paint', 01:37:27 INFO - 'tpaint', 01:37:27 INFO - 'sessionrestore', 01:37:27 INFO - 'sessionrestore_no_auto_restore', 01:37:27 INFO - 'tabpaint']}, 01:37:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:37:27 INFO - 'ts_paint', 01:37:27 INFO - 'tpaint', 01:37:27 INFO - 'sessionrestore', 01:37:27 INFO - 'sessionrestore_no_auto_restore', 01:37:27 INFO - 'tabpaint']}, 01:37:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:37:27 INFO - 'ts_paint', 01:37:27 INFO - 'tpaint', 01:37:27 INFO - 'sessionrestore', 01:37:27 INFO - 'sessionrestore_no_auto_restore', 01:37:27 INFO - 'tabpaint']}, 01:37:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:37:27 INFO - 'tests': ['a11yr', 01:37:27 INFO - 'ts_paint', 01:37:27 INFO - 'tpaint', 01:37:27 INFO - 'sessionrestore', 01:37:27 INFO - 'sessionrestore_no_auto_restore', 01:37:27 INFO - 'tabpaint']}, 01:37:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:37:27 INFO - 'tests': ['a11yr', 01:37:27 INFO - 'ts_paint', 01:37:27 INFO - 'tpaint', 01:37:27 INFO - 'sessionrestore', 01:37:27 INFO - 'sessionrestore_no_auto_restore', 01:37:27 INFO - 'tabpaint']}, 01:37:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:37:27 INFO - 'tests': ['tsvgx', 01:37:27 INFO - 'tsvgr_opacity', 01:37:27 INFO - 'tart', 01:37:27 INFO - 'tscrollx', 01:37:27 INFO - 'cart']}, 01:37:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:37:27 INFO - 'tsvgr_opacity', 01:37:27 INFO - 'tart', 01:37:27 INFO - 'tscrollx', 01:37:27 INFO - 'cart']}, 01:37:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:27 INFO - 'talos_options': ['--disable-e10s'], 01:37:27 INFO - 'tests': ['tp5o']}, 01:37:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:27 INFO - 'tests': ['tp5o']}, 01:37:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:27 INFO - 'talos_options': ['--disable-e10s', 01:37:27 INFO - '--xperf_path', 01:37:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:27 INFO - 'tests': ['tp5n']}, 01:37:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:27 INFO - 'talos_options': ['--xperf_path', 01:37:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:27 INFO - 'tests': ['tp5n']}}, 01:37:27 INFO - 'talos.zip': {'path': '', 01:37:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:37:27 INFO - Running post-action listener: _resource_record_post_action 01:37:27 INFO - ##### 01:37:27 INFO - ##### Running create-virtualenv step. 01:37:27 INFO - ##### 01:37:27 INFO - Running pre-action listener: _resource_record_pre_action 01:37:27 INFO - Running main action method: create_virtualenv 01:37:27 INFO - Creating virtualenv /builds/slave/test/build/venv 01:37:27 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 01:37:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:37:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:37:27 INFO - Using real prefix '/tools/python27' 01:37:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:37:27 INFO - Installing distribute.............................................................................................................................................................................................done. 01:37:30 INFO - Installing pip.................done. 01:37:30 INFO - Return code: 0 01:37:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e27a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e37420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f919259a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc6e00>, '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 0x106b2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cc1b20>, '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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 01:37: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', 'pip>=1.5'] in /builds/slave/test/build 01:37: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 pip>=1.5 01:37:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QK0OVGe3Dv/Render', 01:37:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:30 INFO - 'HOME': '/Users/cltbld', 01:37:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:30 INFO - 'LOGNAME': 'cltbld', 01:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:30 INFO - 'MOZ_NO_REMOTE': '1', 01:37:30 INFO - 'NO_EM_RESTART': '1', 01:37:30 INFO - 'PAGER': '/bin/cat', 01:37:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:30 INFO - 'PWD': '/builds/slave/test', 01:37:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:30 INFO - 'SHELL': '/bin/bash', 01:37:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpsexiaJpm/Listeners', 01:37:30 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:37:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:30 INFO - 'USER': 'cltbld', 01:37:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:30 INFO - 'XPC_FLAGS': '0x0', 01:37:30 INFO - 'XPC_SERVICE_NAME': '0', 01:37:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:31 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 01:37:31 INFO - Cleaning up... 01:37:31 INFO - Return code: 0 01:37:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:31 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 0x106e27a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e37420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f919259a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc6e00>, '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 0x106b2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cc1b20>, '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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 01:37:31 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 01:37:31 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 01:37:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QK0OVGe3Dv/Render', 01:37:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:31 INFO - 'HOME': '/Users/cltbld', 01:37:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:31 INFO - 'LOGNAME': 'cltbld', 01:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:31 INFO - 'MOZ_NO_REMOTE': '1', 01:37:31 INFO - 'NO_EM_RESTART': '1', 01:37:31 INFO - 'PAGER': '/bin/cat', 01:37:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:31 INFO - 'PWD': '/builds/slave/test', 01:37:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:31 INFO - 'SHELL': '/bin/bash', 01:37:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpsexiaJpm/Listeners', 01:37:31 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:37:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:31 INFO - 'USER': 'cltbld', 01:37:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:31 INFO - 'XPC_FLAGS': '0x0', 01:37:31 INFO - 'XPC_SERVICE_NAME': '0', 01:37:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:31 INFO - Downloading/unpacking psutil>=0.7.1 01:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:37:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:34 INFO - Installing collected packages: psutil 01:37:34 INFO - Running setup.py install for psutil 01:37:34 INFO - building 'psutil._psutil_osx' extension 01:37:34 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 01:37:34 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 01:37:35 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 01:37:35 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 01:37:35 INFO - building 'psutil._psutil_posix' extension 01:37:35 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 01:37:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:37:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:37:35 INFO - ^ 01:37:35 INFO - 1 warning generated. 01:37:35 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 01:37:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:35 INFO - Successfully installed psutil 01:37:35 INFO - Cleaning up... 01:37:35 INFO - Return code: 0 01:37:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:37:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:37:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:35 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 0x106e27a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e37420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f919259a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc6e00>, '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 0x106b2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cc1b20>, '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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 01:37:35 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 01:37:35 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 01:37:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QK0OVGe3Dv/Render', 01:37:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:35 INFO - 'HOME': '/Users/cltbld', 01:37:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:35 INFO - 'LOGNAME': 'cltbld', 01:37:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:35 INFO - 'MOZ_NO_REMOTE': '1', 01:37:35 INFO - 'NO_EM_RESTART': '1', 01:37:35 INFO - 'PAGER': '/bin/cat', 01:37:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:35 INFO - 'PWD': '/builds/slave/test', 01:37:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:35 INFO - 'SHELL': '/bin/bash', 01:37:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpsexiaJpm/Listeners', 01:37:35 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:37:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:35 INFO - 'USER': 'cltbld', 01:37:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:35 INFO - 'XPC_FLAGS': '0x0', 01:37:35 INFO - 'XPC_SERVICE_NAME': '0', 01:37:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:37:35 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 01:37:35 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 01:37:35 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 01:37:35 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 01:37:35 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 01:37:35 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 01:37:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:37:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:37:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:37:38 INFO - Installing collected packages: mozsystemmonitor 01:37:38 INFO - Running setup.py install for mozsystemmonitor 01:37:38 INFO - Successfully installed mozsystemmonitor 01:37:38 INFO - Cleaning up... 01:37:38 INFO - Return code: 0 01:37:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:38 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 0x106e27a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e37420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f919259a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc6e00>, '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 0x106b2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cc1b20>, '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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 01:37:38 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 01:37:38 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 01:37:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QK0OVGe3Dv/Render', 01:37:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:38 INFO - 'HOME': '/Users/cltbld', 01:37:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:38 INFO - 'LOGNAME': 'cltbld', 01:37:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:38 INFO - 'MOZ_NO_REMOTE': '1', 01:37:38 INFO - 'NO_EM_RESTART': '1', 01:37:38 INFO - 'PAGER': '/bin/cat', 01:37:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:38 INFO - 'PWD': '/builds/slave/test', 01:37:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:38 INFO - 'SHELL': '/bin/bash', 01:37:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpsexiaJpm/Listeners', 01:37:38 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:37:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:38 INFO - 'USER': 'cltbld', 01:37:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:38 INFO - 'XPC_FLAGS': '0x0', 01:37:38 INFO - 'XPC_SERVICE_NAME': '0', 01:37:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:38 INFO - Downloading/unpacking blobuploader==1.2.4 01:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:41 INFO - Downloading blobuploader-1.2.4.tar.gz 01:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:37:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:37:41 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 01:37:41 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 01:37:41 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 01:37:41 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 01:37:41 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 01:37:41 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 01:37:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:37:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:37:41 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 01:37:41 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 01:37:41 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 01:37:41 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 01:37:41 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 01:37:41 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 01:37:42 INFO - Downloading docopt-0.6.1.tar.gz 01:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:37:42 INFO - Installing collected packages: blobuploader, requests, docopt 01:37:42 INFO - Running setup.py install for blobuploader 01:37:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:37:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:37:42 INFO - Running setup.py install for requests 01:37:43 INFO - Running setup.py install for docopt 01:37:43 INFO - Successfully installed blobuploader requests docopt 01:37:43 INFO - Cleaning up... 01:37:43 INFO - Return code: 0 01:37:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:43 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 0x106e27a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e37420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f919259a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc6e00>, '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 0x106b2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cc1b20>, '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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 01:37:43 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 01:37:43 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 01:37:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QK0OVGe3Dv/Render', 01:37:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:43 INFO - 'HOME': '/Users/cltbld', 01:37:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:43 INFO - 'LOGNAME': 'cltbld', 01:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:43 INFO - 'MOZ_NO_REMOTE': '1', 01:37:43 INFO - 'NO_EM_RESTART': '1', 01:37:43 INFO - 'PAGER': '/bin/cat', 01:37:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:43 INFO - 'PWD': '/builds/slave/test', 01:37:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:43 INFO - 'SHELL': '/bin/bash', 01:37:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpsexiaJpm/Listeners', 01:37:43 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:37:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:43 INFO - 'USER': 'cltbld', 01:37:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:43 INFO - 'XPC_FLAGS': '0x0', 01:37:43 INFO - 'XPC_SERVICE_NAME': '0', 01:37:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:37:43 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-ZteIoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:37:43 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Os5faM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:37:43 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-ee7TGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:37:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:37:43 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-XLMglT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:37:44 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-gbVzjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:37:44 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Zk0CAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:37:44 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-wL787T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:37:44 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-RqTzrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:44 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-w1jZFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:44 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Qagg_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:44 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-gI_xwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:44 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Ivvl3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:44 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-xvEZfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:44 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-POKfb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:45 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-TdPLXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:45 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-vgeqmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:37:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:37:45 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-V6v56P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:37:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:37:45 INFO - Running setup.py install for manifestparser 01:37:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:37:45 INFO - Running setup.py install for mozcrash 01:37:45 INFO - Running setup.py install for mozdebug 01:37:45 INFO - Running setup.py install for mozdevice 01:37:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:37:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:37:45 INFO - Running setup.py install for mozfile 01:37:46 INFO - Running setup.py install for mozhttpd 01:37:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:37:46 INFO - Running setup.py install for mozinfo 01:37:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:37:46 INFO - Running setup.py install for mozInstall 01:37:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:37:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:37:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:37:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:37:46 INFO - Running setup.py install for mozleak 01:37:46 INFO - Running setup.py install for mozlog 01:37:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:37:46 INFO - Running setup.py install for moznetwork 01:37:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:37:46 INFO - Running setup.py install for mozprocess 01:37:47 INFO - Running setup.py install for mozprofile 01:37:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:37:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:37:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:37:47 INFO - Running setup.py install for mozrunner 01:37:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:37:47 INFO - Running setup.py install for mozscreenshot 01:37:47 INFO - Running setup.py install for moztest 01:37:47 INFO - Running setup.py install for mozversion 01:37:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:37:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:37:47 INFO - Cleaning up... 01:37:47 INFO - Return code: 0 01:37:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37:47 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')]} 01:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:47 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')]} 01:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:47 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 0x106e27a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e37420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f919259a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc6e00>, '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 0x106b2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cc1b20>, '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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 01:37:47 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 01:37:47 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 01:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QK0OVGe3Dv/Render', 01:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:47 INFO - 'HOME': '/Users/cltbld', 01:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:47 INFO - 'LOGNAME': 'cltbld', 01:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:47 INFO - 'MOZ_NO_REMOTE': '1', 01:37:47 INFO - 'NO_EM_RESTART': '1', 01:37:47 INFO - 'PAGER': '/bin/cat', 01:37:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:47 INFO - 'PWD': '/builds/slave/test', 01:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:47 INFO - 'SHELL': '/bin/bash', 01:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpsexiaJpm/Listeners', 01:37:47 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:47 INFO - 'USER': 'cltbld', 01:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:47 INFO - 'XPC_FLAGS': '0x0', 01:37:47 INFO - 'XPC_SERVICE_NAME': '0', 01:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:37:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-3FnFFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:37:48 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)) 01:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:37:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-tzIw1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:37:48 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)) 01:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:37:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-zgux9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:37:48 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)) 01:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:37:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-kTCbeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:37:48 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)) 01:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:37:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-vzdGj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:37:48 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)) 01:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:37:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-tfqLzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:37:48 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)) 01:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:37:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Rgnk2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:37:48 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)) 01:37:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:37:48 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-ZU0w2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37:49 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)) 01:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:49 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Mzg4wf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37:49 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)) 01:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:49 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-89dYVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:49 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)) 01:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:49 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-QrqRH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:49 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)) 01:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:49 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-2todxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:49 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)) 01:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:49 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-G9I_J1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:49 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)) 01:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:49 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-cdsAx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:49 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)) 01:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:49 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Jmnr_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:49 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)) 01:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:49 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Yt_3dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:37:49 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)) 01:37:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:37:49 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-uuBU3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:37:49 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)) 01:37:49 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)) 01:37:49 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)) 01:37:49 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)) 01:37:49 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)) 01:37:49 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)) 01:37:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:37:49 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 01:37:49 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 01:37:49 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 01:37:49 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 01:37:49 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 01:37:49 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 01:37:52 INFO - Downloading blessings-1.6.tar.gz 01:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:37:52 INFO - Installing collected packages: blessings 01:37:52 INFO - Running setup.py install for blessings 01:37:52 INFO - Successfully installed blessings 01:37:52 INFO - Cleaning up... 01:37:52 INFO - Return code: 0 01:37:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:37:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:37:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:37:52 INFO - Reading from file tmpfile_stdout 01:37:52 INFO - Current package versions: 01:37:52 INFO - blessings == 1.6 01:37:52 INFO - blobuploader == 1.2.4 01:37:52 INFO - docopt == 0.6.1 01:37:52 INFO - manifestparser == 1.1 01:37:52 INFO - mozInstall == 1.12 01:37:52 INFO - mozcrash == 0.17 01:37:52 INFO - mozdebug == 0.1 01:37:52 INFO - mozdevice == 0.48 01:37:52 INFO - mozfile == 1.2 01:37:52 INFO - mozhttpd == 0.7 01:37:52 INFO - mozinfo == 0.9 01:37:52 INFO - mozleak == 0.1 01:37:52 INFO - mozlog == 3.1 01:37:52 INFO - moznetwork == 0.27 01:37:52 INFO - mozprocess == 0.22 01:37:52 INFO - mozprofile == 0.28 01:37:52 INFO - mozrunner == 6.11 01:37:52 INFO - mozscreenshot == 0.1 01:37:52 INFO - mozsystemmonitor == 0.0 01:37:52 INFO - moztest == 0.7 01:37:52 INFO - mozversion == 1.4 01:37:52 INFO - psutil == 3.1.1 01:37:52 INFO - requests == 1.2.3 01:37:52 INFO - wsgiref == 0.1.2 01:37:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:52 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 0x106e27a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e37420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f919259a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc6e00>, '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 0x106b2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cc1b20>, '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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 01:37:52 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 01:37:52 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 01:37:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QK0OVGe3Dv/Render', 01:37:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:52 INFO - 'HOME': '/Users/cltbld', 01:37:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:52 INFO - 'LOGNAME': 'cltbld', 01:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:52 INFO - 'MOZ_NO_REMOTE': '1', 01:37:52 INFO - 'NO_EM_RESTART': '1', 01:37:52 INFO - 'PAGER': '/bin/cat', 01:37:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:52 INFO - 'PWD': '/builds/slave/test', 01:37:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:52 INFO - 'SHELL': '/bin/bash', 01:37:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpsexiaJpm/Listeners', 01:37:52 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:37:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:52 INFO - 'USER': 'cltbld', 01:37:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:52 INFO - 'XPC_FLAGS': '0x0', 01:37:52 INFO - 'XPC_SERVICE_NAME': '0', 01:37:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:53 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)) 01:37:53 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)) 01:37:53 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)) 01:37:53 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)) 01:37:53 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)) 01:37:53 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)) 01:37:53 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)) 01:37:53 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)) 01:37:53 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)) 01:37:53 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)) 01:37:53 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)) 01:37:53 INFO - Cleaning up... 01:37:53 INFO - Return code: 0 01:37:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106e27a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e37420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f919259a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc6e00>, '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 0x106b2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cc1b20>, '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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 01:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QK0OVGe3Dv/Render', 01:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:53 INFO - 'HOME': '/Users/cltbld', 01:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:53 INFO - 'LOGNAME': 'cltbld', 01:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:53 INFO - 'MOZ_NO_REMOTE': '1', 01:37:53 INFO - 'NO_EM_RESTART': '1', 01:37:53 INFO - 'PAGER': '/bin/cat', 01:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:53 INFO - 'PWD': '/builds/slave/test', 01:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:53 INFO - 'SHELL': '/bin/bash', 01:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpsexiaJpm/Listeners', 01:37:53 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:53 INFO - 'USER': 'cltbld', 01:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:53 INFO - 'XPC_FLAGS': '0x0', 01:37:53 INFO - 'XPC_SERVICE_NAME': '0', 01:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:53 INFO - Downloading/unpacking jsonschema 01:37:53 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 01:37:53 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 01:37:53 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 01:37:53 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 01:37:53 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 01:37:53 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 01:37:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:37:55 INFO - Downloading/unpacking functools32 (from jsonschema) 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:56 INFO - Downloading functools32-3.2.3-2.tar.gz 01:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:37:56 INFO - warning: no files found matching '*.txt' 01:37:56 INFO - no previously-included directories found matching 'build' 01:37:56 INFO - no previously-included directories found matching 'dist' 01:37:56 INFO - no previously-included directories found matching '.git*' 01:37:56 INFO - Installing collected packages: jsonschema, functools32 01:37:56 INFO - Running setup.py install for functools32 01:37:56 INFO - warning: no files found matching '*.txt' 01:37:56 INFO - no previously-included directories found matching 'build' 01:37:56 INFO - no previously-included directories found matching 'dist' 01:37:56 INFO - no previously-included directories found matching '.git*' 01:37:56 INFO - Successfully installed jsonschema functools32 01:37:56 INFO - Cleaning up... 01:37:56 INFO - Return code: 0 01:37:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:56 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 0x106e27a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e37420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f919259a0e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106cc6e00>, '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 0x106b2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cc1b20>, '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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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 01:37:56 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 01:37:56 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 01:37:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QK0OVGe3Dv/Render', 01:37:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:56 INFO - 'HOME': '/Users/cltbld', 01:37:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:56 INFO - 'LOGNAME': 'cltbld', 01:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:56 INFO - 'MOZ_NO_REMOTE': '1', 01:37:56 INFO - 'NO_EM_RESTART': '1', 01:37:56 INFO - 'PAGER': '/bin/cat', 01:37:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:56 INFO - 'PWD': '/builds/slave/test', 01:37:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:56 INFO - 'SHELL': '/bin/bash', 01:37:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpsexiaJpm/Listeners', 01:37:56 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:37:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:56 INFO - 'USER': 'cltbld', 01:37:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:56 INFO - 'XPC_FLAGS': '0x0', 01:37:56 INFO - 'XPC_SERVICE_NAME': '0', 01:37:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:57 INFO - Downloading/unpacking flake8 01:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:37:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:37:59 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 01:37:59 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 01:37:59 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 01:37:59 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 01:37:59 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 01:37:59 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 01:37:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:37:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:37:59 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 01:37:59 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 01:37:59 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 01:37:59 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 01:37:59 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 01:37:59 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 01:38:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:38:00 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 01:38:00 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 01:38:00 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 01:38:00 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 01:38:00 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 01:38:00 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 01:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:38:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:00 INFO - no previously-included directories found matching 'docs/_build' 01:38:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:38:00 INFO - Running setup.py install for pep8 01:38:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:00 INFO - no previously-included directories found matching 'docs/_build' 01:38:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:38:00 INFO - Cleaning up... 01:38:01 INFO - Return code: 0 01:38:01 INFO - Running post-action listener: _resource_record_post_action 01:38:01 INFO - Running post-action listener: _start_resource_monitoring 01:38:01 INFO - Starting resource monitoring. 01:38:01 INFO - ##### 01:38:01 INFO - ##### Running install step. 01:38:01 INFO - ##### 01:38:01 INFO - Running pre-action listener: _resource_record_pre_action 01:38:01 INFO - Running main action method: install 01:38:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:01 INFO - Reading from file tmpfile_stdout 01:38:01 INFO - Detecting whether we're running mozinstall >=1.0... 01:38:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:38:01 INFO - Reading from file tmpfile_stdout 01:38:01 INFO - Output received: 01:38:01 INFO - Usage: mozinstall [options] installer 01:38:01 INFO - Options: 01:38:01 INFO - -h, --help show this help message and exit 01:38:01 INFO - -d DEST, --destination=DEST 01:38:01 INFO - Directory to install application into. [default: 01:38:01 INFO - "/builds/slave/test"] 01:38:01 INFO - --app=APP Application being installed. [default: firefox] 01:38:01 INFO - mkdir: /builds/slave/test/build/application 01:38:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 01:38:23 INFO - Reading from file tmpfile_stdout 01:38:23 INFO - Output received: 01:38:23 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:38:23 INFO - Running post-action listener: _resource_record_post_action 01:38:23 INFO - ##### 01:38:23 INFO - ##### Running run-tests step. 01:38:23 INFO - ##### 01:38:23 INFO - Running pre-action listener: _resource_record_pre_action 01:38:23 INFO - Running main action method: run_tests 01:38:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:38:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:38:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:38:23 INFO - 2016-06-07 01:38:23.202 screenresolution[1636:7407] starting screenresolution argv=screenresolution get 01:38:23 INFO - 2016-06-07 01:38:23.204 screenresolution[1636:7407] Display 0: 1600x1200x32@60 01:38:23 INFO - 2016-06-07 01:38:23.210 screenresolution[1637:7409] starting screenresolution argv=screenresolution list 01:38:23 INFO - Available Modes on Display 0 01:38:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:38:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:38:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:38:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:38:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:38:23 INFO - Intel Iris: 01:38:23 INFO - Chipset Model: Intel Iris 01:38:23 INFO - Type: GPU 01:38:23 INFO - Bus: Built-In 01:38:23 INFO - VRAM (Dynamic, Max): 1536 MB 01:38:23 INFO - Vendor: Intel (0x8086) 01:38:23 INFO - Device ID: 0x0a2e 01:38:23 INFO - Revision ID: 0x0009 01:38:23 INFO - Displays: 01:38:23 INFO - Display: 01:38:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:38:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:38:23 INFO - Display Serial Number: 1600x1200 60 01:38:23 INFO - Main Display: Yes 01:38:23 INFO - Mirror: Off 01:38:23 INFO - Online: Yes 01:38:23 INFO - Rotation: Supported 01:38:23 INFO - Return code: 0 01:38:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:38:23 INFO - Python 2.7.3 01:38:23 INFO - Return code: 0 01:38:23 INFO - grabbing minidump binary from tooltool 01:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:38:23 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 0x106cc6e00>, '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 0x106b2fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106cc1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:38:23 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 01:38:23 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 01:38:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:38:23 INFO - Return code: 0 01:38:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:38:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:38:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:38:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:38:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:38:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:38:24 INFO - Return code: 0 01:38:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0148', '--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 01:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0148 --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 01:38:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QK0OVGe3Dv/Render', 01:38:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:24 INFO - 'HOME': '/Users/cltbld', 01:38:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:24 INFO - 'LOGNAME': 'cltbld', 01:38:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:38:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:24 INFO - 'MOZ_NO_REMOTE': '1', 01:38:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:38:24 INFO - 'NO_EM_RESTART': '1', 01:38:24 INFO - 'PAGER': '/bin/cat', 01:38:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:24 INFO - 'PWD': '/builds/slave/test', 01:38:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:38:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:24 INFO - 'SHELL': '/bin/bash', 01:38:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DpsexiaJpm/Listeners', 01:38:24 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:38:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:24 INFO - 'USER': 'cltbld', 01:38:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:24 INFO - 'XPC_FLAGS': '0x0', 01:38:24 INFO - 'XPC_SERVICE_NAME': '0', 01:38:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0148', '--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 01:38:24 INFO - mozversion application_buildid: 20160606120332 01:38:24 INFO - mozversion application_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 01:38:24 INFO - mozversion application_display_name: Firefox 01:38:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:38:24 INFO - mozversion application_name: Firefox 01:38:24 INFO - mozversion application_remotingname: firefox 01:38:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:38:24 INFO - mozversion application_vendor: Mozilla 01:38:24 INFO - mozversion application_version: 48.0 01:38:24 INFO - mozversion platform_buildid: 20160606120332 01:38:24 INFO - mozversion platform_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 01:38:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:38:24 INFO - mozversion platform_version: 48.0 01:38:24 INFO - using testdate: 1465288704 01:38:24 INFO - actual date: 1465288704 01:38:24 INFO - starting webserver on 'localhost:49278' 01:38:24 INFO - SUITE-START | Running 2 tests 01:38:24 INFO - TEST-START | dromaeo_css 01:38:24 INFO - operating with platform_type : mac_ 01:38:24 INFO - Initialising browser for dromaeo_css test... 01:38:24 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpTBHPxA/profile http://localhost:49278/getInfo.html) 01:38:27 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 01:38:27 INFO - PROCESS | 1655 | colorDepth:24 01:38:27 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 01:38:27 INFO - PROCESS | 1655 | __metrics 01:38:27 INFO - PROCESS | 1655 | 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" 01:38:27 ERROR - PROCESS | 1655 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:38:28 INFO - TEST-INFO | 1655: exit 0 01:38:28 INFO - Browser initialized. 01:38:28 INFO - Running cycle 1/1 for dromaeo_css test... 01:38:28 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpTBHPxA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:40 INFO - PROCESS | 1658 | RSS: Main: 161013760 01:38:40 INFO - PROCESS | 1658 | 01:39:31 INFO - PROCESS | 1658 | 1465288771513 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] 01:41:41 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 01:41:42 INFO - PROCESS | 1658 | RSS: Main: 255438848 01:41:42 INFO - PROCESS | 1658 | 01:44:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 01:44:46 INFO - PROCESS | 1658 | RSS: Main: 300683264 01:44:46 INFO - PROCESS | 1658 | 01:47:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 01:47:48 INFO - PROCESS | 1658 | RSS: Main: 309231616 01:47:48 INFO - PROCESS | 1658 | 01:50:50 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 01:50:51 INFO - PROCESS | 1658 | RSS: Main: 305303552 01:50:51 INFO - PROCESS | 1658 | 01:53:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 01:53:55 INFO - PROCESS | 1658 | RSS: Main: 270426112 01:53:55 INFO - PROCESS | 1658 | 01:56:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 01:56:57 INFO - PROCESS | 1658 | RSS: Main: 314130432 01:56:57 INFO - PROCESS | 1658 | 01:56:57 INFO - PROCESS | 1658 | __start_tp_report 01:56:57 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 01:56:57 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 01:56:57 INFO - PROCESS | 1658 | |i|pagename|runs| 01:56:57 INFO - PROCESS | 1658 | |0;dojo.html;3466.9966667331973;3480.91297717557;3547.095490649884;3551.9289614207714;3562.893113206604;5723.284589426322;5910.88178236435;5950.137230101633;5956.3150237722675;5964.88070238595;5908.261467316585;5945.702714864261;5964.075568286922;5965.164876917235;5968.10478428236;5240.816571420001;5278.6568873023325;5280.3663560372715;5363.302770639812;5424.972875135619;5342.171963345688;5381.461853814626;5383.246345511631;5383.43473935237;5384.246205531229;5319;5362.329708786402;5377.5966802489775;5383.273258110164;5405.135178371462;5369.543588794957;5389.51494365509;5391.946080539223;5411.621186516945;5464.9180262296095;5126.461721519261;5223.895522089575;5300.602454815866;5337.039332920072;5367.892642147135;5669.971650141764;5723.71381430931;5771.451712087345;5774.682392468412;5787.710614469302;6273.0904018917;6282.905756413657;6292.339304373067;6307.463865571432;6311.33730958252;6142.069075791497;6224.906626400608;6325.683715814237;6329.430351268362;6342.429181373653;5853.795117170921;5871.324797648283;5976.7908123215475;6020.909686354708;6032.638041717511;6380.840478988062;6382.489400847921;6383.904241436382;6400.327965563642;6522.478201743849;6120.111926550715;6207.596506227081;6304.401081897213;6326.620402775849;6392.680365981682;6288.654124023223;6307.526935479766;6315.494760419156;6319.684015799192;6323.462505687068;6222.968885155546;6260.593061450991;6278.497720182374;6284.12022316876;6291.653959032297;6174.876502470015;6201.255849298113;6275.246970363585;6304.243490781136;6455.741770329134;4328.199283132631;4937.432195297587;5008.874778130576;5029.874253143701;5042.84871453857;3841.8079096045644;4520.141173177151;4531.13908357411;4538.500764915857;4554.681172317906;5790.768369265266;5896.970515147483;5901.17383566301;6004.0093384591055;6022.69886505673;6253.397772557408;6288.622682639057;6299.212598425197;6301.905471417932;6306.243250809932;5882.676452795137;5950.8809823803285;5958.463738263577;5969.194158788595;5977.970110149508;5411.5129638331955;5460.290162278958;5479.479449452296;5497.835064948058;5557.805476808292;5370.355557333145;6376.171097757448;6405.615663060231;6412.487001039999;6467.773627923;6208.379162083756;6299.464545513682;6314.368563143649;6328.272248691275;6334.461570766536;6357.205349331333;6395.680215989275;6450.645214513059;6466.030095485715;6482.546221764431;6282;6292.590981586182;6296.118543403835;6307.684615769102;6323.462505687068;6233.719482623384;6235.314115447388;6316.115743795965;6333.524985626004;6344.873102537831;6214.720337584729;6323.715432805627;6325.841853953688;6340.112384266298;6343.9682801585695;5535.833924982257;6282.717277722422;6292.590981586182;6321.30465648769;6322.652254126067;5978.192943952511;5979.701014949323;6031.4270144336215;6103.542234332532;6178.1350610913605;6085.6348619083;6123.6631985239455;6203;6298.0552917062805;6310.463610593151;6158.168647232566;6158.692065396623;6202.379762023762;6210.813675589739;6217.626942383471 01:56:57 INFO - PROCESS | 1658 | |1;ext.html;522.4931816138344;557.9246801681772;595.4343373794894;601.7111786342556;627.2723640576932;32938.67061329386;33324;33438.83280583597;33465.832670836615;33474.66525334746;35260.82369588155;43299.78350108245;44802.10395792082;44876.87807804807;44900.77549612256;10030.047145521201;10201.897981020205;10214.233932455058;10218;10230.181585473145;8383.62273697682;9254.167124958753;10049.346792458504;10065.798684026315;10085.546150423248;12271.079669024813;12516.62450126493;12545.372731363395;12552.74894502114;12568.748625027494;12092.4558394872;12229.205101668364;12241.571544995883;12247.203931744409;12261.632151035483;11986.520539178422;12092.637220883387;12119.454624541917;12123.575674851427;12158.148929574932;42492.57507424948;43113;43155.35266970998;43176;43197;3394.5247665326874;3474.2183008822813;3574.7318951078514;3740.4202348636004;3999.560048394674;29471.557926631118;30026.24934376658;30377.848110759525;30437.23906902323;30757.231069223224;2768.8338699678084;2782;2811.7750579953554;2815.5776633504934;2823.8446885421295;481979;483315;484421;484692;488639;38527.229455410736;70546;70784.64607676929;70964.2903570968;71100.64449677718;38269.42595861064;38275.23449531049;38331;38416.8079159608;38422.615773842466;16796.664066718597;16942.830571694125;16961.49115526536;16977.745333820003;16991.660166796595;14361.712765744627;14385.352659130363;14445.566633001026;14452.205128717811;14462.27688615565;8222.218889205516;8396.118407567239;8411.45325553837;8603.655853765778;8638.524881131598;3516.701080408143;3557.4130268505405;3566.928661426809;3578.8389522471552;3593.317269718745;957.4638202606562;999.1107913956585;1014.8274793285159;1074;1107.7286064914147;26444.73555264461;30144.54783178254;32230.871919483176;32379.838100809346;32395.19012024718;1150.8503894493829;1160.4913612303972;1162.8255761635821;1207.2092779229442;1228.619128070301;16240.918795406184;16312.429064982669;16385.50843474698;16538.0154381475;16616.169191540615;545673.2716336392;546908;550142;550511;553013;55240.17139742907;58437.4156258432;58497.70751146217;64876.35123648797;66807.66596166987;1318.2420108437686;1405.1639274631577;1532.1266877879725;1550.0389758349895;1561.9219039048003;25475.726213689613;30775.538366924065;31909.36181276315;32493.675063249066;32575.674243257265;58210;58490.12264816116;59581.51046223879;59632.105518418124;59716.10425843529;560731;576800;577105;577911;579479;37947.81026094852;48127.808287568645;48129.75935120442;48533.27200092072;49060.509394905595;49641.751791240815;49654.503454966434;50916.981660367324;51506.742466287425;51576.74211628918;39819.2036159281;40090;41154.38268425916;41304.58695413007;41942;40289.59710402976;40609.59390406176;40630.39054414127;40762.59237407588;41445.585544144174;39981.00047498836;40711.389329159494;41191;42213.78893105515;42268.73193804191;31632;33312.50031249485;33909.830450847585;33940.66059339375;34107.65892341144;22589.757563334173;25762;26229.606555902057;26449.735502644726;26555.518906114095 01:56:57 INFO - PROCESS | 1658 | |2;jquery.html;406.88810577091306;407;413.24376391204095;414.38050115077965;419.3856000958595;15337.539873803777;20238.494037649067;20954.371368858938;20979.951002449892;21527.784722152774;21114.788852111473;21481.46296342592;22392.440188995282;22446.88776556115;22468.8876555617;5485.890282194354;6209.596376235553;6212.937870621304;6220.875582488347;6226.688665566726;6022.909656355158;6188.381161883821;6192.566520343577;6192.969035154841;6203.658798766066;4347.956520434786;6503.447206987412;6794.864102717943;6802.965985170067;6806.625635590065;6491.545591808575;6758.594484330932;6772.593644381328;6776.695048722795;6776.69504872282;5930.258717660293;5953.077273022688;5954.642721436728;5954.957882370568;5959.880802383928;26330.73669263302;26460.0738974135;27140.642967851527;27271.86364068167;27407.45185096287;2114.7990940860595;2335.49786795838;2394.437307232799;2401.4836810085917;2495.9251222463354;9948.502574871227;10132.848007279898;10456.790864182674;12906.741865162645;15290.388384464608;1520.711064897666;1813.184067169779;1818.254515648591;1864.5991111910869;1909.9045047747557;116482;124804.37597811953;125551;125892.37053814763;126526;11634.6509604712;11872.228305160137;11945.402729863472;11988.460519276654;12162.817557736642;12113.212641178296;14797.556073317817;15067.849321506865;15324.770128448083;15416.306266218047;7352.558846469229;7417.888731669029;9271.072892710676;9344.112309330603;9386.389884657476;9312.674056407994;9340.626374945063;9347.766305842408;9352.672656457127;9463.952680236554;4783.282507623884;4805.063012712488;4817.7350245736825;4822.373091498082;4870.537298956593;2032;2084.3017589107517;2112.556363163753;2113.9471513212293;2131.0516820014946;913.4473643445752;1009.7021378693156;1020.1940467030962;1041.5313109100935;1045.7803861189084;20693;21278.893605532183;21670.674939875913;22220.666689999664;22366.440838979157;962.7929995051097;1016.8322226832638;1035.5495359518484;1056.144522936424;1074.6561100447782;11244.987951084442;11609.013233875216;11644.592439264585;11655.30068195894;11695.1228657851;548848;548898;555002;566164;643085;135679;146324.5367546332;146960;148325;149890;1046.0585473074293;1068.2628985999636;1085.1102096280974;1087.342157994418;1088.5591335509132;17812.643747125243;18746.343877964206;18916.527086822938;18983.050847457296;19080.809191908458;50640;54787.45212547983;54974.17538736842;55383;55553.72223138859;75544.24455755373;77563;77918.2208177911;78623.60688196523;82988.58505707434;8199.01611806587;8238.5056896584;8334.20825021622;8478.915210847812;8546.2308392245;8755.956220218859;8776.561171941505;9027.232685221566;9057;9548.854137503544;4989.625778066587;6182.306429956664;8157;8349.58252087381;8519.190676885686;7173.461990350849;8130.02439707239;8235.660508870988;8287.544185069879;8290.585470726319;7533.359664428585;7810.711232646549;8511.74464766058;8626.18051285127;8903.19871211594;12503.56237531682;12760.489580416679;12866.485340586647;13037.152585082318;13116.688331166806;11987.580434684744;12172.2696638202;12230.571929982409;12332.383380831103;12373.381330933596 01:56:57 INFO - PROCESS | 1658 | |3;mootools.html;1470.2060887120956;1600.8639265662418;1617.110589175953;1645.8765592580553;2014.717939488472;8198.139195384481;8411.116832732567;8412.158784121584;8420.999999999993;8610.440321379107;8857.379983401164;8874.911250887506;8979.102089791018;8986.595603197855;8993.955030224839;2496.9126080587184;2515.949681006379;2516.5721827289312;2516.848989060653;2521.621756736486;2447.21689059501;2538.4034751833306;2539.6444497770326;2541.0217066429373;2542.0594380079397;2507.523570521604;2526.810489213307;2550.7831834294016;2554.7189809120982;2556.7315431879665;2234.597772400959;2503.211488381154;2532.8733563321853;2536.226450932465;2541.097910241856;2471.1845091120067;2514.0320976424027;2515.5094756522485;2526.835755675875;2531.5190113878302;9031.864522032174;9082.818343633156;9090.545472726337;9091.181793638605;9130.95434522823;5433.402325744165;5574.944250557483;5693.572982026323;5735.512481439083;5740.995325817965;3555.6088830228655;3567.678908898212;3624;3630.1287690954246;3641.890743277706;1034.4724190662816;1038.2887721910515;1060.1042119409087;1077.3697387028599;1085.1752667972319;11972.820407693891;12109.455074521667;12116.151869369147;12159.027277817753;12205.023598112219;4696.5303469653445;4754.904901901942;4794.232922732416;4833.32333473314;4833.830815921426;9560.56977436017;9588.424694518351;9685.854712179324;9697.6120955161;9697.806043879084;5577.079781836032;5597.552195824324;5600.803971860965;5603.411641777636;5609.298837645294;4641.559051890065;4792.353032340659;5028.74856257193;5122.282880396748;5215.791368345223;3251.772375933662;4003.7597744134864;4072.0430698785763;4085.652719518874;4115.341545352789;1246.4889395347864;1254.3978890132787;1257.6227131860405;1257.7107265329025;1261.5836773864787;938.2212763406493;950.5294879034922;958.3579002068631;971.2472833554052;982.7199248214367;5042.268871013683;6065.423784740443;6124.35694252106;6168.599041062316;6181.81454556364;460.5302591356797;462.23500107322434;465.76478878166307;477.3317355702045;478.2778005212085;3607.3687104756564;3745.176061266517;3953.881383558498;3990.920181596352;4012.658923991435;9250.95374523123;10884.564617415374;11228.831567526493;11235.83146252807;11294.265872718412;10822.134229261641;10858.402787846744;10930.398828064534;10950;11014.834777478345;8015.318697910743;8362.414630975894;8425.662973481114;8429.704960326482;8462.957685211535;6041.848953776015;6078.513718902389;6172.382761723792;6207.037909124093;6216.160818289473;9815.263855210746;9904.900950990397;10041;10113.5448904798;10121.089101980562;9207.585658645243;9774.902250977399;9776.706698799047;10243.590256389662;10369.896301037195;7056.576605403692;7165.068541089625;7465.253474652492;7634.8091297718;7805;8257.38069644767;8503.23470887623;8563.95718021406;8572.742817715478;8578.957105214435;7526.285002924714;7611.162772094955;7677.270659287359;7724.2275772424555;7773;7461.104667439942;7482.1021477423055;7491.662875170739;7581.658825352762;7659.923400766144;7168.2831716827895;7262.237465066303;7286.234945330664;7293.452991025588;7312.341889229995;4959.801607935787;4986.276989836526;5099.133147365031;5134.4352121267375;5168.198929165986;5024.673396229234;5057.190849464068;5125.8718532037;5145.176771716508;5181.171012637959 01:56:57 INFO - PROCESS | 1658 | |4;prototype.html;323.496962223742;328.64670479234826;336.2669380749964;338.788257339163;340.82617864888914;4848.8787780305465;5171.818986335479;6474.996375561789;6504.089427480157;6504.47964162867;6163.784267550636;6282.183316168903;6388.3709654038275;6433.774817881375;6496.447801936841;4819.734914579714;4867.561919427251;4869.829555965542;4872.366592342991;4883.999999999982;4852.4662287148385;4853.296272040569;4853.441854186778;4861.270809378604;4877.634177436688;4574.771261436915;4647.000894807616;4827.662063655545;4839.346688197101;4848;4802.039592081563;4815;4818.325434439182;4823.662343635947;4824.059308434857;4163.7293575917465;4171.165766846643;4174.603412675791;4176.269152898261;4179.6029377209115;6192.442680158762;6192.752289908398;6194.380561943814;6215.782447614357;6219.289695333774;5673.744681489343;5680.460356266148;5687.175359572839;5687.886242275173;5722.628029178131;6514.315996820361;6771.356721111487;6838.111045564095;6847.931520684829;6878.140232470942;4490.3937968374175;4490.39379683745;4507.887302817456;4509.864704058883;4522.615577675869;7159.212486626467;7228.674709638079;7231.783046508614;7235.082703083687;7246.710131594783;4570.268756998864;4570.314452832102;4571.994161284512;4578.244589642672;4580.770961451981;4644.8374306899095;4645.3032045193495;4649.651276154234;4653.767311634405;4660.906781864343;5276.65701729394;5452.836414907559;5508.394076651565;5513.61404701675;5535.750891209906;6096.817095487142;6498.252700939453;6901.033855260268;6920.688569014305;6925.965370173117;1512.9092254464767;1579.241963857355;1601.7036848183122;1606.9196540172945;1606.9276882540314;966.5988614724951;972.8346181149221;975.3662615119646;994.7115336552318;1017.7964407118606;6406.967965160145;6568.540202185801;6648.4681225501845;6713.295104014008;6717.832054198684;7051.92948070523;7081.752138675225;7091.219965803757;7095.113110861143;7099.396551293198;6512.827691015663;6515.804525864231;6521.315261897527;6701.1288532491435;6705.564138330993;3601.1897323102617;3698.574663913684;3746.569144548357;3755.661990420875;3756.6806821420487;7386.298301661333;7387.445941554405;7406.629668516553;7410.851782964311;7433.331000210007;7304.415646748247;7308.524945878501;7310.963445182846;7312.707491700379;7314.305141011595;6397.840053998594;7017.3684368407085;7396.852062958711;7407.962885196077;7416.592087435135;6691.197056353269;7041.6831242595235;7050.541714788523;7056.6118863463;7078.575285482888;6932.44540436774;6997.545159564612;7006.5095443320515;7015.754448594274;7016.5790052597;7387.261273872785;7391.371733402721;7400.555966642019;7403.18564957865;7406;4602.21762300403;4611.239145540948;4613.838515651936;4622.953770462253;4623.976880115578;6822.351876571718;7075.893861592183;7080;7090.07828982229;7105.893411598933;6899.379055884994;6928.826779330557;6945.166580010229;6951.443884489127;6984.650767461708;6959.373656370951;6967.059446974797;6967.79096627102;6970.268121847133;6993.895091573529;6826.488013398915;6829;6948.444124470131;6990.6504674767075;6995.020697102308;5336.439673834191;6623.801285961429;6837.829054273683;6935.895961560682;6937.549059311129;6571.934280657323;6699.9950007499265;6704.564203326768;6898.275681053417;6910.689018994057 01:56:57 INFO - PROCESS | 1658 | |5;yui.html;705.6154395854259;716.6166101135892;750.2722359311473;759.6088014672445;796.0725754496009;15639.296231669574;15840.128792916385;15851.3659453622;15856.603584910383;15884.761728574067;14397.568072957802;14604.831613470924;14615.123092614424;14619.488317908876;14647.853521464782;784.4626430894841;803.5901690138013;951.8952915179325;978.2614126334607;979.4123525884484;962.7208109648194;970.4129001953822;972.7276362618443;974.3763991045737;978.7993461340444;843.6709683223547;1033.9638112666057;1036.5387402605843;1036.6475398364555;1038.4963292803022;1027.0756319312604;1049.464772965789;1050.968470945873;1051.337657275919;1051.542578978147;781.5310813511904;782.3545574900672;783.3615603283363;783.5690370296314;784.4156103702721;15905.045697258201;16004.679906401923;16005.359785608562;16018.679626407407;16038.117903515302;13213.669658258621;13639.863601363959;13648.658783530393;13671.17972921628;13831.930840345834;10438.269321147523;10501.789964200749;10553.84169237462;10775.35347879122;11044.33733975964;3576.946345804815;3598.712103031777;3654.305681920453;3712.406015037581;3880.7865567393783;81717.59141204316;83728;87916;87928;88651.55674221652;9949.104580587782;9965.900340996643;10158.644447444452;10463.319884207654;10743.194260430499;23957.640635390482;23964.64053039171;24027.7597224029;24031.399215019414;24054.51890962206;7704.537727736241;7865.410094242955;7994.160613135653;8001.199880011952;8097.959510202411;4114.382842573638;4124.13393187434;4159.625633692922;4165.625093741517;4178.080822219168;3845.9615403845605;3892;3911.119998000427;3914.3149948758855;3917.9608203918165;676.950726374128;685.1196212866442;716.5306724095726;732.7435397610793;764.388489208642;527.9947200527946;600.2466904035408;601.5638661970037;606.7057477123592;632.9303776584572;7682.078150621961;8414.15858414166;8456.619452124545;8595.78510537229;8848.778780530538;609.7500024989733;613.25489530221;615.5783288447338;626.6584711332334;647.6567419267795;3810.40938654509;3865.5747867734526;3967.0479085019388;4099.241640296555;4266.765327906995;83218;83416.16583834084;87012.69480957791;87932.56033719791;93050.53474732718;79182;79754;80070;80603.7909431359;81899;71181;71651.99999999895;72546;73577.26422735812;74060.62969685117;6822.624755638289;7833.92166078332;7994.880076798736;8066.112727600077;8480.194381533744;41171;50841;51162.69767860381;51231.74384128056;52639.47360526499;69756.65121674359;70752.64623676849;71157.6442117786;71171.28828711646;72411.63794180995;10546.209034322303;10610.8938910613;10791.892081079088;10808.135349172204;10848.783024339627;10825.404602746925;11082.556697732;11091.439543176191;11243.66269011931;11463.484143213742;10519.78960420772;10709.250352475252;11150.442477876237;11341.092712583139;11451.713707157387;11411.37237451915;11432.428378581204;11454.656360309204;11701.239419437708;11708.941455292668;11243.66269011931;11367.374794386058;11388.032017278623;11579.536818527502;11618.419079045845;9579.281553883626;9767.560459779184;9770.120689138012;9828.803423931624;10080.445575493419;9714.611415543299;10090.596376144871;10104.141148002502;10105.090541850974;10122.291439599157 01:56:57 INFO - PROCESS | 1658 | __end_tp_report 01:56:57 INFO - PROCESS | 1658 | __start_cc_report 01:56:57 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1111 01:56:57 INFO - PROCESS | 1658 | __end_cc_report 01:56:57 INFO - PROCESS | 1658 | __startTimestamp1465289817875__endTimestamp 01:56:57 INFO - PROCESS | 1658 | 01:56:57 INFO - PROCESS | 1658 | ------- Summary: start ------- 01:56:57 INFO - PROCESS | 1658 | Number of tests: 6 01:56:57 INFO - PROCESS | 1658 | 01:56:57 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5856.50 Median:6120.11 stddev:647.46 (10.6%) stddev-sans-first:621.72 01:56:57 INFO - PROCESS | 1658 | Values: 3467.0 3480.9 3547.1 3551.9 3562.9 5723.3 5910.9 5950.1 5956.3 5964.9 5908.3 5945.7 5964.1 5965.2 5968.1 5240.8 5278.7 5280.4 5363.3 5425.0 5342.2 5381.5 5383.2 5383.4 5384.2 5319.0 5362.3 5377.6 5383.3 5405.1 5369.5 5389.5 5391.9 5411.6 5464.9 5126.5 5223.9 5300.6 5337.0 5367.9 5670.0 5723.7 5771.5 5774.7 5787.7 6273.1 6282.9 6292.3 6307.5 6311.3 6142.1 6224.9 6325.7 6329.4 6342.4 5853.8 5871.3 5976.8 6020.9 6032.6 6380.8 6382.5 6383.9 6400.3 6522.5 6120.1 6207.6 6304.4 6326.6 6392.7 6288.7 6307.5 6315.5 6319.7 6323.5 6223.0 6260.6 6278.5 6284.1 6291.7 6174.9 6201.3 6275.2 6304.2 6455.7 4328.2 4937.4 5008.9 5029.9 5042.8 3841.8 4520.1 4531.1 4538.5 4554.7 5790.8 5897.0 5901.2 6004.0 6022.7 6253.4 6288.6 6299.2 6301.9 6306.2 5882.7 5950.9 5958.5 5969.2 5978.0 5411.5 5460.3 5479.5 5497.8 5557.8 5370.4 6376.2 6405.6 6412.5 6467.8 6208.4 6299.5 6314.4 6328.3 6334.5 6357.2 6395.7 6450.6 6466.0 6482.5 6282.0 6292.6 6296.1 6307.7 6323.5 6233.7 6235.3 6316.1 6333.5 6344.9 6214.7 6323.7 6325.8 6340.1 6344.0 5535.8 6282.7 6292.6 6321.3 6322.7 5978.2 5979.7 6031.4 6103.5 6178.1 6085.6 6123.7 6203.0 6298.1 6310.5 6158.2 6158.7 6202.4 6210.8 6217.6 01:56:57 INFO - PROCESS | 1658 | 01:56:57 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:67980.41 Median:3562.17 stddev:143169.05 (4019.2%) stddev-sans-first:143481.08 01:56:57 INFO - PROCESS | 1658 | Values: 522.5 557.9 595.4 601.7 627.3 32938.7 33324.0 33438.8 33465.8 33474.7 35260.8 43299.8 44802.1 44876.9 44900.8 10030.0 10201.9 10214.2 10218.0 10230.2 8383.6 9254.2 10049.3 10065.8 10085.5 12271.1 12516.6 12545.4 12552.7 12568.7 12092.5 12229.2 12241.6 12247.2 12261.6 11986.5 12092.6 12119.5 12123.6 12158.1 42492.6 43113.0 43155.4 43176.0 43197.0 3394.5 3474.2 3574.7 3740.4 3999.6 29471.6 30026.2 30377.8 30437.2 30757.2 2768.8 2782.0 2811.8 2815.6 2823.8 481979.0 483315.0 484421.0 484692.0 488639.0 38527.2 70546.0 70784.6 70964.3 71100.6 38269.4 38275.2 38331.0 38416.8 38422.6 16796.7 16942.8 16961.5 16977.7 16991.7 14361.7 14385.4 14445.6 14452.2 14462.3 8222.2 8396.1 8411.5 8603.7 8638.5 3516.7 3557.4 3566.9 3578.8 3593.3 957.5 999.1 1014.8 1074.0 1107.7 26444.7 30144.5 32230.9 32379.8 32395.2 1150.9 1160.5 1162.8 1207.2 1228.6 16240.9 16312.4 16385.5 16538.0 16616.2 545673.3 546908.0 550142.0 550511.0 553013.0 55240.2 58437.4 58497.7 64876.4 66807.7 1318.2 1405.2 1532.1 1550.0 1561.9 25475.7 30775.5 31909.4 32493.7 32575.7 58210.0 58490.1 59581.5 59632.1 59716.1 560731.0 576800.0 577105.0 577911.0 579479.0 37947.8 48127.8 48129.8 48533.3 49060.5 49641.8 49654.5 50917.0 51506.7 51576.7 39819.2 40090.0 41154.4 41304.6 41942.0 40289.6 40609.6 40630.4 40762.6 41445.6 39981.0 40711.4 41191.0 42213.8 42268.7 31632.0 33312.5 33909.8 33940.7 34107.7 22589.8 25762.0 26229.6 26449.7 26555.5 01:56:57 INFO - PROCESS | 1658 | 01:56:57 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35082.59 Median:27339.66 stddev:96644.81 (353.5%) stddev-sans-first:96880.85 01:56:57 INFO - PROCESS | 1658 | Values: 406.9 407.0 413.2 414.4 419.4 15337.5 20238.5 20954.4 20980.0 21527.8 21114.8 21481.5 22392.4 22446.9 22468.9 5485.9 6209.6 6212.9 6220.9 6226.7 6022.9 6188.4 6192.6 6193.0 6203.7 4348.0 6503.4 6794.9 6803.0 6806.6 6491.5 6758.6 6772.6 6776.7 6776.7 5930.3 5953.1 5954.6 5955.0 5959.9 26330.7 26460.1 27140.6 27271.9 27407.5 2114.8 2335.5 2394.4 2401.5 2495.9 9948.5 10132.8 10456.8 12906.7 15290.4 1520.7 1813.2 1818.3 1864.6 1909.9 116482.0 124804.4 125551.0 125892.4 126526.0 11634.7 11872.2 11945.4 11988.5 12162.8 12113.2 14797.6 15067.8 15324.8 15416.3 7352.6 7417.9 9271.1 9344.1 9386.4 9312.7 9340.6 9347.8 9352.7 9464.0 4783.3 4805.1 4817.7 4822.4 4870.5 2032.0 2084.3 2112.6 2113.9 2131.1 913.4 1009.7 1020.2 1041.5 1045.8 20693.0 21278.9 21670.7 22220.7 22366.4 962.8 1016.8 1035.5 1056.1 1074.7 11245.0 11609.0 11644.6 11655.3 11695.1 548848.0 548898.0 555002.0 566164.0 643085.0 135679.0 146324.5 146960.0 148325.0 149890.0 1046.1 1068.3 1085.1 1087.3 1088.6 17812.6 18746.3 18916.5 18983.1 19080.8 50640.0 54787.5 54974.2 55383.0 55553.7 75544.2 77563.0 77918.2 78623.6 82988.6 8199.0 8238.5 8334.2 8478.9 8546.2 8756.0 8776.6 9027.2 9057.0 9548.9 4989.6 6182.3 8157.0 8349.6 8519.2 7173.5 8130.0 8235.7 8287.5 8290.6 7533.4 7810.7 8511.7 8626.2 8903.2 12503.6 12760.5 12866.5 13037.2 13116.7 11987.6 12172.3 12230.6 12332.4 12373.4 01:56:57 INFO - PROCESS | 1658 | 01:56:57 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5806.55 Median:5049.73 stddev:3236.13 (64.1%) stddev-sans-first:3228.80 01:56:57 INFO - PROCESS | 1658 | Values: 1470.2 1600.9 1617.1 1645.9 2014.7 8198.1 8411.1 8412.2 8421.0 8610.4 8857.4 8874.9 8979.1 8986.6 8994.0 2496.9 2515.9 2516.6 2516.8 2521.6 2447.2 2538.4 2539.6 2541.0 2542.1 2507.5 2526.8 2550.8 2554.7 2556.7 2234.6 2503.2 2532.9 2536.2 2541.1 2471.2 2514.0 2515.5 2526.8 2531.5 9031.9 9082.8 9090.5 9091.2 9131.0 5433.4 5574.9 5693.6 5735.5 5741.0 3555.6 3567.7 3624.0 3630.1 3641.9 1034.5 1038.3 1060.1 1077.4 1085.2 11972.8 12109.5 12116.2 12159.0 12205.0 4696.5 4754.9 4794.2 4833.3 4833.8 9560.6 9588.4 9685.9 9697.6 9697.8 5577.1 5597.6 5600.8 5603.4 5609.3 4641.6 4792.4 5028.7 5122.3 5215.8 3251.8 4003.8 4072.0 4085.7 4115.3 1246.5 1254.4 1257.6 1257.7 1261.6 938.2 950.5 958.4 971.2 982.7 5042.3 6065.4 6124.4 6168.6 6181.8 460.5 462.2 465.8 477.3 478.3 3607.4 3745.2 3953.9 3990.9 4012.7 9251.0 10884.6 11228.8 11235.8 11294.3 10822.1 10858.4 10930.4 10950.0 11014.8 8015.3 8362.4 8425.7 8429.7 8463.0 6041.8 6078.5 6172.4 6207.0 6216.2 9815.3 9904.9 10041.0 10113.5 10121.1 9207.6 9774.9 9776.7 10243.6 10369.9 7056.6 7165.1 7465.3 7634.8 7805.0 8257.4 8503.2 8564.0 8572.7 8579.0 7526.3 7611.2 7677.3 7724.2 7773.0 7461.1 7482.1 7491.7 7581.7 7659.9 7168.3 7262.2 7286.2 7293.5 7312.3 4959.8 4986.3 5099.1 5134.4 5168.2 5024.7 5057.2 5125.9 5145.2 5181.2 01:56:57 INFO - PROCESS | 1658 | 01:56:57 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:5648.36 Median:6508.65 stddev:1786.45 (27.4%) stddev-sans-first:1746.18 01:56:57 INFO - PROCESS | 1658 | Values: 323.5 328.6 336.3 338.8 340.8 4848.9 5171.8 6475.0 6504.1 6504.5 6163.8 6282.2 6388.4 6433.8 6496.4 4819.7 4867.6 4869.8 4872.4 4884.0 4852.5 4853.3 4853.4 4861.3 4877.6 4574.8 4647.0 4827.7 4839.3 4848.0 4802.0 4815.0 4818.3 4823.7 4824.1 4163.7 4171.2 4174.6 4176.3 4179.6 6192.4 6192.8 6194.4 6215.8 6219.3 5673.7 5680.5 5687.2 5687.9 5722.6 6514.3 6771.4 6838.1 6847.9 6878.1 4490.4 4490.4 4507.9 4509.9 4522.6 7159.2 7228.7 7231.8 7235.1 7246.7 4570.3 4570.3 4572.0 4578.2 4580.8 4644.8 4645.3 4649.7 4653.8 4660.9 5276.7 5452.8 5508.4 5513.6 5535.8 6096.8 6498.3 6901.0 6920.7 6926.0 1512.9 1579.2 1601.7 1606.9 1606.9 966.6 972.8 975.4 994.7 1017.8 6407.0 6568.5 6648.5 6713.3 6717.8 7051.9 7081.8 7091.2 7095.1 7099.4 6512.8 6515.8 6521.3 6701.1 6705.6 3601.2 3698.6 3746.6 3755.7 3756.7 7386.3 7387.4 7406.6 7410.9 7433.3 7304.4 7308.5 7311.0 7312.7 7314.3 6397.8 7017.4 7396.9 7408.0 7416.6 6691.2 7041.7 7050.5 7056.6 7078.6 6932.4 6997.5 7006.5 7015.8 7016.6 7387.3 7391.4 7400.6 7403.2 7406.0 4602.2 4611.2 4613.8 4623.0 4624.0 6822.4 7075.9 7080.0 7090.1 7105.9 6899.4 6928.8 6945.2 6951.4 6984.7 6959.4 6967.1 6967.8 6970.3 6993.9 6826.5 6829.0 6948.4 6990.7 6995.0 5336.4 6623.8 6837.8 6935.9 6937.5 6571.9 6700.0 6704.6 6898.3 6910.7 01:56:57 INFO - PROCESS | 1658 | 01:56:57 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:18727.23 Median:4171.85 stddev:26084.63 (625.3%) stddev-sans-first:26122.70 01:56:57 INFO - PROCESS | 1658 | Values: 705.6 716.6 750.3 759.6 796.1 15639.3 15840.1 15851.4 15856.6 15884.8 14397.6 14604.8 14615.1 14619.5 14647.9 784.5 803.6 951.9 978.3 979.4 962.7 970.4 972.7 974.4 978.8 843.7 1034.0 1036.5 1036.6 1038.5 1027.1 1049.5 1051.0 1051.3 1051.5 781.5 782.4 783.4 783.6 784.4 15905.0 16004.7 16005.4 16018.7 16038.1 13213.7 13639.9 13648.7 13671.2 13831.9 10438.3 10501.8 10553.8 10775.4 11044.3 3576.9 3598.7 3654.3 3712.4 3880.8 81717.6 83728.0 87916.0 87928.0 88651.6 9949.1 9965.9 10158.6 10463.3 10743.2 23957.6 23964.6 24027.8 24031.4 24054.5 7704.5 7865.4 7994.2 8001.2 8098.0 4114.4 4124.1 4159.6 4165.6 4178.1 3846.0 3892.0 3911.1 3914.3 3918.0 677.0 685.1 716.5 732.7 764.4 528.0 600.2 601.6 606.7 632.9 7682.1 8414.2 8456.6 8595.8 8848.8 609.8 613.3 615.6 626.7 647.7 3810.4 3865.6 3967.0 4099.2 4266.8 83218.0 83416.2 87012.7 87932.6 93050.5 79182.0 79754.0 80070.0 80603.8 81899.0 71181.0 71652.0 72546.0 73577.3 74060.6 6822.6 7833.9 7994.9 8066.1 8480.2 41171.0 50841.0 51162.7 51231.7 52639.5 69756.7 70752.6 71157.6 71171.3 72411.6 10546.2 10610.9 10791.9 10808.1 10848.8 10825.4 11082.6 11091.4 11243.7 11463.5 10519.8 10709.3 11150.4 11341.1 11451.7 11411.4 11432.4 11454.7 11701.2 11708.9 11243.7 11367.4 11388.0 11579.5 11618.4 9579.3 9767.6 9770.1 9828.8 10080.4 9714.6 10090.6 10104.1 10105.1 10122.3 01:56:57 INFO - PROCESS | 1658 | -------- Summary: end -------- 01:56:57 INFO - PROCESS | 1658 | 01:56:58 INFO - TEST-INFO | 1658: exit 0 01:56:58 INFO - TEST-OK | dromaeo_css | took 1113577ms 01:56:58 INFO - TEST-START | kraken 01:56:58 INFO - operating with platform_type : mac_ 01:56:58 INFO - Initialising browser for kraken test... 01:56:58 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpctmAnv/profile http://localhost:49278/getInfo.html) 01:57:00 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 01:57:00 INFO - PROCESS | 1669 | colorDepth:24 01:57:00 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 01:57:00 INFO - PROCESS | 1669 | __metrics 01:57:00 INFO - PROCESS | 1669 | 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" 01:57:00 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:57:01 INFO - TEST-INFO | 1669: exit 0 01:57:01 INFO - Browser initialized. 01:57:01 INFO - Running cycle 1/1 for kraken test... 01:57:01 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpctmAnv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:12 INFO - PROCESS | 1672 | RSS: Main: 161738752 01:57:12 INFO - PROCESS | 1672 | 01:57:15 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 01:57:16 INFO - PROCESS | 1672 | RSS: Main: 223895552 01:57:16 INFO - PROCESS | 1672 | 01:57:19 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 01:57:19 INFO - PROCESS | 1672 | RSS: Main: 239300608 01:57:19 INFO - PROCESS | 1672 | 01:57:22 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 01:57:23 INFO - PROCESS | 1672 | RSS: Main: 323649536 01:57:23 INFO - PROCESS | 1672 | 01:57:25 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 01:57:26 INFO - PROCESS | 1672 | RSS: Main: 230084608 01:57:26 INFO - PROCESS | 1672 | 01:57:28 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:57:28 INFO - PROCESS | 1672 | RSS: Main: 230412288 01:57:28 INFO - PROCESS | 1672 | 01:57:31 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 01:57:32 INFO - PROCESS | 1672 | RSS: Main: 268476416 01:57:32 INFO - PROCESS | 1672 | 01:57:34 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 01:57:35 INFO - PROCESS | 1672 | RSS: Main: 267808768 01:57:35 INFO - PROCESS | 1672 | 01:57:38 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 01:57:39 INFO - PROCESS | 1672 | RSS: Main: 269107200 01:57:39 INFO - PROCESS | 1672 | 01:57:40 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:57:41 INFO - PROCESS | 1672 | RSS: Main: 260702208 01:57:41 INFO - PROCESS | 1672 | 01:57:43 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:57:43 INFO - PROCESS | 1672 | RSS: Main: 267853824 01:57:43 INFO - PROCESS | 1672 | 01:57:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:57:46 INFO - PROCESS | 1672 | RSS: Main: 270954496 01:57:46 INFO - PROCESS | 1672 | 01:57:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:57:49 INFO - PROCESS | 1672 | RSS: Main: 277938176 01:57:49 INFO - PROCESS | 1672 | 01:57:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:57:53 INFO - PROCESS | 1672 | RSS: Main: 274931712 01:57:53 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 01:57:55 INFO - PROCESS | 1672 | RSS: Main: 335978496 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | __start_tp_report 01:57:55 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 01:57:55 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 01:57:55 INFO - PROCESS | 1672 | |i|pagename|runs| 01:57:55 INFO - PROCESS | 1672 | |0;ai-astar;114;113;118;113;112;112;113;112;113;134 01:57:55 INFO - PROCESS | 1672 | |1;audio-beat-detection;162;142;172;211;123;139;117;149;156;123 01:57:55 INFO - PROCESS | 1672 | |2;audio-dft;183;183;185;193;185;183;185;184;184;187 01:57:55 INFO - PROCESS | 1672 | |3;audio-fft;71;77;71;155;55;56;57;68;152;73 01:57:55 INFO - PROCESS | 1672 | |4;audio-oscillator;91;91;145;76;79;83;124;78;76;123 01:57:55 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;87;84;89;87;89;86;90;87;89;86 01:57:55 INFO - PROCESS | 1672 | |6;imaging-darkroom;94;95;94;94;93;93;94;94;94;94 01:57:55 INFO - PROCESS | 1672 | |7;imaging-desaturate;86;84;83;85;84;83;83;83;84;94 01:57:55 INFO - PROCESS | 1672 | |8;json-parse-financial;57;60;61;63;61;61;61;78;59;56 01:57:55 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;61;61;61;64;70;70;70;66;65;65 01:57:55 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;82;103;105;104;83;78;79;81;92;108 01:57:55 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;128;130;127;128;125;140;141;127;129;153 01:57:55 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;166;162;164;169;164;165;164;162;169;166 01:57:55 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;66;69;68;68;67;66;69;66;68;69 01:57:55 INFO - PROCESS | 1672 | __end_tp_report 01:57:55 INFO - PROCESS | 1672 | __start_cc_report 01:57:55 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1987 01:57:55 INFO - PROCESS | 1672 | __end_cc_report 01:57:55 INFO - PROCESS | 1672 | __startTimestamp1465289875325__endTimestamp 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | ------- Summary: start ------- 01:57:55 INFO - PROCESS | 1672 | Number of tests: 14 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:115.40 Median:113.00 stddev:6.77 (6.0%) stddev-sans-first:7.16 01:57:55 INFO - PROCESS | 1672 | Values: 114.0 113.0 118.0 113.0 112.0 112.0 113.0 112.0 113.0 134.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:152.50 stddev:28.12 (18.4%) stddev-sans-first:29.45 01:57:55 INFO - PROCESS | 1672 | Values: 162.0 142.0 172.0 211.0 123.0 139.0 117.0 149.0 156.0 123.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:185.20 Median:185.00 stddev:3.01 (1.6%) stddev-sans-first:3.09 01:57:55 INFO - PROCESS | 1672 | Values: 183.0 183.0 185.0 193.0 185.0 183.0 185.0 184.0 184.0 187.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:83.50 Median:69.50 stddev:37.68 (54.2%) stddev-sans-first:39.70 01:57:55 INFO - PROCESS | 1672 | Values: 71.0 77.0 71.0 155.0 55.0 56.0 57.0 68.0 152.0 73.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:78.50 stddev:24.82 (31.6%) stddev-sans-first:26.24 01:57:55 INFO - PROCESS | 1672 | Values: 91.0 91.0 145.0 76.0 79.0 83.0 124.0 78.0 76.0 123.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.84 (2.1%) stddev-sans-first:1.94 01:57:55 INFO - PROCESS | 1672 | Values: 87.0 84.0 89.0 87.0 89.0 86.0 90.0 87.0 89.0 86.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 01:57:55 INFO - PROCESS | 1672 | Values: 94.0 95.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 94.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:84.00 stddev:3.35 (4.0%) stddev-sans-first:3.53 01:57:55 INFO - PROCESS | 1672 | Values: 86.0 84.0 83.0 85.0 84.0 83.0 83.0 83.0 84.0 94.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:61.00 stddev:6.09 (10.0%) stddev-sans-first:6.22 01:57:55 INFO - PROCESS | 1672 | Values: 57.0 60.0 61.0 63.0 61.0 61.0 61.0 78.0 59.0 56.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:3.71 (5.7%) stddev-sans-first:3.60 01:57:55 INFO - PROCESS | 1672 | Values: 61.0 61.0 61.0 64.0 70.0 70.0 70.0 66.0 65.0 65.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:80.00 stddev:12.27 (15.3%) stddev-sans-first:12.52 01:57:55 INFO - PROCESS | 1672 | Values: 82.0 103.0 105.0 104.0 83.0 78.0 79.0 81.0 92.0 108.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:129.50 stddev:8.97 (6.9%) stddev-sans-first:9.34 01:57:55 INFO - PROCESS | 1672 | Values: 128.0 130.0 127.0 128.0 125.0 140.0 141.0 127.0 129.0 153.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.50 stddev:2.47 (1.5%) stddev-sans-first:2.60 01:57:55 INFO - PROCESS | 1672 | Values: 166.0 162.0 164.0 169.0 164.0 165.0 164.0 162.0 169.0 166.0 01:57:55 INFO - PROCESS | 1672 | 01:57:55 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.26 (1.9%) stddev-sans-first:1.20 01:57:55 INFO - PROCESS | 1672 | Values: 66.0 69.0 68.0 68.0 67.0 66.0 69.0 66.0 68.0 69.0 01:57:55 INFO - PROCESS | 1672 | -------- Summary: end -------- 01:57:55 INFO - PROCESS | 1672 | 01:57:56 INFO - TEST-INFO | 1672: exit 0 01:57:56 INFO - TEST-OK | kraken | took 57809ms 01:57:56 INFO - SUITE-END | took 1171s 01:57:56 INFO - Completed test suite (00:19:31) 01:57:56 INFO - javascript benchmark 01:57:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3466.9966667331973, 3480.91297717557, 3547.095490649884, 3551.9289614207714, 3562.893113206604, 5723.284589426322, 5910.88178236435, 5950.137230101633, 5956.3150237722675, 5964.88070238595, 5908.261467316585, 5945.702714864261, 5964.075568286922, 5965.164876917235, 5968.10478428236, 5240.816571420001, 5278.6568873023325, 5280.3663560372715, 5363.302770639812, 5424.972875135619, 5342.171963345688, 5381.461853814626, 5383.246345511631, 5383.43473935237, 5384.246205531229, 5319.0, 5362.329708786402, 5377.5966802489775, 5383.273258110164, 5405.135178371462, 5369.543588794957, 5389.51494365509, 5391.946080539223, 5411.621186516945, 5464.9180262296095, 5126.461721519261, 5223.895522089575, 5300.602454815866, 5337.039332920072, 5367.892642147135, 5669.971650141764, 5723.71381430931, 5771.451712087345, 5774.682392468412, 5787.710614469302, 6273.0904018917, 6282.905756413657, 6292.339304373067, 6307.463865571432, 6311.33730958252, 6142.069075791497, 6224.906626400608, 6325.683715814237, 6329.430351268362, 6342.429181373653, 5853.795117170921, 5871.324797648283, 5976.7908123215475, 6020.909686354708, 6032.638041717511, 6380.840478988062, 6382.489400847921, 6383.904241436382, 6400.327965563642, 6522.478201743849, 6120.111926550715, 6207.596506227081, 6304.401081897213, 6326.620402775849, 6392.680365981682, 6288.654124023223, 6307.526935479766, 6315.494760419156, 6319.684015799192, 6323.462505687068, 6222.968885155546, 6260.593061450991, 6278.497720182374, 6284.12022316876, 6291.653959032297, 6174.876502470015, 6201.255849298113, 6275.246970363585, 6304.243490781136, 6455.741770329134, 4328.199283132631, 4937.432195297587, 5008.874778130576, 5029.874253143701, 5042.84871453857, 3841.8079096045644, 4520.141173177151, 4531.13908357411, 4538.500764915857, 4554.681172317906, 5790.768369265266, 5896.970515147483, 5901.17383566301, 6004.0093384591055, 6022.69886505673, 6253.397772557408, 6288.622682639057, 6299.212598425197, 6301.905471417932, 6306.243250809932, 5882.676452795137, 5950.8809823803285, 5958.463738263577, 5969.194158788595, 5977.970110149508, 5411.5129638331955, 5460.290162278958, 5479.479449452296, 5497.835064948058, 5557.805476808292, 5370.355557333145, 6376.171097757448, 6405.615663060231, 6412.487001039999, 6467.773627923, 6208.379162083756, 6299.464545513682, 6314.368563143649, 6328.272248691275, 6334.461570766536, 6357.205349331333, 6395.680215989275, 6450.645214513059, 6466.030095485715, 6482.546221764431, 6282.0, 6292.590981586182, 6296.118543403835, 6307.684615769102, 6323.462505687068, 6233.719482623384, 6235.314115447388, 6316.115743795965, 6333.524985626004, 6344.873102537831, 6214.720337584729, 6323.715432805627, 6325.841853953688, 6340.112384266298, 6343.9682801585695, 5535.833924982257, 6282.717277722422, 6292.590981586182, 6321.30465648769, 6322.652254126067, 5978.192943952511, 5979.701014949323, 6031.4270144336215, 6103.542234332532, 6178.1350610913605, 6085.6348619083, 6123.6631985239455, 6203.0, 6298.0552917062805, 6310.463610593151, 6158.168647232566, 6158.692065396623, 6202.379762023762, 6210.813675589739, 6217.626942383471], "value": 5815.724145975635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.4931816138344, 557.9246801681772, 595.4343373794894, 601.7111786342556, 627.2723640576932, 32938.67061329386, 33324.0, 33438.83280583597, 33465.832670836615, 33474.66525334746, 35260.82369588155, 43299.78350108245, 44802.10395792082, 44876.87807804807, 44900.77549612256, 10030.047145521201, 10201.897981020205, 10214.233932455058, 10218.0, 10230.181585473145, 8383.62273697682, 9254.167124958753, 10049.346792458504, 10065.798684026315, 10085.546150423248, 12271.079669024813, 12516.62450126493, 12545.372731363395, 12552.74894502114, 12568.748625027494, 12092.4558394872, 12229.205101668364, 12241.571544995883, 12247.203931744409, 12261.632151035483, 11986.520539178422, 12092.637220883387, 12119.454624541917, 12123.575674851427, 12158.148929574932, 42492.57507424948, 43113.0, 43155.35266970998, 43176.0, 43197.0, 3394.5247665326874, 3474.2183008822813, 3574.7318951078514, 3740.4202348636004, 3999.560048394674, 29471.557926631118, 30026.24934376658, 30377.848110759525, 30437.23906902323, 30757.231069223224, 2768.8338699678084, 2782.0, 2811.7750579953554, 2815.5776633504934, 2823.8446885421295, 481979.0, 483315.0, 484421.0, 484692.0, 488639.0, 38527.229455410736, 70546.0, 70784.64607676929, 70964.2903570968, 71100.64449677718, 38269.42595861064, 38275.23449531049, 38331.0, 38416.8079159608, 38422.615773842466, 16796.664066718597, 16942.830571694125, 16961.49115526536, 16977.745333820003, 16991.660166796595, 14361.712765744627, 14385.352659130363, 14445.566633001026, 14452.205128717811, 14462.27688615565, 8222.218889205516, 8396.118407567239, 8411.45325553837, 8603.655853765778, 8638.524881131598, 3516.701080408143, 3557.4130268505405, 3566.928661426809, 3578.8389522471552, 3593.317269718745, 957.4638202606562, 999.1107913956585, 1014.8274793285159, 1074.0, 1107.7286064914147, 26444.73555264461, 30144.54783178254, 32230.871919483176, 32379.838100809346, 32395.19012024718, 1150.8503894493829, 1160.4913612303972, 1162.8255761635821, 1207.2092779229442, 1228.619128070301, 16240.918795406184, 16312.429064982669, 16385.50843474698, 16538.0154381475, 16616.169191540615, 545673.2716336392, 546908.0, 550142.0, 550511.0, 553013.0, 55240.17139742907, 58437.4156258432, 58497.70751146217, 64876.35123648797, 66807.66596166987, 1318.2420108437686, 1405.1639274631577, 1532.1266877879725, 1550.0389758349895, 1561.9219039048003, 25475.726213689613, 30775.538366924065, 31909.36181276315, 32493.675063249066, 32575.674243257265, 58210.0, 58490.12264816116, 59581.51046223879, 59632.105518418124, 59716.10425843529, 560731.0, 576800.0, 577105.0, 577911.0, 579479.0, 37947.81026094852, 48127.808287568645, 48129.75935120442, 48533.27200092072, 49060.509394905595, 49641.751791240815, 49654.503454966434, 50916.981660367324, 51506.742466287425, 51576.74211628918, 39819.2036159281, 40090.0, 41154.38268425916, 41304.58695413007, 41942.0, 40289.59710402976, 40609.59390406176, 40630.39054414127, 40762.59237407588, 41445.585544144174, 39981.00047498836, 40711.389329159494, 41191.0, 42213.78893105515, 42268.73193804191, 31632.0, 33312.50031249485, 33909.830450847585, 33940.66059339375, 34107.65892341144, 22589.757563334173, 25762.0, 26229.606555902057, 26449.735502644726, 26555.518906114095], "value": 20049.179182543878, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.88810577091306, 407.0, 413.24376391204095, 414.38050115077965, 419.3856000958595, 15337.539873803777, 20238.494037649067, 20954.371368858938, 20979.951002449892, 21527.784722152774, 21114.788852111473, 21481.46296342592, 22392.440188995282, 22446.88776556115, 22468.8876555617, 5485.890282194354, 6209.596376235553, 6212.937870621304, 6220.875582488347, 6226.688665566726, 6022.909656355158, 6188.381161883821, 6192.566520343577, 6192.969035154841, 6203.658798766066, 4347.956520434786, 6503.447206987412, 6794.864102717943, 6802.965985170067, 6806.625635590065, 6491.545591808575, 6758.594484330932, 6772.593644381328, 6776.695048722795, 6776.69504872282, 5930.258717660293, 5953.077273022688, 5954.642721436728, 5954.957882370568, 5959.880802383928, 26330.73669263302, 26460.0738974135, 27140.642967851527, 27271.86364068167, 27407.45185096287, 2114.7990940860595, 2335.49786795838, 2394.437307232799, 2401.4836810085917, 2495.9251222463354, 9948.502574871227, 10132.848007279898, 10456.790864182674, 12906.741865162645, 15290.388384464608, 1520.711064897666, 1813.184067169779, 1818.254515648591, 1864.5991111910869, 1909.9045047747557, 116482.0, 124804.37597811953, 125551.0, 125892.37053814763, 126526.0, 11634.6509604712, 11872.228305160137, 11945.402729863472, 11988.460519276654, 12162.817557736642, 12113.212641178296, 14797.556073317817, 15067.849321506865, 15324.770128448083, 15416.306266218047, 7352.558846469229, 7417.888731669029, 9271.072892710676, 9344.112309330603, 9386.389884657476, 9312.674056407994, 9340.626374945063, 9347.766305842408, 9352.672656457127, 9463.952680236554, 4783.282507623884, 4805.063012712488, 4817.7350245736825, 4822.373091498082, 4870.537298956593, 2032.0, 2084.3017589107517, 2112.556363163753, 2113.9471513212293, 2131.0516820014946, 913.4473643445752, 1009.7021378693156, 1020.1940467030962, 1041.5313109100935, 1045.7803861189084, 20693.0, 21278.893605532183, 21670.674939875913, 22220.666689999664, 22366.440838979157, 962.7929995051097, 1016.8322226832638, 1035.5495359518484, 1056.144522936424, 1074.6561100447782, 11244.987951084442, 11609.013233875216, 11644.592439264585, 11655.30068195894, 11695.1228657851, 548848.0, 548898.0, 555002.0, 566164.0, 643085.0, 135679.0, 146324.5367546332, 146960.0, 148325.0, 149890.0, 1046.0585473074293, 1068.2628985999636, 1085.1102096280974, 1087.342157994418, 1088.5591335509132, 17812.643747125243, 18746.343877964206, 18916.527086822938, 18983.050847457296, 19080.809191908458, 50640.0, 54787.45212547983, 54974.17538736842, 55383.0, 55553.72223138859, 75544.24455755373, 77563.0, 77918.2208177911, 78623.60688196523, 82988.58505707434, 8199.01611806587, 8238.5056896584, 8334.20825021622, 8478.915210847812, 8546.2308392245, 8755.956220218859, 8776.561171941505, 9027.232685221566, 9057.0, 9548.854137503544, 4989.625778066587, 6182.306429956664, 8157.0, 8349.58252087381, 8519.190676885686, 7173.461990350849, 8130.02439707239, 8235.660508870988, 8287.544185069879, 8290.585470726319, 7533.359664428585, 7810.711232646549, 8511.74464766058, 8626.18051285127, 8903.19871211594, 12503.56237531682, 12760.489580416679, 12866.485340586647, 13037.152585082318, 13116.688331166806, 11987.580434684744, 12172.2696638202, 12230.571929982409, 12332.383380831103, 12373.381330933596], "value": 9755.18861634787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.2060887120956, 1600.8639265662418, 1617.110589175953, 1645.8765592580553, 2014.717939488472, 8198.139195384481, 8411.116832732567, 8412.158784121584, 8420.999999999993, 8610.440321379107, 8857.379983401164, 8874.911250887506, 8979.102089791018, 8986.595603197855, 8993.955030224839, 2496.9126080587184, 2515.949681006379, 2516.5721827289312, 2516.848989060653, 2521.621756736486, 2447.21689059501, 2538.4034751833306, 2539.6444497770326, 2541.0217066429373, 2542.0594380079397, 2507.523570521604, 2526.810489213307, 2550.7831834294016, 2554.7189809120982, 2556.7315431879665, 2234.597772400959, 2503.211488381154, 2532.8733563321853, 2536.226450932465, 2541.097910241856, 2471.1845091120067, 2514.0320976424027, 2515.5094756522485, 2526.835755675875, 2531.5190113878302, 9031.864522032174, 9082.818343633156, 9090.545472726337, 9091.181793638605, 9130.95434522823, 5433.402325744165, 5574.944250557483, 5693.572982026323, 5735.512481439083, 5740.995325817965, 3555.6088830228655, 3567.678908898212, 3624.0, 3630.1287690954246, 3641.890743277706, 1034.4724190662816, 1038.2887721910515, 1060.1042119409087, 1077.3697387028599, 1085.1752667972319, 11972.820407693891, 12109.455074521667, 12116.151869369147, 12159.027277817753, 12205.023598112219, 4696.5303469653445, 4754.904901901942, 4794.232922732416, 4833.32333473314, 4833.830815921426, 9560.56977436017, 9588.424694518351, 9685.854712179324, 9697.6120955161, 9697.806043879084, 5577.079781836032, 5597.552195824324, 5600.803971860965, 5603.411641777636, 5609.298837645294, 4641.559051890065, 4792.353032340659, 5028.74856257193, 5122.282880396748, 5215.791368345223, 3251.772375933662, 4003.7597744134864, 4072.0430698785763, 4085.652719518874, 4115.341545352789, 1246.4889395347864, 1254.3978890132787, 1257.6227131860405, 1257.7107265329025, 1261.5836773864787, 938.2212763406493, 950.5294879034922, 958.3579002068631, 971.2472833554052, 982.7199248214367, 5042.268871013683, 6065.423784740443, 6124.35694252106, 6168.599041062316, 6181.81454556364, 460.5302591356797, 462.23500107322434, 465.76478878166307, 477.3317355702045, 478.2778005212085, 3607.3687104756564, 3745.176061266517, 3953.881383558498, 3990.920181596352, 4012.658923991435, 9250.95374523123, 10884.564617415374, 11228.831567526493, 11235.83146252807, 11294.265872718412, 10822.134229261641, 10858.402787846744, 10930.398828064534, 10950.0, 11014.834777478345, 8015.318697910743, 8362.414630975894, 8425.662973481114, 8429.704960326482, 8462.957685211535, 6041.848953776015, 6078.513718902389, 6172.382761723792, 6207.037909124093, 6216.160818289473, 9815.263855210746, 9904.900950990397, 10041.0, 10113.5448904798, 10121.089101980562, 9207.585658645243, 9774.902250977399, 9776.706698799047, 10243.590256389662, 10369.896301037195, 7056.576605403692, 7165.068541089625, 7465.253474652492, 7634.8091297718, 7805.0, 8257.38069644767, 8503.23470887623, 8563.95718021406, 8572.742817715478, 8578.957105214435, 7526.285002924714, 7611.162772094955, 7677.270659287359, 7724.2275772424555, 7773.0, 7461.104667439942, 7482.1021477423055, 7491.662875170739, 7581.658825352762, 7659.923400766144, 7168.2831716827895, 7262.237465066303, 7286.234945330664, 7293.452991025588, 7312.341889229995, 4959.801607935787, 4986.276989836526, 5099.133147365031, 5134.4352121267375, 5168.198929165986, 5024.673396229234, 5057.190849464068, 5125.8718532037, 5145.176771716508, 5181.171012637959], "value": 4610.3616486099045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.496962223742, 328.64670479234826, 336.2669380749964, 338.788257339163, 340.82617864888914, 4848.8787780305465, 5171.818986335479, 6474.996375561789, 6504.089427480157, 6504.47964162867, 6163.784267550636, 6282.183316168903, 6388.3709654038275, 6433.774817881375, 6496.447801936841, 4819.734914579714, 4867.561919427251, 4869.829555965542, 4872.366592342991, 4883.999999999982, 4852.4662287148385, 4853.296272040569, 4853.441854186778, 4861.270809378604, 4877.634177436688, 4574.771261436915, 4647.000894807616, 4827.662063655545, 4839.346688197101, 4848.0, 4802.039592081563, 4815.0, 4818.325434439182, 4823.662343635947, 4824.059308434857, 4163.7293575917465, 4171.165766846643, 4174.603412675791, 4176.269152898261, 4179.6029377209115, 6192.442680158762, 6192.752289908398, 6194.380561943814, 6215.782447614357, 6219.289695333774, 5673.744681489343, 5680.460356266148, 5687.175359572839, 5687.886242275173, 5722.628029178131, 6514.315996820361, 6771.356721111487, 6838.111045564095, 6847.931520684829, 6878.140232470942, 4490.3937968374175, 4490.39379683745, 4507.887302817456, 4509.864704058883, 4522.615577675869, 7159.212486626467, 7228.674709638079, 7231.783046508614, 7235.082703083687, 7246.710131594783, 4570.268756998864, 4570.314452832102, 4571.994161284512, 4578.244589642672, 4580.770961451981, 4644.8374306899095, 4645.3032045193495, 4649.651276154234, 4653.767311634405, 4660.906781864343, 5276.65701729394, 5452.836414907559, 5508.394076651565, 5513.61404701675, 5535.750891209906, 6096.817095487142, 6498.252700939453, 6901.033855260268, 6920.688569014305, 6925.965370173117, 1512.9092254464767, 1579.241963857355, 1601.7036848183122, 1606.9196540172945, 1606.9276882540314, 966.5988614724951, 972.8346181149221, 975.3662615119646, 994.7115336552318, 1017.7964407118606, 6406.967965160145, 6568.540202185801, 6648.4681225501845, 6713.295104014008, 6717.832054198684, 7051.92948070523, 7081.752138675225, 7091.219965803757, 7095.113110861143, 7099.396551293198, 6512.827691015663, 6515.804525864231, 6521.315261897527, 6701.1288532491435, 6705.564138330993, 3601.1897323102617, 3698.574663913684, 3746.569144548357, 3755.661990420875, 3756.6806821420487, 7386.298301661333, 7387.445941554405, 7406.629668516553, 7410.851782964311, 7433.331000210007, 7304.415646748247, 7308.524945878501, 7310.963445182846, 7312.707491700379, 7314.305141011595, 6397.840053998594, 7017.3684368407085, 7396.852062958711, 7407.962885196077, 7416.592087435135, 6691.197056353269, 7041.6831242595235, 7050.541714788523, 7056.6118863463, 7078.575285482888, 6932.44540436774, 6997.545159564612, 7006.5095443320515, 7015.754448594274, 7016.5790052597, 7387.261273872785, 7391.371733402721, 7400.555966642019, 7403.18564957865, 7406.0, 4602.21762300403, 4611.239145540948, 4613.838515651936, 4622.953770462253, 4623.976880115578, 6822.351876571718, 7075.893861592183, 7080.0, 7090.07828982229, 7105.893411598933, 6899.379055884994, 6928.826779330557, 6945.166580010229, 6951.443884489127, 6984.650767461708, 6959.373656370951, 6967.059446974797, 6967.79096627102, 6970.268121847133, 6993.895091573529, 6826.488013398915, 6829.0, 6948.444124470131, 6990.6504674767075, 6995.020697102308, 5336.439673834191, 6623.801285961429, 6837.829054273683, 6935.895961560682, 6937.549059311129, 6571.934280657323, 6699.9950007499265, 6704.564203326768, 6898.275681053417, 6910.689018994057], "value": 5046.691437244223, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.6154395854259, 716.6166101135892, 750.2722359311473, 759.6088014672445, 796.0725754496009, 15639.296231669574, 15840.128792916385, 15851.3659453622, 15856.603584910383, 15884.761728574067, 14397.568072957802, 14604.831613470924, 14615.123092614424, 14619.488317908876, 14647.853521464782, 784.4626430894841, 803.5901690138013, 951.8952915179325, 978.2614126334607, 979.4123525884484, 962.7208109648194, 970.4129001953822, 972.7276362618443, 974.3763991045737, 978.7993461340444, 843.6709683223547, 1033.9638112666057, 1036.5387402605843, 1036.6475398364555, 1038.4963292803022, 1027.0756319312604, 1049.464772965789, 1050.968470945873, 1051.337657275919, 1051.542578978147, 781.5310813511904, 782.3545574900672, 783.3615603283363, 783.5690370296314, 784.4156103702721, 15905.045697258201, 16004.679906401923, 16005.359785608562, 16018.679626407407, 16038.117903515302, 13213.669658258621, 13639.863601363959, 13648.658783530393, 13671.17972921628, 13831.930840345834, 10438.269321147523, 10501.789964200749, 10553.84169237462, 10775.35347879122, 11044.33733975964, 3576.946345804815, 3598.712103031777, 3654.305681920453, 3712.406015037581, 3880.7865567393783, 81717.59141204316, 83728.0, 87916.0, 87928.0, 88651.55674221652, 9949.104580587782, 9965.900340996643, 10158.644447444452, 10463.319884207654, 10743.194260430499, 23957.640635390482, 23964.64053039171, 24027.7597224029, 24031.399215019414, 24054.51890962206, 7704.537727736241, 7865.410094242955, 7994.160613135653, 8001.199880011952, 8097.959510202411, 4114.382842573638, 4124.13393187434, 4159.625633692922, 4165.625093741517, 4178.080822219168, 3845.9615403845605, 3892.0, 3911.119998000427, 3914.3149948758855, 3917.9608203918165, 676.950726374128, 685.1196212866442, 716.5306724095726, 732.7435397610793, 764.388489208642, 527.9947200527946, 600.2466904035408, 601.5638661970037, 606.7057477123592, 632.9303776584572, 7682.078150621961, 8414.15858414166, 8456.619452124545, 8595.78510537229, 8848.778780530538, 609.7500024989733, 613.25489530221, 615.5783288447338, 626.6584711332334, 647.6567419267795, 3810.40938654509, 3865.5747867734526, 3967.0479085019388, 4099.241640296555, 4266.765327906995, 83218.0, 83416.16583834084, 87012.69480957791, 87932.56033719791, 93050.53474732718, 79182.0, 79754.0, 80070.0, 80603.7909431359, 81899.0, 71181.0, 71651.99999999895, 72546.0, 73577.26422735812, 74060.62969685117, 6822.624755638289, 7833.92166078332, 7994.880076798736, 8066.112727600077, 8480.194381533744, 41171.0, 50841.0, 51162.69767860381, 51231.74384128056, 52639.47360526499, 69756.65121674359, 70752.64623676849, 71157.6442117786, 71171.28828711646, 72411.63794180995, 10546.209034322303, 10610.8938910613, 10791.892081079088, 10808.135349172204, 10848.783024339627, 10825.404602746925, 11082.556697732, 11091.439543176191, 11243.66269011931, 11463.484143213742, 10519.78960420772, 10709.250352475252, 11150.442477876237, 11341.092712583139, 11451.713707157387, 11411.37237451915, 11432.428378581204, 11454.656360309204, 11701.239419437708, 11708.941455292668, 11243.66269011931, 11367.374794386058, 11388.032017278623, 11579.536818527502, 11618.419079045845, 9579.281553883626, 9767.560459779184, 9770.120689138012, 9828.803423931624, 10080.445575493419, 9714.611415543299, 10090.596376144871, 10104.141148002502, 10105.090541850974, 10122.291439599157], "value": 7163.827979150757, "unit": "score"}], "name": "dromaeo_css", "value": 7579.551060577501, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 118.0, 113.0, 112.0, 112.0, 113.0, 112.0, 113.0, 134.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 142.0, 172.0, 211.0, 123.0, 139.0, 117.0, 149.0, 156.0, 123.0], "value": 149.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 185.0, 193.0, 185.0, 183.0, 185.0, 184.0, 184.0, 187.0], "value": 185.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 77.0, 71.0, 155.0, 55.0, 56.0, 57.0, 68.0, 152.0, 73.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 145.0, 76.0, 79.0, 83.0, 124.0, 78.0, 76.0, 123.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 89.0, 87.0, 89.0, 86.0, 90.0, 87.0, 89.0, 86.0], "value": 87.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 83.0, 85.0, 84.0, 83.0, 83.0, 83.0, 84.0, 94.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 61.0, 63.0, 61.0, 61.0, 61.0, 78.0, 59.0, 56.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 64.0, 70.0, 70.0, 70.0, 66.0, 65.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 103.0, 105.0, 104.0, 83.0, 78.0, 79.0, 81.0, 92.0, 108.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 130.0, 127.0, 128.0, 125.0, 140.0, 141.0, 127.0, 129.0, 153.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 164.0, 169.0, 164.0, 165.0, 164.0, 162.0, 169.0, 166.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 68.0, 68.0, 67.0, 66.0, 69.0, 66.0, 68.0, 69.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1480.2999999999997, "alertThreshold": 2.0}]} 01:57:56 INFO - Return code: 0 01:57:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:57:56 ERROR - # TBPL SUCCESS # 01:57:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:57:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:57:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:57:56 INFO - 2016-06-07 01:57:56.641 screenresolution[1676:9822] starting screenresolution argv=screenresolution get 01:57:56 INFO - 2016-06-07 01:57:56.643 screenresolution[1676:9822] Display 0: 1600x1200x32@60 01:57:56 INFO - 2016-06-07 01:57:56.649 screenresolution[1677:9825] starting screenresolution argv=screenresolution list 01:57:56 INFO - Available Modes on Display 0 01:57:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:57:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:57:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:57:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:57:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:57:56 INFO - Intel Iris: 01:57:56 INFO - Chipset Model: Intel Iris 01:57:56 INFO - Type: GPU 01:57:56 INFO - Bus: Built-In 01:57:56 INFO - VRAM (Dynamic, Max): 1536 MB 01:57:56 INFO - Vendor: Intel (0x8086) 01:57:56 INFO - Device ID: 0x0a2e 01:57:56 INFO - Revision ID: 0x0009 01:57:56 INFO - Displays: 01:57:56 INFO - Display: 01:57:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:57:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:57:56 INFO - Display Serial Number: 1600x1200 60 01:57:56 INFO - Main Display: Yes 01:57:56 INFO - Mirror: Off 01:57:56 INFO - Online: Yes 01:57:56 INFO - Rotation: Supported 01:57:56 INFO - Return code: 0 01:57:56 INFO - Running post-action listener: _resource_record_post_action 01:57:56 INFO - Running post-run listener: _resource_record_post_run 01:57:57 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 38290944; Write bytes: 493946880; Read time: 404; Write time: 1474 01:57:57 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 193802752; Write bytes: 187860480; Read time: 17593; Write time: 369 01:57:57 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 36075008; Write bytes: 296350208; Read time: 376; Write time: 1078 01:57:57 INFO - Running post-run listener: _upload_blobber_files 01:57:57 INFO - Blob upload gear active. 01:57:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:57:57 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 01:57:57 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:57:57 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:57:58 INFO - (blobuploader) - INFO - Open directory for files ... 01:57:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:57:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:57:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:57:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:57:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:57:59 INFO - (blobuploader) - INFO - Done attempting. 01:57:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:57:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:57:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:58:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:00 INFO - (blobuploader) - INFO - Done attempting. 01:58:00 INFO - (blobuploader) - INFO - Iteration through files over. 01:58:00 INFO - Return code: 0 01:58:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:58:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:58:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6600bbe83866452ba43f6bc5fff0f277574fa68fc83dd1aeb4b87b1b5fedced6af7efd1cf910916d838ec84fbdbfc6995d0b26e7afa6326febb9b0884fba8ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6d0db49f0ce4fa9b7ae9bf528f8779fe3636b60713e61b9d3982d5354a2e4a491ef82103ce20b7149a188f99f72ebbb4aaf9e44c9285c2a0d3a2000d5b20a85"} 01:58:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:58:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:58:00 INFO - Contents: 01:58:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6600bbe83866452ba43f6bc5fff0f277574fa68fc83dd1aeb4b87b1b5fedced6af7efd1cf910916d838ec84fbdbfc6995d0b26e7afa6326febb9b0884fba8ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6d0db49f0ce4fa9b7ae9bf528f8779fe3636b60713e61b9d3982d5354a2e4a491ef82103ce20b7149a188f99f72ebbb4aaf9e44c9285c2a0d3a2000d5b20a85"} 01:58:00 INFO - Running post-run listener: copy_logs_to_upload_dir 01:58:00 INFO - Copying logs to upload dir... 01:58:00 INFO - mkdir: /builds/slave/test/build/upload/logs 01:58:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.427006 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-06-07 01:58:00.430311) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:00.434479) ========= 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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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/Mozilla-Beta/sha512/c6600bbe83866452ba43f6bc5fff0f277574fa68fc83dd1aeb4b87b1b5fedced6af7efd1cf910916d838ec84fbdbfc6995d0b26e7afa6326febb9b0884fba8ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6d0db49f0ce4fa9b7ae9bf528f8779fe3636b60713e61b9d3982d5354a2e4a491ef82103ce20b7149a188f99f72ebbb4aaf9e44c9285c2a0d3a2000d5b20a85"} build_url:https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010795 build_url: 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6600bbe83866452ba43f6bc5fff0f277574fa68fc83dd1aeb4b87b1b5fedced6af7efd1cf910916d838ec84fbdbfc6995d0b26e7afa6326febb9b0884fba8ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c6d0db49f0ce4fa9b7ae9bf528f8779fe3636b60713e61b9d3982d5354a2e4a491ef82103ce20b7149a188f99f72ebbb4aaf9e44c9285c2a0d3a2000d5b20a85"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:00.466021) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:00.466346) ========= 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.QK0OVGe3Dv/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.DpsexiaJpm/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.005005 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:00.514674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 01:58:00.515023) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 01:58:00.515409) ========= ========= Total master_lag: 0.17 =========