builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0080 starttime: 1464320713.48 results: success (0) buildid: 20160526184553 builduid: 7df0ca47746848eca179f3704fef34cd revision: 4d63dde701b47b8661ab7990f197b6b60e543839 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 20:45:13.478427) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 20:45:13.479015) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 20:45:13.479324) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 20:45:13.500655) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:45:13.501054) ========= 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.kz9NW65ojj/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.lVg7b6oTz9/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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-05-26 20:45:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 32.6M=0s 2016-05-26 20:45:14 (32.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.640873 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:45:14.177588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:45:14.177877) ========= 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.kz9NW65ojj/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.lVg7b6oTz9/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.020166 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 20:45:14.244413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 20:45:14.244738) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4d63dde701b47b8661ab7990f197b6b60e543839 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 4d63dde701b47b8661ab7990f197b6b60e543839 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kz9NW65ojj/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.lVg7b6oTz9/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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-05-26 20:45:14,322 truncating revision to first 12 chars 2016-05-26 20:45:14,323 Setting DEBUG logging. 2016-05-26 20:45:14,323 attempt 1/10 2016-05-26 20:45:14,323 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4d63dde701b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 20:45:15,550 unpacking tar archive at: mozilla-central-4d63dde701b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.490287 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 20:45:15.763715) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 20:45:15.764056) ========= script_repo_revision: 4d63dde701b47b8661ab7990f197b6b60e543839 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 20:45:15.764446) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 20:45:15.765114) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 20:45:15.784714) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-05-26 20:45:15.784990) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kz9NW65ojj/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.lVg7b6oTz9/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 20:45:15 INFO - MultiFileLogger online at 20160526 20:45:15 in /builds/slave/test 20:45:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:45:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:45:15 INFO - {'append_to_log': False, 20:45:15 INFO - 'base_work_dir': '/builds/slave/test', 20:45:15 INFO - 'blob_upload_branch': 'Firefox', 20:45:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:45:15 INFO - 'branch': 'Firefox', 20:45:15 INFO - 'buildbot_json_path': 'buildprops.json', 20:45:15 INFO - 'config_files': ('talos/mac_config.py',), 20:45:15 INFO - 'default_actions': ('clobber', 20:45:15 INFO - 'read-buildbot-config', 20:45:15 INFO - 'download-and-extract', 20:45:15 INFO - 'populate-webroot', 20:45:15 INFO - 'create-virtualenv', 20:45:15 INFO - 'install', 20:45:15 INFO - 'run-tests'), 20:45:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:45:15 INFO - 'download_minidump_stackwalk': True, 20:45:15 INFO - 'download_symbols': 'ondemand', 20:45:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:45:15 INFO - 'tooltool.py': '/tools/tooltool.py', 20:45:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:45:15 INFO - '/tools/misc-python/virtualenv.py')}, 20:45:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:45:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:45:15 INFO - 'installer_path': 'installer.exe', 20:45:15 INFO - 'log_level': 'info', 20:45:15 INFO - 'log_name': 'talos', 20:45:15 INFO - 'log_to_console': True, 20:45:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:45:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:45:15 INFO - 'opt_config_files': (), 20:45:15 INFO - 'pip_index': False, 20:45:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:45:15 INFO - 'cmd': ('bash', 20:45:15 INFO - '-c', 20:45:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:45:15 INFO - 'enabled': True, 20:45:15 INFO - 'halt_on_failure': False, 20:45:15 INFO - 'name': 'check_screen_resolution'},), 20:45:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:45:15 INFO - 'cmd': ('bash', 20:45:15 INFO - '-c', 20:45:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:45:15 INFO - 'enabled': True, 20:45:15 INFO - 'halt_on_failure': False, 20:45:15 INFO - 'name': 'check_screen_resolution'},), 20:45:15 INFO - 'run_cmd_checks_enabled': True, 20:45:15 INFO - 'sps_profile': False, 20:45:15 INFO - 'sps_profile_interval': 0, 20:45:15 INFO - 'suite': 'dromaeojs-e10s', 20:45:15 INFO - 'system_bits': '32', 20:45:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:45:15 INFO - 'title': 't-yosemite-r7-0080', 20:45:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:45:15 INFO - 'use_talos_json': True, 20:45:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:45:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:45:15 INFO - 'work_dir': 'build'} 20:45:15 INFO - ##### 20:45:15 INFO - ##### Running clobber step. 20:45:15 INFO - ##### 20:45:15 INFO - Running pre-action listener: _resource_record_pre_action 20:45:15 INFO - Running main action method: clobber 20:45:15 INFO - rmtree: /builds/slave/test/build 20:45:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:45:16 INFO - Running post-action listener: _resource_record_post_action 20:45:16 INFO - ##### 20:45:16 INFO - ##### Finished clobber step (success) 20:45:16 INFO - ##### 20:45:16 INFO - ##### 20:45:16 INFO - ##### Running read-buildbot-config step. 20:45:16 INFO - ##### 20:45:16 INFO - Running pre-action listener: _resource_record_pre_action 20:45:16 INFO - Running main action method: read_buildbot_config 20:45:16 INFO - Using buildbot properties: 20:45:16 INFO - { 20:45:16 INFO - "project": "", 20:45:16 INFO - "product": "firefox", 20:45:16 INFO - "script_repo_revision": "production", 20:45:16 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 20:45:16 INFO - "repository": "", 20:45:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 20:45:16 INFO - "buildid": "20160526184553", 20:45:16 INFO - "pgo_build": "False", 20:45:16 INFO - "basedir": "/builds/slave/test", 20:45:16 INFO - "buildnumber": 10, 20:45:16 INFO - "slavename": "t-yosemite-r7-0080", 20:45:16 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 20:45:16 INFO - "platform": "yosemite_r7", 20:45:16 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:45:16 INFO - "branch": "mozilla-central", 20:45:16 INFO - "repo_path": "mozilla-central", 20:45:16 INFO - "revision": "4d63dde701b47b8661ab7990f197b6b60e543839", 20:45:16 INFO - "stage_platform": "macosx64", 20:45:16 INFO - "builduid": "7df0ca47746848eca179f3704fef34cd", 20:45:16 INFO - "slavebuilddir": "test" 20:45:16 INFO - } 20:45:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 20:45:16 INFO - Running post-action listener: _resource_record_post_action 20:45:16 INFO - ##### 20:45:16 INFO - ##### Finished read-buildbot-config step (success) 20:45:16 INFO - ##### 20:45:16 INFO - ##### 20:45:16 INFO - ##### Running download-and-extract step. 20:45:16 INFO - ##### 20:45:16 INFO - Running pre-action listener: _resource_record_pre_action 20:45:16 INFO - Running main action method: download_and_extract 20:45:16 INFO - mkdir: /builds/slave/test/build/tests 20:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:45:16 INFO - https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 20:45:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 20:45:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 20:45:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 20:45:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 20:45:17 INFO - Downloaded 1199 bytes. 20:45:17 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 20:45:17 INFO - Using the following test package requirements: 20:45:17 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 20:45:17 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 20:45:17 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 20:45:17 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'jsshell-mac.zip'], 20:45:17 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 20:45:17 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 20:45:17 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 20:45:17 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 20:45:17 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 20:45:17 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:45:17 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 20:45:17 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:45: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')]} 20:45:17 INFO - https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:45:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:45:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:45:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:45:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:45:18 INFO - Downloaded 18684805 bytes. 20:45:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:45:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:45:21 INFO - Return code: 0 20:45:21 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:45: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')]} 20:45:21 INFO - https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:45:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:45:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:45:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:45:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:45:24 INFO - Downloaded 18684805 bytes. 20:45:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:45:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:45:27 INFO - Return code: 0 20:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:45:27 INFO - https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:45:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 20:45:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 20:45:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 20:45:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:45:29 INFO - Downloaded 10834034 bytes. 20:45:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:45:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 20:45:30 INFO - Return code: 0 20:45: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')]} 20:45:30 INFO - https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:45:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:45:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:45:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 20:45:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 20:45:34 INFO - Downloaded 110490723 bytes. 20:45:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:45:34 INFO - mkdir: /builds/slave/test/properties 20:45:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:45:34 INFO - Writing to file /builds/slave/test/properties/build_url 20:45:34 INFO - Contents: 20:45:34 INFO - build_url:https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:45:35 INFO - Running post-action listener: _resource_record_post_action 20:45:35 INFO - Running post-action listener: set_extra_try_arguments 20:45:35 INFO - ##### 20:45:35 INFO - ##### Finished download-and-extract step (success) 20:45:35 INFO - ##### 20:45:35 INFO - ##### 20:45:35 INFO - ##### Running populate-webroot step. 20:45:35 INFO - ##### 20:45:35 INFO - Running pre-action listener: _resource_record_pre_action 20:45:35 INFO - Running main action method: populate_webroot 20:45:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:45:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:45:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:45:35 INFO - '--tppagecycles', 20:45:35 INFO - '7'], 20:45:35 INFO - 'tests': ['tsvgm']}}, 20:45:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:45:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:45:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:45:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:45:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:45:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:45:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:35 INFO - 'talos_options': ['--disable-e10s'], 20:45:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:45:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:45:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:35 INFO - 'talos_options': ['--disable-e10s'], 20:45:35 INFO - 'tests': ['damp', 'tps']}, 20:45:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:35 INFO - 'tests': ['damp', 'tps']}, 20:45:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:45:35 INFO - 'tests': ['dromaeo_dom']}, 20:45:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:45:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:45:35 INFO - 'tests': ['a11yr', 20:45:35 INFO - 'ts_paint', 20:45:35 INFO - 'tpaint', 20:45:35 INFO - 'sessionrestore', 20:45:35 INFO - 'sessionrestore_no_auto_restore', 20:45:35 INFO - 'tabpaint']}, 20:45:35 INFO - 'other-e10s': {'tests': ['a11yr', 20:45:35 INFO - 'ts_paint', 20:45:35 INFO - 'tpaint', 20:45:35 INFO - 'sessionrestore', 20:45:35 INFO - 'sessionrestore_no_auto_restore', 20:45:35 INFO - 'tabpaint']}, 20:45:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:45:35 INFO - 'ts_paint', 20:45:35 INFO - 'tpaint', 20:45:35 INFO - 'sessionrestore', 20:45:35 INFO - 'sessionrestore_no_auto_restore', 20:45:35 INFO - 'tabpaint']}, 20:45:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:45:35 INFO - 'ts_paint', 20:45:35 INFO - 'tpaint', 20:45:35 INFO - 'sessionrestore', 20:45:35 INFO - 'sessionrestore_no_auto_restore', 20:45:35 INFO - 'tabpaint']}, 20:45:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:45:35 INFO - 'tests': ['a11yr', 20:45:35 INFO - 'ts_paint', 20:45:35 INFO - 'tpaint', 20:45:35 INFO - 'sessionrestore', 20:45:35 INFO - 'sessionrestore_no_auto_restore', 20:45:35 INFO - 'tabpaint']}, 20:45:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:45:35 INFO - 'tests': ['a11yr', 20:45:35 INFO - 'ts_paint', 20:45:35 INFO - 'tpaint', 20:45:35 INFO - 'sessionrestore', 20:45:35 INFO - 'sessionrestore_no_auto_restore', 20:45:35 INFO - 'tabpaint']}, 20:45:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:45:35 INFO - 'tests': ['tsvgx', 20:45:35 INFO - 'tsvgr_opacity', 20:45:35 INFO - 'tart', 20:45:35 INFO - 'tscrollx', 20:45:35 INFO - 'cart']}, 20:45:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:45:35 INFO - 'tsvgr_opacity', 20:45:35 INFO - 'tart', 20:45:35 INFO - 'tscrollx', 20:45:35 INFO - 'cart']}, 20:45:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:35 INFO - 'talos_options': ['--disable-e10s'], 20:45:35 INFO - 'tests': ['tp5o']}, 20:45:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:35 INFO - 'tests': ['tp5o']}, 20:45:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:35 INFO - 'talos_options': ['--disable-e10s', 20:45:35 INFO - '--xperf_path', 20:45:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:45:35 INFO - 'tests': ['tp5n']}, 20:45:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:45:35 INFO - 'talos_options': ['--xperf_path', 20:45:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:45:35 INFO - 'tests': ['tp5n']}}, 20:45:35 INFO - 'talos.zip': {'path': '', 20:45:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:45:35 INFO - Running post-action listener: _resource_record_post_action 20:45:35 INFO - ##### 20:45:35 INFO - ##### Finished populate-webroot step (success) 20:45:35 INFO - ##### 20:45:35 INFO - ##### 20:45:35 INFO - ##### Running create-virtualenv step. 20:45:35 INFO - ##### 20:45:35 INFO - Running pre-action listener: _resource_record_pre_action 20:45:35 INFO - Running main action method: create_virtualenv 20:45:35 INFO - Creating virtualenv /builds/slave/test/build/venv 20:45:35 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 20:45:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:45:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:45:35 INFO - Using real prefix '/tools/python27' 20:45:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:45:36 INFO - Installing distribute.............................................................................................................................................................................................done. 20:45:39 INFO - Installing pip.................done. 20:45:39 INFO - Return code: 0 20:45:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:39 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 0x1072c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffde3d85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716cd30>, '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 0x106f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107163b20>, '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.kz9NW65ojj/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.lVg7b6oTz9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 20:45:39 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 20:45:39 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 20:45:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kz9NW65ojj/Render', 20:45:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:39 INFO - 'HOME': '/Users/cltbld', 20:45:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:39 INFO - 'LOGNAME': 'cltbld', 20:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:39 INFO - 'MOZ_NO_REMOTE': '1', 20:45:39 INFO - 'NO_EM_RESTART': '1', 20:45:39 INFO - 'PAGER': '/bin/cat', 20:45:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:39 INFO - 'PWD': '/builds/slave/test', 20:45:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:39 INFO - 'SHELL': '/bin/bash', 20:45:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVg7b6oTz9/Listeners', 20:45:39 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 20:45:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:39 INFO - 'USER': 'cltbld', 20:45:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:39 INFO - 'XPC_FLAGS': '0x0', 20:45:39 INFO - 'XPC_SERVICE_NAME': '0', 20:45:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:39 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 20:45:39 INFO - Cleaning up... 20:45:39 INFO - Return code: 0 20:45:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:45:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:45:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffde3d85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716cd30>, '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 0x106f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107163b20>, '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.kz9NW65ojj/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.lVg7b6oTz9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 20:45:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:45:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:45:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kz9NW65ojj/Render', 20:45:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:39 INFO - 'HOME': '/Users/cltbld', 20:45:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:39 INFO - 'LOGNAME': 'cltbld', 20:45:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:39 INFO - 'MOZ_NO_REMOTE': '1', 20:45:39 INFO - 'NO_EM_RESTART': '1', 20:45:39 INFO - 'PAGER': '/bin/cat', 20:45:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:39 INFO - 'PWD': '/builds/slave/test', 20:45:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:39 INFO - 'SHELL': '/bin/bash', 20:45:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVg7b6oTz9/Listeners', 20:45:39 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 20:45:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:39 INFO - 'USER': 'cltbld', 20:45:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:39 INFO - 'XPC_FLAGS': '0x0', 20:45:39 INFO - 'XPC_SERVICE_NAME': '0', 20:45:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:39 INFO - Downloading/unpacking psutil>=3.1.1 20:45:39 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 20:45:39 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 20:45:39 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 20:45:39 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 20:45:39 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 20:45:39 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 20:45:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:45:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:45:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:45:42 INFO - Installing collected packages: psutil 20:45:42 INFO - Running setup.py install for psutil 20:45:42 INFO - building 'psutil._psutil_osx' extension 20:45:42 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 20:45:43 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 20:45:43 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 20:45:43 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 20:45:43 INFO - building 'psutil._psutil_posix' extension 20:45:43 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 20:45:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:45:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:45:43 INFO - ^ 20:45:43 INFO - 1 warning generated. 20:45:43 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 20:45:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:45:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:45:43 INFO - Successfully installed psutil 20:45:43 INFO - Cleaning up... 20:45:43 INFO - Return code: 0 20:45:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:45: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')]} 20:45:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45: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')]} 20:45:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1072c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffde3d85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716cd30>, '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 0x106f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107163b20>, '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.kz9NW65ojj/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.lVg7b6oTz9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 20:45:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:45:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kz9NW65ojj/Render', 20:45:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:43 INFO - 'HOME': '/Users/cltbld', 20:45:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:43 INFO - 'LOGNAME': 'cltbld', 20:45:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:43 INFO - 'MOZ_NO_REMOTE': '1', 20:45:43 INFO - 'NO_EM_RESTART': '1', 20:45:43 INFO - 'PAGER': '/bin/cat', 20:45:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:43 INFO - 'PWD': '/builds/slave/test', 20:45:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:43 INFO - 'SHELL': '/bin/bash', 20:45:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVg7b6oTz9/Listeners', 20:45:43 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 20:45:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:43 INFO - 'USER': 'cltbld', 20:45:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:43 INFO - 'XPC_FLAGS': '0x0', 20:45:43 INFO - 'XPC_SERVICE_NAME': '0', 20:45:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:45:43 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 20:45:43 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 20:45:43 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 20:45:43 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 20:45:43 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 20:45:43 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 20:45:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:45:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:45:46 INFO - Installing collected packages: mozsystemmonitor 20:45:46 INFO - Running setup.py install for mozsystemmonitor 20:45:46 INFO - Successfully installed mozsystemmonitor 20:45:46 INFO - Cleaning up... 20:45:46 INFO - Return code: 0 20:45:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1072c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffde3d85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716cd30>, '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 0x106f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107163b20>, '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.kz9NW65ojj/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.lVg7b6oTz9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 20:45:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:45:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:45:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kz9NW65ojj/Render', 20:45:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:46 INFO - 'HOME': '/Users/cltbld', 20:45:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:46 INFO - 'LOGNAME': 'cltbld', 20:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:46 INFO - 'MOZ_NO_REMOTE': '1', 20:45:46 INFO - 'NO_EM_RESTART': '1', 20:45:46 INFO - 'PAGER': '/bin/cat', 20:45:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:46 INFO - 'PWD': '/builds/slave/test', 20:45:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:46 INFO - 'SHELL': '/bin/bash', 20:45:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVg7b6oTz9/Listeners', 20:45:46 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 20:45:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:46 INFO - 'USER': 'cltbld', 20:45:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:46 INFO - 'XPC_FLAGS': '0x0', 20:45:46 INFO - 'XPC_SERVICE_NAME': '0', 20:45:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:46 INFO - Downloading/unpacking blobuploader==1.2.4 20:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:45:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:45:49 INFO - Downloading blobuploader-1.2.4.tar.gz 20:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:45:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:45: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 20:45: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 20:45: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 20:45: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 20:45: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 20:45: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 20:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:45:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:45: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 20:45: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 20:45: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 20:45: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 20:45: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 20:45: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 20:45:50 INFO - Downloading docopt-0.6.1.tar.gz 20:45:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:45:50 INFO - Installing collected packages: blobuploader, requests, docopt 20:45:50 INFO - Running setup.py install for blobuploader 20:45:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:45:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:45:50 INFO - Running setup.py install for requests 20:45:51 INFO - Running setup.py install for docopt 20:45:51 INFO - Successfully installed blobuploader requests docopt 20:45:51 INFO - Cleaning up... 20:45:51 INFO - Return code: 0 20:45:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:51 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 0x1072c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffde3d85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716cd30>, '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 0x106f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107163b20>, '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.kz9NW65ojj/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.lVg7b6oTz9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 20:45:51 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 20:45:51 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 20:45:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kz9NW65ojj/Render', 20:45:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:51 INFO - 'HOME': '/Users/cltbld', 20:45:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:51 INFO - 'LOGNAME': 'cltbld', 20:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:51 INFO - 'MOZ_NO_REMOTE': '1', 20:45:51 INFO - 'NO_EM_RESTART': '1', 20:45:51 INFO - 'PAGER': '/bin/cat', 20:45:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:51 INFO - 'PWD': '/builds/slave/test', 20:45:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:51 INFO - 'SHELL': '/bin/bash', 20:45:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVg7b6oTz9/Listeners', 20:45:51 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 20:45:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:51 INFO - 'USER': 'cltbld', 20:45:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:51 INFO - 'XPC_FLAGS': '0x0', 20:45:51 INFO - 'XPC_SERVICE_NAME': '0', 20:45:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:45:51 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-bjOt6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:45:51 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ng541w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:45:51 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ZkqLpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:45:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:45:51 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-fD6Xfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:45:52 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-P8nDPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:45:52 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Dbqejn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:45:52 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-Me_oho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:45:52 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-vxkZxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:45:52 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-8zkADr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:45:52 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-q_jnNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:45:52 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-L3WOMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:45:52 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-8lprKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:45:52 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-dKRftW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:45:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:45:52 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ULlU21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:53 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-AAJCrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:45:53 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-sVNqSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:45:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:45:53 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-itl_2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:45:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:45:53 INFO - Running setup.py install for manifestparser 20:45:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:45:53 INFO - Running setup.py install for mozcrash 20:45:53 INFO - Running setup.py install for mozdebug 20:45:53 INFO - Running setup.py install for mozdevice 20:45:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:45:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:45:53 INFO - Running setup.py install for mozfile 20:45:54 INFO - Running setup.py install for mozhttpd 20:45:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:45:54 INFO - Running setup.py install for mozinfo 20:45:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:45:54 INFO - Running setup.py install for mozInstall 20:45:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:45:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:45:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:45:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:45:54 INFO - Running setup.py install for mozleak 20:45:54 INFO - Running setup.py install for mozlog 20:45:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:45:54 INFO - Running setup.py install for moznetwork 20:45:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:45:54 INFO - Running setup.py install for mozprocess 20:45:55 INFO - Running setup.py install for mozprofile 20:45:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:45:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:45:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:45:55 INFO - Running setup.py install for mozrunner 20:45:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:45:55 INFO - Running setup.py install for mozscreenshot 20:45:55 INFO - Running setup.py install for moztest 20:45:55 INFO - Running setup.py install for mozversion 20:45:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:45:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:45:55 INFO - Cleaning up... 20:45:55 INFO - Return code: 0 20:45:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:45:55 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')]} 20:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:55 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')]} 20:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:45:55 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 0x1072c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffde3d85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716cd30>, '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 0x106f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107163b20>, '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.kz9NW65ojj/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.lVg7b6oTz9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 20:45:55 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 20:45:55 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 20:45:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kz9NW65ojj/Render', 20:45:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:45:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:45:55 INFO - 'HOME': '/Users/cltbld', 20:45:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:45:55 INFO - 'LOGNAME': 'cltbld', 20:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:45:55 INFO - 'MOZ_NO_REMOTE': '1', 20:45:55 INFO - 'NO_EM_RESTART': '1', 20:45:55 INFO - 'PAGER': '/bin/cat', 20:45:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:45:55 INFO - 'PWD': '/builds/slave/test', 20:45:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:45:55 INFO - 'SHELL': '/bin/bash', 20:45:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVg7b6oTz9/Listeners', 20:45:55 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 20:45:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:45:55 INFO - 'USER': 'cltbld', 20:45:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:45:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:45:55 INFO - 'XPC_FLAGS': '0x0', 20:45:55 INFO - 'XPC_SERVICE_NAME': '0', 20:45:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:45:56 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-ihhcEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:45:56 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)) 20:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:45:56 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-zjpTPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:45:56 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)) 20:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:45:56 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-s1dkg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:45:56 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)) 20:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:45:56 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-65LjVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:45:56 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)) 20:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:45:56 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-O2ze2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:45:56 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)) 20:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:45:56 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-tJCoZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:45:56 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)) 20:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:45:56 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-18QyoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:45:56 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)) 20:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:45:56 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-k8Oug6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:45:57 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)) 20:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:45:57 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-DWePs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:45:57 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)) 20:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:45:57 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-qgs9d3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:45:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 20:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:45:57 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-qb996f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:45:57 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)) 20:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:45:57 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-8QJV7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:45:57 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)) 20:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:45:57 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-6QBnrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:45:57 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)) 20:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:45:57 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-r8tIjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:45:57 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)) 20:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:57 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-phC02c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:45:57 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)) 20:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:45:57 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-dpdngF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:45:57 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)) 20:45:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:45:57 INFO - Running setup.py (path:/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/pip-gECvDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:45:57 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)) 20:45:57 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)) 20:45:57 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)) 20:45:57 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)) 20:45:57 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)) 20:45:57 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)) 20:45:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:45:58 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 20:45:58 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 20:45:58 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 20:45:58 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 20:45:58 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 20:45:58 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 20:46:00 INFO - Downloading blessings-1.6.tar.gz 20:46:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:46:00 INFO - Installing collected packages: blessings 20:46:00 INFO - Running setup.py install for blessings 20:46:00 INFO - Successfully installed blessings 20:46:00 INFO - Cleaning up... 20:46:00 INFO - Return code: 0 20:46:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:46:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:01 INFO - Reading from file tmpfile_stdout 20:46:01 INFO - Current package versions: 20:46:01 INFO - blessings == 1.6 20:46:01 INFO - blobuploader == 1.2.4 20:46:01 INFO - docopt == 0.6.1 20:46:01 INFO - manifestparser == 1.1 20:46:01 INFO - mozInstall == 1.12 20:46:01 INFO - mozcrash == 0.17 20:46:01 INFO - mozdebug == 0.1 20:46:01 INFO - mozdevice == 0.48 20:46:01 INFO - mozfile == 1.2 20:46:01 INFO - mozhttpd == 0.7 20:46:01 INFO - mozinfo == 0.9 20:46:01 INFO - mozleak == 0.1 20:46:01 INFO - mozlog == 3.2 20:46:01 INFO - moznetwork == 0.27 20:46:01 INFO - mozprocess == 0.22 20:46:01 INFO - mozprofile == 0.28 20:46:01 INFO - mozrunner == 6.11 20:46:01 INFO - mozscreenshot == 0.1 20:46:01 INFO - mozsystemmonitor == 0.3 20:46:01 INFO - moztest == 0.7 20:46:01 INFO - mozversion == 1.4 20:46:01 INFO - psutil == 3.1.1 20:46:01 INFO - requests == 1.2.3 20:46:01 INFO - wsgiref == 0.1.2 20:46:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:46:01 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')]} 20:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:01 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')]} 20:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:01 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 0x1072c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffde3d85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716cd30>, '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 0x106f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107163b20>, '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.kz9NW65ojj/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.lVg7b6oTz9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 20:46:01 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 20:46:01 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 20:46:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kz9NW65ojj/Render', 20:46:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:01 INFO - 'HOME': '/Users/cltbld', 20:46:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:01 INFO - 'LOGNAME': 'cltbld', 20:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:01 INFO - 'MOZ_NO_REMOTE': '1', 20:46:01 INFO - 'NO_EM_RESTART': '1', 20:46:01 INFO - 'PAGER': '/bin/cat', 20:46:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:01 INFO - 'PWD': '/builds/slave/test', 20:46:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:01 INFO - 'SHELL': '/bin/bash', 20:46:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVg7b6oTz9/Listeners', 20:46:01 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 20:46:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:01 INFO - 'USER': 'cltbld', 20:46:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:01 INFO - 'XPC_FLAGS': '0x0', 20:46:01 INFO - 'XPC_SERVICE_NAME': '0', 20:46:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:01 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)) 20:46:01 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)) 20:46:01 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)) 20:46:01 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)) 20:46:01 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)) 20:46:01 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)) 20:46:01 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)) 20:46:01 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)) 20:46:01 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)) 20:46:01 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)) 20:46:01 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)) 20:46:01 INFO - Cleaning up... 20:46:01 INFO - Return code: 0 20:46:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:46:01 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')]} 20:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:01 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')]} 20:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:01 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 0x1072c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffde3d85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716cd30>, '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 0x106f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107163b20>, '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.kz9NW65ojj/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.lVg7b6oTz9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 20:46:01 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 20:46:01 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 20:46:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kz9NW65ojj/Render', 20:46:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:01 INFO - 'HOME': '/Users/cltbld', 20:46:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:01 INFO - 'LOGNAME': 'cltbld', 20:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:01 INFO - 'MOZ_NO_REMOTE': '1', 20:46:01 INFO - 'NO_EM_RESTART': '1', 20:46:01 INFO - 'PAGER': '/bin/cat', 20:46:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:01 INFO - 'PWD': '/builds/slave/test', 20:46:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:01 INFO - 'SHELL': '/bin/bash', 20:46:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVg7b6oTz9/Listeners', 20:46:01 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 20:46:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:01 INFO - 'USER': 'cltbld', 20:46:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:01 INFO - 'XPC_FLAGS': '0x0', 20:46:01 INFO - 'XPC_SERVICE_NAME': '0', 20:46:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:01 INFO - Downloading/unpacking jsonschema 20:46:01 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 20:46:01 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 20:46:01 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 20:46:01 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 20:46:01 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 20:46:01 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 20:46:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:46:04 INFO - Downloading/unpacking functools32 (from jsonschema) 20:46:04 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 20:46:04 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 20:46:04 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 20:46:04 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 20:46:04 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 20:46:04 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 20:46:04 INFO - Downloading functools32-3.2.3-2.tar.gz 20:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:46:04 INFO - warning: no files found matching '*.txt' 20:46:04 INFO - no previously-included directories found matching 'build' 20:46:04 INFO - no previously-included directories found matching 'dist' 20:46:04 INFO - no previously-included directories found matching '.git*' 20:46:04 INFO - Installing collected packages: jsonschema, functools32 20:46:04 INFO - Running setup.py install for functools32 20:46:04 INFO - warning: no files found matching '*.txt' 20:46:04 INFO - no previously-included directories found matching 'build' 20:46:04 INFO - no previously-included directories found matching 'dist' 20:46:04 INFO - no previously-included directories found matching '.git*' 20:46:04 INFO - Successfully installed jsonschema functools32 20:46:04 INFO - Cleaning up... 20:46:04 INFO - Return code: 0 20:46:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:46:04 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 0x1072c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1072ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffde3d85550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716cd30>, '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 0x106f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107163b20>, '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.kz9NW65ojj/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.lVg7b6oTz9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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 20:46:04 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 20:46:04 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 20:46:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kz9NW65ojj/Render', 20:46:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:04 INFO - 'HOME': '/Users/cltbld', 20:46:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:04 INFO - 'LOGNAME': 'cltbld', 20:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:04 INFO - 'MOZ_NO_REMOTE': '1', 20:46:04 INFO - 'NO_EM_RESTART': '1', 20:46:04 INFO - 'PAGER': '/bin/cat', 20:46:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:04 INFO - 'PWD': '/builds/slave/test', 20:46:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:04 INFO - 'SHELL': '/bin/bash', 20:46:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVg7b6oTz9/Listeners', 20:46:04 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 20:46:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:04 INFO - 'USER': 'cltbld', 20:46:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:04 INFO - 'XPC_FLAGS': '0x0', 20:46:04 INFO - 'XPC_SERVICE_NAME': '0', 20:46:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:46:05 INFO - Downloading/unpacking flake8 20:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:46:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:46:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:46:07 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 20:46:07 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 20:46:07 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 20:46:07 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 20:46:07 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 20:46:07 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 20:46:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:46:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:46:07 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 20:46:07 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 20:46:07 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 20:46:07 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 20:46:07 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 20:46:07 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 20:46:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:46:08 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 20:46:08 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 20:46:08 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 20:46:08 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 20:46:08 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 20:46:08 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 20:46:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:46:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:46:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:46:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:46:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:46:08 INFO - no previously-included directories found matching 'docs/_build' 20:46:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:46:09 INFO - Running setup.py install for pep8 20:46:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:46:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:46:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:46:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:46:09 INFO - no previously-included directories found matching 'docs/_build' 20:46:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:46:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:46:09 INFO - Cleaning up... 20:46:09 INFO - Return code: 0 20:46:09 INFO - Running post-action listener: _resource_record_post_action 20:46:09 INFO - Running post-action listener: _start_resource_monitoring 20:46:09 INFO - Starting resource monitoring. 20:46:09 INFO - ##### 20:46:09 INFO - ##### Finished create-virtualenv step (success) 20:46:09 INFO - ##### 20:46:09 INFO - ##### 20:46:09 INFO - ##### Running install step. 20:46:09 INFO - ##### 20:46:09 INFO - Running pre-action listener: _resource_record_pre_action 20:46:09 INFO - Running main action method: install 20:46:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:46:09 INFO - Reading from file tmpfile_stdout 20:46:09 INFO - Detecting whether we're running mozinstall >=1.0... 20:46:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:46:09 INFO - Reading from file tmpfile_stdout 20:46:09 INFO - Output received: 20:46:09 INFO - Usage: mozinstall [options] installer 20:46:09 INFO - Options: 20:46:09 INFO - -h, --help show this help message and exit 20:46:09 INFO - -d DEST, --destination=DEST 20:46:09 INFO - Directory to install application into. [default: 20:46:09 INFO - "/builds/slave/test"] 20:46:09 INFO - --app=APP Application being installed. [default: firefox] 20:46:09 INFO - mkdir: /builds/slave/test/build/application 20:46:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:46:43 INFO - Reading from file tmpfile_stdout 20:46:43 INFO - Output received: 20:46:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:46:43 INFO - Running post-action listener: _resource_record_post_action 20:46:43 INFO - ##### 20:46:43 INFO - ##### Finished install step (success) 20:46:43 INFO - ##### 20:46:43 INFO - ##### 20:46:43 INFO - ##### Running run-tests step. 20:46:43 INFO - ##### 20:46:43 INFO - Running pre-action listener: _resource_record_pre_action 20:46:43 INFO - Running main action method: run_tests 20:46:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:46:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:46:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:46:43 INFO - 2016-05-26 20:46:43.881 screenresolution[1918:10457] starting screenresolution argv=screenresolution get 20:46:43 INFO - 2016-05-26 20:46:43.883 screenresolution[1918:10457] Display 0: 1600x1200x32@60 20:46:43 INFO - 2016-05-26 20:46:43.888 screenresolution[1919:10459] starting screenresolution argv=screenresolution list 20:46:43 INFO - Available Modes on Display 0 20:46:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:46:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:46:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:46:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:46:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:46:44 INFO - Intel Iris: 20:46:44 INFO - Chipset Model: Intel Iris 20:46:44 INFO - Type: GPU 20:46:44 INFO - Bus: Built-In 20:46:44 INFO - VRAM (Dynamic, Max): 1536 MB 20:46:44 INFO - Vendor: Intel (0x8086) 20:46:44 INFO - Device ID: 0x0a2e 20:46:44 INFO - Revision ID: 0x0009 20:46:44 INFO - Displays: 20:46:44 INFO - Display: 20:46:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:46:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:46:44 INFO - Display Serial Number: 1600x1200 60 20:46:44 INFO - Main Display: Yes 20:46:44 INFO - Mirror: Off 20:46:44 INFO - Online: Yes 20:46:44 INFO - Rotation: Supported 20:46:44 INFO - Return code: 0 20:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:46:44 INFO - Python 2.7.3 20:46:44 INFO - Return code: 0 20:46:44 INFO - grabbing minidump binary from tooltool 20:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:46:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10716cd30>, '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 0x106f90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107163b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:46:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:46:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 20:46:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:46:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:46:44 INFO - Return code: 0 20:46:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:46:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:46:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:46:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:46:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:46:45 INFO - Return code: 0 20:46:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:46:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kz9NW65ojj/Render', 20:46:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:46:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:46:45 INFO - 'HOME': '/Users/cltbld', 20:46:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:46:45 INFO - 'LOGNAME': 'cltbld', 20:46:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:46:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:46:45 INFO - 'MOZ_NO_REMOTE': '1', 20:46:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:46:45 INFO - 'NO_EM_RESTART': '1', 20:46:45 INFO - 'PAGER': '/bin/cat', 20:46:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:46:45 INFO - 'PWD': '/builds/slave/test', 20:46:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:46:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:46:45 INFO - 'SHELL': '/bin/bash', 20:46:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lVg7b6oTz9/Listeners', 20:46:45 INFO - 'TMPDIR': '/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/', 20:46:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:46:45 INFO - 'USER': 'cltbld', 20:46:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:46:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:46:45 INFO - 'XPC_FLAGS': '0x0', 20:46:45 INFO - 'XPC_SERVICE_NAME': '0', 20:46:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:46:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:46:45 INFO - mozversion application_buildid: 20160526184553 20:46:45 INFO - mozversion application_changeset: 4d63dde701b47b8661ab7990f197b6b60e543839 20:46:45 INFO - mozversion application_display_name: Nightly 20:46:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:46:45 INFO - mozversion application_name: Firefox 20:46:45 INFO - mozversion application_remotingname: firefox 20:46:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:46:45 INFO - mozversion application_vendor: Mozilla 20:46:45 INFO - mozversion application_version: 49.0a1 20:46:45 INFO - mozversion platform_buildid: 20160526184553 20:46:45 INFO - mozversion platform_changeset: 4d63dde701b47b8661ab7990f197b6b60e543839 20:46:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:46:45 INFO - mozversion platform_version: 49.0a1 20:46:45 INFO - using testdate: 1464320805 20:46:45 INFO - actual date: 1464320805 20:46:45 INFO - starting webserver on 'localhost:49466' 20:46:45 INFO - SUITE-START | Running 2 tests 20:46:45 INFO - TEST-START | dromaeo_css 20:46:45 INFO - operating with platform_type : mac_ 20:46:45 INFO - Initialising browser for dromaeo_css test... 20:46:45 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpc_5Pmx/profile http://localhost:49466/getInfo.html) 20:46:48 INFO - PROCESS | 1937 | __metrics Screen width/height:1600/1200 20:46:48 INFO - PROCESS | 1937 | colorDepth:24 20:46:48 INFO - PROCESS | 1937 | Browser inner width/height: 1024/689 20:46:48 INFO - PROCESS | 1937 | __metrics 20:46:48 ERROR - PROCESS | 1937 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 20:46:49 INFO - TEST-INFO | 1937: exit 0 20:46:49 INFO - Browser initialized. 20:46:49 INFO - Running cycle 1/1 for dromaeo_css test... 20:46:49 INFO - TEST-INFO | started process 1940 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpc_5Pmx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:47:00 INFO - PROCESS | 1940 | RSS: Main: 252407808 20:47:00 INFO - PROCESS | 1940 | 20:47:50 INFO - PROCESS | 1940 | 1464320870641 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] 20:50:01 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49466/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49466/tests/dromaeo/cssquery-ext.html) 20:50:03 INFO - PROCESS | 1940 | RSS: Main: 266354688 20:50:03 INFO - PROCESS | 1940 | 20:53:05 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49466/tests/dromaeo/cssquery-ext.html (next: http://localhost:49466/tests/dromaeo/cssquery-jquery.html) 20:53:06 INFO - PROCESS | 1940 | RSS: Main: 277917696 20:53:06 INFO - PROCESS | 1940 | 20:56:07 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49466/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49466/tests/dromaeo/cssquery-mootools.html) 20:56:08 INFO - PROCESS | 1940 | RSS: Main: 280064000 20:56:08 INFO - PROCESS | 1940 | 20:59:10 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49466/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49466/tests/dromaeo/cssquery-prototype.html) 20:59:10 INFO - PROCESS | 1940 | RSS: Main: 281432064 20:59:10 INFO - PROCESS | 1940 | 21:02:13 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49466/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49466/tests/dromaeo/cssquery-yui.html) 21:02:14 INFO - PROCESS | 1940 | RSS: Main: 284938240 21:02:14 INFO - PROCESS | 1940 | 21:05:16 INFO - PROCESS | 1940 | Cycle 1(1): loaded http://localhost:49466/tests/dromaeo/cssquery-yui.html (next: http://localhost:49466/tests/dromaeo/cssquery-dojo.html) 21:05:17 INFO - PROCESS | 1940 | RSS: Main: 285212672 21:05:17 INFO - PROCESS | 1940 | 21:05:17 INFO - PROCESS | 1940 | __start_tp_report 21:05:17 INFO - PROCESS | 1940 | _x_x_mozilla_page_load 21:05:17 INFO - PROCESS | 1940 | _x_x_mozilla_page_load_details 21:05:17 INFO - PROCESS | 1940 | |i|pagename|runs| 21:05:17 INFO - PROCESS | 1940 | |0;dojo.html;2832.872520736566;2881.573621057577;3473.895783126507;3500.9824950875227;3513.8067406292653;4962.2556616507545;5199.558037566807;5819.709014549271;5862.413758624136;5887.705614719268;5645.463680950314;5793.275840519935;5793.681347525884;5806.10005449155;5880.059190529516;5225.294585230993;5253.395859476171;5263.34208223972;5386.649867758583;5406.91889621656;4507.842225522108;5397.54120899724;5493.313335833021;5499.587530935176;5512.310961129859;5188.273641690166;5288.788448462057;5316.76074576645;5322.600804939645;5344.118220493653;5298.205269209611;5317.12267475866;5323;5332.786688532454;5337.919931201035;5211.088059589557;5297.443768404339;5306.283651707009;5335.253064570963;5364.839054828361;5408.675479471205;5474.835754927359;5515.751791169367;5565.5825813063775;5602.635828671123;6048.123022161806;6150.323464418911;6151.2618485781995;6151.292601350857;6174.197354343906;6146.416090471398;6160.722767475474;6175;6199.3490683478485;6205.28639206488;5951.791687290924;6021.126936594169;6050.818475445743;6055.182550355689;6085.4827339676185;6312.305646378986;6337.207849018872;6390.7443702251385;6396.808095757135;6397.040443933354;4995.300657907896;6120.599512025131;6152.538559607958;6211.223597050369;6230.7819226326865;6237.282712488031;6280.340564240781;6295.087212354183;6298.622082675054;6308.369163083747;5568.331800184003;5990.9101363479585;6136.509079273647;6224.782132625336;6242.469390101802;6104.481119104837;6154.78458253959;6159.353267906895;6265.028920517327;6288.151099601587;4969.204927211701;4975.825846095369;4987.600991920638;4991.550760431579;5010.799568017312;4430.867073987785;4459.264221403432;4468.419105516327;4472.8210871565425;4503.594676479067;5793.681347525842;5907.881842363128;5980.820575382745;6046.606970546901;6050.727717252734;5267.420583735786;6209.857564314964;6273.153124328157;6280.9685951569945;6303.747850086037;4964.851054468371;6056.394360563909;6058.182145410313;6075.088736689532;6085.5435842312;5340.839774806762;5411;5432.972835135799;5480.616356855062;5490.890182196414;6460.160179176677;6464.838379040561;6464.870702585922;6474.482041436674;6486.6756662167645;6248.718807653758;6257.186565746424;6260.74957001733;6277.340879207617;6278.15244941927;6153.630782153085;6313.43179113882;6323.588966717149;6362.9681851592295;6408.871822563429;6230.968845155927;6234.625922444668;6239.469645080219;6254.9687251563455;6259.749610015549;5115.846524604268;5303.867403314794;6259.092431597484;6283.748650053946;6293.779717709858;5974.701264936823;6018.969905150446;6098.29869564988;6120.724567394389;6161.784337548164;6106.855059071331;6115.145512192008;6147.538934579835;6175.413335733098;6193.473554747897;5929.466348028698;5934.881302374015;6061.515078793598;6092.817215483543;6136.048912418582;6083.330833608211;6237.906431403442;6240.7503699851495;6258.249010118633;6280;5082.745862706776;5959;6127.080937859357;6134.171886795226;6187.690615469299 21:05:17 INFO - PROCESS | 1940 | |1;ext.html;488.87044933092716;525.1256657664989;528.6537318056673;545.9890802183957;555.6249531566197;39238.84186369752;42395;42397.57602423975;42447.57552424475;42484.57515424845;43233.135337293235;43919.902002449955;43945.90135246621;44138.55861441384;44174;9600.80798384032;9755.902440975606;9843.409395436262;9848.704538863809;9850.40897546146;9743.220542356594;9855.753606159831;9856.359336643096;9888.752781180456;9920.95039524805;9817.852732209023;9887.505624718771;9892.653757118502;9898.802023959517;9901.158401535879;9837.901620983806;9839.950800245988;9845.80308393828;9867.259955503294;9896.356736812157;7759.9612001940195;8591.613377398033;9634.90365096354;9754.609815607368;9763.26775491841;40047.99880002994;40118.19763604741;40490.79754601238;40506.594934050576;40560.79719601413;3535.275268569937;3565.322588708163;3641.18073433478;3663.1757854482794;3735.7384983051197;31387.686123138934;31868.20329491758;31889.53981576669;32706.182345441553;33362;3248.3990461764647;3283.770136090475;3307.818070006149;3326.600807903043;3418.008777454535;498379;507858;512384;519071;522330;35787;37016;69676;70580;70666.64666676633;37498;37621.81189094037;37884.86345409587;38014.80992595019;38015.42976855349;14295.92852035733;14372.35324410404;15227.619309517351;15418.306176222097;15578.688426231412;12927.870721292667;12994.805077923838;13001.544945926848;13081.672958175932;13131.737365252642;8198.38512111594;8211.507309561446;8296.875546866802;8345.207205315486;8383.790405239917;2979.3147576057627;3206.9358612828078;3224.8712950467147;3473.982630086884;3495.632958539317;927.3832901120815;1019.7858449725493;1034.9327293725885;1050.3404620699278;1055.4300677634146;29872;31520;31590.842045790083;31667.366652666817;32293.838530807196;1007.1187710753092;1029;1034.715453250347;1085.2457542008228;1186.288227063755;14094;16124;16174.75737863933;16312;16487.587810304598;594878;603099;692901.7484388022;702820;703602;60087.399126009055;60327.39672603218;60568.69715651393;60587.69706151441;60729;1400.033976556173;1403.9578812635636;1457.4825936792497;1461.2766680493223;1464.3410465290663;30314.545281821232;30975.380492390475;31519.896803611762;31632;32043.359132816746;54172.45827541832;59277.40722592892;60995;64160.67919660558;64164.03753943788;645317;649478;654921;656735;656861;45837.31244031409;46222.768886155354;46787.766061169474;46852.76573617246;47094;48926.02147957092;49538.25692614542;49549.29338581173;50276.49723502718;51703.74148129235;40337.59662403339;41559.7922010388;42252.15495690131;42493.93765155896;42861.928451788954;31841.7263309465;40118;40629.390559141044;40887.1822563553;41936;36561;38624;39773.204535909696;40640.79679601583;42463.787681061396;31205.59574819093;34702.82648586741;35747.28505429929;36356.81821590981;36539.08652283608;21910.014049368136;25012.62481062749;26501.674916253723;26518.469630607666;27179.86410067937 21:05:17 INFO - PROCESS | 1940 | |2;jquery.html;356.37456264256224;360.59793330436565;378.82574015952645;381.4526154967622;395.98430026980793;19873.97574157556;21091.2618058368;21534.81558514283;21657.350279491602;21666.566668666655;20109.396718098444;20856.687149692767;21094.789052109474;21225.681614775753;21250.043748031338;5665.951798917193;5761.193432919395;6011.939880601203;6048.485878700316;6053.122297266894;5932.466078052975;5951.49412299955;5955.612885162473;5971.761129554812;6024.518038556905;5550.611457197998;5757.021306377905;5834.795782147626;5835.299764028323;5847.327557330919;5656.208130861683;5758.856028599276;5786.739596718136;5803.21656576361;5817.7091145442555;5091.1854103343285;5108.182690769459;5108.361454818148;5110.080185566597;5129.230615407681;26012.609810852853;26112;26247.475050499073;26284.948602055894;26657.466850663073;2097.0877668214375;2226.1318085946496;2314.90740370385;2528.6333481645243;2631.5921032240035;12927.418266178045;15749.133797641125;16050.839491605051;16121.83878161215;16161.272742726605;1825.6257467219189;1877.7934427212995;1894.526368407898;1906.2756152662039;1914.7606549181353;107934;108020.75937721881;114704.42647786708;120392.39803800925;120771.58456830814;10524.947375263075;10759.83860242097;10915.56337746497;11002.779944401227;11141.94429027866;12428.63285038645;12949.417276222594;13674.453021879013;13697.041207115606;13746.793798093036;8479.06730259671;8564.700235491853;8660.13398660129;8674.739757807276;8763.518006509576;7014.859702806018;8679.218870301704;8703.869441958375;8753.824923501494;8793.604287807064;5592.636478628876;6605.339466053356;6663.5335526513645;6734.158230221223;6747.797566073025;1667.8915870468622;1742.7278086996564;1824.7901491328403;1855.7030875060195;1893.1386219270198;778.6496076765478;818.2390376949494;937.1846493550519;974.4056125763278;1084.978300433987;21086;21892.78107218939;22018.779812201672;22066.88966555157;22145.446363841034;948.6205517792938;953.2659851913987;987.7431867714303;1001.1590264178126;1026.8305729554688;11289;11766.999805016498;11790;11791.823122653168;11827.822582661267;555311;581763.0911845414;593696;598200;600993;115875.42062289634;116604;119909.40045299717;121079.39460302642;122660;1039.5477967084344;1049.7218237167158;1050.7425680708275;1065.6376831877199;1067.4235912607105;18963.14665840013;19152.61694766125;19180.424587262405;19310.420687379403;19374.128164232363;38017.61982380252;52079;52446.73776631092;52481.21278180754;52756.736216320205;69929.65035174791;69998.65000675168;70069.64965175142;71145.6442717783;71189.64405177941;5304.9734751326;5344.679319240858;6324.525660575383;7172;7743.915851780643;9546.809063818824;11052.281601695864;12795.93602031984;13132.868671313165;13153.60539183826;11422.543098275975;11514.251573647685;11632.53469861196;11666.475008624462;11723.648290551297;11372.772544548898;11467.4266286687;11492.94253528727;11545.88454115448;11547.595834145764;10678.412687301961;11540.365279909685;11621.849957757842;11779.469923853618;11969.521219151136;8307.626156822836;8336.87494687568;8441.95779021101;8458.984921809422;8534.359923005675;11355.829662554903;11412.942935285271;11591.536338546364;11685.941570292094;11777.823332649845 21:05:17 INFO - PROCESS | 1940 | |3;mootools.html;1580.9367625294988;1582.67555151194;1601.26341882734;1610.2914717524288;1912.9426117216487;8063.798405039877;8514.446560973533;8755.693550725726;9290.581923813435;9306.674266400678;8631.784205394853;8806.515641639708;8857.734267971971;8943.463392196472;8985.146411090936;2007.9357940291595;2360.539694759518;2367.088670861722;2367.7277113132036;2397.30478161333;2048.4673984763995;2100.348891843526;2131.2540610786255;2303.516261585069;2386.7135943686694;2348.9530209395803;2369.277370402027;2384.3443053160345;2396.149366974725;2399.520095980802;2347.7417484076823;2357.5167090746354;2358.3750306168877;2362.6692263083096;2364.893579788905;2353.776391242829;2366.8698221597806;2372.146027430124;2374.584447721659;2388.904443822245;8873.979492358398;8896.822063558693;8897.510636915033;8935.061818509028;8935.821283574358;5324.600654950894;5331.573474122061;5430.59270554706;5481.205225242357;5525.171224316345;3483.372992861284;3597.280543891206;3725.720570957189;3738.8504459821575;3742.1954279829965;1045.5451878432907;1089.1341383600056;1098.3739268616891;1110.8167152419921;1128.2891778179776;11468.541258349656;11530.711732206762;11700.180987330976;11726.88273117275;11740.178187526877;4771.604876933884;4784.569388755029;4872.537108974641;4896.143174944371;4896.510348965075;10086.949565252127;10245.385276883262;10246.743831404274;10267.435291059064;10278.897211027943;5338.225957236179;5414;5426.267453893753;5426.538744206708;5451.236826844245;4007.699422543321;4383.7588932609015;4791.401074865642;4936.580390666762;4994.300797888299;4033.9193216135513;4081.1837632473625;4090.427340172378;4138.0689344897155;4203.117345357509;1285.5500574798932;1325.6354502511695;1327.3230652367363;1344.8031252185563;1347.9081943625695;801.9398545109024;908.318760929303;956.1585804492141;959.5250351076122;1013.0932815130565;4558.88602784933;5810.564207684441;6005.609635373687;6024.614338702036;6066.787662431793;453.63482396671;460.73968207963065;465.69031593989615;467.39705779544687;467.99532004680196;3956.2680904032272;4038.212548553004;4053.351463765783;4107.8973025674;4123;10365.274430789772;10642.414667193223;10760.085392741705;10814.56741730322;10821.458927053773;10569.735756606146;10741.51663175159;10761.408122553177;10762.78474430507;10809.729756755987;6438.905386084377;8271.627776750061;8284.875726864102;8393.832123357499;8489.278411334983;5843.29880414353;5903.321118071477;6056.969715151572;6154.3845615438095;6349.68251587428;9789.363691360039;9957.651482198089;10059.748506287402;10188.898111018794;10198.745031374276;9843.360181588174;10234.590616375262;10350.171986241234;10491.160707143257;10514.26400151982;7096.858062838611;7538;7750.457467977188;7819.139894611474;7980.361571074184;8508.319334453105;8641.265492432962;8644.308455323433;8648.1784230498;8743;7537.773866784005;7642.4650274480255;7695.692172313269;7790.987171667647;7815.843683126419;7187.425005999612;7412.555246685216;7481.625918703934;7516.436267279866;7553.357964573072;7060.364567188978;7087.149542054986;7139.036230108869;7140.46446516503;7142.142942846684;4439.800208990668;4659.671993481841;4924.581410580141;5029.145045342228;5173.430922598586;5184.7926082956255;5205.791768329224;5247.527722504993;5261.342332208474;5363.19552067193 21:05:17 INFO - PROCESS | 1940 | |4;prototype.html;307.74764692951777;311.43163726199685;312.72636443112276;316.1937060495734;319.3931530092822;5253.3170687810625;5342.492463215998;5550;5621.606487545873;5622.56624560737;4598.356230127785;5447.019536483432;5464.535464535465;5477.726113694309;5562.805301814437;3985.880423587297;4095.5699651536456;4171.290880550298;4196.601322874322;4211.862797044796;4144.523379811315;4163.479565054368;4193.391958166064;4196.265653510639;4197.391378250152;3631.6005239423775;3641.4537819327047;4053.5946405359523;4182.724269097924;4201.117765269297;3535.4166562517153;3855.1904100139004;3907.2576210520197;4110.972256935766;4204.663626909855;3422.349753546818;3546.9536486736215;3631.2011357501306;3650.1787097903025;3654.671079602822;4952.356193694833;5172.560332371753;5199.662021968597;5213.452587478336;5267.815626453055;4357.444791214015;4402.820603801107;4799.160146974265;4817;4822.6624136310475;5071;5326.98787230425;5777.480026797609;5782.132680097977;5782.421757824226;3486.8493397179122;3851.6533511983775;3986.123052928351;3999.920001599952;4036.9192616147807;4739.668223224341;5274.92087618686;5482.930828488446;5658.227468540385;6046.221111805122;4032.516098068251;4055.8986025349013;4071.776052317092;4082.510098788164;4085.97957010219;4126.277901367249;4131.669466442678;4138.710290279651;4183.644390226804;4197.202531519001;4447.82056792176;4764.618830493621;4836.588889944394;4836.903261934742;4844.176489996709;5188.507091826346;5459.918101228484;5775.422457754191;5807.274090738658;5868.882622347529;1383.3429121167364;1416.2423103639503;1418.8793952513945;1421.7085497472992;1423.8932080094035;745.5005146551823;851.1828644501348;861.9138086191456;869.0744357259498;917.3899356927702;5106;5321.3348331458565;5341.679499230058;5380.381256155514;5394.64934779246;5889.352171261158;5899.233099697012;5900.675462849585;5907.873165660359;5957.434043765836;4352.712578110559;4953.7523123844385;5323;5336.639157015014;5428.70142142186;2661.695769073179;2901.868271374166;3099.2561785171847;3104.1530289477723;3120.9219769505944;5049.394072711225;6157.199564056644;6195.349488303663;6195.411435913581;6199.3490683478485;5240.737963101829;5763.106718458645;5813.767449302065;6289.937100628935;6295.653739044396;5358.276632654542;5832.9708351457975;6370.331115232926;6400.199975003125;6429.164208652939;4521.480029796616;6080.087986802015;6112.938870611237;6113.685557605137;6115.462083235585;5996.700164991646;6016.4885984690045;6023.1567580537885;6058;6081.27024757032;5295.696372078159;5684.7157642118555;6009.188759517409;6375.362463753588;6421.967890160519;3621.60162382143;3907.183159830692;3966.7421617594764;3975.7216994811242;3992.941870404287;5166.121759300852;5493.560515158698;5950.107483877453;6028;6041.124037014521;5460.6996615186545;5870.5010074144175;5926.644401335933;5936.851578710394;5947.791827286197;5626.2685850839125;5836.533077353886;5914.550935020948;5916.970415147896;5917.881642367214;5463.235147079333;5581.776728930798;5743.1385292206505;5745.195672605755;5765.5675824314185;5617.74720137603;5900.822975310747;5920.8815823684145;5942.3955532006985;5947;5761.769529218952;5762.625429347079;5792.350818984013;5809.680467574324;5820.854478637899 21:05:17 INFO - PROCESS | 1940 | |5;yui.html;719.4532155561773;801.6753214947945;802.1497212954268;847.5635047950307;856.0626114404732;14534.854651453483;15108.773368399468;15184.544463666107;15279.006864553796;15324.310406031727;12888.291143987077;14017;14076.436942522312;14117.57647270581;14120.858791412084;885.6590212768099;897.9371443998923;902.6163880350857;904.1094521895927;905.7282815155427;874.5976850648709;891.2379915172531;910.927125829932;911.8905731312219;917.1470532404861;920.3235621817959;935.3218916285706;951.2152474208771;952.1573407534313;956.9473678947655;933.5425641435716;937.5546615357719;950.5722424908819;952.5808644196601;954.3367359685021;671.7883866582011;685.8148299958983;690.0994202565649;704.3660705365161;708.4898872811619;12905;13004.21974681522;13136.146150500283;13327.800082998763;13336.733265334737;10035.498225088717;11144;11870.940645296718;11967.760644787055;12347.259164450163;10408.425583643042;10750.946245268724;10777.892221077767;10810.621628242974;11149.99650031501;3689.5756987946193;3749.850005999784;3755.755875868087;3783.205526839367;3920.8039598019986;63020.99999999954;73183.63408182925;73192.17019574554;74689.6265518669;75877;11423.771524569629;11465.828012579817;11576.36330001858;11578.131640127023;12027.232599316621;18405.723914141297;21969.450763730714;22026.44933876666;22119.336419907428;22189;8167.95916020428;8296.25333719956;8314.542700151549;8360.498370097814;8400.033996090406;4441.089576636782;4541.795619197144;4549.363089167519;4563.224251877123;4564.977175114103;3522;3584.62361452049;3611.566612006576;3615.5661320641166;3629.0383048491644;685.0922527650882;695.7669180824379;700.8878579427267;702.5328156775687;706.9823254418578;597.2802772658936;657.1457105762489;683.1255992329826;694.8506071194718;703.63762662229;8993.640254389882;9056.320775941831;9356.719298421058;9443.716688499357;9518.762030949143;610.5817515002237;618.4434009391583;644.2944975252092;668.5921587831419;701.7999870037015;3966.5636779954184;3994.1013272013565;4079.3065178919655;4161.791910404529;4214.494260688675;84237;85726;90551;91129.54435227915;91329;70279.64860175666;76642;77207;77410;78610.6069469649;46995.53004469912;50702.49297507051;66027;71459.64270178616;71768.2057948545;9399.577019034297;9527.857082143635;9734.805303894023;9779.217662586834;9853.113219810251;45529.31706024346;45774.313385299916;46025.53974460212;46145.53854461547;46222.07555848931;56696.71651641715;61813;62125;62213;62270.688646556475;13244.53644122451;13273.66815829612;13310;13502;13767.931160344135;11697.2981621103;12071.275723456269;12092.939535302266;14009.859901400856;14439.494617688331;11414.48634811452;11568.652940411801;11764.176507644383;11791.469383877919;12154.209976351509;11745.412729363668;11798.941005294919;11799.292042477478;11827.586034488751;11849.52601895949;11590.304581725124;11628;11698.532058717896;11710.648680539598;11739.941300293785;9063.274938004812;9284.489353085644;9876.802463950824;9947.701568952943;10293;9743.610255589698;9872.259580531345;9978.700638980843;10043.118668344425;10070.99290070987 21:05:17 INFO - PROCESS | 1940 | __end_tp_report 21:05:17 INFO - PROCESS | 1940 | __start_cc_report 21:05:17 INFO - PROCESS | 1940 | _x_x_mozilla_cycle_collect,413 21:05:17 INFO - PROCESS | 1940 | __end_cc_report 21:05:17 INFO - PROCESS | 1940 | __startTimestamp1464321917001__endTimestamp 21:05:17 INFO - PROCESS | 1940 | 21:05:17 INFO - PROCESS | 1940 | ------- Summary: start ------- 21:05:17 INFO - PROCESS | 1940 | Number of tests: 6 21:05:17 INFO - PROCESS | 1940 | 21:05:17 INFO - PROCESS | 1940 | [#0] dojo.html Cycles:165 Average:5758.35 Median:6055.18 stddev:671.26 (11.1%) stddev-sans-first:632.87 21:05:17 INFO - PROCESS | 1940 | Values: 2832.9 2881.6 3473.9 3501.0 3513.8 4962.3 5199.6 5819.7 5862.4 5887.7 5645.5 5793.3 5793.7 5806.1 5880.1 5225.3 5253.4 5263.3 5386.6 5406.9 4507.8 5397.5 5493.3 5499.6 5512.3 5188.3 5288.8 5316.8 5322.6 5344.1 5298.2 5317.1 5323.0 5332.8 5337.9 5211.1 5297.4 5306.3 5335.3 5364.8 5408.7 5474.8 5515.8 5565.6 5602.6 6048.1 6150.3 6151.3 6151.3 6174.2 6146.4 6160.7 6175.0 6199.3 6205.3 5951.8 6021.1 6050.8 6055.2 6085.5 6312.3 6337.2 6390.7 6396.8 6397.0 4995.3 6120.6 6152.5 6211.2 6230.8 6237.3 6280.3 6295.1 6298.6 6308.4 5568.3 5990.9 6136.5 6224.8 6242.5 6104.5 6154.8 6159.4 6265.0 6288.2 4969.2 4975.8 4987.6 4991.6 5010.8 4430.9 4459.3 4468.4 4472.8 4503.6 5793.7 5907.9 5980.8 6046.6 6050.7 5267.4 6209.9 6273.2 6281.0 6303.7 4964.9 6056.4 6058.2 6075.1 6085.5 5340.8 5411.0 5433.0 5480.6 5490.9 6460.2 6464.8 6464.9 6474.5 6486.7 6248.7 6257.2 6260.7 6277.3 6278.2 6153.6 6313.4 6323.6 6363.0 6408.9 6231.0 6234.6 6239.5 6255.0 6259.7 5115.8 5303.9 6259.1 6283.7 6293.8 5974.7 6019.0 6098.3 6120.7 6161.8 6106.9 6115.1 6147.5 6175.4 6193.5 5929.5 5934.9 6061.5 6092.8 6136.0 6083.3 6237.9 6240.8 6258.2 6280.0 5082.7 5959.0 6127.1 6134.2 6187.7 21:05:17 INFO - PROCESS | 1940 | 21:05:17 INFO - PROCESS | 1940 | [#1] ext.html Cycles:180 Average:73694.61 Median:41223.49 stddev:164031.75 (397.9%) stddev-sans-first:164399.82 21:05:17 INFO - PROCESS | 1940 | Values: 488.9 525.1 528.7 546.0 555.6 39238.8 42395.0 42397.6 42447.6 42484.6 43233.1 43919.9 43945.9 44138.6 44174.0 9600.8 9755.9 9843.4 9848.7 9850.4 9743.2 9855.8 9856.4 9888.8 9921.0 9817.9 9887.5 9892.7 9898.8 9901.2 9837.9 9840.0 9845.8 9867.3 9896.4 7760.0 8591.6 9634.9 9754.6 9763.3 40048.0 40118.2 40490.8 40506.6 40560.8 3535.3 3565.3 3641.2 3663.2 3735.7 31387.7 31868.2 31889.5 32706.2 33362.0 3248.4 3283.8 3307.8 3326.6 3418.0 498379.0 507858.0 512384.0 519071.0 522330.0 35787.0 37016.0 69676.0 70580.0 70666.6 37498.0 37621.8 37884.9 38014.8 38015.4 14295.9 14372.4 15227.6 15418.3 15578.7 12927.9 12994.8 13001.5 13081.7 13131.7 8198.4 8211.5 8296.9 8345.2 8383.8 2979.3 3206.9 3224.9 3474.0 3495.6 927.4 1019.8 1034.9 1050.3 1055.4 29872.0 31520.0 31590.8 31667.4 32293.8 1007.1 1029.0 1034.7 1085.2 1186.3 14094.0 16124.0 16174.8 16312.0 16487.6 594878.0 603099.0 692901.7 702820.0 703602.0 60087.4 60327.4 60568.7 60587.7 60729.0 1400.0 1404.0 1457.5 1461.3 1464.3 30314.5 30975.4 31519.9 31632.0 32043.4 54172.5 59277.4 60995.0 64160.7 64164.0 645317.0 649478.0 654921.0 656735.0 656861.0 45837.3 46222.8 46787.8 46852.8 47094.0 48926.0 49538.3 49549.3 50276.5 51703.7 40337.6 41559.8 42252.2 42493.9 42861.9 31841.7 40118.0 40629.4 40887.2 41936.0 36561.0 38624.0 39773.2 40640.8 42463.8 31205.6 34702.8 35747.3 36356.8 36539.1 21910.0 25012.6 26501.7 26518.5 27179.9 21:05:17 INFO - PROCESS | 1940 | 21:05:17 INFO - PROCESS | 1940 | [#2] jquery.html Cycles:180 Average:34291.80 Median:22042.83 stddev:97506.34 (442.3%) stddev-sans-first:97746.58 21:05:17 INFO - PROCESS | 1940 | Values: 356.4 360.6 378.8 381.5 396.0 19874.0 21091.3 21534.8 21657.4 21666.6 20109.4 20856.7 21094.8 21225.7 21250.0 5666.0 5761.2 6011.9 6048.5 6053.1 5932.5 5951.5 5955.6 5971.8 6024.5 5550.6 5757.0 5834.8 5835.3 5847.3 5656.2 5758.9 5786.7 5803.2 5817.7 5091.2 5108.2 5108.4 5110.1 5129.2 26012.6 26112.0 26247.5 26284.9 26657.5 2097.1 2226.1 2314.9 2528.6 2631.6 12927.4 15749.1 16050.8 16121.8 16161.3 1825.6 1877.8 1894.5 1906.3 1914.8 107934.0 108020.8 114704.4 120392.4 120771.6 10524.9 10759.8 10915.6 11002.8 11141.9 12428.6 12949.4 13674.5 13697.0 13746.8 8479.1 8564.7 8660.1 8674.7 8763.5 7014.9 8679.2 8703.9 8753.8 8793.6 5592.6 6605.3 6663.5 6734.2 6747.8 1667.9 1742.7 1824.8 1855.7 1893.1 778.6 818.2 937.2 974.4 1085.0 21086.0 21892.8 22018.8 22066.9 22145.4 948.6 953.3 987.7 1001.2 1026.8 11289.0 11767.0 11790.0 11791.8 11827.8 555311.0 581763.1 593696.0 598200.0 600993.0 115875.4 116604.0 119909.4 121079.4 122660.0 1039.5 1049.7 1050.7 1065.6 1067.4 18963.1 19152.6 19180.4 19310.4 19374.1 38017.6 52079.0 52446.7 52481.2 52756.7 69929.7 69998.7 70069.6 71145.6 71189.6 5305.0 5344.7 6324.5 7172.0 7743.9 9546.8 11052.3 12795.9 13132.9 13153.6 11422.5 11514.3 11632.5 11666.5 11723.6 11372.8 11467.4 11492.9 11545.9 11547.6 10678.4 11540.4 11621.8 11779.5 11969.5 8307.6 8336.9 8442.0 8459.0 8534.4 11355.8 11412.9 11591.5 11685.9 11777.8 21:05:17 INFO - PROCESS | 1940 | 21:05:17 INFO - PROCESS | 1940 | [#3] mootools.html Cycles:180 Average:5768.55 Median:2563.53 stddev:3258.03 (127.1%) stddev-sans-first:3251.97 21:05:17 INFO - PROCESS | 1940 | Values: 1580.9 1582.7 1601.3 1610.3 1912.9 8063.8 8514.4 8755.7 9290.6 9306.7 8631.8 8806.5 8857.7 8943.5 8985.1 2007.9 2360.5 2367.1 2367.7 2397.3 2048.5 2100.3 2131.3 2303.5 2386.7 2349.0 2369.3 2384.3 2396.1 2399.5 2347.7 2357.5 2358.4 2362.7 2364.9 2353.8 2366.9 2372.1 2374.6 2388.9 8874.0 8896.8 8897.5 8935.1 8935.8 5324.6 5331.6 5430.6 5481.2 5525.2 3483.4 3597.3 3725.7 3738.9 3742.2 1045.5 1089.1 1098.4 1110.8 1128.3 11468.5 11530.7 11700.2 11726.9 11740.2 4771.6 4784.6 4872.5 4896.1 4896.5 10086.9 10245.4 10246.7 10267.4 10278.9 5338.2 5414.0 5426.3 5426.5 5451.2 4007.7 4383.8 4791.4 4936.6 4994.3 4033.9 4081.2 4090.4 4138.1 4203.1 1285.6 1325.6 1327.3 1344.8 1347.9 801.9 908.3 956.2 959.5 1013.1 4558.9 5810.6 6005.6 6024.6 6066.8 453.6 460.7 465.7 467.4 468.0 3956.3 4038.2 4053.4 4107.9 4123.0 10365.3 10642.4 10760.1 10814.6 10821.5 10569.7 10741.5 10761.4 10762.8 10809.7 6438.9 8271.6 8284.9 8393.8 8489.3 5843.3 5903.3 6057.0 6154.4 6349.7 9789.4 9957.7 10059.7 10188.9 10198.7 9843.4 10234.6 10350.2 10491.2 10514.3 7096.9 7538.0 7750.5 7819.1 7980.4 8508.3 8641.3 8644.3 8648.2 8743.0 7537.8 7642.5 7695.7 7791.0 7815.8 7187.4 7412.6 7481.6 7516.4 7553.4 7060.4 7087.1 7139.0 7140.5 7142.1 4439.8 4659.7 4924.6 5029.1 5173.4 5184.8 5205.8 5247.5 5261.3 5363.2 21:05:17 INFO - PROCESS | 1940 | 21:05:17 INFO - PROCESS | 1940 | [#4] prototype.html Cycles:180 Average:4721.10 Median:5324.99 stddev:1466.75 (27.5%) stddev-sans-first:1432.98 21:05:17 INFO - PROCESS | 1940 | Values: 307.7 311.4 312.7 316.2 319.4 5253.3 5342.5 5550.0 5621.6 5622.6 4598.4 5447.0 5464.5 5477.7 5562.8 3985.9 4095.6 4171.3 4196.6 4211.9 4144.5 4163.5 4193.4 4196.3 4197.4 3631.6 3641.5 4053.6 4182.7 4201.1 3535.4 3855.2 3907.3 4111.0 4204.7 3422.3 3547.0 3631.2 3650.2 3654.7 4952.4 5172.6 5199.7 5213.5 5267.8 4357.4 4402.8 4799.2 4817.0 4822.7 5071.0 5327.0 5777.5 5782.1 5782.4 3486.8 3851.7 3986.1 3999.9 4036.9 4739.7 5274.9 5482.9 5658.2 6046.2 4032.5 4055.9 4071.8 4082.5 4086.0 4126.3 4131.7 4138.7 4183.6 4197.2 4447.8 4764.6 4836.6 4836.9 4844.2 5188.5 5459.9 5775.4 5807.3 5868.9 1383.3 1416.2 1418.9 1421.7 1423.9 745.5 851.2 861.9 869.1 917.4 5106.0 5321.3 5341.7 5380.4 5394.6 5889.4 5899.2 5900.7 5907.9 5957.4 4352.7 4953.8 5323.0 5336.6 5428.7 2661.7 2901.9 3099.3 3104.2 3120.9 5049.4 6157.2 6195.3 6195.4 6199.3 5240.7 5763.1 5813.8 6289.9 6295.7 5358.3 5833.0 6370.3 6400.2 6429.2 4521.5 6080.1 6112.9 6113.7 6115.5 5996.7 6016.5 6023.2 6058.0 6081.3 5295.7 5684.7 6009.2 6375.4 6422.0 3621.6 3907.2 3966.7 3975.7 3992.9 5166.1 5493.6 5950.1 6028.0 6041.1 5460.7 5870.5 5926.6 5936.9 5947.8 5626.3 5836.5 5914.6 5917.0 5917.9 5463.2 5581.8 5743.1 5745.2 5765.6 5617.7 5900.8 5920.9 5942.4 5947.0 5761.8 5762.6 5792.4 5809.7 5820.9 21:05:17 INFO - PROCESS | 1940 | 21:05:17 INFO - PROCESS | 1940 | [#5] yui.html Cycles:180 Average:17605.95 Median:28647.00 stddev:23704.51 (82.7%) stddev-sans-first:23737.09 21:05:17 INFO - PROCESS | 1940 | Values: 719.5 801.7 802.1 847.6 856.1 14534.9 15108.8 15184.5 15279.0 15324.3 12888.3 14017.0 14076.4 14117.6 14120.9 885.7 897.9 902.6 904.1 905.7 874.6 891.2 910.9 911.9 917.1 920.3 935.3 951.2 952.2 956.9 933.5 937.6 950.6 952.6 954.3 671.8 685.8 690.1 704.4 708.5 12905.0 13004.2 13136.1 13327.8 13336.7 10035.5 11144.0 11870.9 11967.8 12347.3 10408.4 10750.9 10777.9 10810.6 11150.0 3689.6 3749.9 3755.8 3783.2 3920.8 63021.0 73183.6 73192.2 74689.6 75877.0 11423.8 11465.8 11576.4 11578.1 12027.2 18405.7 21969.5 22026.4 22119.3 22189.0 8168.0 8296.3 8314.5 8360.5 8400.0 4441.1 4541.8 4549.4 4563.2 4565.0 3522.0 3584.6 3611.6 3615.6 3629.0 685.1 695.8 700.9 702.5 707.0 597.3 657.1 683.1 694.9 703.6 8993.6 9056.3 9356.7 9443.7 9518.8 610.6 618.4 644.3 668.6 701.8 3966.6 3994.1 4079.3 4161.8 4214.5 84237.0 85726.0 90551.0 91129.5 91329.0 70279.6 76642.0 77207.0 77410.0 78610.6 46995.5 50702.5 66027.0 71459.6 71768.2 9399.6 9527.9 9734.8 9779.2 9853.1 45529.3 45774.3 46025.5 46145.5 46222.1 56696.7 61813.0 62125.0 62213.0 62270.7 13244.5 13273.7 13310.0 13502.0 13767.9 11697.3 12071.3 12092.9 14009.9 14439.5 11414.5 11568.7 11764.2 11791.5 12154.2 11745.4 11798.9 11799.3 11827.6 11849.5 11590.3 11628.0 11698.5 11710.6 11739.9 9063.3 9284.5 9876.8 9947.7 10293.0 9743.6 9872.3 9978.7 10043.1 10071.0 21:05:17 INFO - PROCESS | 1940 | -------- Summary: end -------- 21:05:17 INFO - PROCESS | 1940 | 21:05:17 INFO - TEST-INFO | 1940: exit 0 21:05:17 INFO - TEST-OK | dromaeo_css | took 1112070ms 21:05:17 INFO - TEST-START | kraken 21:05:17 INFO - operating with platform_type : mac_ 21:05:17 INFO - Initialising browser for kraken test... 21:05:17 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpPZDIJX/profile http://localhost:49466/getInfo.html) 21:05:20 INFO - PROCESS | 1947 | __metrics Screen width/height:1600/1200 21:05:20 INFO - PROCESS | 1947 | colorDepth:24 21:05:20 INFO - PROCESS | 1947 | Browser inner width/height: 1024/689 21:05:20 INFO - PROCESS | 1947 | __metrics 21:05:20 ERROR - PROCESS | 1947 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 21:05:21 INFO - TEST-INFO | 1947: exit 0 21:05:21 INFO - Browser initialized. 21:05:21 INFO - Running cycle 1/1 for kraken test... 21:05:21 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/tmpPZDIJX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:05:33 INFO - PROCESS | 1949 | RSS: Main: 252432384 21:05:33 INFO - PROCESS | 1949 | 21:05:36 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49466/tests/kraken/driver.html?testName=audio-beat-detection) 21:05:37 INFO - PROCESS | 1949 | RSS: Main: 264925184 21:05:37 INFO - PROCESS | 1949 | 21:05:39 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49466/tests/kraken/driver.html?testName=audio-dft) 21:05:40 INFO - PROCESS | 1949 | RSS: Main: 269701120 21:05:40 INFO - PROCESS | 1949 | 21:05:43 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49466/tests/kraken/driver.html?testName=audio-fft) 21:05:44 INFO - PROCESS | 1949 | RSS: Main: 269287424 21:05:44 INFO - PROCESS | 1949 | 21:05:46 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49466/tests/kraken/driver.html?testName=audio-oscillator) 21:05:47 INFO - PROCESS | 1949 | RSS: Main: 270163968 21:05:47 INFO - PROCESS | 1949 | 21:05:49 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49466/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:05:49 INFO - PROCESS | 1949 | RSS: Main: 270696448 21:05:49 INFO - PROCESS | 1949 | 21:05:52 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49466/tests/kraken/driver.html?testName=imaging-darkroom) 21:05:53 INFO - PROCESS | 1949 | RSS: Main: 271007744 21:05:53 INFO - PROCESS | 1949 | 21:05:56 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49466/tests/kraken/driver.html?testName=imaging-desaturate) 21:05:57 INFO - PROCESS | 1949 | RSS: Main: 271171584 21:05:57 INFO - PROCESS | 1949 | 21:06:00 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49466/tests/kraken/driver.html?testName=json-parse-financial) 21:06:01 INFO - PROCESS | 1949 | RSS: Main: 271536128 21:06:01 INFO - PROCESS | 1949 | 21:06:02 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49466/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:06:03 INFO - PROCESS | 1949 | RSS: Main: 271003648 21:06:03 INFO - PROCESS | 1949 | 21:06:05 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49466/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:06:06 INFO - PROCESS | 1949 | RSS: Main: 271060992 21:06:06 INFO - PROCESS | 1949 | 21:06:08 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49466/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:06:09 INFO - PROCESS | 1949 | RSS: Main: 271269888 21:06:09 INFO - PROCESS | 1949 | 21:06:11 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:06:12 INFO - PROCESS | 1949 | RSS: Main: 271306752 21:06:12 INFO - PROCESS | 1949 | 21:06:15 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:06:16 INFO - PROCESS | 1949 | RSS: Main: 271228928 21:06:16 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:49466/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49466/tests/kraken/driver.html?testName=ai-astar) 21:06:18 INFO - PROCESS | 1949 | RSS: Main: 272281600 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | __start_tp_report 21:06:18 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 21:06:18 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 21:06:18 INFO - PROCESS | 1949 | |i|pagename|runs| 21:06:18 INFO - PROCESS | 1949 | |0;ai-astar;167;156;113;116;96;168;102;165;169;169 21:06:18 INFO - PROCESS | 1949 | |1;audio-beat-detection;157;118;163;199;151;139;136;120;167;121 21:06:18 INFO - PROCESS | 1949 | |2;audio-dft;194;229;270;209;196;198;194;196;192;193 21:06:18 INFO - PROCESS | 1949 | |3;audio-fft;74;82;74;143;63;73;72;84;164;83 21:06:18 INFO - PROCESS | 1949 | |4;audio-oscillator;71;72;119;71;72;81;114;69;73;116 21:06:18 INFO - PROCESS | 1949 | |5;imaging-gaussian-blur;88;87;88;85;88;87;90;78;134;132 21:06:18 INFO - PROCESS | 1949 | |6;imaging-darkroom;96;142;94;147;151;95;96;99;151;152 21:06:18 INFO - PROCESS | 1949 | |7;imaging-desaturate;108;91;125;154;101;151;119;151;92;119 21:06:18 INFO - PROCESS | 1949 | |8;json-parse-financial;54;58;54;62;85;90;88;91;57;57 21:06:18 INFO - PROCESS | 1949 | |9;json-stringify-tinderbox;69;71;71;88;66;114;112;109;104;60 21:06:18 INFO - PROCESS | 1949 | |10;stanford-crypto-aes;87;106;110;112;108;87;106;102;152;89 21:06:18 INFO - PROCESS | 1949 | |11;stanford-crypto-ccm;128;155;150;150;155;150;139;139;147;128 21:06:18 INFO - PROCESS | 1949 | |12;stanford-crypto-pbkdf2;169;195;228;165;225;212;169;167;160;168 21:06:18 INFO - PROCESS | 1949 | |13;stanford-crypto-sha256-iterative;68;68;71;80;84;86;75;65;66;65 21:06:18 INFO - PROCESS | 1949 | __end_tp_report 21:06:18 INFO - PROCESS | 1949 | __start_cc_report 21:06:18 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,1066 21:06:18 INFO - PROCESS | 1949 | __end_cc_report 21:06:18 INFO - PROCESS | 1949 | __startTimestamp1464321978292__endTimestamp 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | ------- Summary: start ------- 21:06:18 INFO - PROCESS | 1949 | Number of tests: 14 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#0] ai-astar Cycles:10 Average:142.10 Median:167.50 stddev:31.12 (18.6%) stddev-sans-first:31.68 21:06:18 INFO - PROCESS | 1949 | Values: 167.0 156.0 113.0 116.0 96.0 168.0 102.0 165.0 169.0 169.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:154.00 stddev:25.62 (16.6%) stddev-sans-first:26.92 21:06:18 INFO - PROCESS | 1949 | Values: 157.0 118.0 163.0 199.0 151.0 139.0 136.0 120.0 167.0 121.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#2] audio-dft Cycles:10 Average:207.10 Median:197.00 stddev:24.81 (12.6%) stddev-sans-first:25.86 21:06:18 INFO - PROCESS | 1949 | Values: 194.0 229.0 270.0 209.0 196.0 198.0 194.0 196.0 192.0 193.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#3] audio-fft Cycles:10 Average:91.20 Median:74.00 stddev:33.79 (45.7%) stddev-sans-first:35.26 21:06:18 INFO - PROCESS | 1949 | Values: 74.0 82.0 74.0 143.0 63.0 73.0 72.0 84.0 164.0 83.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#4] audio-oscillator Cycles:10 Average:85.80 Median:71.50 stddev:21.34 (29.8%) stddev-sans-first:21.95 21:06:18 INFO - PROCESS | 1949 | Values: 71.0 72.0 119.0 71.0 72.0 81.0 114.0 69.0 73.0 116.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:87.50 stddev:19.93 (22.8%) stddev-sans-first:20.94 21:06:18 INFO - PROCESS | 1949 | Values: 88.0 87.0 88.0 85.0 88.0 87.0 90.0 78.0 134.0 132.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#6] imaging-darkroom Cycles:10 Average:122.30 Median:94.50 stddev:27.89 (29.5%) stddev-sans-first:27.91 21:06:18 INFO - PROCESS | 1949 | Values: 96.0 142.0 94.0 147.0 151.0 95.0 96.0 99.0 151.0 152.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#7] imaging-desaturate Cycles:10 Average:121.10 Median:151.00 stddev:24.09 (16.0%) stddev-sans-first:25.08 21:06:18 INFO - PROCESS | 1949 | Values: 108.0 91.0 125.0 154.0 101.0 151.0 119.0 151.0 92.0 119.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#8] json-parse-financial Cycles:10 Average:69.60 Median:73.50 stddev:16.49 (22.4%) stddev-sans-first:16.49 21:06:18 INFO - PROCESS | 1949 | Values: 54.0 58.0 54.0 62.0 85.0 90.0 88.0 91.0 57.0 57.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#9] json-stringify-tinderbox Cycles:10 Average:86.40 Median:67.50 stddev:21.42 (31.7%) stddev-sans-first:21.78 21:06:18 INFO - PROCESS | 1949 | Values: 69.0 71.0 71.0 88.0 66.0 114.0 112.0 109.0 104.0 60.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#10] stanford-crypto-aes Cycles:10 Average:105.90 Median:132.00 stddev:18.85 (14.3%) stddev-sans-first:18.71 21:06:18 INFO - PROCESS | 1949 | Values: 87.0 106.0 110.0 112.0 108.0 87.0 106.0 102.0 152.0 89.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#11] stanford-crypto-ccm Cycles:10 Average:144.10 Median:150.00 stddev:10.12 (6.7%) stddev-sans-first:8.89 21:06:18 INFO - PROCESS | 1949 | Values: 128.0 155.0 150.0 150.0 155.0 150.0 139.0 139.0 147.0 128.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.80 Median:182.00 stddev:26.71 (14.7%) stddev-sans-first:27.63 21:06:18 INFO - PROCESS | 1949 | Values: 169.0 195.0 228.0 165.0 225.0 212.0 169.0 167.0 160.0 168.0 21:06:18 INFO - PROCESS | 1949 | 21:06:18 INFO - PROCESS | 1949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:73.00 stddev:7.98 (10.9%) stddev-sans-first:8.28 21:06:18 INFO - PROCESS | 1949 | Values: 68.0 68.0 71.0 80.0 84.0 86.0 75.0 65.0 66.0 65.0 21:06:18 INFO - PROCESS | 1949 | -------- Summary: end -------- 21:06:18 INFO - PROCESS | 1949 | 21:06:19 INFO - TEST-INFO | 1949: exit 0 21:06:19 INFO - TEST-OK | kraken | took 61472ms 21:06:19 INFO - SUITE-END | took 1173s 21:06:19 INFO - Completed test suite (00:19:33) 21:06:19 INFO - javascript benchmark 21:06:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7287.109533102318, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2832.872520736566, 2881.573621057577, 3473.895783126507, 3500.9824950875227, 3513.8067406292653, 4962.2556616507545, 5199.558037566807, 5819.709014549271, 5862.413758624136, 5887.705614719268, 5645.463680950314, 5793.275840519935, 5793.681347525884, 5806.10005449155, 5880.059190529516, 5225.294585230993, 5253.395859476171, 5263.34208223972, 5386.649867758583, 5406.91889621656, 4507.842225522108, 5397.54120899724, 5493.313335833021, 5499.587530935176, 5512.310961129859, 5188.273641690166, 5288.788448462057, 5316.76074576645, 5322.600804939645, 5344.118220493653, 5298.205269209611, 5317.12267475866, 5323.0, 5332.786688532454, 5337.919931201035, 5211.088059589557, 5297.443768404339, 5306.283651707009, 5335.253064570963, 5364.839054828361, 5408.675479471205, 5474.835754927359, 5515.751791169367, 5565.5825813063775, 5602.635828671123, 6048.123022161806, 6150.323464418911, 6151.2618485781995, 6151.292601350857, 6174.197354343906, 6146.416090471398, 6160.722767475474, 6175.0, 6199.3490683478485, 6205.28639206488, 5951.791687290924, 6021.126936594169, 6050.818475445743, 6055.182550355689, 6085.4827339676185, 6312.305646378986, 6337.207849018872, 6390.7443702251385, 6396.808095757135, 6397.040443933354, 4995.300657907896, 6120.599512025131, 6152.538559607958, 6211.223597050369, 6230.7819226326865, 6237.282712488031, 6280.340564240781, 6295.087212354183, 6298.622082675054, 6308.369163083747, 5568.331800184003, 5990.9101363479585, 6136.509079273647, 6224.782132625336, 6242.469390101802, 6104.481119104837, 6154.78458253959, 6159.353267906895, 6265.028920517327, 6288.151099601587, 4969.204927211701, 4975.825846095369, 4987.600991920638, 4991.550760431579, 5010.799568017312, 4430.867073987785, 4459.264221403432, 4468.419105516327, 4472.8210871565425, 4503.594676479067, 5793.681347525842, 5907.881842363128, 5980.820575382745, 6046.606970546901, 6050.727717252734, 5267.420583735786, 6209.857564314964, 6273.153124328157, 6280.9685951569945, 6303.747850086037, 4964.851054468371, 6056.394360563909, 6058.182145410313, 6075.088736689532, 6085.5435842312, 5340.839774806762, 5411.0, 5432.972835135799, 5480.616356855062, 5490.890182196414, 6460.160179176677, 6464.838379040561, 6464.870702585922, 6474.482041436674, 6486.6756662167645, 6248.718807653758, 6257.186565746424, 6260.74957001733, 6277.340879207617, 6278.15244941927, 6153.630782153085, 6313.43179113882, 6323.588966717149, 6362.9681851592295, 6408.871822563429, 6230.968845155927, 6234.625922444668, 6239.469645080219, 6254.9687251563455, 6259.749610015549, 5115.846524604268, 5303.867403314794, 6259.092431597484, 6283.748650053946, 6293.779717709858, 5974.701264936823, 6018.969905150446, 6098.29869564988, 6120.724567394389, 6161.784337548164, 6106.855059071331, 6115.145512192008, 6147.538934579835, 6175.413335733098, 6193.473554747897, 5929.466348028698, 5934.881302374015, 6061.515078793598, 6092.817215483543, 6136.048912418582, 6083.330833608211, 6237.906431403442, 6240.7503699851495, 6258.249010118633, 6280.0, 5082.745862706776, 5959.0, 6127.080937859357, 6134.171886795226, 6187.690615469299], "value": 5715.764237615136, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.87044933092716, 525.1256657664989, 528.6537318056673, 545.9890802183957, 555.6249531566197, 39238.84186369752, 42395.0, 42397.57602423975, 42447.57552424475, 42484.57515424845, 43233.135337293235, 43919.902002449955, 43945.90135246621, 44138.55861441384, 44174.0, 9600.80798384032, 9755.902440975606, 9843.409395436262, 9848.704538863809, 9850.40897546146, 9743.220542356594, 9855.753606159831, 9856.359336643096, 9888.752781180456, 9920.95039524805, 9817.852732209023, 9887.505624718771, 9892.653757118502, 9898.802023959517, 9901.158401535879, 9837.901620983806, 9839.950800245988, 9845.80308393828, 9867.259955503294, 9896.356736812157, 7759.9612001940195, 8591.613377398033, 9634.90365096354, 9754.609815607368, 9763.26775491841, 40047.99880002994, 40118.19763604741, 40490.79754601238, 40506.594934050576, 40560.79719601413, 3535.275268569937, 3565.322588708163, 3641.18073433478, 3663.1757854482794, 3735.7384983051197, 31387.686123138934, 31868.20329491758, 31889.53981576669, 32706.182345441553, 33362.0, 3248.3990461764647, 3283.770136090475, 3307.818070006149, 3326.600807903043, 3418.008777454535, 498379.0, 507858.0, 512384.0, 519071.0, 522330.0, 35787.0, 37016.0, 69676.0, 70580.0, 70666.64666676633, 37498.0, 37621.81189094037, 37884.86345409587, 38014.80992595019, 38015.42976855349, 14295.92852035733, 14372.35324410404, 15227.619309517351, 15418.306176222097, 15578.688426231412, 12927.870721292667, 12994.805077923838, 13001.544945926848, 13081.672958175932, 13131.737365252642, 8198.38512111594, 8211.507309561446, 8296.875546866802, 8345.207205315486, 8383.790405239917, 2979.3147576057627, 3206.9358612828078, 3224.8712950467147, 3473.982630086884, 3495.632958539317, 927.3832901120815, 1019.7858449725493, 1034.9327293725885, 1050.3404620699278, 1055.4300677634146, 29872.0, 31520.0, 31590.842045790083, 31667.366652666817, 32293.838530807196, 1007.1187710753092, 1029.0, 1034.715453250347, 1085.2457542008228, 1186.288227063755, 14094.0, 16124.0, 16174.75737863933, 16312.0, 16487.587810304598, 594878.0, 603099.0, 692901.7484388022, 702820.0, 703602.0, 60087.399126009055, 60327.39672603218, 60568.69715651393, 60587.69706151441, 60729.0, 1400.033976556173, 1403.9578812635636, 1457.4825936792497, 1461.2766680493223, 1464.3410465290663, 30314.545281821232, 30975.380492390475, 31519.896803611762, 31632.0, 32043.359132816746, 54172.45827541832, 59277.40722592892, 60995.0, 64160.67919660558, 64164.03753943788, 645317.0, 649478.0, 654921.0, 656735.0, 656861.0, 45837.31244031409, 46222.768886155354, 46787.766061169474, 46852.76573617246, 47094.0, 48926.02147957092, 49538.25692614542, 49549.29338581173, 50276.49723502718, 51703.74148129235, 40337.59662403339, 41559.7922010388, 42252.15495690131, 42493.93765155896, 42861.928451788954, 31841.7263309465, 40118.0, 40629.390559141044, 40887.1822563553, 41936.0, 36561.0, 38624.0, 39773.204535909696, 40640.79679601583, 42463.787681061396, 31205.59574819093, 34702.82648586741, 35747.28505429929, 36356.81821590981, 36539.08652283608, 21910.014049368136, 25012.62481062749, 26501.674916253723, 26518.469630607666, 27179.86410067937], "value": 19686.953850667076, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.37456264256224, 360.59793330436565, 378.82574015952645, 381.4526154967622, 395.98430026980793, 19873.97574157556, 21091.2618058368, 21534.81558514283, 21657.350279491602, 21666.566668666655, 20109.396718098444, 20856.687149692767, 21094.789052109474, 21225.681614775753, 21250.043748031338, 5665.951798917193, 5761.193432919395, 6011.939880601203, 6048.485878700316, 6053.122297266894, 5932.466078052975, 5951.49412299955, 5955.612885162473, 5971.761129554812, 6024.518038556905, 5550.611457197998, 5757.021306377905, 5834.795782147626, 5835.299764028323, 5847.327557330919, 5656.208130861683, 5758.856028599276, 5786.739596718136, 5803.21656576361, 5817.7091145442555, 5091.1854103343285, 5108.182690769459, 5108.361454818148, 5110.080185566597, 5129.230615407681, 26012.609810852853, 26112.0, 26247.475050499073, 26284.948602055894, 26657.466850663073, 2097.0877668214375, 2226.1318085946496, 2314.90740370385, 2528.6333481645243, 2631.5921032240035, 12927.418266178045, 15749.133797641125, 16050.839491605051, 16121.83878161215, 16161.272742726605, 1825.6257467219189, 1877.7934427212995, 1894.526368407898, 1906.2756152662039, 1914.7606549181353, 107934.0, 108020.75937721881, 114704.42647786708, 120392.39803800925, 120771.58456830814, 10524.947375263075, 10759.83860242097, 10915.56337746497, 11002.779944401227, 11141.94429027866, 12428.63285038645, 12949.417276222594, 13674.453021879013, 13697.041207115606, 13746.793798093036, 8479.06730259671, 8564.700235491853, 8660.13398660129, 8674.739757807276, 8763.518006509576, 7014.859702806018, 8679.218870301704, 8703.869441958375, 8753.824923501494, 8793.604287807064, 5592.636478628876, 6605.339466053356, 6663.5335526513645, 6734.158230221223, 6747.797566073025, 1667.8915870468622, 1742.7278086996564, 1824.7901491328403, 1855.7030875060195, 1893.1386219270198, 778.6496076765478, 818.2390376949494, 937.1846493550519, 974.4056125763278, 1084.978300433987, 21086.0, 21892.78107218939, 22018.779812201672, 22066.88966555157, 22145.446363841034, 948.6205517792938, 953.2659851913987, 987.7431867714303, 1001.1590264178126, 1026.8305729554688, 11289.0, 11766.999805016498, 11790.0, 11791.823122653168, 11827.822582661267, 555311.0, 581763.0911845414, 593696.0, 598200.0, 600993.0, 115875.42062289634, 116604.0, 119909.40045299717, 121079.39460302642, 122660.0, 1039.5477967084344, 1049.7218237167158, 1050.7425680708275, 1065.6376831877199, 1067.4235912607105, 18963.14665840013, 19152.61694766125, 19180.424587262405, 19310.420687379403, 19374.128164232363, 38017.61982380252, 52079.0, 52446.73776631092, 52481.21278180754, 52756.736216320205, 69929.65035174791, 69998.65000675168, 70069.64965175142, 71145.6442717783, 71189.64405177941, 5304.9734751326, 5344.679319240858, 6324.525660575383, 7172.0, 7743.915851780643, 9546.809063818824, 11052.281601695864, 12795.93602031984, 13132.868671313165, 13153.60539183826, 11422.543098275975, 11514.251573647685, 11632.53469861196, 11666.475008624462, 11723.648290551297, 11372.772544548898, 11467.4266286687, 11492.94253528727, 11545.88454115448, 11547.595834145764, 10678.412687301961, 11540.365279909685, 11621.849957757842, 11779.469923853618, 11969.521219151136, 8307.626156822836, 8336.87494687568, 8441.95779021101, 8458.984921809422, 8534.359923005675, 11355.829662554903, 11412.942935285271, 11591.536338546364, 11685.941570292094, 11777.823332649845], "value": 9691.282836231923, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1580.9367625294988, 1582.67555151194, 1601.26341882734, 1610.2914717524288, 1912.9426117216487, 8063.798405039877, 8514.446560973533, 8755.693550725726, 9290.581923813435, 9306.674266400678, 8631.784205394853, 8806.515641639708, 8857.734267971971, 8943.463392196472, 8985.146411090936, 2007.9357940291595, 2360.539694759518, 2367.088670861722, 2367.7277113132036, 2397.30478161333, 2048.4673984763995, 2100.348891843526, 2131.2540610786255, 2303.516261585069, 2386.7135943686694, 2348.9530209395803, 2369.277370402027, 2384.3443053160345, 2396.149366974725, 2399.520095980802, 2347.7417484076823, 2357.5167090746354, 2358.3750306168877, 2362.6692263083096, 2364.893579788905, 2353.776391242829, 2366.8698221597806, 2372.146027430124, 2374.584447721659, 2388.904443822245, 8873.979492358398, 8896.822063558693, 8897.510636915033, 8935.061818509028, 8935.821283574358, 5324.600654950894, 5331.573474122061, 5430.59270554706, 5481.205225242357, 5525.171224316345, 3483.372992861284, 3597.280543891206, 3725.720570957189, 3738.8504459821575, 3742.1954279829965, 1045.5451878432907, 1089.1341383600056, 1098.3739268616891, 1110.8167152419921, 1128.2891778179776, 11468.541258349656, 11530.711732206762, 11700.180987330976, 11726.88273117275, 11740.178187526877, 4771.604876933884, 4784.569388755029, 4872.537108974641, 4896.143174944371, 4896.510348965075, 10086.949565252127, 10245.385276883262, 10246.743831404274, 10267.435291059064, 10278.897211027943, 5338.225957236179, 5414.0, 5426.267453893753, 5426.538744206708, 5451.236826844245, 4007.699422543321, 4383.7588932609015, 4791.401074865642, 4936.580390666762, 4994.300797888299, 4033.9193216135513, 4081.1837632473625, 4090.427340172378, 4138.0689344897155, 4203.117345357509, 1285.5500574798932, 1325.6354502511695, 1327.3230652367363, 1344.8031252185563, 1347.9081943625695, 801.9398545109024, 908.318760929303, 956.1585804492141, 959.5250351076122, 1013.0932815130565, 4558.88602784933, 5810.564207684441, 6005.609635373687, 6024.614338702036, 6066.787662431793, 453.63482396671, 460.73968207963065, 465.69031593989615, 467.39705779544687, 467.99532004680196, 3956.2680904032272, 4038.212548553004, 4053.351463765783, 4107.8973025674, 4123.0, 10365.274430789772, 10642.414667193223, 10760.085392741705, 10814.56741730322, 10821.458927053773, 10569.735756606146, 10741.51663175159, 10761.408122553177, 10762.78474430507, 10809.729756755987, 6438.905386084377, 8271.627776750061, 8284.875726864102, 8393.832123357499, 8489.278411334983, 5843.29880414353, 5903.321118071477, 6056.969715151572, 6154.3845615438095, 6349.68251587428, 9789.363691360039, 9957.651482198089, 10059.748506287402, 10188.898111018794, 10198.745031374276, 9843.360181588174, 10234.590616375262, 10350.171986241234, 10491.160707143257, 10514.26400151982, 7096.858062838611, 7538.0, 7750.457467977188, 7819.139894611474, 7980.361571074184, 8508.319334453105, 8641.265492432962, 8644.308455323433, 8648.1784230498, 8743.0, 7537.773866784005, 7642.4650274480255, 7695.692172313269, 7790.987171667647, 7815.843683126419, 7187.425005999612, 7412.555246685216, 7481.625918703934, 7516.436267279866, 7553.357964573072, 7060.364567188978, 7087.149542054986, 7139.036230108869, 7140.46446516503, 7142.142942846684, 4439.800208990668, 4659.671993481841, 4924.581410580141, 5029.145045342228, 5173.430922598586, 5184.7926082956255, 5205.791768329224, 5247.527722504993, 5261.342332208474, 5363.19552067193], "value": 4555.799008233367, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.74764692951777, 311.43163726199685, 312.72636443112276, 316.1937060495734, 319.3931530092822, 5253.3170687810625, 5342.492463215998, 5550.0, 5621.606487545873, 5622.56624560737, 4598.356230127785, 5447.019536483432, 5464.535464535465, 5477.726113694309, 5562.805301814437, 3985.880423587297, 4095.5699651536456, 4171.290880550298, 4196.601322874322, 4211.862797044796, 4144.523379811315, 4163.479565054368, 4193.391958166064, 4196.265653510639, 4197.391378250152, 3631.6005239423775, 3641.4537819327047, 4053.5946405359523, 4182.724269097924, 4201.117765269297, 3535.4166562517153, 3855.1904100139004, 3907.2576210520197, 4110.972256935766, 4204.663626909855, 3422.349753546818, 3546.9536486736215, 3631.2011357501306, 3650.1787097903025, 3654.671079602822, 4952.356193694833, 5172.560332371753, 5199.662021968597, 5213.452587478336, 5267.815626453055, 4357.444791214015, 4402.820603801107, 4799.160146974265, 4817.0, 4822.6624136310475, 5071.0, 5326.98787230425, 5777.480026797609, 5782.132680097977, 5782.421757824226, 3486.8493397179122, 3851.6533511983775, 3986.123052928351, 3999.920001599952, 4036.9192616147807, 4739.668223224341, 5274.92087618686, 5482.930828488446, 5658.227468540385, 6046.221111805122, 4032.516098068251, 4055.8986025349013, 4071.776052317092, 4082.510098788164, 4085.97957010219, 4126.277901367249, 4131.669466442678, 4138.710290279651, 4183.644390226804, 4197.202531519001, 4447.82056792176, 4764.618830493621, 4836.588889944394, 4836.903261934742, 4844.176489996709, 5188.507091826346, 5459.918101228484, 5775.422457754191, 5807.274090738658, 5868.882622347529, 1383.3429121167364, 1416.2423103639503, 1418.8793952513945, 1421.7085497472992, 1423.8932080094035, 745.5005146551823, 851.1828644501348, 861.9138086191456, 869.0744357259498, 917.3899356927702, 5106.0, 5321.3348331458565, 5341.679499230058, 5380.381256155514, 5394.64934779246, 5889.352171261158, 5899.233099697012, 5900.675462849585, 5907.873165660359, 5957.434043765836, 4352.712578110559, 4953.7523123844385, 5323.0, 5336.639157015014, 5428.70142142186, 2661.695769073179, 2901.868271374166, 3099.2561785171847, 3104.1530289477723, 3120.9219769505944, 5049.394072711225, 6157.199564056644, 6195.349488303663, 6195.411435913581, 6199.3490683478485, 5240.737963101829, 5763.106718458645, 5813.767449302065, 6289.937100628935, 6295.653739044396, 5358.276632654542, 5832.9708351457975, 6370.331115232926, 6400.199975003125, 6429.164208652939, 4521.480029796616, 6080.087986802015, 6112.938870611237, 6113.685557605137, 6115.462083235585, 5996.700164991646, 6016.4885984690045, 6023.1567580537885, 6058.0, 6081.27024757032, 5295.696372078159, 5684.7157642118555, 6009.188759517409, 6375.362463753588, 6421.967890160519, 3621.60162382143, 3907.183159830692, 3966.7421617594764, 3975.7216994811242, 3992.941870404287, 5166.121759300852, 5493.560515158698, 5950.107483877453, 6028.0, 6041.124037014521, 5460.6996615186545, 5870.5010074144175, 5926.644401335933, 5936.851578710394, 5947.791827286197, 5626.2685850839125, 5836.533077353886, 5914.550935020948, 5916.970415147896, 5917.881642367214, 5463.235147079333, 5581.776728930798, 5743.1385292206505, 5745.195672605755, 5765.5675824314185, 5617.74720137603, 5900.822975310747, 5920.8815823684145, 5942.3955532006985, 5947.0, 5761.769529218952, 5762.625429347079, 5792.350818984013, 5809.680467574324, 5820.854478637899], "value": 4246.62669874451, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.4532155561773, 801.6753214947945, 802.1497212954268, 847.5635047950307, 856.0626114404732, 14534.854651453483, 15108.773368399468, 15184.544463666107, 15279.006864553796, 15324.310406031727, 12888.291143987077, 14017.0, 14076.436942522312, 14117.57647270581, 14120.858791412084, 885.6590212768099, 897.9371443998923, 902.6163880350857, 904.1094521895927, 905.7282815155427, 874.5976850648709, 891.2379915172531, 910.927125829932, 911.8905731312219, 917.1470532404861, 920.3235621817959, 935.3218916285706, 951.2152474208771, 952.1573407534313, 956.9473678947655, 933.5425641435716, 937.5546615357719, 950.5722424908819, 952.5808644196601, 954.3367359685021, 671.7883866582011, 685.8148299958983, 690.0994202565649, 704.3660705365161, 708.4898872811619, 12905.0, 13004.21974681522, 13136.146150500283, 13327.800082998763, 13336.733265334737, 10035.498225088717, 11144.0, 11870.940645296718, 11967.760644787055, 12347.259164450163, 10408.425583643042, 10750.946245268724, 10777.892221077767, 10810.621628242974, 11149.99650031501, 3689.5756987946193, 3749.850005999784, 3755.755875868087, 3783.205526839367, 3920.8039598019986, 63020.99999999954, 73183.63408182925, 73192.17019574554, 74689.6265518669, 75877.0, 11423.771524569629, 11465.828012579817, 11576.36330001858, 11578.131640127023, 12027.232599316621, 18405.723914141297, 21969.450763730714, 22026.44933876666, 22119.336419907428, 22189.0, 8167.95916020428, 8296.25333719956, 8314.542700151549, 8360.498370097814, 8400.033996090406, 4441.089576636782, 4541.795619197144, 4549.363089167519, 4563.224251877123, 4564.977175114103, 3522.0, 3584.62361452049, 3611.566612006576, 3615.5661320641166, 3629.0383048491644, 685.0922527650882, 695.7669180824379, 700.8878579427267, 702.5328156775687, 706.9823254418578, 597.2802772658936, 657.1457105762489, 683.1255992329826, 694.8506071194718, 703.63762662229, 8993.640254389882, 9056.320775941831, 9356.719298421058, 9443.716688499357, 9518.762030949143, 610.5817515002237, 618.4434009391583, 644.2944975252092, 668.5921587831419, 701.7999870037015, 3966.5636779954184, 3994.1013272013565, 4079.3065178919655, 4161.791910404529, 4214.494260688675, 84237.0, 85726.0, 90551.0, 91129.54435227915, 91329.0, 70279.64860175666, 76642.0, 77207.0, 77410.0, 78610.6069469649, 46995.53004469912, 50702.49297507051, 66027.0, 71459.64270178616, 71768.2057948545, 9399.577019034297, 9527.857082143635, 9734.805303894023, 9779.217662586834, 9853.113219810251, 45529.31706024346, 45774.313385299916, 46025.53974460212, 46145.53854461547, 46222.07555848931, 56696.71651641715, 61813.0, 62125.0, 62213.0, 62270.688646556475, 13244.53644122451, 13273.66815829612, 13310.0, 13502.0, 13767.931160344135, 11697.2981621103, 12071.275723456269, 12092.939535302266, 14009.859901400856, 14439.494617688331, 11414.48634811452, 11568.652940411801, 11764.176507644383, 11791.469383877919, 12154.209976351509, 11745.412729363668, 11798.941005294919, 11799.292042477478, 11827.586034488751, 11849.52601895949, 11590.304581725124, 11628.0, 11698.532058717896, 11710.648680539598, 11739.941300293785, 9063.274938004812, 9284.489353085644, 9876.802463950824, 9947.701568952943, 10293.0, 9743.610255589698, 9872.259580531345, 9978.700638980843, 10043.118668344425, 10070.99290070987], "value": 7096.512848144, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1677.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 156.0, 113.0, 116.0, 96.0, 168.0, 102.0, 165.0, 169.0, 169.0], "value": 142.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 118.0, 163.0, 199.0, 151.0, 139.0, 136.0, 120.0, 167.0, 121.0], "value": 147.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 229.0, 270.0, 209.0, 196.0, 198.0, 194.0, 196.0, 192.0, 193.0], "value": 207.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 82.0, 74.0, 143.0, 63.0, 73.0, 72.0, 84.0, 164.0, 83.0], "value": 91.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 119.0, 71.0, 72.0, 81.0, 114.0, 69.0, 73.0, 116.0], "value": 85.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 85.0, 88.0, 87.0, 90.0, 78.0, 134.0, 132.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 142.0, 94.0, 147.0, 151.0, 95.0, 96.0, 99.0, 151.0, 152.0], "value": 122.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 91.0, 125.0, 154.0, 101.0, 151.0, 119.0, 151.0, 92.0, 119.0], "value": 121.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 54.0, 62.0, 85.0, 90.0, 88.0, 91.0, 57.0, 57.0], "value": 69.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 71.0, 88.0, 66.0, 114.0, 112.0, 109.0, 104.0, 60.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 106.0, 110.0, 112.0, 108.0, 87.0, 106.0, 102.0, 152.0, 89.0], "value": 105.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 155.0, 150.0, 150.0, 155.0, 150.0, 139.0, 139.0, 147.0, 128.0], "value": 144.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 195.0, 228.0, 165.0, 225.0, 212.0, 169.0, 167.0, 160.0, 168.0], "value": 185.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 71.0, 80.0, 84.0, 86.0, 75.0, 65.0, 66.0, 65.0], "value": 72.8, "unit": "score"}]}]} 21:06:19 INFO - Return code: 0 21:06:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:06:19 ERROR - # TBPL SUCCESS # 21:06:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:06:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:06:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:06:19 INFO - 2016-05-26 21:06:19.603 screenresolution[1954:13167] starting screenresolution argv=screenresolution get 21:06:19 INFO - 2016-05-26 21:06:19.605 screenresolution[1954:13167] Display 0: 1600x1200x32@60 21:06:19 INFO - 2016-05-26 21:06:19.611 screenresolution[1955:13170] starting screenresolution argv=screenresolution list 21:06:19 INFO - Available Modes on Display 0 21:06:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:06:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:06:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:06:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:06:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:06:19 INFO - Intel Iris: 21:06:19 INFO - Chipset Model: Intel Iris 21:06:19 INFO - Type: GPU 21:06:19 INFO - Bus: Built-In 21:06:19 INFO - VRAM (Dynamic, Max): 1536 MB 21:06:19 INFO - Vendor: Intel (0x8086) 21:06:19 INFO - Device ID: 0x0a2e 21:06:19 INFO - Revision ID: 0x0009 21:06:19 INFO - Displays: 21:06:19 INFO - Display: 21:06:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:06:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:06:19 INFO - Display Serial Number: 1600x1200 60 21:06:19 INFO - Main Display: Yes 21:06:19 INFO - Mirror: Off 21:06:19 INFO - Online: Yes 21:06:19 INFO - Rotation: Supported 21:06:19 INFO - Return code: 0 21:06:19 INFO - Running post-action listener: _resource_record_post_action 21:06:19 INFO - ##### 21:06:19 INFO - ##### Finished run-tests step (success) 21:06:19 INFO - ##### 21:06:19 INFO - Running post-run listener: _resource_record_post_run 21:06:19 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 1822720; Write bytes: 698864640; Read time: 19; Write time: 2145 21:06:19 INFO - TinderboxPrint: CPU usage
54.5% 21:06:19 INFO - TinderboxPrint: I/O read bytes / time
1,822,720 / 19 21:06:19 INFO - TinderboxPrint: I/O write bytes / time
698,864,640 / 2,145 21:06:19 INFO - TinderboxPrint: CPU idle
2,204.7 (45.5%) 21:06:19 INFO - TinderboxPrint: CPU system
976.5 (20.2%) 21:06:19 INFO - TinderboxPrint: CPU user
1,660.5 (34.3%) 21:06:19 INFO - TinderboxPrint: Swap in / out
399,912,960 / 0 21:06:19 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 387283456; Write bytes: 382175232; Read time: 28950; Write time: 712 21:06:19 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 987136; Write bytes: 297188352; Read time: 15; Write time: 1385 21:06:20 INFO - Running post-run listener: _upload_blobber_files 21:06:20 INFO - Blob upload gear active. 21:06:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:06:20 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 21:06:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:06:20 INFO - (blobuploader) - INFO - Open directory for files ... 21:06:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:06:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:06:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:21 INFO - (blobuploader) - INFO - Done attempting. 21:06:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:06:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:06:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:22 INFO - (blobuploader) - INFO - Done attempting. 21:06:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:06:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:06:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:06:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:06:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:06:25 INFO - (blobuploader) - INFO - Done attempting. 21:06:25 INFO - (blobuploader) - INFO - Iteration through files over. 21:06:25 INFO - Return code: 0 21:06:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:06:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:06:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/059f01096747978a1fcd36ab38b17957540848aaa1760b3d3df6689fa08a85bb65fe9c2a51f77646e3755f791426bbdefa08b16f9277d5a789fb8efb751416c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/566f2907ef61eda7471409e99cca0ec3b865390f8715246cfec324fc6fe8b3b136369281845969db4f2fbf2caf3c94063b164407ded6707c505d577d5a478b66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/075b9177c668e5b12c19df6e1bd972bad3729c0a3d3ca8e69f21fcf50eb3c354c86a371a7ebfbac865752fbca5b0f456d7d726539d07cdf79f77d7e9f1d544ea"} 21:06:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:06:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:06:25 INFO - Contents: 21:06:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/059f01096747978a1fcd36ab38b17957540848aaa1760b3d3df6689fa08a85bb65fe9c2a51f77646e3755f791426bbdefa08b16f9277d5a789fb8efb751416c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/566f2907ef61eda7471409e99cca0ec3b865390f8715246cfec324fc6fe8b3b136369281845969db4f2fbf2caf3c94063b164407ded6707c505d577d5a478b66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/075b9177c668e5b12c19df6e1bd972bad3729c0a3d3ca8e69f21fcf50eb3c354c86a371a7ebfbac865752fbca5b0f456d7d726539d07cdf79f77d7e9f1d544ea"} 21:06:25 INFO - Running post-run listener: copy_logs_to_upload_dir 21:06:25 INFO - Copying logs to upload dir... 21:06:25 INFO - mkdir: /builds/slave/test/build/upload/logs 21:06:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.619075 ========= master_lag: 1.62 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-05-26 21:06:27.025447) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 21:06:27.028776) ========= 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.kz9NW65ojj/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.lVg7b6oTz9/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/059f01096747978a1fcd36ab38b17957540848aaa1760b3d3df6689fa08a85bb65fe9c2a51f77646e3755f791426bbdefa08b16f9277d5a789fb8efb751416c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/566f2907ef61eda7471409e99cca0ec3b865390f8715246cfec324fc6fe8b3b136369281845969db4f2fbf2caf3c94063b164407ded6707c505d577d5a478b66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/075b9177c668e5b12c19df6e1bd972bad3729c0a3d3ca8e69f21fcf50eb3c354c86a371a7ebfbac865752fbca5b0f456d7d726539d07cdf79f77d7e9f1d544ea"} build_url:https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011209 build_url: 'https://queue.taskcluster.net/v1/task/EMcj2RZQQKqeh5QLFYafAQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/059f01096747978a1fcd36ab38b17957540848aaa1760b3d3df6689fa08a85bb65fe9c2a51f77646e3755f791426bbdefa08b16f9277d5a789fb8efb751416c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/566f2907ef61eda7471409e99cca0ec3b865390f8715246cfec324fc6fe8b3b136369281845969db4f2fbf2caf3c94063b164407ded6707c505d577d5a478b66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/075b9177c668e5b12c19df6e1bd972bad3729c0a3d3ca8e69f21fcf50eb3c354c86a371a7ebfbac865752fbca5b0f456d7d726539d07cdf79f77d7e9f1d544ea"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 21:06:27.066782) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 21:06:27.067139) ========= 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.kz9NW65ojj/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.lVg7b6oTz9/Listeners TMPDIR=/var/folders/kj/gw3205m94z174y2y_m3c8f_800000w/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.005221 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 21:06:27.117792) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 21:06:27.118330) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 21:06:27.118949) ========= ========= Total master_lag: 1.80 =========