builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0127 starttime: 1464284154.2 results: success (0) buildid: 20160526082506 builduid: b74b2a85d859405cb1936c22930e5043 revision: b0096c5c727749ad3e79cbdf20d2e96bd179c213 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 10:35:54.203469) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-26 10:35:54.203944) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 10:35:54.204232) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-26 10:35:54.231022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-05-26 10:35:54.231411) ========= 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.Ccao7hDZJj/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.g5J40MdNVM/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 10:35:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.73M=0.001s 2016-05-26 10:35:53 (7.73 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133986 ========= master_lag: 3.75 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-05-26 10:35:58.119173) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:35:58.119553) ========= 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.Ccao7hDZJj/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.g5J40MdNVM/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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.020437 ========= master_lag: 0.66 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:35:58.801532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 10:35:58.801951) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b0096c5c727749ad3e79cbdf20d2e96bd179c213 --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 b0096c5c727749ad3e79cbdf20d2e96bd179c213 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ccao7hDZJj/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.g5J40MdNVM/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 10:35:58,153 truncating revision to first 12 chars 2016-05-26 10:35:58,153 Setting DEBUG logging. 2016-05-26 10:35:58,153 attempt 1/10 2016-05-26 10:35:58,153 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b0096c5c7277?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-26 10:35:59,150 unpacking tar archive at: mozilla-central-b0096c5c7277/testing/mozharness/ program finished with exit code 0 elapsedTime=1.268262 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-26 10:36:00.091990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 10:36:00.092410) ========= script_repo_revision: b0096c5c727749ad3e79cbdf20d2e96bd179c213 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-26 10:36:00.092852) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 10:36:00.093141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-26 10:36:00.110205) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2016-05-26 10:36:00.110653) ========= /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.Ccao7hDZJj/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.g5J40MdNVM/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 10:35:59 INFO - MultiFileLogger online at 20160526 10:35:59 in /builds/slave/test 10:35:59 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 10:35:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:35:59 INFO - {'append_to_log': False, 10:35:59 INFO - 'base_work_dir': '/builds/slave/test', 10:35:59 INFO - 'blob_upload_branch': 'Firefox', 10:35:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:35:59 INFO - 'branch': 'Firefox', 10:35:59 INFO - 'buildbot_json_path': 'buildprops.json', 10:35:59 INFO - 'config_files': ('talos/mac_config.py',), 10:35:59 INFO - 'default_actions': ('clobber', 10:35:59 INFO - 'read-buildbot-config', 10:35:59 INFO - 'download-and-extract', 10:35:59 INFO - 'populate-webroot', 10:35:59 INFO - 'create-virtualenv', 10:35:59 INFO - 'install', 10:35:59 INFO - 'run-tests'), 10:35:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:35:59 INFO - 'download_minidump_stackwalk': True, 10:35:59 INFO - 'download_symbols': 'ondemand', 10:35:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:35:59 INFO - 'tooltool.py': '/tools/tooltool.py', 10:35:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:35:59 INFO - '/tools/misc-python/virtualenv.py')}, 10:35:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:35:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:35:59 INFO - 'installer_path': 'installer.exe', 10:35:59 INFO - 'log_level': 'info', 10:35:59 INFO - 'log_name': 'talos', 10:35:59 INFO - 'log_to_console': True, 10:35:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:35:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:35:59 INFO - 'opt_config_files': (), 10:35:59 INFO - 'pip_index': False, 10:35:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:35:59 INFO - 'cmd': ('bash', 10:35:59 INFO - '-c', 10:35:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:35:59 INFO - 'enabled': True, 10:35:59 INFO - 'halt_on_failure': False, 10:35:59 INFO - 'name': 'check_screen_resolution'},), 10:35:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:35:59 INFO - 'cmd': ('bash', 10:35:59 INFO - '-c', 10:35:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:35:59 INFO - 'enabled': True, 10:35:59 INFO - 'halt_on_failure': False, 10:35:59 INFO - 'name': 'check_screen_resolution'},), 10:35:59 INFO - 'run_cmd_checks_enabled': True, 10:35:59 INFO - 'sps_profile': False, 10:35:59 INFO - 'sps_profile_interval': 0, 10:35:59 INFO - 'suite': 'dromaeojs-e10s', 10:35:59 INFO - 'system_bits': '32', 10:35:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:35:59 INFO - 'title': 't-yosemite-r7-0127', 10:35:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:35:59 INFO - 'use_talos_json': True, 10:35:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:35:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:35:59 INFO - 'work_dir': 'build'} 10:35:59 INFO - ##### 10:35:59 INFO - ##### Running clobber step. 10:35:59 INFO - ##### 10:35:59 INFO - Running pre-action listener: _resource_record_pre_action 10:35:59 INFO - Running main action method: clobber 10:35:59 INFO - rmtree: /builds/slave/test/build 10:35:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:36:01 INFO - Running post-action listener: _resource_record_post_action 10:36:01 INFO - ##### 10:36:01 INFO - ##### Finished clobber step (success) 10:36:01 INFO - ##### 10:36:01 INFO - ##### 10:36:01 INFO - ##### Running read-buildbot-config step. 10:36:01 INFO - ##### 10:36:01 INFO - Running pre-action listener: _resource_record_pre_action 10:36:01 INFO - Running main action method: read_buildbot_config 10:36:01 INFO - Using buildbot properties: 10:36:01 INFO - { 10:36:01 INFO - "project": "", 10:36:01 INFO - "product": "firefox", 10:36:01 INFO - "script_repo_revision": "production", 10:36:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:36:01 INFO - "repository": "", 10:36:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:36:01 INFO - "buildid": "20160526082506", 10:36:01 INFO - "stage_platform": "macosx64", 10:36:01 INFO - "basedir": "/builds/slave/test", 10:36:01 INFO - "nightly_build": "True", 10:36:01 INFO - "buildnumber": 17, 10:36:01 INFO - "slavename": "t-yosemite-r7-0127", 10:36:01 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:36:01 INFO - "platform": "yosemite_r7", 10:36:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:36:01 INFO - "branch": "mozilla-central", 10:36:01 INFO - "repo_path": "mozilla-central", 10:36:01 INFO - "revision": "b0096c5c727749ad3e79cbdf20d2e96bd179c213", 10:36:01 INFO - "pgo_build": "False", 10:36:01 INFO - "builduid": "b74b2a85d859405cb1936c22930e5043", 10:36:01 INFO - "slavebuilddir": "test" 10:36:01 INFO - } 10:36:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 10:36:01 INFO - Running post-action listener: _resource_record_post_action 10:36:01 INFO - ##### 10:36:01 INFO - ##### Finished read-buildbot-config step (success) 10:36:01 INFO - ##### 10:36:01 INFO - ##### 10:36:01 INFO - ##### Running download-and-extract step. 10:36:01 INFO - ##### 10:36:01 INFO - Running pre-action listener: _resource_record_pre_action 10:36:01 INFO - Running main action method: download_and_extract 10:36:01 INFO - mkdir: /builds/slave/test/build/tests 10:36: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')]} 10:36:01 INFO - https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:36:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 10:36:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 10:36:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/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 10:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/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 10:36:03 INFO - Downloaded 1199 bytes. 10:36:03 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 10:36:03 INFO - Using the following test package requirements: 10:36:03 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 10:36:03 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:36:03 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 10:36:03 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:36:03 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 10:36:03 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:36:03 INFO - u'jsshell-mac.zip'], 10:36:03 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:36:03 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 10:36:03 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 10:36:03 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:36:03 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 10:36:03 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:36:03 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 10:36:03 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:36:03 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 10:36:03 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:36:03 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 10:36:03 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:36:03 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')]} 10:36:03 INFO - https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:36:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:36:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:36:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/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 10:36:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/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 10:36:05 INFO - Downloaded 18622077 bytes. 10:36:05 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'] 10:36:05 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 10:36:08 INFO - Return code: 0 10:36:08 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 10:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:36:08 INFO - https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:36:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:36:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:36:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/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 10:36:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/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 10:36:10 INFO - Downloaded 18622077 bytes. 10:36:10 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'] 10:36:10 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 10:36:14 INFO - Return code: 0 10:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:36:14 INFO - https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:36:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:36:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:36:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/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 10:36:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/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 10:36:15 INFO - Downloaded 10834034 bytes. 10:36:15 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'] 10:36:15 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 10:36:15 INFO - Return code: 0 10:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:36:15 INFO - https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:36:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:36:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:36:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 10:36:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/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 10:36:18 INFO - Downloaded 110628326 bytes. 10:36:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:36:18 INFO - mkdir: /builds/slave/test/properties 10:36:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:36:18 INFO - Writing to file /builds/slave/test/properties/build_url 10:36:18 INFO - Contents: 10:36:18 INFO - build_url:https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:36:19 INFO - Running post-action listener: _resource_record_post_action 10:36:19 INFO - Running post-action listener: set_extra_try_arguments 10:36:19 INFO - ##### 10:36:19 INFO - ##### Finished download-and-extract step (success) 10:36:19 INFO - ##### 10:36:19 INFO - ##### 10:36:19 INFO - ##### Running populate-webroot step. 10:36:19 INFO - ##### 10:36:19 INFO - Running pre-action listener: _resource_record_pre_action 10:36:19 INFO - Running main action method: populate_webroot 10:36:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:36:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:36:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:36:19 INFO - '--tppagecycles', 10:36:19 INFO - '7'], 10:36:19 INFO - 'tests': ['tsvgm']}}, 10:36:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:36:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:36:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:36:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:36:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:36:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:36:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:19 INFO - 'talos_options': ['--disable-e10s'], 10:36:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:36:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:19 INFO - 'talos_options': ['--disable-e10s'], 10:36:19 INFO - 'tests': ['damp', 'tps']}, 10:36:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:19 INFO - 'tests': ['damp', 'tps']}, 10:36:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:36:19 INFO - 'tests': ['dromaeo_dom']}, 10:36:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:36:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:36:19 INFO - 'tests': ['a11yr', 10:36:19 INFO - 'ts_paint', 10:36:19 INFO - 'tpaint', 10:36:19 INFO - 'sessionrestore', 10:36:19 INFO - 'sessionrestore_no_auto_restore', 10:36:19 INFO - 'tabpaint']}, 10:36:19 INFO - 'other-e10s': {'tests': ['a11yr', 10:36:19 INFO - 'ts_paint', 10:36:19 INFO - 'tpaint', 10:36:19 INFO - 'sessionrestore', 10:36:19 INFO - 'sessionrestore_no_auto_restore', 10:36:19 INFO - 'tabpaint']}, 10:36:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:36:19 INFO - 'ts_paint', 10:36:19 INFO - 'tpaint', 10:36:19 INFO - 'sessionrestore', 10:36:19 INFO - 'sessionrestore_no_auto_restore', 10:36:19 INFO - 'tabpaint']}, 10:36:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:36:19 INFO - 'ts_paint', 10:36:19 INFO - 'tpaint', 10:36:19 INFO - 'sessionrestore', 10:36:19 INFO - 'sessionrestore_no_auto_restore', 10:36:19 INFO - 'tabpaint']}, 10:36:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:36:19 INFO - 'tests': ['a11yr', 10:36:19 INFO - 'ts_paint', 10:36:19 INFO - 'tpaint', 10:36:19 INFO - 'sessionrestore', 10:36:19 INFO - 'sessionrestore_no_auto_restore', 10:36:19 INFO - 'tabpaint']}, 10:36:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:36:19 INFO - 'tests': ['a11yr', 10:36:19 INFO - 'ts_paint', 10:36:19 INFO - 'tpaint', 10:36:19 INFO - 'sessionrestore', 10:36:19 INFO - 'sessionrestore_no_auto_restore', 10:36:19 INFO - 'tabpaint']}, 10:36:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:36:19 INFO - 'tests': ['tsvgx', 10:36:19 INFO - 'tsvgr_opacity', 10:36:19 INFO - 'tart', 10:36:19 INFO - 'tscrollx', 10:36:19 INFO - 'cart']}, 10:36:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:36:19 INFO - 'tsvgr_opacity', 10:36:19 INFO - 'tart', 10:36:19 INFO - 'tscrollx', 10:36:19 INFO - 'cart']}, 10:36:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:19 INFO - 'talos_options': ['--disable-e10s'], 10:36:19 INFO - 'tests': ['tp5o']}, 10:36:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:19 INFO - 'tests': ['tp5o']}, 10:36:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:19 INFO - 'talos_options': ['--disable-e10s', 10:36:19 INFO - '--xperf_path', 10:36:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:19 INFO - 'tests': ['tp5n']}, 10:36:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:36:19 INFO - 'talos_options': ['--xperf_path', 10:36:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:36:19 INFO - 'tests': ['tp5n']}}, 10:36:19 INFO - 'talos.zip': {'path': '', 10:36:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:36:19 INFO - Running post-action listener: _resource_record_post_action 10:36:19 INFO - ##### 10:36:19 INFO - ##### Finished populate-webroot step (success) 10:36:19 INFO - ##### 10:36:19 INFO - ##### 10:36:19 INFO - ##### Running create-virtualenv step. 10:36:19 INFO - ##### 10:36:19 INFO - Running pre-action listener: _resource_record_pre_action 10:36:19 INFO - Running main action method: create_virtualenv 10:36:19 INFO - Creating virtualenv /builds/slave/test/build/venv 10:36:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:36:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:36:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:36:20 INFO - Using real prefix '/tools/python27' 10:36:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:36:20 INFO - Installing distribute.............................................................................................................................................................................................done. 10:36:23 INFO - Installing pip.................done. 10:36:23 INFO - Return code: 0 10:36:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db20570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97205982c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bed30>, '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 0x10d7e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b5b20>, '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.Ccao7hDZJj/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.g5J40MdNVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 10:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:36:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ccao7hDZJj/Render', 10:36:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:23 INFO - 'HOME': '/Users/cltbld', 10:36:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:23 INFO - 'LOGNAME': 'cltbld', 10:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:23 INFO - 'MOZ_NO_REMOTE': '1', 10:36:23 INFO - 'NO_EM_RESTART': '1', 10:36:23 INFO - 'PAGER': '/bin/cat', 10:36:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:23 INFO - 'PWD': '/builds/slave/test', 10:36:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:23 INFO - 'SHELL': '/bin/bash', 10:36:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5J40MdNVM/Listeners', 10:36:23 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 10:36:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:23 INFO - 'USER': 'cltbld', 10:36:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:23 INFO - 'XPC_FLAGS': '0x0', 10:36:23 INFO - 'XPC_SERVICE_NAME': '0', 10:36:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:36:23 INFO - Cleaning up... 10:36:23 INFO - Return code: 0 10:36:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db20570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97205982c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bed30>, '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 0x10d7e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b5b20>, '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.Ccao7hDZJj/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.g5J40MdNVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 10:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:36:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ccao7hDZJj/Render', 10:36:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:23 INFO - 'HOME': '/Users/cltbld', 10:36:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:23 INFO - 'LOGNAME': 'cltbld', 10:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:23 INFO - 'MOZ_NO_REMOTE': '1', 10:36:23 INFO - 'NO_EM_RESTART': '1', 10:36:23 INFO - 'PAGER': '/bin/cat', 10:36:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:23 INFO - 'PWD': '/builds/slave/test', 10:36:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:23 INFO - 'SHELL': '/bin/bash', 10:36:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5J40MdNVM/Listeners', 10:36:23 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 10:36:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:23 INFO - 'USER': 'cltbld', 10:36:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:23 INFO - 'XPC_FLAGS': '0x0', 10:36:23 INFO - 'XPC_SERVICE_NAME': '0', 10:36:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:24 INFO - Downloading/unpacking psutil>=3.1.1 10:36:24 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 10:36:24 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 10:36:24 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 10:36:24 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 10:36:24 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 10:36:24 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 10:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:36:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:27 INFO - Installing collected packages: psutil 10:36:27 INFO - Running setup.py install for psutil 10:36:27 INFO - building 'psutil._psutil_osx' extension 10:36:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:36:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:36:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:36:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:36:27 INFO - building 'psutil._psutil_posix' extension 10:36:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:36:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:36:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:36:27 INFO - ^ 10:36:27 INFO - 1 warning generated. 10:36:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:36:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:36:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:36:27 INFO - Successfully installed psutil 10:36:27 INFO - Cleaning up... 10:36:28 INFO - Return code: 0 10:36:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:36:28 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')]} 10:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:28 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')]} 10:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:28 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 0x10db1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db20570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97205982c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bed30>, '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 0x10d7e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b5b20>, '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.Ccao7hDZJj/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.g5J40MdNVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 10:36:28 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 10:36:28 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 10:36:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ccao7hDZJj/Render', 10:36:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:28 INFO - 'HOME': '/Users/cltbld', 10:36:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:28 INFO - 'LOGNAME': 'cltbld', 10:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:28 INFO - 'MOZ_NO_REMOTE': '1', 10:36:28 INFO - 'NO_EM_RESTART': '1', 10:36:28 INFO - 'PAGER': '/bin/cat', 10:36:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:28 INFO - 'PWD': '/builds/slave/test', 10:36:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:28 INFO - 'SHELL': '/bin/bash', 10:36:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5J40MdNVM/Listeners', 10:36:28 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 10:36:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:28 INFO - 'USER': 'cltbld', 10:36:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:28 INFO - 'XPC_FLAGS': '0x0', 10:36:28 INFO - 'XPC_SERVICE_NAME': '0', 10:36:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:36:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:36:30 INFO - Installing collected packages: mozsystemmonitor 10:36:30 INFO - Running setup.py install for mozsystemmonitor 10:36:30 INFO - Successfully installed mozsystemmonitor 10:36:30 INFO - Cleaning up... 10:36:31 INFO - Return code: 0 10:36:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10db1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db20570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97205982c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bed30>, '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 0x10d7e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b5b20>, '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.Ccao7hDZJj/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.g5J40MdNVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 10:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:36:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ccao7hDZJj/Render', 10:36:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:31 INFO - 'HOME': '/Users/cltbld', 10:36:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:31 INFO - 'LOGNAME': 'cltbld', 10:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:31 INFO - 'MOZ_NO_REMOTE': '1', 10:36:31 INFO - 'NO_EM_RESTART': '1', 10:36:31 INFO - 'PAGER': '/bin/cat', 10:36:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:31 INFO - 'PWD': '/builds/slave/test', 10:36:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:31 INFO - 'SHELL': '/bin/bash', 10:36:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5J40MdNVM/Listeners', 10:36:31 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 10:36:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:31 INFO - 'USER': 'cltbld', 10:36:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:31 INFO - 'XPC_FLAGS': '0x0', 10:36:31 INFO - 'XPC_SERVICE_NAME': '0', 10:36:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:31 INFO - Downloading/unpacking blobuploader==1.2.4 10:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:33 INFO - Downloading blobuploader-1.2.4.tar.gz 10:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:36:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:36:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:34 INFO - Downloading docopt-0.6.1.tar.gz 10:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:36:34 INFO - Installing collected packages: blobuploader, requests, docopt 10:36:34 INFO - Running setup.py install for blobuploader 10:36:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:36:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:36:35 INFO - Running setup.py install for requests 10:36:35 INFO - Running setup.py install for docopt 10:36:35 INFO - Successfully installed blobuploader requests docopt 10:36:35 INFO - Cleaning up... 10:36:35 INFO - Return code: 0 10:36:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:35 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 0x10db1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db20570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97205982c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bed30>, '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 0x10d7e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b5b20>, '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.Ccao7hDZJj/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.g5J40MdNVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 10:36:35 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 10:36:35 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 10:36:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ccao7hDZJj/Render', 10:36:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:35 INFO - 'HOME': '/Users/cltbld', 10:36:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:35 INFO - 'LOGNAME': 'cltbld', 10:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:35 INFO - 'MOZ_NO_REMOTE': '1', 10:36:35 INFO - 'NO_EM_RESTART': '1', 10:36:35 INFO - 'PAGER': '/bin/cat', 10:36:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:35 INFO - 'PWD': '/builds/slave/test', 10:36:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:35 INFO - 'SHELL': '/bin/bash', 10:36:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5J40MdNVM/Listeners', 10:36:35 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 10:36:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:35 INFO - 'USER': 'cltbld', 10:36:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:35 INFO - 'XPC_FLAGS': '0x0', 10:36:35 INFO - 'XPC_SERVICE_NAME': '0', 10:36:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:36:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-j5189W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:36:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-DgrY3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:36:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-LmcvK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:36:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-wNddc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:36:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-OgTWBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:36:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-yNX22m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:36:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-T3KqWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:36:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-EHhGhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:36:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:36:36 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-IkuPPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:36:37 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-ntVzse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:36:37 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-0YbOp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:36:37 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-q769kY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:36:37 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-f4uVVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:36:37 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-baLehZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:37 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-izxJKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:36:37 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-U0NTdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:36:37 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-Y_7Jwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:36:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:36:37 INFO - Running setup.py install for manifestparser 10:36:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:36:38 INFO - Running setup.py install for mozcrash 10:36:38 INFO - Running setup.py install for mozdebug 10:36:38 INFO - Running setup.py install for mozdevice 10:36:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:36:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:36:38 INFO - Running setup.py install for mozfile 10:36:38 INFO - Running setup.py install for mozhttpd 10:36:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:36:38 INFO - Running setup.py install for mozinfo 10:36:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:36:38 INFO - Running setup.py install for mozInstall 10:36:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:36:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:36:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:36:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:36:39 INFO - Running setup.py install for mozleak 10:36:39 INFO - Running setup.py install for mozlog 10:36:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:36:39 INFO - Running setup.py install for moznetwork 10:36:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:36:39 INFO - Running setup.py install for mozprocess 10:36:39 INFO - Running setup.py install for mozprofile 10:36:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:36:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:36:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:36:39 INFO - Running setup.py install for mozrunner 10:36:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:36:40 INFO - Running setup.py install for mozscreenshot 10:36:40 INFO - Running setup.py install for moztest 10:36:40 INFO - Running setup.py install for mozversion 10:36:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:36:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:36:40 INFO - Cleaning up... 10:36:40 INFO - Return code: 0 10:36:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:40 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 0x10db1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db20570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97205982c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bed30>, '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 0x10d7e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b5b20>, '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.Ccao7hDZJj/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.g5J40MdNVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 10:36:40 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 10:36:40 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 10:36:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ccao7hDZJj/Render', 10:36:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:40 INFO - 'HOME': '/Users/cltbld', 10:36:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:40 INFO - 'LOGNAME': 'cltbld', 10:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:40 INFO - 'MOZ_NO_REMOTE': '1', 10:36:40 INFO - 'NO_EM_RESTART': '1', 10:36:40 INFO - 'PAGER': '/bin/cat', 10:36:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:40 INFO - 'PWD': '/builds/slave/test', 10:36:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:40 INFO - 'SHELL': '/bin/bash', 10:36:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5J40MdNVM/Listeners', 10:36:40 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 10:36:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:40 INFO - 'USER': 'cltbld', 10:36:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:40 INFO - 'XPC_FLAGS': '0x0', 10:36:40 INFO - 'XPC_SERVICE_NAME': '0', 10:36:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:36:40 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-kXG7QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:36:40 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)) 10:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:36:40 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-JfIJ1u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:36:40 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)) 10:36:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:36:40 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-FHeL7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:36:41 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)) 10:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:36:41 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-afNc6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:36:41 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)) 10:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:36:41 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-uPp1gK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:36:41 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)) 10:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:36:41 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-HGY58l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:36:41 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)) 10:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:36:41 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-mDX2HS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:36:41 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)) 10:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:36:41 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-tA8rY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:36:41 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)) 10:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:36:41 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-yjGiwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:36:41 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)) 10:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:36:41 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-QkRwIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:36:41 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)) 10:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:36:41 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-SZhaGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:36:41 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)) 10:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:36:41 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-rI3Yn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:36:42 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)) 10:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:36:42 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-m7LjMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:36:42 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)) 10:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:36:42 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-m3tbuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:36:42 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)) 10:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:42 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-JhbUwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:36:42 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)) 10:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:36:42 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-X7ajES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:36:42 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)) 10:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:36:42 INFO - Running setup.py (path:/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/pip-f3ucra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:36:42 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)) 10:36:42 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)) 10:36:42 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)) 10:36:42 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)) 10:36:42 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)) 10:36:42 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)) 10:36:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:36:42 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 10:36:42 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 10:36:42 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 10:36:42 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 10:36:42 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 10:36:42 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 10:36:45 INFO - Downloading blessings-1.6.tar.gz 10:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:36:45 INFO - Installing collected packages: blessings 10:36:45 INFO - Running setup.py install for blessings 10:36:45 INFO - Successfully installed blessings 10:36:45 INFO - Cleaning up... 10:36:45 INFO - Return code: 0 10:36:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:36:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:36:45 INFO - Reading from file tmpfile_stdout 10:36:45 INFO - Current package versions: 10:36:45 INFO - blessings == 1.6 10:36:45 INFO - blobuploader == 1.2.4 10:36:45 INFO - docopt == 0.6.1 10:36:45 INFO - manifestparser == 1.1 10:36:45 INFO - mozInstall == 1.12 10:36:45 INFO - mozcrash == 0.17 10:36:45 INFO - mozdebug == 0.1 10:36:45 INFO - mozdevice == 0.48 10:36:45 INFO - mozfile == 1.2 10:36:45 INFO - mozhttpd == 0.7 10:36:45 INFO - mozinfo == 0.9 10:36:45 INFO - mozleak == 0.1 10:36:45 INFO - mozlog == 3.2 10:36:45 INFO - moznetwork == 0.27 10:36:45 INFO - mozprocess == 0.22 10:36:45 INFO - mozprofile == 0.28 10:36:45 INFO - mozrunner == 6.11 10:36:45 INFO - mozscreenshot == 0.1 10:36:45 INFO - mozsystemmonitor == 0.3 10:36:45 INFO - moztest == 0.7 10:36:45 INFO - mozversion == 1.4 10:36:45 INFO - psutil == 3.1.1 10:36:45 INFO - requests == 1.2.3 10:36:45 INFO - wsgiref == 0.1.2 10:36:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:36:45 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')]} 10:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:45 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')]} 10:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:45 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 0x10db1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db20570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97205982c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bed30>, '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 0x10d7e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b5b20>, '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.Ccao7hDZJj/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.g5J40MdNVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 10:36:45 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 10:36:45 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 10:36:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ccao7hDZJj/Render', 10:36:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:45 INFO - 'HOME': '/Users/cltbld', 10:36:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:45 INFO - 'LOGNAME': 'cltbld', 10:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:45 INFO - 'MOZ_NO_REMOTE': '1', 10:36:45 INFO - 'NO_EM_RESTART': '1', 10:36:45 INFO - 'PAGER': '/bin/cat', 10:36:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:45 INFO - 'PWD': '/builds/slave/test', 10:36:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:45 INFO - 'SHELL': '/bin/bash', 10:36:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5J40MdNVM/Listeners', 10:36:45 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 10:36:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:45 INFO - 'USER': 'cltbld', 10:36:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:45 INFO - 'XPC_FLAGS': '0x0', 10:36:45 INFO - 'XPC_SERVICE_NAME': '0', 10:36:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:45 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)) 10:36:45 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)) 10:36:45 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)) 10:36:45 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)) 10:36:45 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)) 10:36:45 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)) 10:36:45 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)) 10:36:45 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)) 10:36:45 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)) 10:36:45 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)) 10:36:45 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)) 10:36:45 INFO - Cleaning up... 10:36:45 INFO - Return code: 0 10:36:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:36:45 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')]} 10:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:45 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')]} 10:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:45 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 0x10db1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db20570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97205982c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bed30>, '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 0x10d7e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b5b20>, '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.Ccao7hDZJj/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.g5J40MdNVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 10:36:45 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 10:36:45 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 10:36:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ccao7hDZJj/Render', 10:36:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:45 INFO - 'HOME': '/Users/cltbld', 10:36:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:45 INFO - 'LOGNAME': 'cltbld', 10:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:45 INFO - 'MOZ_NO_REMOTE': '1', 10:36:45 INFO - 'NO_EM_RESTART': '1', 10:36:45 INFO - 'PAGER': '/bin/cat', 10:36:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:45 INFO - 'PWD': '/builds/slave/test', 10:36:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:45 INFO - 'SHELL': '/bin/bash', 10:36:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5J40MdNVM/Listeners', 10:36:45 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 10:36:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:45 INFO - 'USER': 'cltbld', 10:36:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:45 INFO - 'XPC_FLAGS': '0x0', 10:36:45 INFO - 'XPC_SERVICE_NAME': '0', 10:36:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:46 INFO - Downloading/unpacking jsonschema 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36: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 10:36:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:36:48 INFO - Downloading/unpacking functools32 (from jsonschema) 10:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:48 INFO - Downloading functools32-3.2.3-2.tar.gz 10:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:36:49 INFO - warning: no files found matching '*.txt' 10:36:49 INFO - no previously-included directories found matching 'build' 10:36:49 INFO - no previously-included directories found matching 'dist' 10:36:49 INFO - no previously-included directories found matching '.git*' 10:36:49 INFO - Installing collected packages: jsonschema, functools32 10:36:49 INFO - Running setup.py install for functools32 10:36:49 INFO - warning: no files found matching '*.txt' 10:36:49 INFO - no previously-included directories found matching 'build' 10:36:49 INFO - no previously-included directories found matching 'dist' 10:36:49 INFO - no previously-included directories found matching '.git*' 10:36:49 INFO - Successfully installed jsonschema functools32 10:36:49 INFO - Cleaning up... 10:36:49 INFO - Return code: 0 10:36:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:50 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')]} 10:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:36:50 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 0x10db1aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db20570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97205982c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9bed30>, '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 0x10d7e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b5b20>, '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.Ccao7hDZJj/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.g5J40MdNVM/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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 10:36:50 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 10:36:50 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 10:36:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ccao7hDZJj/Render', 10:36:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:36:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:36:50 INFO - 'HOME': '/Users/cltbld', 10:36:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:36:50 INFO - 'LOGNAME': 'cltbld', 10:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:36:50 INFO - 'MOZ_NO_REMOTE': '1', 10:36:50 INFO - 'NO_EM_RESTART': '1', 10:36:50 INFO - 'PAGER': '/bin/cat', 10:36:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:36:50 INFO - 'PWD': '/builds/slave/test', 10:36:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:36:50 INFO - 'SHELL': '/bin/bash', 10:36:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5J40MdNVM/Listeners', 10:36:50 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 10:36:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:36:50 INFO - 'USER': 'cltbld', 10:36:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:36:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:36:50 INFO - 'XPC_FLAGS': '0x0', 10:36:50 INFO - 'XPC_SERVICE_NAME': '0', 10:36:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:36:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:36:50 INFO - Downloading/unpacking flake8 10:36:50 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 10:36:50 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 10:36:50 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 10:36:50 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 10:36:50 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 10:36:50 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 10:36:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:36:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:36:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:36:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:36:54 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 10:36:54 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 10:36:54 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 10:36:54 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 10:36:54 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 10:36:54 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 10:36:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:36:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:36:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:36:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:36:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:36:54 INFO - no previously-included directories found matching 'docs/_build' 10:36:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:36:54 INFO - Running setup.py install for pep8 10:36:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:36:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:36:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:36:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:36:55 INFO - no previously-included directories found matching 'docs/_build' 10:36:55 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:36:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:36:55 INFO - Cleaning up... 10:36:55 INFO - Return code: 0 10:36:55 INFO - Running post-action listener: _resource_record_post_action 10:36:55 INFO - Running post-action listener: _start_resource_monitoring 10:36:55 INFO - Starting resource monitoring. 10:36:55 INFO - ##### 10:36:55 INFO - ##### Finished create-virtualenv step (success) 10:36:55 INFO - ##### 10:36:55 INFO - ##### 10:36:55 INFO - ##### Running install step. 10:36:55 INFO - ##### 10:36:55 INFO - Running pre-action listener: _resource_record_pre_action 10:36:55 INFO - Running main action method: install 10:36:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:36:55 INFO - Reading from file tmpfile_stdout 10:36:55 INFO - Detecting whether we're running mozinstall >=1.0... 10:36:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:36:55 INFO - Reading from file tmpfile_stdout 10:36:55 INFO - Output received: 10:36:55 INFO - Usage: mozinstall [options] installer 10:36:55 INFO - Options: 10:36:55 INFO - -h, --help show this help message and exit 10:36:55 INFO - -d DEST, --destination=DEST 10:36:55 INFO - Directory to install application into. [default: 10:36:55 INFO - "/builds/slave/test"] 10:36:55 INFO - --app=APP Application being installed. [default: firefox] 10:36:55 INFO - mkdir: /builds/slave/test/build/application 10:36:55 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'] 10:36:55 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 10:37:29 INFO - Reading from file tmpfile_stdout 10:37:29 INFO - Output received: 10:37:29 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 10:37:29 INFO - Running post-action listener: _resource_record_post_action 10:37:29 INFO - ##### 10:37:29 INFO - ##### Finished install step (success) 10:37:29 INFO - ##### 10:37:29 INFO - ##### 10:37:29 INFO - ##### Running run-tests step. 10:37:29 INFO - ##### 10:37:29 INFO - Running pre-action listener: _resource_record_pre_action 10:37:29 INFO - Running main action method: run_tests 10:37:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:37:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:37:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:37:29 INFO - 2016-05-26 10:37:29.494 screenresolution[1906:15277] starting screenresolution argv=screenresolution get 10:37:29 INFO - 2016-05-26 10:37:29.497 screenresolution[1906:15277] Display 0: 1600x1200x32@60 10:37:29 INFO - 2016-05-26 10:37:29.502 screenresolution[1907:15279] starting screenresolution argv=screenresolution list 10:37:29 INFO - Available Modes on Display 0 10:37:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:37:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:37:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:37:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:37:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:37:29 INFO - Intel Iris: 10:37:29 INFO - Chipset Model: Intel Iris 10:37:29 INFO - Type: GPU 10:37:29 INFO - Bus: Built-In 10:37:29 INFO - VRAM (Dynamic, Max): 1536 MB 10:37:29 INFO - Vendor: Intel (0x8086) 10:37:29 INFO - Device ID: 0x0a2e 10:37:29 INFO - Revision ID: 0x0009 10:37:29 INFO - Displays: 10:37:29 INFO - Display: 10:37:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:37:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:37:29 INFO - Display Serial Number: 1600x1200 60 10:37:29 INFO - Main Display: Yes 10:37:29 INFO - Mirror: Off 10:37:29 INFO - Online: Yes 10:37:29 INFO - Rotation: Supported 10:37:29 INFO - Return code: 0 10:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:37:29 INFO - Python 2.7.3 10:37:29 INFO - Return code: 0 10:37:29 INFO - grabbing minidump binary from tooltool 10:37:29 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')]} 10:37:29 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 0x10d9bed30>, '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 0x10d7e2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9b5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:37:29 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 10:37:29 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 10:37:29 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 10:37:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:37:29 INFO - Return code: 0 10:37:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:37:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:37:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:37:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:37:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:37:30 INFO - Return code: 0 10:37:30 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0127', '--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 10:37:30 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0127 --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 10:37:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ccao7hDZJj/Render', 10:37:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:37:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:37:30 INFO - 'HOME': '/Users/cltbld', 10:37:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:37:30 INFO - 'LOGNAME': 'cltbld', 10:37:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:37:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:37:30 INFO - 'MOZ_NO_REMOTE': '1', 10:37:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:37:30 INFO - 'NO_EM_RESTART': '1', 10:37:30 INFO - 'PAGER': '/bin/cat', 10:37:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:37:30 INFO - 'PWD': '/builds/slave/test', 10:37:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:37:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:37:30 INFO - 'SHELL': '/bin/bash', 10:37:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5J40MdNVM/Listeners', 10:37:30 INFO - 'TMPDIR': '/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/', 10:37:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:37:30 INFO - 'USER': 'cltbld', 10:37:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:37:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:37:30 INFO - 'XPC_FLAGS': '0x0', 10:37:30 INFO - 'XPC_SERVICE_NAME': '0', 10:37:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:37:30 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0127', '--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 10:37:31 INFO - mozversion application_buildid: 20160526082506 10:37:31 INFO - mozversion application_changeset: b0096c5c727749ad3e79cbdf20d2e96bd179c213 10:37:31 INFO - mozversion application_display_name: Nightly 10:37:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:37:31 INFO - mozversion application_name: Firefox 10:37:31 INFO - mozversion application_remotingname: firefox 10:37:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:37:31 INFO - mozversion application_vendor: Mozilla 10:37:31 INFO - mozversion application_version: 49.0a1 10:37:31 INFO - mozversion platform_buildid: 20160526082506 10:37:31 INFO - mozversion platform_changeset: b0096c5c727749ad3e79cbdf20d2e96bd179c213 10:37:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:37:31 INFO - mozversion platform_version: 49.0a1 10:37:31 INFO - using testdate: 1464284251 10:37:31 INFO - actual date: 1464284251 10:37:31 INFO - starting webserver on 'localhost:52122' 10:37:31 INFO - SUITE-START | Running 2 tests 10:37:31 INFO - TEST-START | dromaeo_css 10:37:31 INFO - operating with platform_type : mac_ 10:37:31 INFO - Initialising browser for dromaeo_css test... 10:37:31 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpxoFILB/profile http://localhost:52122/getInfo.html) 10:37:34 INFO - PROCESS | 1925 | __metrics Screen width/height:1600/1200 10:37:34 INFO - PROCESS | 1925 | colorDepth:24 10:37:34 INFO - PROCESS | 1925 | Browser inner width/height: 1024/689 10:37:34 INFO - PROCESS | 1925 | __metrics 10:37:34 ERROR - PROCESS | 1925 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:37:35 INFO - TEST-INFO | 1925: exit 0 10:37:35 INFO - Browser initialized. 10:37:35 INFO - Running cycle 1/1 for dromaeo_css test... 10:37:35 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpxoFILB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:37:47 INFO - PROCESS | 1929 | RSS: Main: 252317696 10:37:47 INFO - PROCESS | 1929 | 10:38:37 INFO - PROCESS | 1929 | 1464284317300 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] 10:40:47 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52122/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52122/tests/dromaeo/cssquery-ext.html) 10:40:49 INFO - PROCESS | 1929 | RSS: Main: 264302592 10:40:49 INFO - PROCESS | 1929 | 10:43:51 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52122/tests/dromaeo/cssquery-ext.html (next: http://localhost:52122/tests/dromaeo/cssquery-jquery.html) 10:43:51 INFO - PROCESS | 1929 | RSS: Main: 275820544 10:43:51 INFO - PROCESS | 1929 | 10:46:53 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52122/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52122/tests/dromaeo/cssquery-mootools.html) 10:46:54 INFO - PROCESS | 1929 | RSS: Main: 277966848 10:46:54 INFO - PROCESS | 1929 | 10:49:56 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52122/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52122/tests/dromaeo/cssquery-prototype.html) 10:49:56 INFO - PROCESS | 1929 | RSS: Main: 279646208 10:49:56 INFO - PROCESS | 1929 | 10:52:59 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52122/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52122/tests/dromaeo/cssquery-yui.html) 10:53:00 INFO - PROCESS | 1929 | RSS: Main: 283070464 10:53:00 INFO - PROCESS | 1929 | 10:56:03 INFO - PROCESS | 1929 | Cycle 1(1): loaded http://localhost:52122/tests/dromaeo/cssquery-yui.html (next: http://localhost:52122/tests/dromaeo/cssquery-dojo.html) 10:56:03 INFO - PROCESS | 1929 | RSS: Main: 283738112 10:56:03 INFO - PROCESS | 1929 | 10:56:03 INFO - PROCESS | 1929 | __start_tp_report 10:56:03 INFO - PROCESS | 1929 | _x_x_mozilla_page_load 10:56:03 INFO - PROCESS | 1929 | _x_x_mozilla_page_load_details 10:56:03 INFO - PROCESS | 1929 | |i|pagename|runs| 10:56:03 INFO - PROCESS | 1929 | |0;dojo.html;3208.502682084277;3436.982815085925;3458.775179613325;3470.618231994482;3488.2674638325952;5632.746526406311;5699.202111704365;5769.740361683724;5786.218860453838;5827.708614569276;5582.944170558303;5652.5195358394585;5684.2326285951385;5688.203651488784;5767.30792304924;5142.202958541423;5159.690418574879;5228.73856307185;5262.394824595182;5304;362.47183881416026;5268.525832675058;5278.736063196844;5286.180642000477;5319.228711836781;5182.404023537304;5209.661372010807;5244.056069907415;5253.921191182136;5326.174442961308;4312.698111132222;5084.211947148198;5248.632595718302;5278.973605131988;5286.180642000496;4203.642690371292;5106.897862042775;5174.146265866128;5198.948010519922;5264.236685680555;4713.670043096985;5570.359408668014;5631.267935168402;5666.716664166775;5717.628354156966;6045.727942242565;6140.2588579677695;6221.346758590374;6256.311805701369;6287.96856015717;6172.938270617281;6189.195404597373;6211.968940155315;6247.125402443661;6260.40526150015;5863.355030946593;5904.5571582131515;5934.991051521209;5939.673317967553;5979.2824861016525;6157.630542167484;6193.411625895533;6194.721237544321;6257.155284036597;6265.342139075331;6200.0699895016105;6219.440250377488;6221.626702397871;6249.625022498664;6267.62394256346;6204.906926396107;6207.193064901534;6249.375062493805;6259.061140828912;6261.279952805395;6061.757529698851;6156.476699480505;6157.415045570664;6207.503399728011;6279.654618995908;6079.6960151992225;6097.390260973867;6129.086972572236;6144.126041557368;6176.166217560662;4872.4883887192045;4938.9012219755405;4956.90086198274;4961.42943561495;4965.354503914468;4431.246688063037;4435.3125265583885;4466.397036400044;4502.774861256989;4508.1659892919915;4523.954760452353;5780.739866706008;5785.392533783976;5867.501262392744;5873.676947767828;6274.749010039639;6278.780242691484;6279;6289.77985770505;6291.213598300213;5697;5816.970915145397;5825.912611310834;5846.181534585162;5902.822915312548;5477.424870388551;5482.533984611273;5486.615936884459;5488.368837583649;5496.477834605706;6075.848103797441;6431.099646049557;6436.806895793134;6441.452476539453;6443.838904027437;6202.658853763086;6221;6269;6272.059191121369;6309.652969086745;6358.2687990879795;6373.458256048288;6387.361263873576;6395.584287021329;6424.743010279536;6065.181200537871;6124.594542075475;6188.659623720739;6252.96826023701;6294.748210071546;6208.317085120723;6222.160008398808;6229.813105606839;6261.5616906816085;6279.780207692892;5951.464368206709;5986.730597123227;5991.2510936132985;6013.759449621966;6033.276006879027;5803.941960580509;5846.093855452412;5864.237649105589;5908.3205431375945;6005.069214271794;5576.832695019156;5604.579656525695;5791.362950075404;5822.7670893163795;5885.588008839341;5058.494150584912;5094.439611642642;6001.639901605918;6022.698865056817;6025.698715064317;5689.487946084872;5702.800401985911;5737.168110623853;5738.196652468574;5780.450857168562 10:56:03 INFO - PROCESS | 1929 | |1;ext.html;487.5197930038913;499.1514425476689;509.9898002039959;537.2666310486186;556.6520924422236;38887;41482.79258603703;41527;41585.16829663409;41622.791886040526;42360;43111;43142.13715725691;43145.7842710786;43175.56824431755;9555.426674399541;9685.515724213796;9769.120779129877;9790.46152461618;9801.970793066732;8197.754067377988;9760.658376956808;9790.559424825864;9821.803563928717;9832.901670983307;9765.951170244174;9798;9845.40927544346;9859.457729824857;9862.211023118134;9739.56171972263;9805.705828825146;9817.067378599093;9819.263555233387;9841.261905357127;7793.649285782153;8688.565571721452;9620.807583848355;9764.414135151914;9764.755881102958;27804.86097569499;30718.539221911687;32750.508742368882;33086.83456582726;40345.39481907774;2740.725927407263;3031.6816734242807;3052.435299469605;3286.8520916558814;3321.618013928405;22208.555828883495;26500.204993850217;27900.302492437648;28954.565681514796;28954.986575469757;2519.407939134302;2643.3920198354485;2643.4316621926378;2702.7972902032425;2825.844578548179;416700;433252;475471;476038;477852;33408.66591334104;33526.664733352845;33592.49611255833;33981.660183398344;34935.65064349324;35672.64327356693;35849.82075089608;35990.64009359925;36137;36185.81907090448;15164.696706065817;15193;15291.770623440658;15303.38786448552;15311.770323445156;10839.729006774736;12797.296148711725;13016;13056.21662700241;13064.934675326562;7830.6084695764985;7865.803354916173;7912.446128771046;7919.089304729914;7980.760577182694;2866.813657112281;3294.225856923621;3320;3321.103302108417;3344.8494817733263;852.9019162796234;853.4836423963537;1039.7140786283833;1044.6448207609449;1126.1385040444068;22551;28967.84128634831;29560;30078.69921300803;30272.84863575712;1087.7164945364545;1090.7927493776158;1113.9053180479589;1135.7728454309172;1194.8386967759416;15085;15137.091774493565;15185;15318.923405382902;15401.152936588594;697923;699344;701700;705965;707951;59989;61040.694796525735;61103.38896610977;61424.692876536225;61922;1273.751618434415;1410.8730214280763;1471.0658731705444;1479.0903594289434;1489.8361180270163;25270.873645631655;28999.420011599228;29277;29597.408051839273;29938.95213667511;50401.99196016132;50984.74507627438;51154.232686508985;51376.48623513717;51386.972260555325;635038;638424;638637;640184;641586;26066.34834129162;26414.07550735715;28212.294692632848;28250.85874570614;28396;39734.80132599318;46023.53976460193;46633.533664664275;46755.76622117004;47127;37814.62185378111;38163.18368163273;38535.42196867106;38756.41865372078;39641;37794.433083503216;38079.04802379962;38518.84443466701;38613.80693096516;38904.80547597244;29738;37230.627693722716;37568.43647345238;37929;37966.24067518579;32804.67195328112;33551.63828702253;33829.884691215106;34344;34351.141221468664;24420.755792441847;25093;25173.49653006893;25595.872020639777;25737.485250295264 10:56:03 INFO - PROCESS | 1929 | |2;jquery.html;294.7840159342711;358.23516791649826;369.71901354970214;376.1348897535669;395.72299390426707;19876.801231987694;20533.691994620094;20738.585228295426;21479.67780483292;21500.8924955375;20582;20801.063952122153;21073.367798966017;21185.47036324089;21254.57490850182;2842.7583655389317;5283.841484755463;5906.751785651891;6153.507719382439;6184.536159788011;6000.069989151689;6011.969940150293;6048.274207095133;6087.817365479021;6093.086037094427;5813.447722466359;5885.823425297248;6034.788782392618;6117.969410152943;6120;5994.310654274771;6001.434605881872;6076.908846367308;6083.543734219929;6114.480269177126;4469.86018565267;5056.84829455117;5245.423003469616;5254;5255.369355677305;25787;25923.48153036929;26351.472970540482;26493.3376665583;26691.866540667368;2066.2664754012258;2112.640851055324;2123.384218576626;2175.4887601413657;2213.889305534733;14880.479183228643;15383.615409614737;15453.5363939082;15649.608759780982;15678.216089195495;1714.8027976782705;1715.9399421020205;1756.464278395089;1760.8063113057553;1832.1388947194798;84964.15035849686;116083;121189;130550;134474;11494;11807.822882656767;11855.525778968744;11865.288082715064;11973.281603103842;14648.85351146475;14658.560243192722;14684.678378945946;14757.926210369094;14770.113793172444;8571.914280857236;8768.649254029768;8817.515036673045;8921;8943.865842012376;8626.827463450696;8754.21212090915;8762.824743505094;8850.513221772735;8850.513221772864;4519.18654642161;4573.931391029138;4620.630349572026;4654.674172807939;4677.7193368398;1946.4355336952126;1995.3614843250311;1997.7203191553194;2000.3098930868828;2031.1266155552958;361.92037751694585;385.6413535412038;407.5618709886883;429.06249844090763;829.7344849648055;11593;11770.058395328353;11837;11885.821712674144;11906.404679765978;430.9612134907873;436.85365402589855;445.0320552797652;448.47976347436816;451.0415367344393;5664.376918538957;6100;6166.599171053867;6173.938260617426;6208.596441231305;449116;532489;536552;539845.3007734936;588423;123301.38349308375;135123;135819;140914.2954285222;142078;372.51944990961897;419.59509073743374;433.7874441523694;438.79157400234635;443.07839693438217;8888.977767556813;9105.544722763703;9582;10729.248952573556;10857.077148442471;44129.77935110304;54107;54152.187717185065;54264;54879;61748.382516174264;79368;79582.6020869892;80126.39747204907;82559.17440825755;7345.8898116527225;7909.841803164019;8038.276555110068;8076.353891688534;8093.55485448306;12045.63863084109;12245.142840001114;12528;12528.937355313165;12645.557405490763;9589.904100958902;10829.783404332027;10860.294080884718;10932.125429965425;11179.720506987065;10370.688879333633;10443.738906527398;10490.370577765358;10573.735656608646;10846.783064338826;10902.345859248471;10905.781884362426;10950.671479855617;10982.945085274523;11278.379689117177;6850.177978642595;7369.016769427797;7406.740764073232;7533.133689625544;8221.54781487024;9827.5086245686;11265.26775759573;11556.537738490366;11585.88414115848;11588.884111159117 10:56:03 INFO - PROCESS | 1929 | |3;mootools.html;1542.4678485922357;1577.7554479055748;1827.5339788353967;1930.334034758008;1974.5359840437504;6858.9025755879065;7722.459427840054;8174.427790054699;8638.784030399243;8708.782280442992;7178.641067946595;8350.832983340344;8511.616977236024;8568.271696905755;8586.742397728063;1962.9509262268487;2335.0543030072804;2337.9883100584475;2355.988220058906;2366.810655147584;1781.8663600230034;2325.9651105233434;2342.6251799711963;2348.9060437582475;2357.3399448154546;2263.1400067974146;2295.6556516522487;2296.2651951375565;2332.976670233293;2382.9285121446383;2312.5259321839153;2316.7683231676865;2322.3729593009875;2333.381653861728;2344.7303560090636;2300.493891343902;2315.7568455312285;2328.8136949044206;2335.135999680112;2342.0982921575146;8553.572321383906;8580.099089595627;8620.82758344836;8629.913700862973;8640.697575584825;5180.352455943007;5308.416074231832;5340.465953404668;5350.491703288181;5368.32895888014;3334.3328335832084;3340.5490258815234;3549.361114999299;3556.466530020492;3558.0393293810525;999.3004896572355;1021.7343490692399;1022.3661329975463;1028.0490546244769;1039.018127869164;10527.78944421115;11012.063974562172;11147;11174.994250517411;11290.774184516345;4432.667549933768;4494.707843990195;4559.931601025987;4562.634989200856;4597.3333866589155;8966.641334346554;8997.865032024525;8999.010108888016;9003.819923601623;9004.774880627905;5130.256112863613;5205;5206.843794686166;5219.08665983459;5233.2935053768015;4355.499117601453;4737.407824021997;4832.4684284728655;4883.389576302962;4907.705537667752;3408.5799082651597;3653.926921461556;3844.038990252437;3851.9422208666892;3872.7676339419727;1181.704573856536;1184.3071802995344;1192.070185255502;1196.7845787758288;1197.886200810939;777.9883301750478;887.7647423432795;892.8526793079069;897.2821742605889;966.9274804389559;4420.381146639473;4845.248986407112;5788.681622510802;5820.126980952891;5922.674252916131;384.2679695180685;431.7221025763712;440.62546835189835;442.94684637843665;451.74927915007487;3860.517435320585;3905.921881562353;3949.921001579952;3994.6205110514456;4013.0769922917893;10046.648367307109;10201.74495637615;10367.963203679723;10429.478526073666;10478.73803154912;10314;10388.220883433773;10409.479526023668;10413.11488523484;10415.843762343571;7768.378529717496;7970.322522585529;7994.920050799534;8016.478928869605;8061.234182752629;5492.697901615449;5502;5874.236349274567;5916.467517923407;5966.910496342645;8097.1497992712275;9212.769680758034;9625.807483850143;9687.564059617192;9743.805123897624;8008.439409241297;9921.206303495559;9937.602495900082;9960.203183745429;9976.05227503386;5567.387587365306;7195.424366050808;7348.853022939618;7459.850802984019;7537.359324457482;8159.510429374256;8213.055498617736;8264.628091736007;8299.917000829915;8321.16788321163;7289.307515785992;7387.741429050173;7447.329740323397;7531.133919599097;7577.924220757722;7248.767709489294;7294.96352518234;7317.524360916524;7348;7353.852922941618;6826.761063362758;6865.931340686729;6917.100776898971;6933.5493192942295;6954.235034146341;4773.284007398918;4806.47128815823;4862.5380588844;4936.234883593049;5057.367829021372;4286.121345124305;4672.159011377985;4828.782704778223;4876.344139700636;4988.8752781180765 10:56:03 INFO - PROCESS | 1929 | |4;prototype.html;300.1011969152389;312.40486872507864;314.31636191283957;319.1606076020067;321.41823299827297;4858.149823780837;5354.518093371596;5521.950829342432;5576.442355764431;5656.660600363981;5511.807086751955;5514.332968575903;5515.283013208277;5517.44825517448;5554.944450555493;3986.1698194282094;3992.6606238469694;4080.224757296119;4206.47419072616;4213.178430206111;3834.8657796977113;3843.250566139604;4125.133721918401;4213.199492096507;4217.536071032184;3473.513708080871;4079.1841631673637;4202.684798640099;4211.810468528924;4215.536291008002;3089.258577941278;3764.209516001643;3850.4224366344993;3947.934057804391;4123.525794533637;2682.1685277563824;2901.405211931549;3325.900222993314;3515.437529995214;3537.4693795930816;4145.854895078658;4590.311453282001;4905.852824415273;5254.6847189168775;5278.208268759717;4376.737395756233;4498.852792537915;4612.215923293048;4736.881577960544;4776.522347765231;4719.598834099105;5092.516210959953;5792.565557583198;5818.330891947396;5827.4755272025295;3056.5873607062986;3764.3976963685677;3884.6892248620325;3925.7840818754958;3959.5050618672667;5712.742926568314;5823.417658234142;5929.6145750526075;6109.625334299792;6126.009047059679;3558.857645694195;3673.3571624965525;3992;3997.220541994341;4002.579729128458;4046.433499310099;4050.696197785178;4061.2739585675968;4068.2270368629866;4105.507339119325;4020.4170395292517;4772.308015337826;4801.4718380978065;4811.845157162255;4847.781849816696;4419.823207071746;5794.8989691958395;5871.706414679249;5896.764129434775;6059.75816928152;1258.942488309824;1261.4449642157422;1341.597520743773;1387.4796951143321;1399.433229542037;752.3492179264897;789.6959670526888;817.9631916563769;857.7212405968086;900.1583519409373;5383.461653834585;5429;5445.618806683573;5452.40023597404;5552.555795536347;4871.952530206023;5958.616553378683;6009.218801555857;6032.487238584769;6068.271807383142;4715.882102947454;4932.753362331869;5372.435894231127;5394.865128371822;5435.239066530688;2552.719200887901;2778.3470884342164;2960.7712799188525;3016.834074125944;3017.204763165913;5533.391326954032;5662.150677398423;6024.277086749618;6168.272883592601;6224.844378890564;5519.917201241985;6001.879962400728;6287.434130928147;6303.590266632654;6333.081703153109;5293.967676303161;5797.797077102281;6114.602550834271;6384.457321127663;6410.647414392253;4720.787564559534;5600.635958662674;5642.802501912413;5736.282964629421;5966.970165149147;5080.9006506030555;5544.696996205807;5980.760769569169;5981.611195272293;6007.729652165575;5404.702741349263;5605.24329215567;6041.697915104315;6291.937080629135;6309.7160627770945;3329.500574913782;3473.652634736506;3849.5957924417535;3980.7858603125164;4007.3988901664984;5154.690718556899;5626.324841019104;6056.333803281547;6139.201903752483;6151.6001459904965;5301.390340110936;5680.375158732453;5791.391903850035;5793.362730099601;5845.824625261249;4862.854114376574;5097.776533631976;5759.625624334405;5789.2184555086205;5798.76804927815;4697.788599512962;4971.776270067783;5380.623356365173;5585.748641311232;5646.88706225865;4876.439209490812;4959.603231741524;5552.750126244248;5683.744231509675;5801.1878337033695;4623.92508981537;4898.951010489992;4919.434265059421;5482.533984611353;5491.364145210401 10:56:03 INFO - PROCESS | 1929 | |5;yui.html;613.4049971527618;664.68759682949;697.49431662045;735.0774777654043;766.7316439246262;13257.40341684624;14951.925240373797;15046.172460514666;15167.393304267829;15175.848241517582;13852.584422467342;13920.095193812394;13928.582142535715;13936;14003.649908752286;700.8773464643692;854.0775961961098;864.8486514859906;873.9563021848913;905.0316161706976;870.0386073388909;886.4858382138376;893.6648756716231;901.7204666553357;903.9909600904006;957.5020989085672;962.3263715399214;963.5037955452947;963.7060696487569;965.6089283840021;803.3412601666636;949.6960972488806;959.5250351076193;959.8128364968799;960.7270366764066;700.8563244534859;711.7508871894847;713.2582114600809;714.7641278378175;716.0476566166985;14495.855041449662;14533.837293016533;14560.126392416383;14566.854331456761;14619.049761765558;12321.5071397144;12465.93767031159;12472.376381180904;12484.875151248461;12777.808332875014;9563.187129094036;9958.253131015203;10058.094771470604;10313.793724125551;10346.172306215485;3394.9490757638655;3473.1838018065732;3536.4341705327024;3550.8579656813695;3562.4834399012257;56191;77288;77874;80827.59586202032;80833;7489.887651685229;9396.67111651089;9469.431834089839;9691.9030809691;9768.36505627132;21465.356039318845;21841.126354945623;21866.45333866666;21912.780872191073;21922.013509392116;7334.523255988343;7401.512136888203;7468.439867009996;7586.924130758622;7592.582407967615;3990.501187351581;4035.394690796404;4051.513818341818;4063.167050754588;4071.2875246831686;2920.678725340211;3447.3277710846646;3515.472679098156;3526.4357702767948;3550.786952782841;606.6814922165898;617.9907301390483;622.2936966543007;630.8864404407159;633.4425705379236;528.8942211557704;561.1190431023255;573.4838645219336;582.6766144789598;593.9910901336483;6838.1794184697155;7040.190378106481;7507.798752199622;8096.352291816641;8379.162083791573;474.18440282713675;517.526463286089;537.9536800922247;540.3650710415246;567.6934455394123;3317.4857897026;3841.4814000110186;3853.9421908671393;3917.764934103963;3956.5756327721997;64110.679446602466;90827;91184;92324;92438;56210.15684764732;74573;75825;75990;79794;27018.459630807665;27035.459290814073;50386.49613503891;51046.979060419326;68517.65741171263;6368.64972426521;7149.678264478215;7200.279972002758;7646.31183193493;7855.253750893656;42401.78799105985;42536.149277014905;43123;43256;44919.66924089321;55293;59852.40147598468;60725;61999.6900015497;62147.06779398222;10096.69709908704;10203.234757393373;10308.381497110197;10529.36823790575;10606.628767993083;11006.339619622848;11106.61126860556;11124.499397526968;11246.550137994389;11387.145964052563;10277.383356998604;10354.637587684394;10471.79056418852;10491;10567.735806604896;9563.187129093827;9651.420914745138;9960.402375857471;10606.045455909005;10677.718673759198;8338.04112527067;9892.356996795184;9983.850242246517;10374.481275936023;10485.423301718478;8656.220133800483;8996.775080623036;9037.412568183046;9100.31747618918;9135.26917846584;6997;7292.708291668486;8708.564571771512;8737.301015918838;9204.677836275698 10:56:03 INFO - PROCESS | 1929 | __end_tp_report 10:56:03 INFO - PROCESS | 1929 | __start_cc_report 10:56:03 INFO - PROCESS | 1929 | _x_x_mozilla_cycle_collect,422 10:56:03 INFO - PROCESS | 1929 | __end_cc_report 10:56:03 INFO - PROCESS | 1929 | __startTimestamp1464285363438__endTimestamp 10:56:03 INFO - PROCESS | 1929 | 10:56:03 INFO - PROCESS | 1929 | ------- Summary: start ------- 10:56:03 INFO - PROCESS | 1929 | Number of tests: 6 10:56:03 INFO - PROCESS | 1929 | 10:56:03 INFO - PROCESS | 1929 | [#0] dojo.html Cycles:165 Average:5678.21 Median:5867.50 stddev:774.99 (13.2%) stddev-sans-first:752.76 10:56:03 INFO - PROCESS | 1929 | Values: 3208.5 3437.0 3458.8 3470.6 3488.3 5632.7 5699.2 5769.7 5786.2 5827.7 5582.9 5652.5 5684.2 5688.2 5767.3 5142.2 5159.7 5228.7 5262.4 5304.0 362.5 5268.5 5278.7 5286.2 5319.2 5182.4 5209.7 5244.1 5253.9 5326.2 4312.7 5084.2 5248.6 5279.0 5286.2 4203.6 5106.9 5174.1 5198.9 5264.2 4713.7 5570.4 5631.3 5666.7 5717.6 6045.7 6140.3 6221.3 6256.3 6288.0 6172.9 6189.2 6212.0 6247.1 6260.4 5863.4 5904.6 5935.0 5939.7 5979.3 6157.6 6193.4 6194.7 6257.2 6265.3 6200.1 6219.4 6221.6 6249.6 6267.6 6204.9 6207.2 6249.4 6259.1 6261.3 6061.8 6156.5 6157.4 6207.5 6279.7 6079.7 6097.4 6129.1 6144.1 6176.2 4872.5 4938.9 4956.9 4961.4 4965.4 4431.2 4435.3 4466.4 4502.8 4508.2 4524.0 5780.7 5785.4 5867.5 5873.7 6274.7 6278.8 6279.0 6289.8 6291.2 5697.0 5817.0 5825.9 5846.2 5902.8 5477.4 5482.5 5486.6 5488.4 5496.5 6075.8 6431.1 6436.8 6441.5 6443.8 6202.7 6221.0 6269.0 6272.1 6309.7 6358.3 6373.5 6387.4 6395.6 6424.7 6065.2 6124.6 6188.7 6253.0 6294.7 6208.3 6222.2 6229.8 6261.6 6279.8 5951.5 5986.7 5991.3 6013.8 6033.3 5803.9 5846.1 5864.2 5908.3 6005.1 5576.8 5604.6 5791.4 5822.8 5885.6 5058.5 5094.4 6001.6 6022.7 6025.7 5689.5 5702.8 5737.2 5738.2 5780.5 10:56:03 INFO - PROCESS | 1929 | 10:56:03 INFO - PROCESS | 1929 | [#1] ext.html Cycles:180 Average:70462.86 Median:37804.53 stddev:163517.38 (432.5%) stddev-sans-first:163891.68 10:56:03 INFO - PROCESS | 1929 | Values: 487.5 499.2 510.0 537.3 556.7 38887.0 41482.8 41527.0 41585.2 41622.8 42360.0 43111.0 43142.1 43145.8 43175.6 9555.4 9685.5 9769.1 9790.5 9802.0 8197.8 9760.7 9790.6 9821.8 9832.9 9766.0 9798.0 9845.4 9859.5 9862.2 9739.6 9805.7 9817.1 9819.3 9841.3 7793.6 8688.6 9620.8 9764.4 9764.8 27804.9 30718.5 32750.5 33086.8 40345.4 2740.7 3031.7 3052.4 3286.9 3321.6 22208.6 26500.2 27900.3 28954.6 28955.0 2519.4 2643.4 2643.4 2702.8 2825.8 416700.0 433252.0 475471.0 476038.0 477852.0 33408.7 33526.7 33592.5 33981.7 34935.7 35672.6 35849.8 35990.6 36137.0 36185.8 15164.7 15193.0 15291.8 15303.4 15311.8 10839.7 12797.3 13016.0 13056.2 13064.9 7830.6 7865.8 7912.4 7919.1 7980.8 2866.8 3294.2 3320.0 3321.1 3344.8 852.9 853.5 1039.7 1044.6 1126.1 22551.0 28967.8 29560.0 30078.7 30272.8 1087.7 1090.8 1113.9 1135.8 1194.8 15085.0 15137.1 15185.0 15318.9 15401.2 697923.0 699344.0 701700.0 705965.0 707951.0 59989.0 61040.7 61103.4 61424.7 61922.0 1273.8 1410.9 1471.1 1479.1 1489.8 25270.9 28999.4 29277.0 29597.4 29939.0 50402.0 50984.7 51154.2 51376.5 51387.0 635038.0 638424.0 638637.0 640184.0 641586.0 26066.3 26414.1 28212.3 28250.9 28396.0 39734.8 46023.5 46633.5 46755.8 47127.0 37814.6 38163.2 38535.4 38756.4 39641.0 37794.4 38079.0 38518.8 38613.8 38904.8 29738.0 37230.6 37568.4 37929.0 37966.2 32804.7 33551.6 33829.9 34344.0 34351.1 24420.8 25093.0 25173.5 25595.9 25737.5 10:56:03 INFO - PROCESS | 1929 | 10:56:03 INFO - PROCESS | 1929 | [#2] jquery.html Cycles:180 Average:32727.57 Median:380.89 stddev:89740.48 (23560.9%) stddev-sans-first:89959.19 10:56:03 INFO - PROCESS | 1929 | Values: 294.8 358.2 369.7 376.1 395.7 19876.8 20533.7 20738.6 21479.7 21500.9 20582.0 20801.1 21073.4 21185.5 21254.6 2842.8 5283.8 5906.8 6153.5 6184.5 6000.1 6012.0 6048.3 6087.8 6093.1 5813.4 5885.8 6034.8 6118.0 6120.0 5994.3 6001.4 6076.9 6083.5 6114.5 4469.9 5056.8 5245.4 5254.0 5255.4 25787.0 25923.5 26351.5 26493.3 26691.9 2066.3 2112.6 2123.4 2175.5 2213.9 14880.5 15383.6 15453.5 15649.6 15678.2 1714.8 1715.9 1756.5 1760.8 1832.1 84964.2 116083.0 121189.0 130550.0 134474.0 11494.0 11807.8 11855.5 11865.3 11973.3 14648.9 14658.6 14684.7 14757.9 14770.1 8571.9 8768.6 8817.5 8921.0 8943.9 8626.8 8754.2 8762.8 8850.5 8850.5 4519.2 4573.9 4620.6 4654.7 4677.7 1946.4 1995.4 1997.7 2000.3 2031.1 361.9 385.6 407.6 429.1 829.7 11593.0 11770.1 11837.0 11885.8 11906.4 431.0 436.9 445.0 448.5 451.0 5664.4 6100.0 6166.6 6173.9 6208.6 449116.0 532489.0 536552.0 539845.3 588423.0 123301.4 135123.0 135819.0 140914.3 142078.0 372.5 419.6 433.8 438.8 443.1 8889.0 9105.5 9582.0 10729.2 10857.1 44129.8 54107.0 54152.2 54264.0 54879.0 61748.4 79368.0 79582.6 80126.4 82559.2 7345.9 7909.8 8038.3 8076.4 8093.6 12045.6 12245.1 12528.0 12528.9 12645.6 9589.9 10829.8 10860.3 10932.1 11179.7 10370.7 10443.7 10490.4 10573.7 10846.8 10902.3 10905.8 10950.7 10982.9 11278.4 6850.2 7369.0 7406.7 7533.1 8221.5 9827.5 11265.3 11556.5 11585.9 11588.9 10:56:03 INFO - PROCESS | 1929 | 10:56:03 INFO - PROCESS | 1929 | [#3] mootools.html Cycles:180 Average:5492.36 Median:4879.87 stddev:3060.94 (62.7%) stddev-sans-first:3055.13 10:56:03 INFO - PROCESS | 1929 | Values: 1542.5 1577.8 1827.5 1930.3 1974.5 6858.9 7722.5 8174.4 8638.8 8708.8 7178.6 8350.8 8511.6 8568.3 8586.7 1963.0 2335.1 2338.0 2356.0 2366.8 1781.9 2326.0 2342.6 2348.9 2357.3 2263.1 2295.7 2296.3 2333.0 2382.9 2312.5 2316.8 2322.4 2333.4 2344.7 2300.5 2315.8 2328.8 2335.1 2342.1 8553.6 8580.1 8620.8 8629.9 8640.7 5180.4 5308.4 5340.5 5350.5 5368.3 3334.3 3340.5 3549.4 3556.5 3558.0 999.3 1021.7 1022.4 1028.0 1039.0 10527.8 11012.1 11147.0 11175.0 11290.8 4432.7 4494.7 4559.9 4562.6 4597.3 8966.6 8997.9 8999.0 9003.8 9004.8 5130.3 5205.0 5206.8 5219.1 5233.3 4355.5 4737.4 4832.5 4883.4 4907.7 3408.6 3653.9 3844.0 3851.9 3872.8 1181.7 1184.3 1192.1 1196.8 1197.9 778.0 887.8 892.9 897.3 966.9 4420.4 4845.2 5788.7 5820.1 5922.7 384.3 431.7 440.6 442.9 451.7 3860.5 3905.9 3949.9 3994.6 4013.1 10046.6 10201.7 10368.0 10429.5 10478.7 10314.0 10388.2 10409.5 10413.1 10415.8 7768.4 7970.3 7994.9 8016.5 8061.2 5492.7 5502.0 5874.2 5916.5 5966.9 8097.1 9212.8 9625.8 9687.6 9743.8 8008.4 9921.2 9937.6 9960.2 9976.1 5567.4 7195.4 7348.9 7459.9 7537.4 8159.5 8213.1 8264.6 8299.9 8321.2 7289.3 7387.7 7447.3 7531.1 7577.9 7248.8 7295.0 7317.5 7348.0 7353.9 6826.8 6865.9 6917.1 6933.5 6954.2 4773.3 4806.5 4862.5 4936.2 5057.4 4286.1 4672.2 4828.8 4876.3 4988.9 10:56:03 INFO - PROCESS | 1929 | 10:56:03 INFO - PROCESS | 1929 | [#4] prototype.html Cycles:180 Average:4614.11 Median:5126.23 stddev:1474.10 (28.8%) stddev-sans-first:1442.23 10:56:03 INFO - PROCESS | 1929 | Values: 300.1 312.4 314.3 319.2 321.4 4858.1 5354.5 5522.0 5576.4 5656.7 5511.8 5514.3 5515.3 5517.4 5554.9 3986.2 3992.7 4080.2 4206.5 4213.2 3834.9 3843.3 4125.1 4213.2 4217.5 3473.5 4079.2 4202.7 4211.8 4215.5 3089.3 3764.2 3850.4 3947.9 4123.5 2682.2 2901.4 3325.9 3515.4 3537.5 4145.9 4590.3 4905.9 5254.7 5278.2 4376.7 4498.9 4612.2 4736.9 4776.5 4719.6 5092.5 5792.6 5818.3 5827.5 3056.6 3764.4 3884.7 3925.8 3959.5 5712.7 5823.4 5929.6 6109.6 6126.0 3558.9 3673.4 3992.0 3997.2 4002.6 4046.4 4050.7 4061.3 4068.2 4105.5 4020.4 4772.3 4801.5 4811.8 4847.8 4419.8 5794.9 5871.7 5896.8 6059.8 1258.9 1261.4 1341.6 1387.5 1399.4 752.3 789.7 818.0 857.7 900.2 5383.5 5429.0 5445.6 5452.4 5552.6 4872.0 5958.6 6009.2 6032.5 6068.3 4715.9 4932.8 5372.4 5394.9 5435.2 2552.7 2778.3 2960.8 3016.8 3017.2 5533.4 5662.2 6024.3 6168.3 6224.8 5519.9 6001.9 6287.4 6303.6 6333.1 5294.0 5797.8 6114.6 6384.5 6410.6 4720.8 5600.6 5642.8 5736.3 5967.0 5080.9 5544.7 5980.8 5981.6 6007.7 5404.7 5605.2 6041.7 6291.9 6309.7 3329.5 3473.7 3849.6 3980.8 4007.4 5154.7 5626.3 6056.3 6139.2 6151.6 5301.4 5680.4 5791.4 5793.4 5845.8 4862.9 5097.8 5759.6 5789.2 5798.8 4697.8 4971.8 5380.6 5585.7 5646.9 4876.4 4959.6 5552.8 5683.7 5801.2 4623.9 4899.0 4919.4 5482.5 5491.4 10:56:03 INFO - PROCESS | 1929 | 10:56:03 INFO - PROCESS | 1929 | [#5] yui.html Cycles:180 Average:16411.63 Median:30665.84 stddev:22988.92 (75.0%) stddev-sans-first:23022.80 10:56:03 INFO - PROCESS | 1929 | Values: 613.4 664.7 697.5 735.1 766.7 13257.4 14951.9 15046.2 15167.4 15175.8 13852.6 13920.1 13928.6 13936.0 14003.6 700.9 854.1 864.8 874.0 905.0 870.0 886.5 893.7 901.7 904.0 957.5 962.3 963.5 963.7 965.6 803.3 949.7 959.5 959.8 960.7 700.9 711.8 713.3 714.8 716.0 14495.9 14533.8 14560.1 14566.9 14619.0 12321.5 12465.9 12472.4 12484.9 12777.8 9563.2 9958.3 10058.1 10313.8 10346.2 3394.9 3473.2 3536.4 3550.9 3562.5 56191.0 77288.0 77874.0 80827.6 80833.0 7489.9 9396.7 9469.4 9691.9 9768.4 21465.4 21841.1 21866.5 21912.8 21922.0 7334.5 7401.5 7468.4 7586.9 7592.6 3990.5 4035.4 4051.5 4063.2 4071.3 2920.7 3447.3 3515.5 3526.4 3550.8 606.7 618.0 622.3 630.9 633.4 528.9 561.1 573.5 582.7 594.0 6838.2 7040.2 7507.8 8096.4 8379.2 474.2 517.5 538.0 540.4 567.7 3317.5 3841.5 3853.9 3917.8 3956.6 64110.7 90827.0 91184.0 92324.0 92438.0 56210.2 74573.0 75825.0 75990.0 79794.0 27018.5 27035.5 50386.5 51047.0 68517.7 6368.6 7149.7 7200.3 7646.3 7855.3 42401.8 42536.1 43123.0 43256.0 44919.7 55293.0 59852.4 60725.0 61999.7 62147.1 10096.7 10203.2 10308.4 10529.4 10606.6 11006.3 11106.6 11124.5 11246.6 11387.1 10277.4 10354.6 10471.8 10491.0 10567.7 9563.2 9651.4 9960.4 10606.0 10677.7 8338.0 9892.4 9983.9 10374.5 10485.4 8656.2 8996.8 9037.4 9100.3 9135.3 6997.0 7292.7 8708.6 8737.3 9204.7 10:56:03 INFO - PROCESS | 1929 | -------- Summary: end -------- 10:56:03 INFO - PROCESS | 1929 | 10:56:03 INFO - TEST-INFO | 1929: exit 0 10:56:03 INFO - TEST-OK | dromaeo_css | took 1112794ms 10:56:03 INFO - TEST-START | kraken 10:56:03 INFO - operating with platform_type : mac_ 10:56:03 INFO - Initialising browser for kraken test... 10:56:03 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpW7YMHJ/profile http://localhost:52122/getInfo.html) 10:56:06 INFO - PROCESS | 1934 | __metrics Screen width/height:1600/1200 10:56:06 INFO - PROCESS | 1934 | colorDepth:24 10:56:06 INFO - PROCESS | 1934 | Browser inner width/height: 1024/689 10:56:06 INFO - PROCESS | 1934 | __metrics 10:56:07 ERROR - PROCESS | 1934 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 10:56:07 INFO - TEST-INFO | 1934: exit 0 10:56:07 INFO - Browser initialized. 10:56:07 INFO - Running cycle 1/1 for kraken test... 10:56:07 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/T/tmpW7YMHJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:56:19 INFO - PROCESS | 1937 | RSS: Main: 252600320 10:56:19 INFO - PROCESS | 1937 | 10:56:22 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52122/tests/kraken/driver.html?testName=audio-beat-detection) 10:56:23 INFO - PROCESS | 1937 | RSS: Main: 264359936 10:56:23 INFO - PROCESS | 1937 | 10:56:26 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52122/tests/kraken/driver.html?testName=audio-dft) 10:56:26 INFO - PROCESS | 1937 | RSS: Main: 269545472 10:56:26 INFO - PROCESS | 1937 | 10:56:30 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52122/tests/kraken/driver.html?testName=audio-fft) 10:56:30 INFO - PROCESS | 1937 | RSS: Main: 269381632 10:56:30 INFO - PROCESS | 1937 | 10:56:32 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52122/tests/kraken/driver.html?testName=audio-oscillator) 10:56:33 INFO - PROCESS | 1937 | RSS: Main: 269983744 10:56:33 INFO - PROCESS | 1937 | 10:56:35 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52122/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:56:35 INFO - PROCESS | 1937 | RSS: Main: 270569472 10:56:35 INFO - PROCESS | 1937 | 10:56:38 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52122/tests/kraken/driver.html?testName=imaging-darkroom) 10:56:39 INFO - PROCESS | 1937 | RSS: Main: 271110144 10:56:39 INFO - PROCESS | 1937 | 10:56:42 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52122/tests/kraken/driver.html?testName=imaging-desaturate) 10:56:42 INFO - PROCESS | 1937 | RSS: Main: 271826944 10:56:42 INFO - PROCESS | 1937 | 10:56:46 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52122/tests/kraken/driver.html?testName=json-parse-financial) 10:56:46 INFO - PROCESS | 1937 | RSS: Main: 271527936 10:56:46 INFO - PROCESS | 1937 | 10:56:48 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52122/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:56:48 INFO - PROCESS | 1937 | RSS: Main: 270725120 10:56:48 INFO - PROCESS | 1937 | 10:56:50 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52122/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:56:51 INFO - PROCESS | 1937 | RSS: Main: 270905344 10:56:51 INFO - PROCESS | 1937 | 10:56:53 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52122/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:56:54 INFO - PROCESS | 1937 | RSS: Main: 271187968 10:56:54 INFO - PROCESS | 1937 | 10:56:57 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:56:58 INFO - PROCESS | 1937 | RSS: Main: 271228928 10:56:58 INFO - PROCESS | 1937 | 10:57:00 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:57:01 INFO - PROCESS | 1937 | RSS: Main: 271241216 10:57:01 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:52122/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52122/tests/kraken/driver.html?testName=ai-astar) 10:57:03 INFO - PROCESS | 1937 | RSS: Main: 273264640 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | __start_tp_report 10:57:03 INFO - PROCESS | 1937 | _x_x_mozilla_page_load 10:57:03 INFO - PROCESS | 1937 | _x_x_mozilla_page_load_details 10:57:03 INFO - PROCESS | 1937 | |i|pagename|runs| 10:57:03 INFO - PROCESS | 1937 | |0;ai-astar;115;111;114;140;153;117;116;174;176;127 10:57:03 INFO - PROCESS | 1937 | |1;audio-beat-detection;159;128;144;164;120;140;142;124;171;122 10:57:03 INFO - PROCESS | 1937 | |2;audio-dft;192;199;203;224;200;232;261;197;197;197 10:57:03 INFO - PROCESS | 1937 | |3;audio-fft;75;79;73;149;57;59;62;67;160;85 10:57:03 INFO - PROCESS | 1937 | |4;audio-oscillator;70;89;121;71;72;85;119;72;73;116 10:57:03 INFO - PROCESS | 1937 | |5;imaging-gaussian-blur;91;95;90;88;91;89;128;88;90;87 10:57:03 INFO - PROCESS | 1937 | |6;imaging-darkroom;96;98;103;113;92;98;91;98;108;111 10:57:03 INFO - PROCESS | 1937 | |7;imaging-desaturate;91;114;128;148;104;78;78;140;132;144 10:57:03 INFO - PROCESS | 1937 | |8;json-parse-financial;58;60;58;60;62;62;60;81;62;59 10:57:03 INFO - PROCESS | 1937 | |9;json-stringify-tinderbox;68;70;69;66;79;71;81;107;100;61 10:57:03 INFO - PROCESS | 1937 | |10;stanford-crypto-aes;101;109;109;84;88;85;85;94;96;118 10:57:03 INFO - PROCESS | 1937 | |11;stanford-crypto-ccm;137;139;136;139;162;146;154;144;180;142 10:57:03 INFO - PROCESS | 1937 | |12;stanford-crypto-pbkdf2;170;167;219;171;172;162;155;206;225;166 10:57:03 INFO - PROCESS | 1937 | |13;stanford-crypto-sha256-iterative;69;64;68;65;70;69;66;68;65;68 10:57:03 INFO - PROCESS | 1937 | __end_tp_report 10:57:03 INFO - PROCESS | 1937 | __start_cc_report 10:57:03 INFO - PROCESS | 1937 | _x_x_mozilla_cycle_collect,1088 10:57:03 INFO - PROCESS | 1937 | __end_cc_report 10:57:03 INFO - PROCESS | 1937 | __startTimestamp1464285423525__endTimestamp 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | ------- Summary: start ------- 10:57:03 INFO - PROCESS | 1937 | Number of tests: 14 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#0] ai-astar Cycles:10 Average:134.30 Median:133.50 stddev:25.19 (18.9%) stddev-sans-first:25.73 10:57:03 INFO - PROCESS | 1937 | Values: 115.0 111.0 114.0 140.0 153.0 117.0 116.0 174.0 176.0 127.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:143.00 stddev:18.33 (12.8%) stddev-sans-first:18.30 10:57:03 INFO - PROCESS | 1937 | Values: 159.0 128.0 144.0 164.0 120.0 140.0 142.0 124.0 171.0 122.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#2] audio-dft Cycles:10 Average:210.20 Median:201.50 stddev:22.06 (11.0%) stddev-sans-first:22.40 10:57:03 INFO - PROCESS | 1937 | Values: 192.0 199.0 203.0 224.0 200.0 232.0 261.0 197.0 197.0 197.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#3] audio-fft Cycles:10 Average:86.60 Median:70.00 stddev:36.95 (52.8%) stddev-sans-first:38.95 10:57:03 INFO - PROCESS | 1937 | Values: 75.0 79.0 73.0 149.0 57.0 59.0 62.0 67.0 160.0 85.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:72.00 stddev:21.57 (30.0%) stddev-sans-first:21.78 10:57:03 INFO - PROCESS | 1937 | Values: 70.0 89.0 121.0 71.0 72.0 85.0 119.0 72.0 73.0 116.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#5] imaging-gaussian-blur Cycles:10 Average:93.70 Median:90.00 stddev:12.26 (13.6%) stddev-sans-first:12.96 10:57:03 INFO - PROCESS | 1937 | Values: 91.0 95.0 90.0 88.0 91.0 89.0 128.0 88.0 90.0 87.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#6] imaging-darkroom Cycles:10 Average:100.80 Median:94.00 stddev:7.67 (8.2%) stddev-sans-first:7.94 10:57:03 INFO - PROCESS | 1937 | Values: 96.0 98.0 103.0 113.0 92.0 98.0 91.0 98.0 108.0 111.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#7] imaging-desaturate Cycles:10 Average:115.70 Median:146.00 stddev:26.76 (18.3%) stddev-sans-first:26.85 10:57:03 INFO - PROCESS | 1937 | Values: 91.0 114.0 128.0 148.0 104.0 78.0 78.0 140.0 132.0 144.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:61.00 stddev:6.78 (11.1%) stddev-sans-first:7.02 10:57:03 INFO - PROCESS | 1937 | Values: 58.0 60.0 58.0 60.0 62.0 62.0 60.0 81.0 62.0 59.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#9] json-stringify-tinderbox Cycles:10 Average:77.20 Median:69.50 stddev:15.11 (21.7%) stddev-sans-first:15.66 10:57:03 INFO - PROCESS | 1937 | Values: 68.0 70.0 69.0 66.0 79.0 71.0 81.0 107.0 100.0 61.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#10] stanford-crypto-aes Cycles:10 Average:96.90 Median:85.00 stddev:11.99 (14.1%) stddev-sans-first:12.62 10:57:03 INFO - PROCESS | 1937 | Values: 101.0 109.0 109.0 84.0 88.0 85.0 85.0 94.0 96.0 118.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:145.00 stddev:13.90 (9.6%) stddev-sans-first:14.17 10:57:03 INFO - PROCESS | 1937 | Values: 137.0 139.0 136.0 139.0 162.0 146.0 154.0 144.0 180.0 142.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.30 Median:171.50 stddev:25.31 (14.8%) stddev-sans-first:26.51 10:57:03 INFO - PROCESS | 1937 | Values: 170.0 167.0 219.0 171.0 172.0 162.0 155.0 206.0 225.0 166.0 10:57:03 INFO - PROCESS | 1937 | 10:57:03 INFO - PROCESS | 1937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:2.04 (3.0%) stddev-sans-first:2.06 10:57:03 INFO - PROCESS | 1937 | Values: 69.0 64.0 68.0 65.0 70.0 69.0 66.0 68.0 65.0 68.0 10:57:03 INFO - PROCESS | 1937 | -------- Summary: end -------- 10:57:03 INFO - PROCESS | 1937 | 10:57:04 INFO - TEST-INFO | 1937: exit 0 10:57:04 INFO - TEST-OK | kraken | took 60336ms 10:57:04 INFO - SUITE-END | took 1173s 10:57:04 INFO - Completed test suite (00:19:33) 10:57:04 INFO - javascript benchmark 10:57:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6842.77081307452, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.502682084277, 3436.982815085925, 3458.775179613325, 3470.618231994482, 3488.2674638325952, 5632.746526406311, 5699.202111704365, 5769.740361683724, 5786.218860453838, 5827.708614569276, 5582.944170558303, 5652.5195358394585, 5684.2326285951385, 5688.203651488784, 5767.30792304924, 5142.202958541423, 5159.690418574879, 5228.73856307185, 5262.394824595182, 5304.0, 362.47183881416026, 5268.525832675058, 5278.736063196844, 5286.180642000477, 5319.228711836781, 5182.404023537304, 5209.661372010807, 5244.056069907415, 5253.921191182136, 5326.174442961308, 4312.698111132222, 5084.211947148198, 5248.632595718302, 5278.973605131988, 5286.180642000496, 4203.642690371292, 5106.897862042775, 5174.146265866128, 5198.948010519922, 5264.236685680555, 4713.670043096985, 5570.359408668014, 5631.267935168402, 5666.716664166775, 5717.628354156966, 6045.727942242565, 6140.2588579677695, 6221.346758590374, 6256.311805701369, 6287.96856015717, 6172.938270617281, 6189.195404597373, 6211.968940155315, 6247.125402443661, 6260.40526150015, 5863.355030946593, 5904.5571582131515, 5934.991051521209, 5939.673317967553, 5979.2824861016525, 6157.630542167484, 6193.411625895533, 6194.721237544321, 6257.155284036597, 6265.342139075331, 6200.0699895016105, 6219.440250377488, 6221.626702397871, 6249.625022498664, 6267.62394256346, 6204.906926396107, 6207.193064901534, 6249.375062493805, 6259.061140828912, 6261.279952805395, 6061.757529698851, 6156.476699480505, 6157.415045570664, 6207.503399728011, 6279.654618995908, 6079.6960151992225, 6097.390260973867, 6129.086972572236, 6144.126041557368, 6176.166217560662, 4872.4883887192045, 4938.9012219755405, 4956.90086198274, 4961.42943561495, 4965.354503914468, 4431.246688063037, 4435.3125265583885, 4466.397036400044, 4502.774861256989, 4508.1659892919915, 4523.954760452353, 5780.739866706008, 5785.392533783976, 5867.501262392744, 5873.676947767828, 6274.749010039639, 6278.780242691484, 6279.0, 6289.77985770505, 6291.213598300213, 5697.0, 5816.970915145397, 5825.912611310834, 5846.181534585162, 5902.822915312548, 5477.424870388551, 5482.533984611273, 5486.615936884459, 5488.368837583649, 5496.477834605706, 6075.848103797441, 6431.099646049557, 6436.806895793134, 6441.452476539453, 6443.838904027437, 6202.658853763086, 6221.0, 6269.0, 6272.059191121369, 6309.652969086745, 6358.2687990879795, 6373.458256048288, 6387.361263873576, 6395.584287021329, 6424.743010279536, 6065.181200537871, 6124.594542075475, 6188.659623720739, 6252.96826023701, 6294.748210071546, 6208.317085120723, 6222.160008398808, 6229.813105606839, 6261.5616906816085, 6279.780207692892, 5951.464368206709, 5986.730597123227, 5991.2510936132985, 6013.759449621966, 6033.276006879027, 5803.941960580509, 5846.093855452412, 5864.237649105589, 5908.3205431375945, 6005.069214271794, 5576.832695019156, 5604.579656525695, 5791.362950075404, 5822.7670893163795, 5885.588008839341, 5058.494150584912, 5094.439611642642, 6001.639901605918, 6022.698865056817, 6025.698715064317, 5689.487946084872, 5702.800401985911, 5737.168110623853, 5738.196652468574, 5780.450857168562], "value": 5632.325865007177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.5197930038913, 499.1514425476689, 509.9898002039959, 537.2666310486186, 556.6520924422236, 38887.0, 41482.79258603703, 41527.0, 41585.16829663409, 41622.791886040526, 42360.0, 43111.0, 43142.13715725691, 43145.7842710786, 43175.56824431755, 9555.426674399541, 9685.515724213796, 9769.120779129877, 9790.46152461618, 9801.970793066732, 8197.754067377988, 9760.658376956808, 9790.559424825864, 9821.803563928717, 9832.901670983307, 9765.951170244174, 9798.0, 9845.40927544346, 9859.457729824857, 9862.211023118134, 9739.56171972263, 9805.705828825146, 9817.067378599093, 9819.263555233387, 9841.261905357127, 7793.649285782153, 8688.565571721452, 9620.807583848355, 9764.414135151914, 9764.755881102958, 27804.86097569499, 30718.539221911687, 32750.508742368882, 33086.83456582726, 40345.39481907774, 2740.725927407263, 3031.6816734242807, 3052.435299469605, 3286.8520916558814, 3321.618013928405, 22208.555828883495, 26500.204993850217, 27900.302492437648, 28954.565681514796, 28954.986575469757, 2519.407939134302, 2643.3920198354485, 2643.4316621926378, 2702.7972902032425, 2825.844578548179, 416700.0, 433252.0, 475471.0, 476038.0, 477852.0, 33408.66591334104, 33526.664733352845, 33592.49611255833, 33981.660183398344, 34935.65064349324, 35672.64327356693, 35849.82075089608, 35990.64009359925, 36137.0, 36185.81907090448, 15164.696706065817, 15193.0, 15291.770623440658, 15303.38786448552, 15311.770323445156, 10839.729006774736, 12797.296148711725, 13016.0, 13056.21662700241, 13064.934675326562, 7830.6084695764985, 7865.803354916173, 7912.446128771046, 7919.089304729914, 7980.760577182694, 2866.813657112281, 3294.225856923621, 3320.0, 3321.103302108417, 3344.8494817733263, 852.9019162796234, 853.4836423963537, 1039.7140786283833, 1044.6448207609449, 1126.1385040444068, 22551.0, 28967.84128634831, 29560.0, 30078.69921300803, 30272.84863575712, 1087.7164945364545, 1090.7927493776158, 1113.9053180479589, 1135.7728454309172, 1194.8386967759416, 15085.0, 15137.091774493565, 15185.0, 15318.923405382902, 15401.152936588594, 697923.0, 699344.0, 701700.0, 705965.0, 707951.0, 59989.0, 61040.694796525735, 61103.38896610977, 61424.692876536225, 61922.0, 1273.751618434415, 1410.8730214280763, 1471.0658731705444, 1479.0903594289434, 1489.8361180270163, 25270.873645631655, 28999.420011599228, 29277.0, 29597.408051839273, 29938.95213667511, 50401.99196016132, 50984.74507627438, 51154.232686508985, 51376.48623513717, 51386.972260555325, 635038.0, 638424.0, 638637.0, 640184.0, 641586.0, 26066.34834129162, 26414.07550735715, 28212.294692632848, 28250.85874570614, 28396.0, 39734.80132599318, 46023.53976460193, 46633.533664664275, 46755.76622117004, 47127.0, 37814.62185378111, 38163.18368163273, 38535.42196867106, 38756.41865372078, 39641.0, 37794.433083503216, 38079.04802379962, 38518.84443466701, 38613.80693096516, 38904.80547597244, 29738.0, 37230.627693722716, 37568.43647345238, 37929.0, 37966.24067518579, 32804.67195328112, 33551.63828702253, 33829.884691215106, 34344.0, 34351.141221468664, 24420.755792441847, 25093.0, 25173.49653006893, 25595.872020639777, 25737.485250295264], "value": 18191.502553479808, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.7840159342711, 358.23516791649826, 369.71901354970214, 376.1348897535669, 395.72299390426707, 19876.801231987694, 20533.691994620094, 20738.585228295426, 21479.67780483292, 21500.8924955375, 20582.0, 20801.063952122153, 21073.367798966017, 21185.47036324089, 21254.57490850182, 2842.7583655389317, 5283.841484755463, 5906.751785651891, 6153.507719382439, 6184.536159788011, 6000.069989151689, 6011.969940150293, 6048.274207095133, 6087.817365479021, 6093.086037094427, 5813.447722466359, 5885.823425297248, 6034.788782392618, 6117.969410152943, 6120.0, 5994.310654274771, 6001.434605881872, 6076.908846367308, 6083.543734219929, 6114.480269177126, 4469.86018565267, 5056.84829455117, 5245.423003469616, 5254.0, 5255.369355677305, 25787.0, 25923.48153036929, 26351.472970540482, 26493.3376665583, 26691.866540667368, 2066.2664754012258, 2112.640851055324, 2123.384218576626, 2175.4887601413657, 2213.889305534733, 14880.479183228643, 15383.615409614737, 15453.5363939082, 15649.608759780982, 15678.216089195495, 1714.8027976782705, 1715.9399421020205, 1756.464278395089, 1760.8063113057553, 1832.1388947194798, 84964.15035849686, 116083.0, 121189.0, 130550.0, 134474.0, 11494.0, 11807.822882656767, 11855.525778968744, 11865.288082715064, 11973.281603103842, 14648.85351146475, 14658.560243192722, 14684.678378945946, 14757.926210369094, 14770.113793172444, 8571.914280857236, 8768.649254029768, 8817.515036673045, 8921.0, 8943.865842012376, 8626.827463450696, 8754.21212090915, 8762.824743505094, 8850.513221772735, 8850.513221772864, 4519.18654642161, 4573.931391029138, 4620.630349572026, 4654.674172807939, 4677.7193368398, 1946.4355336952126, 1995.3614843250311, 1997.7203191553194, 2000.3098930868828, 2031.1266155552958, 361.92037751694585, 385.6413535412038, 407.5618709886883, 429.06249844090763, 829.7344849648055, 11593.0, 11770.058395328353, 11837.0, 11885.821712674144, 11906.404679765978, 430.9612134907873, 436.85365402589855, 445.0320552797652, 448.47976347436816, 451.0415367344393, 5664.376918538957, 6100.0, 6166.599171053867, 6173.938260617426, 6208.596441231305, 449116.0, 532489.0, 536552.0, 539845.3007734936, 588423.0, 123301.38349308375, 135123.0, 135819.0, 140914.2954285222, 142078.0, 372.51944990961897, 419.59509073743374, 433.7874441523694, 438.79157400234635, 443.07839693438217, 8888.977767556813, 9105.544722763703, 9582.0, 10729.248952573556, 10857.077148442471, 44129.77935110304, 54107.0, 54152.187717185065, 54264.0, 54879.0, 61748.382516174264, 79368.0, 79582.6020869892, 80126.39747204907, 82559.17440825755, 7345.8898116527225, 7909.841803164019, 8038.276555110068, 8076.353891688534, 8093.55485448306, 12045.63863084109, 12245.142840001114, 12528.0, 12528.937355313165, 12645.557405490763, 9589.904100958902, 10829.783404332027, 10860.294080884718, 10932.125429965425, 11179.720506987065, 10370.688879333633, 10443.738906527398, 10490.370577765358, 10573.735656608646, 10846.783064338826, 10902.345859248471, 10905.781884362426, 10950.671479855617, 10982.945085274523, 11278.379689117177, 6850.177978642595, 7369.016769427797, 7406.740764073232, 7533.133689625544, 8221.54781487024, 9827.5086245686, 11265.26775759573, 11556.537738490366, 11585.88414115848, 11588.884111159117], "value": 8562.851368323454, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1542.4678485922357, 1577.7554479055748, 1827.5339788353967, 1930.334034758008, 1974.5359840437504, 6858.9025755879065, 7722.459427840054, 8174.427790054699, 8638.784030399243, 8708.782280442992, 7178.641067946595, 8350.832983340344, 8511.616977236024, 8568.271696905755, 8586.742397728063, 1962.9509262268487, 2335.0543030072804, 2337.9883100584475, 2355.988220058906, 2366.810655147584, 1781.8663600230034, 2325.9651105233434, 2342.6251799711963, 2348.9060437582475, 2357.3399448154546, 2263.1400067974146, 2295.6556516522487, 2296.2651951375565, 2332.976670233293, 2382.9285121446383, 2312.5259321839153, 2316.7683231676865, 2322.3729593009875, 2333.381653861728, 2344.7303560090636, 2300.493891343902, 2315.7568455312285, 2328.8136949044206, 2335.135999680112, 2342.0982921575146, 8553.572321383906, 8580.099089595627, 8620.82758344836, 8629.913700862973, 8640.697575584825, 5180.352455943007, 5308.416074231832, 5340.465953404668, 5350.491703288181, 5368.32895888014, 3334.3328335832084, 3340.5490258815234, 3549.361114999299, 3556.466530020492, 3558.0393293810525, 999.3004896572355, 1021.7343490692399, 1022.3661329975463, 1028.0490546244769, 1039.018127869164, 10527.78944421115, 11012.063974562172, 11147.0, 11174.994250517411, 11290.774184516345, 4432.667549933768, 4494.707843990195, 4559.931601025987, 4562.634989200856, 4597.3333866589155, 8966.641334346554, 8997.865032024525, 8999.010108888016, 9003.819923601623, 9004.774880627905, 5130.256112863613, 5205.0, 5206.843794686166, 5219.08665983459, 5233.2935053768015, 4355.499117601453, 4737.407824021997, 4832.4684284728655, 4883.389576302962, 4907.705537667752, 3408.5799082651597, 3653.926921461556, 3844.038990252437, 3851.9422208666892, 3872.7676339419727, 1181.704573856536, 1184.3071802995344, 1192.070185255502, 1196.7845787758288, 1197.886200810939, 777.9883301750478, 887.7647423432795, 892.8526793079069, 897.2821742605889, 966.9274804389559, 4420.381146639473, 4845.248986407112, 5788.681622510802, 5820.126980952891, 5922.674252916131, 384.2679695180685, 431.7221025763712, 440.62546835189835, 442.94684637843665, 451.74927915007487, 3860.517435320585, 3905.921881562353, 3949.921001579952, 3994.6205110514456, 4013.0769922917893, 10046.648367307109, 10201.74495637615, 10367.963203679723, 10429.478526073666, 10478.73803154912, 10314.0, 10388.220883433773, 10409.479526023668, 10413.11488523484, 10415.843762343571, 7768.378529717496, 7970.322522585529, 7994.920050799534, 8016.478928869605, 8061.234182752629, 5492.697901615449, 5502.0, 5874.236349274567, 5916.467517923407, 5966.910496342645, 8097.1497992712275, 9212.769680758034, 9625.807483850143, 9687.564059617192, 9743.805123897624, 8008.439409241297, 9921.206303495559, 9937.602495900082, 9960.203183745429, 9976.05227503386, 5567.387587365306, 7195.424366050808, 7348.853022939618, 7459.850802984019, 7537.359324457482, 8159.510429374256, 8213.055498617736, 8264.628091736007, 8299.917000829915, 8321.16788321163, 7289.307515785992, 7387.741429050173, 7447.329740323397, 7531.133919599097, 7577.924220757722, 7248.767709489294, 7294.96352518234, 7317.524360916524, 7348.0, 7353.852922941618, 6826.761063362758, 6865.931340686729, 6917.100776898971, 6933.5493192942295, 6954.235034146341, 4773.284007398918, 4806.47128815823, 4862.5380588844, 4936.234883593049, 5057.367829021372, 4286.121345124305, 4672.159011377985, 4828.782704778223, 4876.344139700636, 4988.8752781180765], "value": 4359.187010769767, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.1011969152389, 312.40486872507864, 314.31636191283957, 319.1606076020067, 321.41823299827297, 4858.149823780837, 5354.518093371596, 5521.950829342432, 5576.442355764431, 5656.660600363981, 5511.807086751955, 5514.332968575903, 5515.283013208277, 5517.44825517448, 5554.944450555493, 3986.1698194282094, 3992.6606238469694, 4080.224757296119, 4206.47419072616, 4213.178430206111, 3834.8657796977113, 3843.250566139604, 4125.133721918401, 4213.199492096507, 4217.536071032184, 3473.513708080871, 4079.1841631673637, 4202.684798640099, 4211.810468528924, 4215.536291008002, 3089.258577941278, 3764.209516001643, 3850.4224366344993, 3947.934057804391, 4123.525794533637, 2682.1685277563824, 2901.405211931549, 3325.900222993314, 3515.437529995214, 3537.4693795930816, 4145.854895078658, 4590.311453282001, 4905.852824415273, 5254.6847189168775, 5278.208268759717, 4376.737395756233, 4498.852792537915, 4612.215923293048, 4736.881577960544, 4776.522347765231, 4719.598834099105, 5092.516210959953, 5792.565557583198, 5818.330891947396, 5827.4755272025295, 3056.5873607062986, 3764.3976963685677, 3884.6892248620325, 3925.7840818754958, 3959.5050618672667, 5712.742926568314, 5823.417658234142, 5929.6145750526075, 6109.625334299792, 6126.009047059679, 3558.857645694195, 3673.3571624965525, 3992.0, 3997.220541994341, 4002.579729128458, 4046.433499310099, 4050.696197785178, 4061.2739585675968, 4068.2270368629866, 4105.507339119325, 4020.4170395292517, 4772.308015337826, 4801.4718380978065, 4811.845157162255, 4847.781849816696, 4419.823207071746, 5794.8989691958395, 5871.706414679249, 5896.764129434775, 6059.75816928152, 1258.942488309824, 1261.4449642157422, 1341.597520743773, 1387.4796951143321, 1399.433229542037, 752.3492179264897, 789.6959670526888, 817.9631916563769, 857.7212405968086, 900.1583519409373, 5383.461653834585, 5429.0, 5445.618806683573, 5452.40023597404, 5552.555795536347, 4871.952530206023, 5958.616553378683, 6009.218801555857, 6032.487238584769, 6068.271807383142, 4715.882102947454, 4932.753362331869, 5372.435894231127, 5394.865128371822, 5435.239066530688, 2552.719200887901, 2778.3470884342164, 2960.7712799188525, 3016.834074125944, 3017.204763165913, 5533.391326954032, 5662.150677398423, 6024.277086749618, 6168.272883592601, 6224.844378890564, 5519.917201241985, 6001.879962400728, 6287.434130928147, 6303.590266632654, 6333.081703153109, 5293.967676303161, 5797.797077102281, 6114.602550834271, 6384.457321127663, 6410.647414392253, 4720.787564559534, 5600.635958662674, 5642.802501912413, 5736.282964629421, 5966.970165149147, 5080.9006506030555, 5544.696996205807, 5980.760769569169, 5981.611195272293, 6007.729652165575, 5404.702741349263, 5605.24329215567, 6041.697915104315, 6291.937080629135, 6309.7160627770945, 3329.500574913782, 3473.652634736506, 3849.5957924417535, 3980.7858603125164, 4007.3988901664984, 5154.690718556899, 5626.324841019104, 6056.333803281547, 6139.201903752483, 6151.6001459904965, 5301.390340110936, 5680.375158732453, 5791.391903850035, 5793.362730099601, 5845.824625261249, 4862.854114376574, 5097.776533631976, 5759.625624334405, 5789.2184555086205, 5798.76804927815, 4697.788599512962, 4971.776270067783, 5380.623356365173, 5585.748641311232, 5646.88706225865, 4876.439209490812, 4959.603231741524, 5552.750126244248, 5683.744231509675, 5801.1878337033695, 4623.92508981537, 4898.951010489992, 4919.434265059421, 5482.533984611353, 5491.364145210401], "value": 4141.574715798439, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.4049971527618, 664.68759682949, 697.49431662045, 735.0774777654043, 766.7316439246262, 13257.40341684624, 14951.925240373797, 15046.172460514666, 15167.393304267829, 15175.848241517582, 13852.584422467342, 13920.095193812394, 13928.582142535715, 13936.0, 14003.649908752286, 700.8773464643692, 854.0775961961098, 864.8486514859906, 873.9563021848913, 905.0316161706976, 870.0386073388909, 886.4858382138376, 893.6648756716231, 901.7204666553357, 903.9909600904006, 957.5020989085672, 962.3263715399214, 963.5037955452947, 963.7060696487569, 965.6089283840021, 803.3412601666636, 949.6960972488806, 959.5250351076193, 959.8128364968799, 960.7270366764066, 700.8563244534859, 711.7508871894847, 713.2582114600809, 714.7641278378175, 716.0476566166985, 14495.855041449662, 14533.837293016533, 14560.126392416383, 14566.854331456761, 14619.049761765558, 12321.5071397144, 12465.93767031159, 12472.376381180904, 12484.875151248461, 12777.808332875014, 9563.187129094036, 9958.253131015203, 10058.094771470604, 10313.793724125551, 10346.172306215485, 3394.9490757638655, 3473.1838018065732, 3536.4341705327024, 3550.8579656813695, 3562.4834399012257, 56191.0, 77288.0, 77874.0, 80827.59586202032, 80833.0, 7489.887651685229, 9396.67111651089, 9469.431834089839, 9691.9030809691, 9768.36505627132, 21465.356039318845, 21841.126354945623, 21866.45333866666, 21912.780872191073, 21922.013509392116, 7334.523255988343, 7401.512136888203, 7468.439867009996, 7586.924130758622, 7592.582407967615, 3990.501187351581, 4035.394690796404, 4051.513818341818, 4063.167050754588, 4071.2875246831686, 2920.678725340211, 3447.3277710846646, 3515.472679098156, 3526.4357702767948, 3550.786952782841, 606.6814922165898, 617.9907301390483, 622.2936966543007, 630.8864404407159, 633.4425705379236, 528.8942211557704, 561.1190431023255, 573.4838645219336, 582.6766144789598, 593.9910901336483, 6838.1794184697155, 7040.190378106481, 7507.798752199622, 8096.352291816641, 8379.162083791573, 474.18440282713675, 517.526463286089, 537.9536800922247, 540.3650710415246, 567.6934455394123, 3317.4857897026, 3841.4814000110186, 3853.9421908671393, 3917.764934103963, 3956.5756327721997, 64110.679446602466, 90827.0, 91184.0, 92324.0, 92438.0, 56210.15684764732, 74573.0, 75825.0, 75990.0, 79794.0, 27018.459630807665, 27035.459290814073, 50386.49613503891, 51046.979060419326, 68517.65741171263, 6368.64972426521, 7149.678264478215, 7200.279972002758, 7646.31183193493, 7855.253750893656, 42401.78799105985, 42536.149277014905, 43123.0, 43256.0, 44919.66924089321, 55293.0, 59852.40147598468, 60725.0, 61999.6900015497, 62147.06779398222, 10096.69709908704, 10203.234757393373, 10308.381497110197, 10529.36823790575, 10606.628767993083, 11006.339619622848, 11106.61126860556, 11124.499397526968, 11246.550137994389, 11387.145964052563, 10277.383356998604, 10354.637587684394, 10471.79056418852, 10491.0, 10567.735806604896, 9563.187129093827, 9651.420914745138, 9960.402375857471, 10606.045455909005, 10677.718673759198, 8338.04112527067, 9892.356996795184, 9983.850242246517, 10374.481275936023, 10485.423301718478, 8656.220133800483, 8996.775080623036, 9037.412568183046, 9100.31747618918, 9135.26917846584, 6997.0, 7292.708291668486, 8708.564571771512, 8737.301015918838, 9204.677836275698], "value": 6480.430028844728, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1604.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 111.0, 114.0, 140.0, 153.0, 117.0, 116.0, 174.0, 176.0, 127.0], "value": 134.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 128.0, 144.0, 164.0, 120.0, 140.0, 142.0, 124.0, 171.0, 122.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 199.0, 203.0, 224.0, 200.0, 232.0, 261.0, 197.0, 197.0, 197.0], "value": 210.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 73.0, 149.0, 57.0, 59.0, 62.0, 67.0, 160.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 89.0, 121.0, 71.0, 72.0, 85.0, 119.0, 72.0, 73.0, 116.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 90.0, 88.0, 91.0, 89.0, 128.0, 88.0, 90.0, 87.0], "value": 93.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 103.0, 113.0, 92.0, 98.0, 91.0, 98.0, 108.0, 111.0], "value": 100.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 114.0, 128.0, 148.0, 104.0, 78.0, 78.0, 140.0, 132.0, 144.0], "value": 115.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 60.0, 62.0, 62.0, 60.0, 81.0, 62.0, 59.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 69.0, 66.0, 79.0, 71.0, 81.0, 107.0, 100.0, 61.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 109.0, 84.0, 88.0, 85.0, 85.0, 94.0, 96.0, 118.0], "value": 96.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 139.0, 136.0, 139.0, 162.0, 146.0, 154.0, 144.0, 180.0, 142.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 167.0, 219.0, 171.0, 172.0, 162.0, 155.0, 206.0, 225.0, 166.0], "value": 181.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 68.0, 65.0, 70.0, 69.0, 66.0, 68.0, 65.0, 68.0], "value": 67.2, "unit": "score"}]}]} 10:57:04 INFO - Return code: 0 10:57:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:57:04 ERROR - # TBPL SUCCESS # 10:57:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:57:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:57:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:57:04 INFO - 2016-05-26 10:57:04.868 screenresolution[1942:17760] starting screenresolution argv=screenresolution get 10:57:04 INFO - 2016-05-26 10:57:04.870 screenresolution[1942:17760] Display 0: 1600x1200x32@60 10:57:04 INFO - 2016-05-26 10:57:04.876 screenresolution[1943:17763] starting screenresolution argv=screenresolution list 10:57:04 INFO - Available Modes on Display 0 10:57:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:57:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:57:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:57:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:57:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:57:05 INFO - Intel Iris: 10:57:05 INFO - Chipset Model: Intel Iris 10:57:05 INFO - Type: GPU 10:57:05 INFO - Bus: Built-In 10:57:05 INFO - VRAM (Dynamic, Max): 1536 MB 10:57:05 INFO - Vendor: Intel (0x8086) 10:57:05 INFO - Device ID: 0x0a2e 10:57:05 INFO - Revision ID: 0x0009 10:57:05 INFO - Displays: 10:57:05 INFO - Display: 10:57:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:57:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:57:05 INFO - Display Serial Number: 1600x1200 60 10:57:05 INFO - Main Display: Yes 10:57:05 INFO - Mirror: Off 10:57:05 INFO - Online: Yes 10:57:05 INFO - Rotation: Supported 10:57:05 INFO - Return code: 0 10:57:05 INFO - Running post-action listener: _resource_record_post_action 10:57:05 INFO - ##### 10:57:05 INFO - ##### Finished run-tests step (success) 10:57:05 INFO - ##### 10:57:05 INFO - Running post-run listener: _resource_record_post_run 10:57:05 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 1490944; Write bytes: 696345600; Read time: 16; Write time: 2031 10:57:05 INFO - TinderboxPrint: CPU usage
54.3% 10:57:05 INFO - TinderboxPrint: I/O read bytes / time
1,490,944 / 16 10:57:05 INFO - TinderboxPrint: I/O write bytes / time
696,345,600 / 2,031 10:57:05 INFO - TinderboxPrint: CPU idle
2,211.9 (45.7%) 10:57:05 INFO - TinderboxPrint: CPU system
973.0 (20.1%) 10:57:05 INFO - TinderboxPrint: CPU user
1,652.9 (34.2%) 10:57:05 INFO - TinderboxPrint: Swap in / out
398,196,736 / 0 10:57:05 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 395151872; Write bytes: 389474304; Read time: 29735; Write time: 685 10:57:05 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1490944; Write bytes: 295758848; Read time: 16; Write time: 1314 10:57:05 INFO - Running post-run listener: _upload_blobber_files 10:57:05 INFO - Blob upload gear active. 10:57:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:57:05 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 10:57:05 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'] 10:57:05 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 10:57:15 INFO - (blobuploader) - INFO - Open directory for files ... 10:57:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:57:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:57:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:23 INFO - (blobuploader) - INFO - Done attempting. 10:57:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:57:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:57:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:57:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:57:40 INFO - (blobuploader) - INFO - Done attempting. 10:57:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:57:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:57:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:58:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:58:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:58:03 INFO - (blobuploader) - INFO - Done attempting. 10:58:03 INFO - (blobuploader) - INFO - Iteration through files over. 10:58:03 INFO - Return code: 0 10:58:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:58:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:58:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdc1a1d7dc567fd446ded4155c067a4e046c2219091cae16831f627de44dbd0ba3f1372d4d66f141971d4b0228322fb670a5575623771f825a0a7fff0e65c792", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b5b7733ad67eed4bf6c022c22ebf7ccaacc2cbcd90c676aa6d480686feb1f1067c5357dd316b6a7f1f388c1870191bfb3f3e46a01def1f18cd8c3f3f2885b68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7112010b53934e9ab6f7315b2c409a245fd0eaac97e70020816d908a38db1f6249179fcac009d70bf279475df4cf144a5f9e1f7d8882365d8e95dab7d657c352"} 10:58:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:58:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:58:03 INFO - Contents: 10:58:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fdc1a1d7dc567fd446ded4155c067a4e046c2219091cae16831f627de44dbd0ba3f1372d4d66f141971d4b0228322fb670a5575623771f825a0a7fff0e65c792", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b5b7733ad67eed4bf6c022c22ebf7ccaacc2cbcd90c676aa6d480686feb1f1067c5357dd316b6a7f1f388c1870191bfb3f3e46a01def1f18cd8c3f3f2885b68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7112010b53934e9ab6f7315b2c409a245fd0eaac97e70020816d908a38db1f6249179fcac009d70bf279475df4cf144a5f9e1f7d8882365d8e95dab7d657c352"} 10:58:03 INFO - Running post-run listener: copy_logs_to_upload_dir 10:58:03 INFO - Copying logs to upload dir... 10:58:03 INFO - mkdir: /builds/slave/test/build/upload/logs 10:58:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1324.153310 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2016-05-26 10:58:04.319714) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 10:58:04.324424) ========= 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.Ccao7hDZJj/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.g5J40MdNVM/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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/fdc1a1d7dc567fd446ded4155c067a4e046c2219091cae16831f627de44dbd0ba3f1372d4d66f141971d4b0228322fb670a5575623771f825a0a7fff0e65c792", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b5b7733ad67eed4bf6c022c22ebf7ccaacc2cbcd90c676aa6d480686feb1f1067c5357dd316b6a7f1f388c1870191bfb3f3e46a01def1f18cd8c3f3f2885b68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7112010b53934e9ab6f7315b2c409a245fd0eaac97e70020816d908a38db1f6249179fcac009d70bf279475df4cf144a5f9e1f7d8882365d8e95dab7d657c352"} build_url:https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010436 build_url: 'https://queue.taskcluster.net/v1/task/WNmL3ss6Sd6-wVYwyALUiQ/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/fdc1a1d7dc567fd446ded4155c067a4e046c2219091cae16831f627de44dbd0ba3f1372d4d66f141971d4b0228322fb670a5575623771f825a0a7fff0e65c792", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b5b7733ad67eed4bf6c022c22ebf7ccaacc2cbcd90c676aa6d480686feb1f1067c5357dd316b6a7f1f388c1870191bfb3f3e46a01def1f18cd8c3f3f2885b68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7112010b53934e9ab6f7315b2c409a245fd0eaac97e70020816d908a38db1f6249179fcac009d70bf279475df4cf144a5f9e1f7d8882365d8e95dab7d657c352"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-26 10:58:04.357575) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:58:04.358003) ========= 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.Ccao7hDZJj/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.g5J40MdNVM/Listeners TMPDIR=/var/folders/cw/zb33kjnn0fl7x243_8cyf2fm00000w/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.005149 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-26 10:58:04.407349) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 10:58:04.407658) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-26 10:58:04.411136) ========= ========= Total master_lag: 4.56 =========