builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0370 starttime: 1463140179.76 results: success (0) buildid: 20160513030046 builduid: f13e940a58724e47b6786411ede947d8 revision: 5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 04:49:39.755661) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 04:49:39.756113) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-05-13 04:49:39.756386) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-05-13 04:49:42.013565) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 04:49:42.013892) ========= 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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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-13 04:49:41-- 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% 10.0M=0.001s 2016-05-13 04:49:42 (10.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.080982 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 04:49:42.113700) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 04:49:42.114019) ========= 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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.019740 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 04:49:42.166915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 04:49:42.167255) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4 --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 5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bFTrHg3q9Y/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.NABjDBxc4P/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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-13 04:49:42,191 truncating revision to first 12 chars 2016-05-13 04:49:42,191 Setting DEBUG logging. 2016-05-13 04:49:42,191 attempt 1/10 2016-05-13 04:49:42,192 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5a2deb5a9b09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 04:49:43,392 unpacking tar archive at: mozilla-central-5a2deb5a9b09/testing/mozharness/ program finished with exit code 0 elapsedTime=1.448624 ========= master_lag: 0.38 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 04:49:43.996770) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 04:49:44.000120) ========= script_repo_revision: 5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 04:49:44.000527) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 04:49:44.000790) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 04:49:44.015003) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-13 04:49:44.015313) ========= /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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 04:49:44 INFO - MultiFileLogger online at 20160513 04:49:44 in /builds/slave/test 04:49:44 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 04:49:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:49:44 INFO - {'append_to_log': False, 04:49:44 INFO - 'base_work_dir': '/builds/slave/test', 04:49:44 INFO - 'blob_upload_branch': 'Firefox', 04:49:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:49:44 INFO - 'branch': 'Firefox', 04:49:44 INFO - 'buildbot_json_path': 'buildprops.json', 04:49:44 INFO - 'config_files': ('talos/mac_config.py',), 04:49:44 INFO - 'default_actions': ('clobber', 04:49:44 INFO - 'read-buildbot-config', 04:49:44 INFO - 'download-and-extract', 04:49:44 INFO - 'populate-webroot', 04:49:44 INFO - 'create-virtualenv', 04:49:44 INFO - 'install', 04:49:44 INFO - 'run-tests'), 04:49:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:49:44 INFO - 'download_minidump_stackwalk': True, 04:49:44 INFO - 'download_symbols': 'ondemand', 04:49:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:49:44 INFO - 'tooltool.py': '/tools/tooltool.py', 04:49:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:49:44 INFO - '/tools/misc-python/virtualenv.py')}, 04:49:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:49:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:49:44 INFO - 'installer_path': 'installer.exe', 04:49:44 INFO - 'log_level': 'info', 04:49:44 INFO - 'log_name': 'talos', 04:49:44 INFO - 'log_to_console': True, 04:49:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:49:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:49:44 INFO - 'opt_config_files': (), 04:49:44 INFO - 'pip_index': False, 04:49:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:49:44 INFO - 'cmd': ('bash', 04:49:44 INFO - '-c', 04:49:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:49:44 INFO - 'enabled': True, 04:49:44 INFO - 'halt_on_failure': False, 04:49:44 INFO - 'name': 'check_screen_resolution'},), 04:49:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:49:44 INFO - 'cmd': ('bash', 04:49:44 INFO - '-c', 04:49:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:49:44 INFO - 'enabled': True, 04:49:44 INFO - 'halt_on_failure': False, 04:49:44 INFO - 'name': 'check_screen_resolution'},), 04:49:44 INFO - 'run_cmd_checks_enabled': True, 04:49:44 INFO - 'sps_profile': False, 04:49:44 INFO - 'sps_profile_interval': 0, 04:49:44 INFO - 'suite': 'dromaeojs-e10s', 04:49:44 INFO - 'system_bits': '32', 04:49:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:49:44 INFO - 'title': 't-yosemite-r7-0370', 04:49:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:49:44 INFO - 'use_talos_json': True, 04:49:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:49:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:49:44 INFO - 'work_dir': 'build'} 04:49:44 INFO - ##### 04:49:44 INFO - ##### Running clobber step. 04:49:44 INFO - ##### 04:49:44 INFO - Running pre-action listener: _resource_record_pre_action 04:49:44 INFO - Running main action method: clobber 04:49:44 INFO - rmtree: /builds/slave/test/build 04:49:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:49:44 INFO - Running post-action listener: _resource_record_post_action 04:49:44 INFO - ##### 04:49:44 INFO - ##### Finished clobber step (success) 04:49:44 INFO - ##### 04:49:44 INFO - ##### 04:49:44 INFO - ##### Running read-buildbot-config step. 04:49:44 INFO - ##### 04:49:44 INFO - Running pre-action listener: _resource_record_pre_action 04:49:44 INFO - Running main action method: read_buildbot_config 04:49:44 INFO - Using buildbot properties: 04:49:44 INFO - { 04:49:44 INFO - "project": "", 04:49:44 INFO - "product": "firefox", 04:49:44 INFO - "script_repo_revision": "production", 04:49:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:49:44 INFO - "repository": "", 04:49:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:49:44 INFO - "buildid": "20160513030046", 04:49:44 INFO - "pgo_build": "False", 04:49:44 INFO - "basedir": "/builds/slave/test", 04:49:44 INFO - "buildnumber": 43, 04:49:44 INFO - "slavename": "t-yosemite-r7-0370", 04:49:44 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:49:44 INFO - "platform": "yosemite_r7", 04:49:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:49:44 INFO - "branch": "mozilla-central", 04:49:44 INFO - "repo_path": "mozilla-central", 04:49:44 INFO - "revision": "5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4", 04:49:44 INFO - "stage_platform": "macosx64", 04:49:44 INFO - "builduid": "f13e940a58724e47b6786411ede947d8", 04:49:44 INFO - "slavebuilddir": "test" 04:49:44 INFO - } 04:49:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 04:49:44 INFO - Running post-action listener: _resource_record_post_action 04:49:44 INFO - ##### 04:49:44 INFO - ##### Finished read-buildbot-config step (success) 04:49:44 INFO - ##### 04:49:44 INFO - ##### 04:49:44 INFO - ##### Running download-and-extract step. 04:49:44 INFO - ##### 04:49:44 INFO - Running pre-action listener: _resource_record_pre_action 04:49:44 INFO - Running main action method: download_and_extract 04:49:44 INFO - mkdir: /builds/slave/test/build/tests 04:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:44 INFO - https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:49:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 04:49:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 04:49:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/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 04:49:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/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 04:49:45 INFO - Downloaded 1199 bytes. 04:49:45 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 04:49:45 INFO - Using the following test package requirements: 04:49:45 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 04:49:45 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:49:45 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 04:49:45 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:49:45 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 04:49:45 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:49:45 INFO - u'jsshell-mac.zip'], 04:49:45 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:49:45 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 04:49:45 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 04:49:45 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:49:45 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 04:49:45 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:49:45 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 04:49:45 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:49:45 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 04:49:45 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 04:49:45 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 04:49:45 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:49: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')]} 04:49:45 INFO - https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:49:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:49:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:49:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/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 04:49:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/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 04:49:46 INFO - Downloaded 18153870 bytes. 04:49:46 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'] 04:49:46 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 04:49:50 INFO - Return code: 0 04:49:50 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 04:49: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')]} 04:49:50 INFO - https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:49:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:49:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 04:49:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/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 04:49:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/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 04:49:51 INFO - Downloaded 18153870 bytes. 04:49:51 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'] 04:49:51 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 04:49:54 INFO - Return code: 0 04:49:54 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')]} 04:49:54 INFO - https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:49:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:49:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 04:49:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/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 04:49:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/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 04:49:55 INFO - Downloaded 10840239 bytes. 04:49:55 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'] 04:49:55 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 04:49:56 INFO - Return code: 0 04:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:56 INFO - https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:49:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:49:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:49:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 04:49:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/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 04:49:58 INFO - Downloaded 110077139 bytes. 04:49:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:49:58 INFO - mkdir: /builds/slave/test/properties 04:49:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:49:58 INFO - Writing to file /builds/slave/test/properties/build_url 04:49:58 INFO - Contents: 04:49:58 INFO - build_url:https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 04:49:59 INFO - Running post-action listener: _resource_record_post_action 04:49:59 INFO - Running post-action listener: set_extra_try_arguments 04:49:59 INFO - ##### 04:49:59 INFO - ##### Finished download-and-extract step (success) 04:49:59 INFO - ##### 04:49:59 INFO - ##### 04:49:59 INFO - ##### Running populate-webroot step. 04:49:59 INFO - ##### 04:49:59 INFO - Running pre-action listener: _resource_record_pre_action 04:49:59 INFO - Running main action method: populate_webroot 04:49:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:59 INFO - '--tppagecycles', 04:49:59 INFO - '7'], 04:49:59 INFO - 'tests': ['tsvgm']}}, 04:49:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:49:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:49:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:49:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:49:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:49:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:49:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:59 INFO - 'talos_options': ['--disable-e10s'], 04:49:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:59 INFO - 'talos_options': ['--disable-e10s'], 04:49:59 INFO - 'tests': ['damp', 'tps']}, 04:49:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:59 INFO - 'tests': ['damp', 'tps']}, 04:49:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:49:59 INFO - 'tests': ['dromaeo_dom']}, 04:49:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:49:59 INFO - 'tests': ['a11yr', 04:49:59 INFO - 'ts_paint', 04:49:59 INFO - 'tpaint', 04:49:59 INFO - 'sessionrestore', 04:49:59 INFO - 'sessionrestore_no_auto_restore', 04:49:59 INFO - 'tabpaint']}, 04:49:59 INFO - 'other-e10s': {'tests': ['a11yr', 04:49:59 INFO - 'ts_paint', 04:49:59 INFO - 'tpaint', 04:49:59 INFO - 'sessionrestore', 04:49:59 INFO - 'sessionrestore_no_auto_restore', 04:49:59 INFO - 'tabpaint']}, 04:49:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:49:59 INFO - 'ts_paint', 04:49:59 INFO - 'tpaint', 04:49:59 INFO - 'sessionrestore', 04:49:59 INFO - 'sessionrestore_no_auto_restore', 04:49:59 INFO - 'tabpaint']}, 04:49:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:49:59 INFO - 'ts_paint', 04:49:59 INFO - 'tpaint', 04:49:59 INFO - 'sessionrestore', 04:49:59 INFO - 'sessionrestore_no_auto_restore', 04:49:59 INFO - 'tabpaint']}, 04:49:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:49:59 INFO - 'tests': ['a11yr', 04:49:59 INFO - 'ts_paint', 04:49:59 INFO - 'tpaint', 04:49:59 INFO - 'sessionrestore', 04:49:59 INFO - 'sessionrestore_no_auto_restore', 04:49:59 INFO - 'tabpaint']}, 04:49:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:49:59 INFO - 'tests': ['a11yr', 04:49:59 INFO - 'ts_paint', 04:49:59 INFO - 'tpaint', 04:49:59 INFO - 'sessionrestore', 04:49:59 INFO - 'sessionrestore_no_auto_restore', 04:49:59 INFO - 'tabpaint']}, 04:49:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:49:59 INFO - 'tests': ['tsvgx', 04:49:59 INFO - 'tsvgr_opacity', 04:49:59 INFO - 'tart', 04:49:59 INFO - 'tscrollx', 04:49:59 INFO - 'cart']}, 04:49:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:49:59 INFO - 'tsvgr_opacity', 04:49:59 INFO - 'tart', 04:49:59 INFO - 'tscrollx', 04:49:59 INFO - 'cart']}, 04:49:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:59 INFO - 'talos_options': ['--disable-e10s'], 04:49:59 INFO - 'tests': ['tp5o']}, 04:49:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:59 INFO - 'tests': ['tp5o']}, 04:49:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:59 INFO - 'talos_options': ['--disable-e10s', 04:49:59 INFO - '--xperf_path', 04:49:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:59 INFO - 'tests': ['tp5n']}, 04:49:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:59 INFO - 'talos_options': ['--xperf_path', 04:49:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:59 INFO - 'tests': ['tp5n']}}, 04:49:59 INFO - 'talos.zip': {'path': '', 04:49:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:59 INFO - Running post-action listener: _resource_record_post_action 04:49:59 INFO - ##### 04:49:59 INFO - ##### Finished populate-webroot step (success) 04:49:59 INFO - ##### 04:49:59 INFO - ##### 04:49:59 INFO - ##### Running create-virtualenv step. 04:49:59 INFO - ##### 04:49:59 INFO - Running pre-action listener: _resource_record_pre_action 04:49:59 INFO - Running main action method: create_virtualenv 04:49:59 INFO - Creating virtualenv /builds/slave/test/build/venv 04:49:59 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 04:49:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:49:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:59 INFO - Using real prefix '/tools/python27' 04:49:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:50:00 INFO - Installing distribute.............................................................................................................................................................................................done. 04:50:03 INFO - Installing pip.................done. 04:50:03 INFO - Return code: 0 04:50:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:50: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')]} 04:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:03 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 0x101562a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101568570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d09582ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101406d30>, '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 0x10122adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013fdb20>, '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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 04:50:03 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 04:50:03 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 04:50:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFTrHg3q9Y/Render', 04:50:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:03 INFO - 'HOME': '/Users/cltbld', 04:50:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:03 INFO - 'LOGNAME': 'cltbld', 04:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:03 INFO - 'MOZ_NO_REMOTE': '1', 04:50:03 INFO - 'NO_EM_RESTART': '1', 04:50:03 INFO - 'PAGER': '/bin/cat', 04:50:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:03 INFO - 'PWD': '/builds/slave/test', 04:50:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:03 INFO - 'SHELL': '/bin/bash', 04:50:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NABjDBxc4P/Listeners', 04:50:03 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:50:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:03 INFO - 'USER': 'cltbld', 04:50:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:03 INFO - 'XPC_FLAGS': '0x0', 04:50:03 INFO - 'XPC_SERVICE_NAME': '0', 04:50:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:03 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 04:50:03 INFO - Cleaning up... 04:50:03 INFO - Return code: 0 04:50:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:50: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')]} 04:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:03 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 0x101562a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101568570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d09582ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101406d30>, '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 0x10122adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013fdb20>, '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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 04:50:03 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 04:50:03 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 04:50:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFTrHg3q9Y/Render', 04:50:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:03 INFO - 'HOME': '/Users/cltbld', 04:50:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:03 INFO - 'LOGNAME': 'cltbld', 04:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:03 INFO - 'MOZ_NO_REMOTE': '1', 04:50:03 INFO - 'NO_EM_RESTART': '1', 04:50:03 INFO - 'PAGER': '/bin/cat', 04:50:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:03 INFO - 'PWD': '/builds/slave/test', 04:50:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:03 INFO - 'SHELL': '/bin/bash', 04:50:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NABjDBxc4P/Listeners', 04:50:03 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:50:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:03 INFO - 'USER': 'cltbld', 04:50:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:03 INFO - 'XPC_FLAGS': '0x0', 04:50:03 INFO - 'XPC_SERVICE_NAME': '0', 04:50:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:03 INFO - Downloading/unpacking psutil>=3.1.1 04:50:03 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 04:50:03 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 04:50:03 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 04:50:03 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 04:50:03 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 04:50:03 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 04:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:50:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:50:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:50:06 INFO - Installing collected packages: psutil 04:50:06 INFO - Running setup.py install for psutil 04:50:06 INFO - building 'psutil._psutil_osx' extension 04:50:06 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 04:50:06 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 04:50:06 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 04:50:07 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 04:50:07 INFO - building 'psutil._psutil_posix' extension 04:50:07 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 04:50:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:50:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:50:07 INFO - ^ 04:50:07 INFO - 1 warning generated. 04:50:07 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 04:50:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:50:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:50:07 INFO - Successfully installed psutil 04:50:07 INFO - Cleaning up... 04:50:07 INFO - Return code: 0 04:50:07 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 04:50:07 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')]} 04:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:07 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')]} 04:50:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:07 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.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101562a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101568570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d09582ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101406d30>, '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 0x10122adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013fdb20>, '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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 04:50:07 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.1'] in /builds/slave/test/build 04:50:07 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.1 04:50:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFTrHg3q9Y/Render', 04:50:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:07 INFO - 'HOME': '/Users/cltbld', 04:50:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:07 INFO - 'LOGNAME': 'cltbld', 04:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:07 INFO - 'MOZ_NO_REMOTE': '1', 04:50:07 INFO - 'NO_EM_RESTART': '1', 04:50:07 INFO - 'PAGER': '/bin/cat', 04:50:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:07 INFO - 'PWD': '/builds/slave/test', 04:50:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:07 INFO - 'SHELL': '/bin/bash', 04:50:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NABjDBxc4P/Listeners', 04:50:07 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:50:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:07 INFO - 'USER': 'cltbld', 04:50:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:07 INFO - 'XPC_FLAGS': '0x0', 04:50:07 INFO - 'XPC_SERVICE_NAME': '0', 04:50:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:07 INFO - Downloading/unpacking mozsystemmonitor==0.1 04:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:10 INFO - Downloading mozsystemmonitor-0.1.tar.gz 04:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 04:50:10 INFO - Installing collected packages: mozsystemmonitor 04:50:10 INFO - Running setup.py install for mozsystemmonitor 04:50:10 INFO - Successfully installed mozsystemmonitor 04:50:10 INFO - Cleaning up... 04:50:10 INFO - Return code: 0 04:50:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:50:10 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')]} 04:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:10 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')]} 04:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:10 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 0x101562a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101568570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d09582ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101406d30>, '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 0x10122adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013fdb20>, '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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 04:50:10 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 04:50:10 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 04:50:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFTrHg3q9Y/Render', 04:50:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:10 INFO - 'HOME': '/Users/cltbld', 04:50:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:10 INFO - 'LOGNAME': 'cltbld', 04:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:10 INFO - 'MOZ_NO_REMOTE': '1', 04:50:10 INFO - 'NO_EM_RESTART': '1', 04:50:10 INFO - 'PAGER': '/bin/cat', 04:50:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:10 INFO - 'PWD': '/builds/slave/test', 04:50:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:10 INFO - 'SHELL': '/bin/bash', 04:50:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NABjDBxc4P/Listeners', 04:50:10 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:50:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:10 INFO - 'USER': 'cltbld', 04:50:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:10 INFO - 'XPC_FLAGS': '0x0', 04:50:10 INFO - 'XPC_SERVICE_NAME': '0', 04:50:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:50:10 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 04:50:10 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 04:50:10 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 04:50:10 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 04:50:10 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 04:50:10 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 04:50:12 INFO - Downloading blobuploader-1.2.4.tar.gz 04:50:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:50:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:50:13 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 04:50:13 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 04:50:13 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 04:50:13 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 04:50:13 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 04:50:13 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 04:50:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:50:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:50:13 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 04:50:13 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 04:50:13 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 04:50:13 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 04:50:13 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 04:50:13 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 04:50:14 INFO - Downloading docopt-0.6.1.tar.gz 04:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:50:14 INFO - Installing collected packages: blobuploader, requests, docopt 04:50:14 INFO - Running setup.py install for blobuploader 04:50:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:50:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:50:14 INFO - Running setup.py install for requests 04:50:14 INFO - Running setup.py install for docopt 04:50:15 INFO - Successfully installed blobuploader requests docopt 04:50:15 INFO - Cleaning up... 04:50:15 INFO - Return code: 0 04:50:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50: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')]} 04:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:15 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 0x101562a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101568570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d09582ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101406d30>, '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 0x10122adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013fdb20>, '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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 04:50:15 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 04:50:15 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 04:50:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFTrHg3q9Y/Render', 04:50:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:15 INFO - 'HOME': '/Users/cltbld', 04:50:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:15 INFO - 'LOGNAME': 'cltbld', 04:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:15 INFO - 'MOZ_NO_REMOTE': '1', 04:50:15 INFO - 'NO_EM_RESTART': '1', 04:50:15 INFO - 'PAGER': '/bin/cat', 04:50:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:15 INFO - 'PWD': '/builds/slave/test', 04:50:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:15 INFO - 'SHELL': '/bin/bash', 04:50:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NABjDBxc4P/Listeners', 04:50:15 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:50:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:15 INFO - 'USER': 'cltbld', 04:50:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:15 INFO - 'XPC_FLAGS': '0x0', 04:50:15 INFO - 'XPC_SERVICE_NAME': '0', 04:50:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-5W_6Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-3cC1XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-IUhVSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-kOXULy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:15 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-AHVYyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:16 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ywCWBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:16 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-2rPVct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:16 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-qgQj9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:16 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-xEDDS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:16 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-UHHS7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:16 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-kRGLDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:16 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-bUyT2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:16 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-9TSlo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:16 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-PelDYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:16 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-YKXiZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:17 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-N2QPSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:17 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-6NECLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:50:17 INFO - Running setup.py install for manifestparser 04:50:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:50:17 INFO - Running setup.py install for mozcrash 04:50:17 INFO - Running setup.py install for mozdebug 04:50:17 INFO - Running setup.py install for mozdevice 04:50:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:50:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:50:17 INFO - Running setup.py install for mozfile 04:50:17 INFO - Running setup.py install for mozhttpd 04:50:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:50:18 INFO - Running setup.py install for mozinfo 04:50:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:50:18 INFO - Running setup.py install for mozInstall 04:50:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:50:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:50:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:50:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:50:18 INFO - Running setup.py install for mozleak 04:50:18 INFO - Running setup.py install for mozlog 04:50:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:50:18 INFO - Running setup.py install for moznetwork 04:50:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:50:18 INFO - Running setup.py install for mozprocess 04:50:19 INFO - Running setup.py install for mozprofile 04:50:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:50:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:50:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:50:19 INFO - Running setup.py install for mozrunner 04:50:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:50:19 INFO - Running setup.py install for mozscreenshot 04:50:19 INFO - Running setup.py install for moztest 04:50:19 INFO - Running setup.py install for mozversion 04:50:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:50:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:50:19 INFO - Cleaning up... 04:50:19 INFO - Return code: 0 04:50:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:19 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')]} 04:50:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:19 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')]} 04:50:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:19 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 0x101562a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101568570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d09582ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101406d30>, '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 0x10122adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013fdb20>, '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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 04:50:19 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 04:50:19 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 04:50:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFTrHg3q9Y/Render', 04:50:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:19 INFO - 'HOME': '/Users/cltbld', 04:50:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:19 INFO - 'LOGNAME': 'cltbld', 04:50:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:19 INFO - 'MOZ_NO_REMOTE': '1', 04:50:19 INFO - 'NO_EM_RESTART': '1', 04:50:19 INFO - 'PAGER': '/bin/cat', 04:50:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:19 INFO - 'PWD': '/builds/slave/test', 04:50:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:19 INFO - 'SHELL': '/bin/bash', 04:50:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NABjDBxc4P/Listeners', 04:50:19 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:50:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:19 INFO - 'USER': 'cltbld', 04:50:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:19 INFO - 'XPC_FLAGS': '0x0', 04:50:19 INFO - 'XPC_SERVICE_NAME': '0', 04:50:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:20 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-465e70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:20 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)) 04:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:20 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-dL3dCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:20 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)) 04:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:20 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-t5grz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:20 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)) 04:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:20 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-kTiHbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:20 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)) 04:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:20 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-xenp21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:20 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)) 04:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:20 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ZBjHrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:20 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)) 04:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:20 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-CjoQEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:20 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)) 04:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:20 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-o0sdTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:20 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)) 04:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:20 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-XTiMWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:21 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)) 04:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:21 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ZgfGud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:21 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)) 04:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:21 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-TfKznM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:21 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)) 04:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:21 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-LDTcbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:21 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)) 04:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:21 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-bbCrZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:21 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)) 04:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:21 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-luUFnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:21 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)) 04:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:21 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Sh2O5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:21 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)) 04:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:21 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ipz29a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:21 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)) 04:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:21 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-IeMmfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:21 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)) 04:50:21 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)) 04:50:21 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)) 04:50:21 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)) 04:50:21 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)) 04:50:21 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)) 04:50:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:50:21 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 04:50:21 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 04:50:21 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 04:50:21 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 04:50:21 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 04:50:21 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 04:50:24 INFO - Downloading blessings-1.6.tar.gz 04:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:50:24 INFO - Installing collected packages: blessings 04:50:24 INFO - Running setup.py install for blessings 04:50:24 INFO - Successfully installed blessings 04:50:24 INFO - Cleaning up... 04:50:24 INFO - Return code: 0 04:50:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:50:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:24 INFO - Reading from file tmpfile_stdout 04:50:24 INFO - Current package versions: 04:50:24 INFO - blessings == 1.6 04:50:24 INFO - blobuploader == 1.2.4 04:50:24 INFO - docopt == 0.6.1 04:50:24 INFO - manifestparser == 1.1 04:50:24 INFO - mozInstall == 1.12 04:50:24 INFO - mozcrash == 0.17 04:50:24 INFO - mozdebug == 0.1 04:50:24 INFO - mozdevice == 0.48 04:50:24 INFO - mozfile == 1.2 04:50:24 INFO - mozhttpd == 0.7 04:50:24 INFO - mozinfo == 0.9 04:50:24 INFO - mozleak == 0.1 04:50:24 INFO - mozlog == 3.2 04:50:24 INFO - moznetwork == 0.27 04:50:24 INFO - mozprocess == 0.22 04:50:24 INFO - mozprofile == 0.28 04:50:24 INFO - mozrunner == 6.11 04:50:24 INFO - mozscreenshot == 0.1 04:50:24 INFO - mozsystemmonitor == 0.1 04:50:24 INFO - moztest == 0.7 04:50:24 INFO - mozversion == 1.4 04:50:24 INFO - psutil == 3.1.1 04:50:24 INFO - requests == 1.2.3 04:50:24 INFO - wsgiref == 0.1.2 04:50:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:24 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')]} 04:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:24 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')]} 04:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:24 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 0x101562a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101568570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d09582ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101406d30>, '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 0x10122adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013fdb20>, '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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 04:50:24 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 04:50:24 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 04:50:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFTrHg3q9Y/Render', 04:50:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:24 INFO - 'HOME': '/Users/cltbld', 04:50:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:24 INFO - 'LOGNAME': 'cltbld', 04:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:24 INFO - 'MOZ_NO_REMOTE': '1', 04:50:24 INFO - 'NO_EM_RESTART': '1', 04:50:24 INFO - 'PAGER': '/bin/cat', 04:50:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:24 INFO - 'PWD': '/builds/slave/test', 04:50:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:24 INFO - 'SHELL': '/bin/bash', 04:50:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NABjDBxc4P/Listeners', 04:50:24 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:50:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:24 INFO - 'USER': 'cltbld', 04:50:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:24 INFO - 'XPC_FLAGS': '0x0', 04:50:24 INFO - 'XPC_SERVICE_NAME': '0', 04:50:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:25 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)) 04:50:25 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)) 04:50:25 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)) 04:50:25 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)) 04:50:25 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)) 04:50:25 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)) 04:50:25 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)) 04:50:25 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)) 04:50:25 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)) 04:50:25 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)) 04:50:25 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)) 04:50:25 INFO - Cleaning up... 04:50:25 INFO - Return code: 0 04:50:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:50:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:25 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 0x101562a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101568570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d09582ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101406d30>, '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 0x10122adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013fdb20>, '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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 04:50:25 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 04:50:25 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 04:50:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFTrHg3q9Y/Render', 04:50:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:25 INFO - 'HOME': '/Users/cltbld', 04:50:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:25 INFO - 'LOGNAME': 'cltbld', 04:50:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:25 INFO - 'MOZ_NO_REMOTE': '1', 04:50:25 INFO - 'NO_EM_RESTART': '1', 04:50:25 INFO - 'PAGER': '/bin/cat', 04:50:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:25 INFO - 'PWD': '/builds/slave/test', 04:50:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:25 INFO - 'SHELL': '/bin/bash', 04:50:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NABjDBxc4P/Listeners', 04:50:25 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:50:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:25 INFO - 'USER': 'cltbld', 04:50:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:25 INFO - 'XPC_FLAGS': '0x0', 04:50:25 INFO - 'XPC_SERVICE_NAME': '0', 04:50:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:25 INFO - Downloading/unpacking jsonschema 04:50:25 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 04:50:25 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 04:50:25 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 04:50:25 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 04:50:25 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 04:50:25 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 04:50:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:50:28 INFO - Downloading/unpacking functools32 (from jsonschema) 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:28 INFO - Downloading functools32-3.2.3-2.tar.gz 04:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:50:28 INFO - warning: no files found matching '*.txt' 04:50:28 INFO - no previously-included directories found matching 'build' 04:50:28 INFO - no previously-included directories found matching 'dist' 04:50:28 INFO - no previously-included directories found matching '.git*' 04:50:28 INFO - Installing collected packages: jsonschema, functools32 04:50:28 INFO - Running setup.py install for functools32 04:50:28 INFO - warning: no files found matching '*.txt' 04:50:28 INFO - no previously-included directories found matching 'build' 04:50:28 INFO - no previously-included directories found matching 'dist' 04:50:28 INFO - no previously-included directories found matching '.git*' 04:50:28 INFO - Successfully installed jsonschema functools32 04:50:28 INFO - Cleaning up... 04:50:28 INFO - Return code: 0 04:50:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:50: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')]} 04:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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')]} 04:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101562a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101568570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d09582ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101406d30>, '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 0x10122adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013fdb20>, '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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 04:50: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', 'flake8'] in /builds/slave/test/build 04:50: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 flake8 04:50:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFTrHg3q9Y/Render', 04:50:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:28 INFO - 'HOME': '/Users/cltbld', 04:50:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:28 INFO - 'LOGNAME': 'cltbld', 04:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:28 INFO - 'MOZ_NO_REMOTE': '1', 04:50:28 INFO - 'NO_EM_RESTART': '1', 04:50:28 INFO - 'PAGER': '/bin/cat', 04:50:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:28 INFO - 'PWD': '/builds/slave/test', 04:50:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:28 INFO - 'SHELL': '/bin/bash', 04:50:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NABjDBxc4P/Listeners', 04:50:28 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:50:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:28 INFO - 'USER': 'cltbld', 04:50:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:28 INFO - 'XPC_FLAGS': '0x0', 04:50:28 INFO - 'XPC_SERVICE_NAME': '0', 04:50:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:29 INFO - Downloading/unpacking flake8 04:50:29 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 04:50:29 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 04:50:29 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 04:50:29 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 04:50:29 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 04:50:29 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 04:50:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:50:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:50:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50: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 04:50:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:50:32 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 04:50:32 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 04:50:32 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 04:50:32 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 04:50:32 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 04:50:32 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 04:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:50:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:50:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:50:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:50:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:50:32 INFO - no previously-included directories found matching 'docs/_build' 04:50:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:50:32 INFO - Running setup.py install for pep8 04:50:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:50:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:50:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:50:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:50:32 INFO - no previously-included directories found matching 'docs/_build' 04:50:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:50:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:50:32 INFO - Cleaning up... 04:50:33 INFO - Return code: 0 04:50:33 INFO - Running post-action listener: _resource_record_post_action 04:50:33 INFO - Running post-action listener: _start_resource_monitoring 04:50:33 INFO - Starting resource monitoring. 04:50:33 INFO - ##### 04:50:33 INFO - ##### Finished create-virtualenv step (success) 04:50:33 INFO - ##### 04:50:33 INFO - ##### 04:50:33 INFO - ##### Running install step. 04:50:33 INFO - ##### 04:50:33 INFO - Running pre-action listener: _resource_record_pre_action 04:50:33 INFO - Running main action method: install 04:50:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:33 INFO - Reading from file tmpfile_stdout 04:50:33 INFO - Detecting whether we're running mozinstall >=1.0... 04:50:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:50:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:50:33 INFO - Reading from file tmpfile_stdout 04:50:33 INFO - Output received: 04:50:33 INFO - Usage: mozinstall [options] installer 04:50:33 INFO - Options: 04:50:33 INFO - -h, --help show this help message and exit 04:50:33 INFO - -d DEST, --destination=DEST 04:50:33 INFO - Directory to install application into. [default: 04:50:33 INFO - "/builds/slave/test"] 04:50:33 INFO - --app=APP Application being installed. [default: firefox] 04:50:33 INFO - mkdir: /builds/slave/test/build/application 04:50:33 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'] 04:50:33 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 04:51:07 INFO - Reading from file tmpfile_stdout 04:51:07 INFO - Output received: 04:51:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:51:07 INFO - Running post-action listener: _resource_record_post_action 04:51:07 INFO - ##### 04:51:07 INFO - ##### Finished install step (success) 04:51:07 INFO - ##### 04:51:07 INFO - ##### 04:51:07 INFO - ##### Running run-tests step. 04:51:07 INFO - ##### 04:51:07 INFO - Running pre-action listener: _resource_record_pre_action 04:51:07 INFO - Running main action method: run_tests 04:51:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:51:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:51:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:51:07 INFO - 2016-05-13 04:51:07.316 screenresolution[1930:9842] starting screenresolution argv=screenresolution get 04:51:07 INFO - 2016-05-13 04:51:07.319 screenresolution[1930:9842] Display 0: 1600x1200x32@60 04:51:07 INFO - 2016-05-13 04:51:07.325 screenresolution[1931:9849] starting screenresolution argv=screenresolution list 04:51:07 INFO - Available Modes on Display 0 04:51:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:51:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:51:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:51:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:51:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:51:07 INFO - Intel Iris: 04:51:07 INFO - Chipset Model: Intel Iris 04:51:07 INFO - Type: GPU 04:51:07 INFO - Bus: Built-In 04:51:07 INFO - VRAM (Dynamic, Max): 1536 MB 04:51:07 INFO - Vendor: Intel (0x8086) 04:51:07 INFO - Device ID: 0x0a2e 04:51:07 INFO - Revision ID: 0x0009 04:51:07 INFO - Displays: 04:51:07 INFO - Display: 04:51:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:51:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:51:07 INFO - Display Serial Number: 1600x1200 60 04:51:07 INFO - Main Display: Yes 04:51:07 INFO - Mirror: Off 04:51:07 INFO - Online: Yes 04:51:07 INFO - Rotation: Supported 04:51:07 INFO - Return code: 0 04:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:51:07 INFO - Python 2.7.3 04:51:07 INFO - Return code: 0 04:51:07 INFO - grabbing minidump binary from tooltool 04:51:07 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')]} 04:51:07 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 0x101406d30>, '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 0x10122adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1013fdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:51:07 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 04:51:07 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 04:51:07 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 04:51:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:51:07 INFO - Return code: 0 04:51:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:51:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:51:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:51:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:51:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:51:08 INFO - Return code: 0 04:51:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--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 04:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0370 --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 04:51:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bFTrHg3q9Y/Render', 04:51:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:51:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:51:08 INFO - 'HOME': '/Users/cltbld', 04:51:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:51:08 INFO - 'LOGNAME': 'cltbld', 04:51:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:51:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:51:08 INFO - 'MOZ_NO_REMOTE': '1', 04:51:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:51:08 INFO - 'NO_EM_RESTART': '1', 04:51:08 INFO - 'PAGER': '/bin/cat', 04:51:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:51:08 INFO - 'PWD': '/builds/slave/test', 04:51:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:51:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:51:08 INFO - 'SHELL': '/bin/bash', 04:51:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NABjDBxc4P/Listeners', 04:51:08 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 04:51:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:51:08 INFO - 'USER': 'cltbld', 04:51:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:51:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:51:08 INFO - 'XPC_FLAGS': '0x0', 04:51:08 INFO - 'XPC_SERVICE_NAME': '0', 04:51:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:51:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--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 04:51:09 INFO - mozversion application_buildid: 20160513030046 04:51:09 INFO - mozversion application_changeset: 5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4 04:51:09 INFO - mozversion application_display_name: Nightly 04:51:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:51:09 INFO - mozversion application_name: Firefox 04:51:09 INFO - mozversion application_remotingname: firefox 04:51:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:51:09 INFO - mozversion application_vendor: Mozilla 04:51:09 INFO - mozversion application_version: 49.0a1 04:51:09 INFO - mozversion platform_buildid: 20160513030046 04:51:09 INFO - mozversion platform_changeset: 5a2deb5a9b09df9ad2ca3ac1d0c480be250d31e4 04:51:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:51:09 INFO - mozversion platform_version: 49.0a1 04:51:09 INFO - using testdate: 1463140269 04:51:09 INFO - actual date: 1463140269 04:51:09 INFO - starting webserver on 'localhost:49474' 04:51:09 INFO - SUITE-START | Running 2 tests 04:51:09 INFO - TEST-START | dromaeo_css 04:51:09 INFO - operating with platform_type : mac_ 04:51:09 INFO - Initialising browser for dromaeo_css test... 04:51:09 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpIe_Rsw/profile http://localhost:49474/getInfo.html) 04:51:11 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 04:51:11 INFO - PROCESS | 1949 | colorDepth:24 04:51:11 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 04:51:11 INFO - PROCESS | 1949 | __metrics 04:51:11 ERROR - PROCESS | 1949 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 04:51:12 INFO - TEST-INFO | 1949: exit 0 04:51:12 INFO - Browser initialized. 04:51:12 INFO - Running cycle 1/1 for dromaeo_css test... 04:51:12 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpIe_Rsw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:24 INFO - PROCESS | 1952 | RSS: Main: 250195968 04:51:24 INFO - PROCESS | 1952 | 04:52:14 INFO - PROCESS | 1952 | 1463140334112 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] 04:54:25 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49474/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49474/tests/dromaeo/cssquery-ext.html) 04:54:26 INFO - PROCESS | 1952 | RSS: Main: 263041024 04:54:26 INFO - PROCESS | 1952 | 04:57:28 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49474/tests/dromaeo/cssquery-ext.html (next: http://localhost:49474/tests/dromaeo/cssquery-jquery.html) 04:57:29 INFO - PROCESS | 1952 | RSS: Main: 273805312 04:57:29 INFO - PROCESS | 1952 | 05:00:31 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49474/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49474/tests/dromaeo/cssquery-mootools.html) 05:00:32 INFO - PROCESS | 1952 | RSS: Main: 275419136 05:00:32 INFO - PROCESS | 1952 | 05:03:33 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49474/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49474/tests/dromaeo/cssquery-prototype.html) 05:03:34 INFO - PROCESS | 1952 | RSS: Main: 277028864 05:03:34 INFO - PROCESS | 1952 | 05:06:37 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49474/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49474/tests/dromaeo/cssquery-yui.html) 05:06:37 INFO - PROCESS | 1952 | RSS: Main: 280055808 05:06:37 INFO - PROCESS | 1952 | 05:09:40 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49474/tests/dromaeo/cssquery-yui.html (next: http://localhost:49474/tests/dromaeo/cssquery-dojo.html) 05:09:40 INFO - PROCESS | 1952 | RSS: Main: 281251840 05:09:40 INFO - PROCESS | 1952 | 05:09:40 INFO - PROCESS | 1952 | __start_tp_report 05:09:40 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 05:09:40 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 05:09:40 INFO - PROCESS | 1952 | |i|pagename|runs| 05:09:40 INFO - PROCESS | 1952 | |0;dojo.html;3497.825108744563;3522.7357948153863;3556.466530020497;3556.5732112146547;3565;4902.950970490294;5833.766649334027;5927.970360148199;5937.703114844257;5991.310999235089;4975.7263350515705;5641.464060914206;5851.4148585141465;5882.499987501067;6003.429674180957;5233.607479439038;5256.290400795881;5344.278522399465;5383.865403364908;5408.513233808956;569.3651381923969;4918.693596498294;5252.3697156341295;5342.946570534304;5345.412004679482;5308.362996440414;5331.120365139747;5343.839684809462;5351.973240133813;5359.464053594648;5353.411124776271;5370.812021579265;5390.4879036491475;5399.406065332811;5414.972925135388;5194.168932970707;5225.973870130663;5262.97368513155;5273.789048438058;5324.973375133139;4634.745089020103;5590.217369568264;5845.444682755174;5930.703464826742;5951.16683664283;6195.256569211679;6236;6255.499560035186;6267.59260648061;6269.310375858652;5300.946990530084;6250.0624906263965;6256.280527739323;6326.79790839739;6330.113784070234;6059.121427393004;6061.363556826514;6062.151298818169;6075.848103797396;6105;6256.687165641791;6338.809835704937;6439.066335381437;6451.41937225652;6462.741490340428;6234.438900498977;6278.340774218641;6294.496440284766;6300.1494798202575;6306.085617585516;6287.842803929939;6305.527085468608;6311.873762524724;6317.684115794192;6337.429631333202;5458.208559758813;6136.417040381157;6219.564630475914;6233.875322493524;6272.780452684134;5141.203113517411;5228.764705588258;6213.906791398133;6222.937770622327;6236.6258024518675;4330.566943305707;5038.0931432341795;5039.44566097729;5052.393712754493;5092.159793634083;3761.83383151224;4503.752293623882;4511.075229577928;4543.25036369002;4599.448066232007;5913.940860591339;5984.401559843981;6003.7898673546215;6108.419700128481;6160.630362178284;5541.445855414427;6326.051092336186;6345.524085693499;6354.3963323484195;6382.266039405527;5996.070609055603;6006.789762358297;6041.516678665696;6042.3655516170165;6046.546509011754;4531.410916580823;5510.448955104457;5511.311086114236;5513.696746678891;5522.723863806794;6281.340459251713;6463.7737679181;6497.382748638872;6500.642464664489;6522.739090436329;6214.689265536796;6255.155554000152;6295;6345.3654634538025;6346.397092276226;6468.773592924225;6506.121673574007;6518.152640156749;6529.640869752019;6557.2131344239;6147.200863887666;6189.35011823752;6271;6282.780102696383;6293.496520278275;6251.218597675291;6274.341194174546;6324.905126423199;6325.462335701332;6329.303776584664;6257;6284.905726414199;6286.465650419766;6288.151099601679;6313.715882785377;6145.385461453819;6203.255609326729;6246.312905580474;6263.498920086473;6288.993760998218;4092.0792821616087;4915.606751459946;5108.66793658411;6134.8039827316215;6220.0047992321015;5536.307961504812;6091.269047714302;6179.825833091698;6233.625982441068;6242.812715618538;6053.667048312209;6145.35473775265;6146.6004709693725;6194.845128871814;6250.624962502265 05:09:40 INFO - PROCESS | 1952 | |1;ext.html;513.4147072337536;529.4705294705295;563.2396265042194;579.6116601876743;596.2070446306412;32794.836025819866;41157.7942110289;41459.37810932838;41479.58520414795;41516.792416037875;42304.365434518506;42787.930301742475;42934;42956;43021.139577208436;8832.8675069874;9603.135717785399;9698.933117357084;9743.07440793127;9808.21534277256;8610.741677749678;9363.923148837868;9618.182454491376;9723.27075469339;9724.416535007887;9622.470764107971;9641.90358096417;9683.515824208796;9689.903100969006;9717.562709678046;9653.613855445774;9655;9695.07896749804;9700.320977531575;9711.125998660154;8956.238719708832;9231.984481707006;9556.952215238949;9672.371295865816;9684.273679474067;39457.60542394597;39500;39705;39966.80016599927;40065.19869602592;2990.6411230652243;3197.4084794312894;3222.2910959588853;3354.630990591033;3439.0542600784734;28295.009674661287;29092.563611545844;29191.97828076007;29550.85224573885;29881.551776723365;2669.2526092694075;2725.2505560970694;2733.8906443742226;2804.186785832106;2805.5370863807652;489187.554062231;528319;530878;531274;531798.3410082964;56717.14924276139;57205.14192287119;57333.14000289999;57344.13983790246;57356.71321643365;35955.460668089996;36753.816230918674;63792.362076378646;64190.6790466054;64999.67500162469;16408.507744767678;16433.506994790176;16559.08925009112;16613.0862802547;16668.416605418995;12430.751384972249;12688.429020694091;12722.491100356066;12761.744765104646;12774.23354598727;15601.531954041397;19838.60322793536;19978.600427991358;20136.295229667183;20163.495912602302;8363.121872203452;8458.492490450593;8497.872531912026;8530.914690853013;8584.184502472255;923.4182465047112;1075.7525769073156;1092.448313601626;1101.6970333158285;1147.3650048680597;24596.262112136665;27779.722202778117;29389.530523473743;29818.850905745334;30541;1038.896110388955;1068.407034096084;1090.939998300101;1097.3032124600777;1101;15484.612884677974;15536.912416130763;15594.610134746723;15660.373585056697;16028;639573;646458;653075;656284;657275;59694.80610387768;61546.38453615496;61742.69128654418;61768.69115654393;61773.382266177665;1475.3582191746625;1476.859698328657;1482.5404124721372;1493.37278343094;1498.3257534109694;29363.70636293695;29460.410791784474;29500.852495737385;30061.398772024873;30122.945696900504;51072.489275106775;51404;51666.48333516767;52054;52126.73936630293;559195;567242;568093.5836228561;568612;568687.31312688;26276.21171364862;26722.465550689267;27078.458430831666;27085.864570677022;27139.457210856068;45135.32297015613;46250.768746156056;46943;47368;47563.762181188875;37923.05192370213;38631.61368386393;39108.02229944274;39590.40614390844;39710.84529824038;36957.63042369649;37400;38318;39156.608433915295;39996.80001599973;31521.36957260796;36998;37344.62655373412;37626.43560346542;37833.81083094677;32872.83563582167;33249.833750831094;33405;33498.66501335053;33527.83236083804;21619.675704864127;24510.264692059267;24828.634425106793;25441.618375724007;26007.869960650074 05:09:40 INFO - PROCESS | 1952 | |2;jquery.html;345.41969491254684;362.9618890016548;397.4773173277141;397.73749325445203;407.35637692445937;18776.530586735338;19244;20442.795572044295;20816.063277152527;21676.458088547755;17540.386086486975;18176.18207180677;20265;21631.35105946824;21708.3487495375;5385.569154467653;5856.355800861912;6048.758049678029;6071.757129714806;6072.878542429149;6005.12925625784;6037;6055.666938318391;6060.969695151518;6062.090686397031;5216.400113986883;5687.203791469197;5823.912641310362;5993.820185394424;6001.759929602811;5699.088145896637;5838.4453476919625;5843.357230704619;5978.880422391571;5984.611000284989;5076.923846142311;5139.820106296299;5165.66423182492;5166.3800343958965;5175.197844334134;25876.48247035049;25920.351991200183;25976.09083682081;26501.867490662422;26747.598786018225;2001.4896201468678;2023.6660950943076;2212.23677831148;2290.679304897316;2325.616273314918;12548.309842958633;14684.26578671062;15244.46644367453;15518.224088795516;15567.299471523695;1737.3311275159028;1765.523308706642;1787.3744189533688;1791.8566514678794;1820.417466410749;116321.3471461149;118664;119883;120224.39887800506;121931;8977.596008179647;9036.277097832157;11339.433028348549;11548.307101573933;11702;13983.930080349533;14025.649358765908;14038;14059.648508787157;14092.577222683336;8093.271605555528;8713.912860871436;8730.476171429735;8826.735197943943;8874.822503549893;7769.028871391076;7900.802479938047;8428.241458268785;8743.38796284254;8841.469511829311;5876.647401155944;6724.193096828314;6861.656917154122;6880;6895.793126206222;1703.9233234504477;1913.8373238274623;1914.3969649560345;1922.375228050889;1962.9411117666493;880.5157163560017;967.9661211857551;993.5082134343402;1042.551702767802;1052.9789404211872;20928;20951.371458856258;21109;21206.15175392998;21289;921.2307723051327;952.6713283917038;998.610541888664;1008.2287050406445;1018.8930162332848;8498.150184981576;11315.660530184108;11326.603568875049;11365.602203922823;11380.26028308174;524232.78836058045;598863;605153;615821;618751;85228;101051.48422773664;101255.4937225324;116660;118419.40790295994;896.9416987895765;1000.4847503535685;1008.7982403519326;1034.1881622926117;1040.1366865501616;18710.625787483903;18784.342548010754;18995;19024.239030438628;19179.041047947827;39214.41178382384;40293.79118626446;47610.76194619005;48928.75535622299;49111;75292;75548.62225689057;76070.57682404194;77073.61463192648;78368.60815695886;6737.3599508046655;7846.489978151402;7963.163867793798;8090.393220508367;8422.536760478233;10692.518836652214;11623.825642615537;12378.071644626509;12674.809877851656;12918.935405322913;8227.382946278933;8999.820003600022;10584.523696433833;10898.564057437614;11127.332360058423;10397.428141452292;10698.197635177548;10897.727556811144;10950.56197752081;11095.001449869551;11134.777304454028;11297.378644174649;11322.716932076435;11327.093832493216;11384.544618215179;7996.280334769898;8077.515349079074;8161.387895907949;8167.101618821806;8355.623996920274;10710.410927398756;10738.355698658106;10760.139188864716;10802;11231.494582743959 05:09:40 INFO - PROCESS | 1952 | |3;mootools.html;1615.5153453963812;1667.0664427920365;1957.4225603446982;2004.66922957712;2017.677171652536;7381.630918454076;8336.499810011404;9019.278457723383;9518.666846660359;9530.285228607856;7400;9294.581743821527;9361.906380936189;9374.343795934288;9381.249500039998;2422.600270955299;2438.743931887153;2478;2481.5409149307347;2481.565725997952;2434.5374378868046;2484.2050543825985;2500.4997001798956;2501.874906254689;2506.448581312108;2456.9631455528183;2475.8266921315517;2498.6876640419946;2501.4871951250043;2506.260653107338;2425.854448733073;2426.0902161689364;2437.85372877627;2439.499902519988;2466.1245257933533;2432.8297019208662;2445.510897820443;2447.5349683560066;2457.1400009996537;2465.3220364399754;8473.364497662638;8489.320854331638;8901.243394311492;9403.952980235055;9441.15029647328;5329.147336426192;5726.427357264281;5736.225609542742;5746.827595172152;5753.395893431171;3548.1129717570607;3550.431930891045;3703.740738148331;3731.1418373774186;3748.887533374003;1002.2483137646765;1043.3791893823163;1045.231754660324;1054.936703797767;1058.4125810175349;12492.875071249262;12583.496660133584;12633;12657.873421265762;12702.745945081047;4955.231939049453;4980.825671101494;5062.696238225718;5128.435872054071;5150.690958542425;10587;10608.20438467118;10615.1507879371;10629.5216715248;10641.308314959502;5268.841934741964;5596.636218645856;5708.457696518824;5709.115087161496;5720.170575266563;4587.3348364486965;5000.62495312853;5090.52374811308;5188.169892817206;5196.792128314901;3502.7372947029075;4116.732412393185;4197.559256278047;4263.126059157865;4326.567343265711;1364.6383708317303;1381.4543255414255;1381.696026874106;1386.2860626777217;1393.5610282760897;778.9182135875765;794.797326681704;859.6432480520639;901.5350056158742;940.0975063938558;5380.865478363072;5889.617174883619;5940.138679891392;6009.819705408845;6163.19878415803;833.5205011105337;1005.1958433253368;1019.8929112443235;1026.6817286641017;1056.8414737789394;4067;4120.320147175742;4152.8131234094535;4194.937075943863;4197.601227883346;11373;11711.121665875093;11759.05927525796;11766.764664706658;11871.940640296743;11817.231879927776;11841.644750657493;11858.110641701907;11861.5848445304;11930.940345298219;7228.530145540523;8638.13618638131;8641.395102342776;8651.52416617092;8770.736877893545;6030.547708921761;6200.937990620036;6232;6273.498120150286;6373.521985851173;8366.790830229293;10530;10654.520546575268;10704.197185210984;10753.838692419464;10717.732056698645;10771.730706732082;10917.727056823644;11026;11046.944765276123;6085.604435711664;6773.593584384953;7761.534307941542;7823.76528704117;7861.292483676497;8754.343424243334;8790.604422801118;8805.515696636747;8838.292936565187;8838.513881736566;7661.616919154131;7722.266384693445;7824.608769561613;7925.801854953672;7932;7573.810654733676;7586.658600362886;7665.501742386727;7811.179826118176;7827.608619569112;6447.903281450688;7238.746643867439;7324.597147156957;7326.670299836626;7331.3768329692575;4583.312503124558;4874.731889745956;5030.6668732786575;5091.770870310771;5143.691378517301;4536.6824322297125;4832.661713680009;5077.39071311445;5098.1588037973315;5336.359636843604 05:09:40 INFO - PROCESS | 1952 | |4;prototype.html;296.94358071966326;314.27089153164655;318.36803944170833;320.9743220542358;328.2466738834375;4906.803727850891;5451.073317536018;5575.581831362649;5643.520300774434;5656.292963379583;5463.241063263056;5467.917981230285;5483.451654834515;5497.340319161696;5509.696966666832;3799.924001519968;3968.702347323948;4025.2553277643583;4128.958710412902;4175.582441755815;3824.5792962774212;3888.794473713158;4063.1557909463495;4145.647619952292;4163.396307535406;3700.9452306092767;3823.2353529294114;4129.958700412987;4149.688773342012;4169.97915010426;3517.4723791431234;3728.217074414349;3876.7867767272787;3951.4467974483596;4105.7331273467125;3131.230854567162;3425.6231814500384;3542.752007359486;3571.321448924696;3604.2070744436182;4222.78886055696;5279.577633789288;5319.574434045306;5325.227841962894;5406.621536492447;4616;4659.394278743775;4762.214234651278;4767.237242041291;4771.355866957951;5496.725163741837;5763.3948435414095;5767.5962682612235;5808.12878068289;5840.634543010087;3530.593981692087;3752.255201331394;3772.849086036555;3956.6439020488006;3969.3450580654157;5173.3533308336455;5344.984452953926;5813.418658134195;6103.389661033905;6158.692065396757;3615.5299811024925;3787;3816.694664426839;3941.842326306973;4003.499562554681;3775.6035616260447;4053.1893621275863;4059.3099173140636;4083.9387409188885;4095.8566450174103;4200.789960501963;4578.908421831545;4677.228257337501;4759.714417134983;4761;5002.774875130628;5399.757010934517;5600.747966341524;5746.109353050284;5854.677992710356;1244.7137158453606;1313.2120727563386;1346.064485182808;1355.9897876082382;1379.4344318829233;837.7947402886332;853.5860107847689;855.4653341661461;858.1590041759112;886.6409104312763;4297.076128632359;5045.217991211368;5167.718498753318;5364.329458817648;5401.621886467988;4996.775145118479;5516.400243929215;5663.348714897839;5890.646561206256;5911.556633252523;4452.777361131995;4516.932246016312;5170.922436163461;5284.260203571503;5417.51242388187;2932.299266425468;3099.535069739557;3104.7360974317435;3132.2952335724735;3136.5765621641244;5433.750237445331;5716.570857285678;5815.487973126933;6087;6222.444388902774;5425.945740542623;5483.8338856151595;5703.7166637506225;5754.625949313281;5853.707314634336;5569.693666848362;5753.59724819267;6182.959623324202;6203.410675985774;6232.594881332699;4926.438252108955;5227.065985585357;5705.202861098741;5927.525797936241;5933.881322373615;5043.823466178666;5310.070737620978;5571.9442805571425;6026.608270462406;6063.272407311151;5953.374895635896;6302.180716506825;6310.52671049664;6315.4947604192475;6326.43062124411;3413;3419.606745224331;3855.9036024099623;4016.8995775105855;4025.315696331572;5174.7153906535505;5946.375630558729;6082.878342433215;6102.938970610237;6108.739766286502;5456.727163641723;5877;5877.94122058774;5904.52763778888;5955.821325360246;5565.526930210977;5836.883262334814;5859.44335288147;5918.348981611933;5926.496247818984;5175.404828444777;5284.603654725834;5359.732013399393;5619;5688.639214725842;4481.529439408815;4912.508749125059;5057.039162559102;5822.534197264294;5850.297964244318;5662.8301150965535;5692.743826527733;5747;5747.48272655463;5755.057785417002 05:09:40 INFO - PROCESS | 1952 | |5;yui.html;632.8259728574644;655.3479288108333;701.5439964023387;724.5254358395252;734.8530293941213;14092.43630254791;14928;15364.385424583017;15555.922220388911;15556.911016228869;14187.006909516338;14292.999490035701;14294.571162865132;14306.713865722679;14787.112773233586;884.2395539835752;913.2693844924034;935.5369092299287;937.4843835890267;939.7086903060039;723.0528008309105;891.7114769158568;905.7690288976302;911.9908800912006;919.9586018629178;894.9239314658262;963.0081016552962;974.9805003899918;977.8533220017018;978.7014960437064;947.7772723409993;965.9951700241525;968.0271327316037;968.8982656821073;969.6460791811008;690.6926417744106;697.6267696782248;704.2007321689867;718.9934092270811;720.9819754506127;14757.926210368987;14823.18472484013;14856.405743770236;15205.695886082216;15264.618384540365;12257.080718946114;12296.262224266484;12297.385130743427;12366.381680915918;12639.304838233893;9905.752356191153;9989.450580218085;10093.495325233709;10432.895671043269;10887.183461240438;3437.74216933731;3461.238527523941;3479.860805567774;3540.274243780019;3566.35805555;75172.62413687952;79975;85701.57149214215;86018.56990715068;86287.56856215741;8526.701565445179;9083.545822708838;9181.908180918106;9306.72079837606;9509.714708558755;18830.623387532174;21797.237096701858;22361.664575031387;22897.427564311027;22899;7404.481686282016;7587.924120758832;7605.923940760632;7734.651940662684;7813.648385822538;3878.2437424702475;3881.7865017424315;3895.454636350913;3984.1633257015774;3992.5208974922616;3451.913702157416;3453;3525;3548.769329993542;3554.608993010767;639.7824739588563;643.1895811277824;652.4780175859294;659.120074700271;662.8906230472014;493.7876713013367;533.7438029745666;581.4534337722528;606.659421005826;627.3506920337429;7991.360691144694;8195.139510351446;8201.42590018693;8353.54055526952;8389.496630202208;497.9402471703419;556.4852511426914;577.6418620455261;588.2969851027981;606.4299558415075;3898.532176138825;3934.2131573684806;3980.3034468967817;4002.779847108437;4084.4281800547947;88756;90543;91822.54088729514;92023;97885;76176;77907.44185116266;78586.60706696544;78644.85420583113;80320;64422.033669494995;65509;66368.34079147964;72507.63746181235;72726.63636681782;8251.628676709443;8279.782378209984;8348.165183481604;8418.579071046546;8486.448380855225;42371;42788;42828.175879496775;43364.56635433605;45544.54455455403;52261.17085901975;52554.47445525649;56279.718601406734;56838.43161568497;59870.50323741941;10684.786304274026;11015.339079655247;11123.054540363835;11135.99776020162;11414.315141091562;10627.628033019117;11763.705907352385;11796.2332448394;11875.762484750085;12324.938375308066;10887.673369798918;11452.656420307405;11498.54005839757;11649.825252621387;11668.299902005907;11424.657260282205;11546.364949927834;11554.711132221762;11638.88361116378;11807.881921180679;11235.213535052468;11309.66071017838;11372.20394572372;11644.825327619923;11728.824067638821;9573.234141268542;9586.808263834544;9765.853512197466;9852.064053914866;10179.338343007681;9383.718488445358;9509.429434233969;10098.754231077968;10103.35340917552;10231.386116833013 05:09:40 INFO - PROCESS | 1952 | __end_tp_report 05:09:40 INFO - PROCESS | 1952 | __start_cc_report 05:09:40 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,416 05:09:40 INFO - PROCESS | 1952 | __end_cc_report 05:09:40 INFO - PROCESS | 1952 | __startTimestamp1463141380944__endTimestamp 05:09:40 INFO - PROCESS | 1952 | 05:09:40 INFO - PROCESS | 1952 | ------- Summary: start ------- 05:09:40 INFO - PROCESS | 1952 | Number of tests: 6 05:09:40 INFO - PROCESS | 1952 | 05:09:40 INFO - PROCESS | 1952 | [#0] dojo.html Cycles:165 Average:5759.57 Median:6091.27 stddev:802.18 (13.2%) stddev-sans-first:784.77 05:09:40 INFO - PROCESS | 1952 | Values: 3497.8 3522.7 3556.5 3556.6 3565.0 4903.0 5833.8 5928.0 5937.7 5991.3 4975.7 5641.5 5851.4 5882.5 6003.4 5233.6 5256.3 5344.3 5383.9 5408.5 569.4 4918.7 5252.4 5342.9 5345.4 5308.4 5331.1 5343.8 5352.0 5359.5 5353.4 5370.8 5390.5 5399.4 5415.0 5194.2 5226.0 5263.0 5273.8 5325.0 4634.7 5590.2 5845.4 5930.7 5951.2 6195.3 6236.0 6255.5 6267.6 6269.3 5300.9 6250.1 6256.3 6326.8 6330.1 6059.1 6061.4 6062.2 6075.8 6105.0 6256.7 6338.8 6439.1 6451.4 6462.7 6234.4 6278.3 6294.5 6300.1 6306.1 6287.8 6305.5 6311.9 6317.7 6337.4 5458.2 6136.4 6219.6 6233.9 6272.8 5141.2 5228.8 6213.9 6222.9 6236.6 4330.6 5038.1 5039.4 5052.4 5092.2 3761.8 4503.8 4511.1 4543.3 4599.4 5913.9 5984.4 6003.8 6108.4 6160.6 5541.4 6326.1 6345.5 6354.4 6382.3 5996.1 6006.8 6041.5 6042.4 6046.5 4531.4 5510.4 5511.3 5513.7 5522.7 6281.3 6463.8 6497.4 6500.6 6522.7 6214.7 6255.2 6295.0 6345.4 6346.4 6468.8 6506.1 6518.2 6529.6 6557.2 6147.2 6189.4 6271.0 6282.8 6293.5 6251.2 6274.3 6324.9 6325.5 6329.3 6257.0 6284.9 6286.5 6288.2 6313.7 6145.4 6203.3 6246.3 6263.5 6289.0 4092.1 4915.6 5108.7 6134.8 6220.0 5536.3 6091.3 6179.8 6233.6 6242.8 6053.7 6145.4 6146.6 6194.8 6250.6 05:09:40 INFO - PROCESS | 1952 | 05:09:40 INFO - PROCESS | 1952 | [#1] ext.html Cycles:180 Average:70760.28 Median:39545.20 stddev:155676.00 (393.7%) stddev-sans-first:156023.37 05:09:40 INFO - PROCESS | 1952 | Values: 513.4 529.5 563.2 579.6 596.2 32794.8 41157.8 41459.4 41479.6 41516.8 42304.4 42787.9 42934.0 42956.0 43021.1 8832.9 9603.1 9698.9 9743.1 9808.2 8610.7 9363.9 9618.2 9723.3 9724.4 9622.5 9641.9 9683.5 9689.9 9717.6 9653.6 9655.0 9695.1 9700.3 9711.1 8956.2 9232.0 9557.0 9672.4 9684.3 39457.6 39500.0 39705.0 39966.8 40065.2 2990.6 3197.4 3222.3 3354.6 3439.1 28295.0 29092.6 29192.0 29550.9 29881.6 2669.3 2725.3 2733.9 2804.2 2805.5 489187.6 528319.0 530878.0 531274.0 531798.3 56717.1 57205.1 57333.1 57344.1 57356.7 35955.5 36753.8 63792.4 64190.7 64999.7 16408.5 16433.5 16559.1 16613.1 16668.4 12430.8 12688.4 12722.5 12761.7 12774.2 15601.5 19838.6 19978.6 20136.3 20163.5 8363.1 8458.5 8497.9 8530.9 8584.2 923.4 1075.8 1092.4 1101.7 1147.4 24596.3 27779.7 29389.5 29818.9 30541.0 1038.9 1068.4 1090.9 1097.3 1101.0 15484.6 15536.9 15594.6 15660.4 16028.0 639573.0 646458.0 653075.0 656284.0 657275.0 59694.8 61546.4 61742.7 61768.7 61773.4 1475.4 1476.9 1482.5 1493.4 1498.3 29363.7 29460.4 29500.9 30061.4 30122.9 51072.5 51404.0 51666.5 52054.0 52126.7 559195.0 567242.0 568093.6 568612.0 568687.3 26276.2 26722.5 27078.5 27085.9 27139.5 45135.3 46250.8 46943.0 47368.0 47563.8 37923.1 38631.6 39108.0 39590.4 39710.8 36957.6 37400.0 38318.0 39156.6 39996.8 31521.4 36998.0 37344.6 37626.4 37833.8 32872.8 33249.8 33405.0 33498.7 33527.8 21619.7 24510.3 24828.6 25441.6 26007.9 05:09:40 INFO - PROCESS | 1952 | 05:09:40 INFO - PROCESS | 1952 | [#2] jquery.html Cycles:180 Average:34077.23 Median:2308.15 stddev:98568.18 (4270.4%) stddev-sans-first:98812.15 05:09:40 INFO - PROCESS | 1952 | Values: 345.4 363.0 397.5 397.7 407.4 18776.5 19244.0 20442.8 20816.1 21676.5 17540.4 18176.2 20265.0 21631.4 21708.3 5385.6 5856.4 6048.8 6071.8 6072.9 6005.1 6037.0 6055.7 6061.0 6062.1 5216.4 5687.2 5823.9 5993.8 6001.8 5699.1 5838.4 5843.4 5978.9 5984.6 5076.9 5139.8 5165.7 5166.4 5175.2 25876.5 25920.4 25976.1 26501.9 26747.6 2001.5 2023.7 2212.2 2290.7 2325.6 12548.3 14684.3 15244.5 15518.2 15567.3 1737.3 1765.5 1787.4 1791.9 1820.4 116321.3 118664.0 119883.0 120224.4 121931.0 8977.6 9036.3 11339.4 11548.3 11702.0 13983.9 14025.6 14038.0 14059.6 14092.6 8093.3 8713.9 8730.5 8826.7 8874.8 7769.0 7900.8 8428.2 8743.4 8841.5 5876.6 6724.2 6861.7 6880.0 6895.8 1703.9 1913.8 1914.4 1922.4 1962.9 880.5 968.0 993.5 1042.6 1053.0 20928.0 20951.4 21109.0 21206.2 21289.0 921.2 952.7 998.6 1008.2 1018.9 8498.2 11315.7 11326.6 11365.6 11380.3 524232.8 598863.0 605153.0 615821.0 618751.0 85228.0 101051.5 101255.5 116660.0 118419.4 896.9 1000.5 1008.8 1034.2 1040.1 18710.6 18784.3 18995.0 19024.2 19179.0 39214.4 40293.8 47610.8 48928.8 49111.0 75292.0 75548.6 76070.6 77073.6 78368.6 6737.4 7846.5 7963.2 8090.4 8422.5 10692.5 11623.8 12378.1 12674.8 12918.9 8227.4 8999.8 10584.5 10898.6 11127.3 10397.4 10698.2 10897.7 10950.6 11095.0 11134.8 11297.4 11322.7 11327.1 11384.5 7996.3 8077.5 8161.4 8167.1 8355.6 10710.4 10738.4 10760.1 10802.0 11231.5 05:09:40 INFO - PROCESS | 1952 | 05:09:40 INFO - PROCESS | 1952 | [#3] mootools.html Cycles:180 Average:5980.92 Median:4710.00 stddev:3421.47 (72.6%) stddev-sans-first:3415.34 05:09:40 INFO - PROCESS | 1952 | Values: 1615.5 1667.1 1957.4 2004.7 2017.7 7381.6 8336.5 9019.3 9518.7 9530.3 7400.0 9294.6 9361.9 9374.3 9381.2 2422.6 2438.7 2478.0 2481.5 2481.6 2434.5 2484.2 2500.5 2501.9 2506.4 2457.0 2475.8 2498.7 2501.5 2506.3 2425.9 2426.1 2437.9 2439.5 2466.1 2432.8 2445.5 2447.5 2457.1 2465.3 8473.4 8489.3 8901.2 9404.0 9441.2 5329.1 5726.4 5736.2 5746.8 5753.4 3548.1 3550.4 3703.7 3731.1 3748.9 1002.2 1043.4 1045.2 1054.9 1058.4 12492.9 12583.5 12633.0 12657.9 12702.7 4955.2 4980.8 5062.7 5128.4 5150.7 10587.0 10608.2 10615.2 10629.5 10641.3 5268.8 5596.6 5708.5 5709.1 5720.2 4587.3 5000.6 5090.5 5188.2 5196.8 3502.7 4116.7 4197.6 4263.1 4326.6 1364.6 1381.5 1381.7 1386.3 1393.6 778.9 794.8 859.6 901.5 940.1 5380.9 5889.6 5940.1 6009.8 6163.2 833.5 1005.2 1019.9 1026.7 1056.8 4067.0 4120.3 4152.8 4194.9 4197.6 11373.0 11711.1 11759.1 11766.8 11871.9 11817.2 11841.6 11858.1 11861.6 11930.9 7228.5 8638.1 8641.4 8651.5 8770.7 6030.5 6200.9 6232.0 6273.5 6373.5 8366.8 10530.0 10654.5 10704.2 10753.8 10717.7 10771.7 10917.7 11026.0 11046.9 6085.6 6773.6 7761.5 7823.8 7861.3 8754.3 8790.6 8805.5 8838.3 8838.5 7661.6 7722.3 7824.6 7925.8 7932.0 7573.8 7586.7 7665.5 7811.2 7827.6 6447.9 7238.7 7324.6 7326.7 7331.4 4583.3 4874.7 5030.7 5091.8 5143.7 4536.7 4832.7 5077.4 5098.2 5336.4 05:09:40 INFO - PROCESS | 1952 | 05:09:40 INFO - PROCESS | 1952 | [#4] prototype.html Cycles:180 Average:4639.12 Median:5284.43 stddev:1452.36 (27.5%) stddev-sans-first:1419.39 05:09:40 INFO - PROCESS | 1952 | Values: 296.9 314.3 318.4 321.0 328.2 4906.8 5451.1 5575.6 5643.5 5656.3 5463.2 5467.9 5483.5 5497.3 5509.7 3799.9 3968.7 4025.3 4129.0 4175.6 3824.6 3888.8 4063.2 4145.6 4163.4 3700.9 3823.2 4130.0 4149.7 4170.0 3517.5 3728.2 3876.8 3951.4 4105.7 3131.2 3425.6 3542.8 3571.3 3604.2 4222.8 5279.6 5319.6 5325.2 5406.6 4616.0 4659.4 4762.2 4767.2 4771.4 5496.7 5763.4 5767.6 5808.1 5840.6 3530.6 3752.3 3772.8 3956.6 3969.3 5173.4 5345.0 5813.4 6103.4 6158.7 3615.5 3787.0 3816.7 3941.8 4003.5 3775.6 4053.2 4059.3 4083.9 4095.9 4200.8 4578.9 4677.2 4759.7 4761.0 5002.8 5399.8 5600.7 5746.1 5854.7 1244.7 1313.2 1346.1 1356.0 1379.4 837.8 853.6 855.5 858.2 886.6 4297.1 5045.2 5167.7 5364.3 5401.6 4996.8 5516.4 5663.3 5890.6 5911.6 4452.8 4516.9 5170.9 5284.3 5417.5 2932.3 3099.5 3104.7 3132.3 3136.6 5433.8 5716.6 5815.5 6087.0 6222.4 5425.9 5483.8 5703.7 5754.6 5853.7 5569.7 5753.6 6183.0 6203.4 6232.6 4926.4 5227.1 5705.2 5927.5 5933.9 5043.8 5310.1 5571.9 6026.6 6063.3 5953.4 6302.2 6310.5 6315.5 6326.4 3413.0 3419.6 3855.9 4016.9 4025.3 5174.7 5946.4 6082.9 6102.9 6108.7 5456.7 5877.0 5877.9 5904.5 5955.8 5565.5 5836.9 5859.4 5918.3 5926.5 5175.4 5284.6 5359.7 5619.0 5688.6 4481.5 4912.5 5057.0 5822.5 5850.3 5662.8 5692.7 5747.0 5747.5 5755.1 05:09:40 INFO - PROCESS | 1952 | 05:09:40 INFO - PROCESS | 1952 | [#5] yui.html Cycles:180 Average:17813.60 Median:579.55 stddev:24964.73 (4307.6%) stddev-sans-first:25001.43 05:09:40 INFO - PROCESS | 1952 | Values: 632.8 655.3 701.5 724.5 734.9 14092.4 14928.0 15364.4 15555.9 15556.9 14187.0 14293.0 14294.6 14306.7 14787.1 884.2 913.3 935.5 937.5 939.7 723.1 891.7 905.8 912.0 920.0 894.9 963.0 975.0 977.9 978.7 947.8 966.0 968.0 968.9 969.6 690.7 697.6 704.2 719.0 721.0 14757.9 14823.2 14856.4 15205.7 15264.6 12257.1 12296.3 12297.4 12366.4 12639.3 9905.8 9989.5 10093.5 10432.9 10887.2 3437.7 3461.2 3479.9 3540.3 3566.4 75172.6 79975.0 85701.6 86018.6 86287.6 8526.7 9083.5 9181.9 9306.7 9509.7 18830.6 21797.2 22361.7 22897.4 22899.0 7404.5 7587.9 7605.9 7734.7 7813.6 3878.2 3881.8 3895.5 3984.2 3992.5 3451.9 3453.0 3525.0 3548.8 3554.6 639.8 643.2 652.5 659.1 662.9 493.8 533.7 581.5 606.7 627.4 7991.4 8195.1 8201.4 8353.5 8389.5 497.9 556.5 577.6 588.3 606.4 3898.5 3934.2 3980.3 4002.8 4084.4 88756.0 90543.0 91822.5 92023.0 97885.0 76176.0 77907.4 78586.6 78644.9 80320.0 64422.0 65509.0 66368.3 72507.6 72726.6 8251.6 8279.8 8348.2 8418.6 8486.4 42371.0 42788.0 42828.2 43364.6 45544.5 52261.2 52554.5 56279.7 56838.4 59870.5 10684.8 11015.3 11123.1 11136.0 11414.3 10627.6 11763.7 11796.2 11875.8 12324.9 10887.7 11452.7 11498.5 11649.8 11668.3 11424.7 11546.4 11554.7 11638.9 11807.9 11235.2 11309.7 11372.2 11644.8 11728.8 9573.2 9586.8 9765.9 9852.1 10179.3 9383.7 9509.4 10098.8 10103.4 10231.4 05:09:40 INFO - PROCESS | 1952 | -------- Summary: end -------- 05:09:40 INFO - PROCESS | 1952 | 05:09:41 INFO - TEST-INFO | 1952: exit 0 05:09:41 INFO - TEST-OK | dromaeo_css | took 1112491ms 05:09:41 INFO - TEST-START | kraken 05:09:41 INFO - operating with platform_type : mac_ 05:09:41 INFO - Initialising browser for kraken test... 05:09:41 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmptpIsH4/profile http://localhost:49474/getInfo.html) 05:09:44 INFO - PROCESS | 1960 | __metrics Screen width/height:1600/1200 05:09:44 INFO - PROCESS | 1960 | colorDepth:24 05:09:44 INFO - PROCESS | 1960 | Browser inner width/height: 1024/689 05:09:44 INFO - PROCESS | 1960 | __metrics 05:09:44 ERROR - PROCESS | 1960 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:09:45 INFO - TEST-INFO | 1960: exit 0 05:09:45 INFO - Browser initialized. 05:09:45 INFO - Running cycle 1/1 for kraken test... 05:09:45 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmptpIsH4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:57 INFO - PROCESS | 1963 | RSS: Main: 249868288 05:09:57 INFO - PROCESS | 1963 | 05:10:00 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49474/tests/kraken/driver.html?testName=audio-beat-detection) 05:10:01 INFO - PROCESS | 1963 | RSS: Main: 261816320 05:10:01 INFO - PROCESS | 1963 | 05:10:03 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49474/tests/kraken/driver.html?testName=audio-dft) 05:10:04 INFO - PROCESS | 1963 | RSS: Main: 266461184 05:10:04 INFO - PROCESS | 1963 | 05:10:08 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49474/tests/kraken/driver.html?testName=audio-fft) 05:10:08 INFO - PROCESS | 1963 | RSS: Main: 267710464 05:10:08 INFO - PROCESS | 1963 | 05:10:10 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49474/tests/kraken/driver.html?testName=audio-oscillator) 05:10:11 INFO - PROCESS | 1963 | RSS: Main: 267956224 05:10:11 INFO - PROCESS | 1963 | 05:10:13 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49474/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:10:14 INFO - PROCESS | 1963 | RSS: Main: 267956224 05:10:14 INFO - PROCESS | 1963 | 05:10:16 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49474/tests/kraken/driver.html?testName=imaging-darkroom) 05:10:17 INFO - PROCESS | 1963 | RSS: Main: 267952128 05:10:17 INFO - PROCESS | 1963 | 05:10:20 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49474/tests/kraken/driver.html?testName=imaging-desaturate) 05:10:21 INFO - PROCESS | 1963 | RSS: Main: 269684736 05:10:21 INFO - PROCESS | 1963 | 05:10:24 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49474/tests/kraken/driver.html?testName=json-parse-financial) 05:10:25 INFO - PROCESS | 1963 | RSS: Main: 270143488 05:10:25 INFO - PROCESS | 1963 | 05:10:26 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49474/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:10:27 INFO - PROCESS | 1963 | RSS: Main: 269737984 05:10:27 INFO - PROCESS | 1963 | 05:10:29 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49474/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:10:30 INFO - PROCESS | 1963 | RSS: Main: 269791232 05:10:30 INFO - PROCESS | 1963 | 05:10:32 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49474/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:10:33 INFO - PROCESS | 1963 | RSS: Main: 270159872 05:10:33 INFO - PROCESS | 1963 | 05:10:36 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:10:36 INFO - PROCESS | 1963 | RSS: Main: 270184448 05:10:36 INFO - PROCESS | 1963 | 05:10:39 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:10:40 INFO - PROCESS | 1963 | RSS: Main: 270180352 05:10:40 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:49474/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49474/tests/kraken/driver.html?testName=ai-astar) 05:10:42 INFO - PROCESS | 1963 | RSS: Main: 272142336 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | __start_tp_report 05:10:42 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 05:10:42 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 05:10:42 INFO - PROCESS | 1963 | |i|pagename|runs| 05:10:42 INFO - PROCESS | 1963 | |0;ai-astar;163;169;132;118;97;171;160;136;120;118 05:10:42 INFO - PROCESS | 1963 | |1;audio-beat-detection;155;121;142;201;119;137;154;147;171;141 05:10:42 INFO - PROCESS | 1963 | |2;audio-dft;204;239;261;226;197;202;200;196;196;197 05:10:42 INFO - PROCESS | 1963 | |3;audio-fft;73;82;75;173;58;63;62;66;135;57 05:10:42 INFO - PROCESS | 1963 | |4;audio-oscillator;79;87;144;77;80;80;121;83;81;124 05:10:42 INFO - PROCESS | 1963 | |5;imaging-gaussian-blur;90;88;91;90;91;87;92;89;92;86 05:10:42 INFO - PROCESS | 1963 | |6;imaging-darkroom;147;97;110;98;97;97;97;97;97;97 05:10:42 INFO - PROCESS | 1963 | |7;imaging-desaturate;82;148;143;91;90;92;92;90;128;138 05:10:42 INFO - PROCESS | 1963 | |8;json-parse-financial;58;61;61;60;59;59;58;120;59;57 05:10:42 INFO - PROCESS | 1963 | |9;json-stringify-tinderbox;68;67;66;75;77;77;75;67;69;69 05:10:42 INFO - PROCESS | 1963 | |10;stanford-crypto-aes;91;87;86;84;86;86;89;107;95;88 05:10:42 INFO - PROCESS | 1963 | |11;stanford-crypto-ccm;134;142;139;148;136;135;135;147;216;152 05:10:42 INFO - PROCESS | 1963 | |12;stanford-crypto-pbkdf2;170;219;165;161;169;165;204;161;164;181 05:10:42 INFO - PROCESS | 1963 | |13;stanford-crypto-sha256-iterative;66;68;65;66;68;65;68;78;83;82 05:10:42 INFO - PROCESS | 1963 | __end_tp_report 05:10:42 INFO - PROCESS | 1963 | __start_cc_report 05:10:42 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1088 05:10:42 INFO - PROCESS | 1963 | __end_cc_report 05:10:42 INFO - PROCESS | 1963 | __startTimestamp1463141442344__endTimestamp 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | ------- Summary: start ------- 05:10:42 INFO - PROCESS | 1963 | Number of tests: 14 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#0] ai-astar Cycles:10 Average:138.40 Median:161.50 stddev:25.83 (16.0%) stddev-sans-first:25.81 05:10:42 INFO - PROCESS | 1963 | Values: 163.0 169.0 132.0 118.0 97.0 171.0 160.0 136.0 120.0 118.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:150.50 stddev:24.02 (16.0%) stddev-sans-first:25.37 05:10:42 INFO - PROCESS | 1963 | Values: 155.0 121.0 142.0 201.0 119.0 137.0 154.0 147.0 171.0 141.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#2] audio-dft Cycles:10 Average:211.80 Median:203.00 stddev:22.60 (11.1%) stddev-sans-first:23.79 05:10:42 INFO - PROCESS | 1963 | Values: 204.0 239.0 261.0 226.0 197.0 202.0 200.0 196.0 196.0 197.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#3] audio-fft Cycles:10 Average:84.40 Median:64.50 stddev:38.56 (59.8%) stddev-sans-first:40.68 05:10:42 INFO - PROCESS | 1963 | Values: 73.0 82.0 75.0 173.0 58.0 63.0 62.0 66.0 135.0 57.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:80.00 stddev:24.38 (30.5%) stddev-sans-first:25.11 05:10:42 INFO - PROCESS | 1963 | Values: 79.0 87.0 144.0 77.0 80.0 80.0 121.0 83.0 81.0 124.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:90.50 stddev:2.07 (2.3%) stddev-sans-first:2.19 05:10:42 INFO - PROCESS | 1963 | Values: 90.0 88.0 91.0 90.0 91.0 87.0 92.0 89.0 92.0 86.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:97.00 stddev:15.85 (16.3%) stddev-sans-first:4.30 05:10:42 INFO - PROCESS | 1963 | Values: 147.0 97.0 110.0 98.0 97.0 97.0 97.0 97.0 97.0 97.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#7] imaging-desaturate Cycles:10 Average:109.40 Median:90.00 stddev:26.31 (29.2%) stddev-sans-first:25.97 05:10:42 INFO - PROCESS | 1963 | Values: 82.0 148.0 143.0 91.0 90.0 92.0 92.0 90.0 128.0 138.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:59.00 stddev:19.30 (32.7%) stddev-sans-first:20.29 05:10:42 INFO - PROCESS | 1963 | Values: 58.0 61.0 61.0 60.0 59.0 59.0 58.0 120.0 59.0 57.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:72.00 stddev:4.45 (6.2%) stddev-sans-first:4.58 05:10:42 INFO - PROCESS | 1963 | Values: 68.0 67.0 66.0 75.0 77.0 77.0 75.0 67.0 69.0 69.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:87.50 stddev:6.77 (7.7%) stddev-sans-first:7.17 05:10:42 INFO - PROCESS | 1963 | Values: 91.0 87.0 86.0 84.0 86.0 86.0 89.0 107.0 95.0 88.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:144.50 stddev:24.57 (17.0%) stddev-sans-first:25.50 05:10:42 INFO - PROCESS | 1963 | Values: 134.0 142.0 139.0 148.0 136.0 135.0 135.0 147.0 216.0 152.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:169.50 stddev:19.94 (11.8%) stddev-sans-first:21.04 05:10:42 INFO - PROCESS | 1963 | Values: 170.0 219.0 165.0 161.0 169.0 165.0 204.0 161.0 164.0 181.0 05:10:42 INFO - PROCESS | 1963 | 05:10:42 INFO - PROCESS | 1963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:68.00 stddev:7.17 (10.5%) stddev-sans-first:7.38 05:10:42 INFO - PROCESS | 1963 | Values: 66.0 68.0 65.0 66.0 68.0 65.0 68.0 78.0 83.0 82.0 05:10:42 INFO - PROCESS | 1963 | -------- Summary: end -------- 05:10:42 INFO - PROCESS | 1963 | 05:10:43 INFO - TEST-INFO | 1963: exit 0 05:10:43 INFO - TEST-OK | kraken | took 61650ms 05:10:43 INFO - SUITE-END | took 1174s 05:10:43 INFO - Completed test suite (00:19:34) 05:10:43 INFO - javascript benchmark 05:10:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7281.088574344443, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3497.825108744563, 3522.7357948153863, 3556.466530020497, 3556.5732112146547, 3565.0, 4902.950970490294, 5833.766649334027, 5927.970360148199, 5937.703114844257, 5991.310999235089, 4975.7263350515705, 5641.464060914206, 5851.4148585141465, 5882.499987501067, 6003.429674180957, 5233.607479439038, 5256.290400795881, 5344.278522399465, 5383.865403364908, 5408.513233808956, 569.3651381923969, 4918.693596498294, 5252.3697156341295, 5342.946570534304, 5345.412004679482, 5308.362996440414, 5331.120365139747, 5343.839684809462, 5351.973240133813, 5359.464053594648, 5353.411124776271, 5370.812021579265, 5390.4879036491475, 5399.406065332811, 5414.972925135388, 5194.168932970707, 5225.973870130663, 5262.97368513155, 5273.789048438058, 5324.973375133139, 4634.745089020103, 5590.217369568264, 5845.444682755174, 5930.703464826742, 5951.16683664283, 6195.256569211679, 6236.0, 6255.499560035186, 6267.59260648061, 6269.310375858652, 5300.946990530084, 6250.0624906263965, 6256.280527739323, 6326.79790839739, 6330.113784070234, 6059.121427393004, 6061.363556826514, 6062.151298818169, 6075.848103797396, 6105.0, 6256.687165641791, 6338.809835704937, 6439.066335381437, 6451.41937225652, 6462.741490340428, 6234.438900498977, 6278.340774218641, 6294.496440284766, 6300.1494798202575, 6306.085617585516, 6287.842803929939, 6305.527085468608, 6311.873762524724, 6317.684115794192, 6337.429631333202, 5458.208559758813, 6136.417040381157, 6219.564630475914, 6233.875322493524, 6272.780452684134, 5141.203113517411, 5228.764705588258, 6213.906791398133, 6222.937770622327, 6236.6258024518675, 4330.566943305707, 5038.0931432341795, 5039.44566097729, 5052.393712754493, 5092.159793634083, 3761.83383151224, 4503.752293623882, 4511.075229577928, 4543.25036369002, 4599.448066232007, 5913.940860591339, 5984.401559843981, 6003.7898673546215, 6108.419700128481, 6160.630362178284, 5541.445855414427, 6326.051092336186, 6345.524085693499, 6354.3963323484195, 6382.266039405527, 5996.070609055603, 6006.789762358297, 6041.516678665696, 6042.3655516170165, 6046.546509011754, 4531.410916580823, 5510.448955104457, 5511.311086114236, 5513.696746678891, 5522.723863806794, 6281.340459251713, 6463.7737679181, 6497.382748638872, 6500.642464664489, 6522.739090436329, 6214.689265536796, 6255.155554000152, 6295.0, 6345.3654634538025, 6346.397092276226, 6468.773592924225, 6506.121673574007, 6518.152640156749, 6529.640869752019, 6557.2131344239, 6147.200863887666, 6189.35011823752, 6271.0, 6282.780102696383, 6293.496520278275, 6251.218597675291, 6274.341194174546, 6324.905126423199, 6325.462335701332, 6329.303776584664, 6257.0, 6284.905726414199, 6286.465650419766, 6288.151099601679, 6313.715882785377, 6145.385461453819, 6203.255609326729, 6246.312905580474, 6263.498920086473, 6288.993760998218, 4092.0792821616087, 4915.606751459946, 5108.66793658411, 6134.8039827316215, 6220.0047992321015, 5536.307961504812, 6091.269047714302, 6179.825833091698, 6233.625982441068, 6242.812715618538, 6053.667048312209, 6145.35473775265, 6146.6004709693725, 6194.845128871814, 6250.624962502265], "value": 5712.727540021278, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.4147072337536, 529.4705294705295, 563.2396265042194, 579.6116601876743, 596.2070446306412, 32794.836025819866, 41157.7942110289, 41459.37810932838, 41479.58520414795, 41516.792416037875, 42304.365434518506, 42787.930301742475, 42934.0, 42956.0, 43021.139577208436, 8832.8675069874, 9603.135717785399, 9698.933117357084, 9743.07440793127, 9808.21534277256, 8610.741677749678, 9363.923148837868, 9618.182454491376, 9723.27075469339, 9724.416535007887, 9622.470764107971, 9641.90358096417, 9683.515824208796, 9689.903100969006, 9717.562709678046, 9653.613855445774, 9655.0, 9695.07896749804, 9700.320977531575, 9711.125998660154, 8956.238719708832, 9231.984481707006, 9556.952215238949, 9672.371295865816, 9684.273679474067, 39457.60542394597, 39500.0, 39705.0, 39966.80016599927, 40065.19869602592, 2990.6411230652243, 3197.4084794312894, 3222.2910959588853, 3354.630990591033, 3439.0542600784734, 28295.009674661287, 29092.563611545844, 29191.97828076007, 29550.85224573885, 29881.551776723365, 2669.2526092694075, 2725.2505560970694, 2733.8906443742226, 2804.186785832106, 2805.5370863807652, 489187.554062231, 528319.0, 530878.0, 531274.0, 531798.3410082964, 56717.14924276139, 57205.14192287119, 57333.14000289999, 57344.13983790246, 57356.71321643365, 35955.460668089996, 36753.816230918674, 63792.362076378646, 64190.6790466054, 64999.67500162469, 16408.507744767678, 16433.506994790176, 16559.08925009112, 16613.0862802547, 16668.416605418995, 12430.751384972249, 12688.429020694091, 12722.491100356066, 12761.744765104646, 12774.23354598727, 15601.531954041397, 19838.60322793536, 19978.600427991358, 20136.295229667183, 20163.495912602302, 8363.121872203452, 8458.492490450593, 8497.872531912026, 8530.914690853013, 8584.184502472255, 923.4182465047112, 1075.7525769073156, 1092.448313601626, 1101.6970333158285, 1147.3650048680597, 24596.262112136665, 27779.722202778117, 29389.530523473743, 29818.850905745334, 30541.0, 1038.896110388955, 1068.407034096084, 1090.939998300101, 1097.3032124600777, 1101.0, 15484.612884677974, 15536.912416130763, 15594.610134746723, 15660.373585056697, 16028.0, 639573.0, 646458.0, 653075.0, 656284.0, 657275.0, 59694.80610387768, 61546.38453615496, 61742.69128654418, 61768.69115654393, 61773.382266177665, 1475.3582191746625, 1476.859698328657, 1482.5404124721372, 1493.37278343094, 1498.3257534109694, 29363.70636293695, 29460.410791784474, 29500.852495737385, 30061.398772024873, 30122.945696900504, 51072.489275106775, 51404.0, 51666.48333516767, 52054.0, 52126.73936630293, 559195.0, 567242.0, 568093.5836228561, 568612.0, 568687.31312688, 26276.21171364862, 26722.465550689267, 27078.458430831666, 27085.864570677022, 27139.457210856068, 45135.32297015613, 46250.768746156056, 46943.0, 47368.0, 47563.762181188875, 37923.05192370213, 38631.61368386393, 39108.02229944274, 39590.40614390844, 39710.84529824038, 36957.63042369649, 37400.0, 38318.0, 39156.608433915295, 39996.80001599973, 31521.36957260796, 36998.0, 37344.62655373412, 37626.43560346542, 37833.81083094677, 32872.83563582167, 33249.833750831094, 33405.0, 33498.66501335053, 33527.83236083804, 21619.675704864127, 24510.264692059267, 24828.634425106793, 25441.618375724007, 26007.869960650074], "value": 19938.244421584954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.41969491254684, 362.9618890016548, 397.4773173277141, 397.73749325445203, 407.35637692445937, 18776.530586735338, 19244.0, 20442.795572044295, 20816.063277152527, 21676.458088547755, 17540.386086486975, 18176.18207180677, 20265.0, 21631.35105946824, 21708.3487495375, 5385.569154467653, 5856.355800861912, 6048.758049678029, 6071.757129714806, 6072.878542429149, 6005.12925625784, 6037.0, 6055.666938318391, 6060.969695151518, 6062.090686397031, 5216.400113986883, 5687.203791469197, 5823.912641310362, 5993.820185394424, 6001.759929602811, 5699.088145896637, 5838.4453476919625, 5843.357230704619, 5978.880422391571, 5984.611000284989, 5076.923846142311, 5139.820106296299, 5165.66423182492, 5166.3800343958965, 5175.197844334134, 25876.48247035049, 25920.351991200183, 25976.09083682081, 26501.867490662422, 26747.598786018225, 2001.4896201468678, 2023.6660950943076, 2212.23677831148, 2290.679304897316, 2325.616273314918, 12548.309842958633, 14684.26578671062, 15244.46644367453, 15518.224088795516, 15567.299471523695, 1737.3311275159028, 1765.523308706642, 1787.3744189533688, 1791.8566514678794, 1820.417466410749, 116321.3471461149, 118664.0, 119883.0, 120224.39887800506, 121931.0, 8977.596008179647, 9036.277097832157, 11339.433028348549, 11548.307101573933, 11702.0, 13983.930080349533, 14025.649358765908, 14038.0, 14059.648508787157, 14092.577222683336, 8093.271605555528, 8713.912860871436, 8730.476171429735, 8826.735197943943, 8874.822503549893, 7769.028871391076, 7900.802479938047, 8428.241458268785, 8743.38796284254, 8841.469511829311, 5876.647401155944, 6724.193096828314, 6861.656917154122, 6880.0, 6895.793126206222, 1703.9233234504477, 1913.8373238274623, 1914.3969649560345, 1922.375228050889, 1962.9411117666493, 880.5157163560017, 967.9661211857551, 993.5082134343402, 1042.551702767802, 1052.9789404211872, 20928.0, 20951.371458856258, 21109.0, 21206.15175392998, 21289.0, 921.2307723051327, 952.6713283917038, 998.610541888664, 1008.2287050406445, 1018.8930162332848, 8498.150184981576, 11315.660530184108, 11326.603568875049, 11365.602203922823, 11380.26028308174, 524232.78836058045, 598863.0, 605153.0, 615821.0, 618751.0, 85228.0, 101051.48422773664, 101255.4937225324, 116660.0, 118419.40790295994, 896.9416987895765, 1000.4847503535685, 1008.7982403519326, 1034.1881622926117, 1040.1366865501616, 18710.625787483903, 18784.342548010754, 18995.0, 19024.239030438628, 19179.041047947827, 39214.41178382384, 40293.79118626446, 47610.76194619005, 48928.75535622299, 49111.0, 75292.0, 75548.62225689057, 76070.57682404194, 77073.61463192648, 78368.60815695886, 6737.3599508046655, 7846.489978151402, 7963.163867793798, 8090.393220508367, 8422.536760478233, 10692.518836652214, 11623.825642615537, 12378.071644626509, 12674.809877851656, 12918.935405322913, 8227.382946278933, 8999.820003600022, 10584.523696433833, 10898.564057437614, 11127.332360058423, 10397.428141452292, 10698.197635177548, 10897.727556811144, 10950.56197752081, 11095.001449869551, 11134.777304454028, 11297.378644174649, 11322.716932076435, 11327.093832493216, 11384.544618215179, 7996.280334769898, 8077.515349079074, 8161.387895907949, 8167.101618821806, 8355.623996920274, 10710.410927398756, 10738.355698658106, 10760.139188864716, 10802.0, 11231.494582743959], "value": 9566.172910051073, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1615.5153453963812, 1667.0664427920365, 1957.4225603446982, 2004.66922957712, 2017.677171652536, 7381.630918454076, 8336.499810011404, 9019.278457723383, 9518.666846660359, 9530.285228607856, 7400.0, 9294.581743821527, 9361.906380936189, 9374.343795934288, 9381.249500039998, 2422.600270955299, 2438.743931887153, 2478.0, 2481.5409149307347, 2481.565725997952, 2434.5374378868046, 2484.2050543825985, 2500.4997001798956, 2501.874906254689, 2506.448581312108, 2456.9631455528183, 2475.8266921315517, 2498.6876640419946, 2501.4871951250043, 2506.260653107338, 2425.854448733073, 2426.0902161689364, 2437.85372877627, 2439.499902519988, 2466.1245257933533, 2432.8297019208662, 2445.510897820443, 2447.5349683560066, 2457.1400009996537, 2465.3220364399754, 8473.364497662638, 8489.320854331638, 8901.243394311492, 9403.952980235055, 9441.15029647328, 5329.147336426192, 5726.427357264281, 5736.225609542742, 5746.827595172152, 5753.395893431171, 3548.1129717570607, 3550.431930891045, 3703.740738148331, 3731.1418373774186, 3748.887533374003, 1002.2483137646765, 1043.3791893823163, 1045.231754660324, 1054.936703797767, 1058.4125810175349, 12492.875071249262, 12583.496660133584, 12633.0, 12657.873421265762, 12702.745945081047, 4955.231939049453, 4980.825671101494, 5062.696238225718, 5128.435872054071, 5150.690958542425, 10587.0, 10608.20438467118, 10615.1507879371, 10629.5216715248, 10641.308314959502, 5268.841934741964, 5596.636218645856, 5708.457696518824, 5709.115087161496, 5720.170575266563, 4587.3348364486965, 5000.62495312853, 5090.52374811308, 5188.169892817206, 5196.792128314901, 3502.7372947029075, 4116.732412393185, 4197.559256278047, 4263.126059157865, 4326.567343265711, 1364.6383708317303, 1381.4543255414255, 1381.696026874106, 1386.2860626777217, 1393.5610282760897, 778.9182135875765, 794.797326681704, 859.6432480520639, 901.5350056158742, 940.0975063938558, 5380.865478363072, 5889.617174883619, 5940.138679891392, 6009.819705408845, 6163.19878415803, 833.5205011105337, 1005.1958433253368, 1019.8929112443235, 1026.6817286641017, 1056.8414737789394, 4067.0, 4120.320147175742, 4152.8131234094535, 4194.937075943863, 4197.601227883346, 11373.0, 11711.121665875093, 11759.05927525796, 11766.764664706658, 11871.940640296743, 11817.231879927776, 11841.644750657493, 11858.110641701907, 11861.5848445304, 11930.940345298219, 7228.530145540523, 8638.13618638131, 8641.395102342776, 8651.52416617092, 8770.736877893545, 6030.547708921761, 6200.937990620036, 6232.0, 6273.498120150286, 6373.521985851173, 8366.790830229293, 10530.0, 10654.520546575268, 10704.197185210984, 10753.838692419464, 10717.732056698645, 10771.730706732082, 10917.727056823644, 11026.0, 11046.944765276123, 6085.604435711664, 6773.593584384953, 7761.534307941542, 7823.76528704117, 7861.292483676497, 8754.343424243334, 8790.604422801118, 8805.515696636747, 8838.292936565187, 8838.513881736566, 7661.616919154131, 7722.266384693445, 7824.608769561613, 7925.801854953672, 7932.0, 7573.810654733676, 7586.658600362886, 7665.501742386727, 7811.179826118176, 7827.608619569112, 6447.903281450688, 7238.746643867439, 7324.597147156957, 7326.670299836626, 7331.3768329692575, 4583.312503124558, 4874.731889745956, 5030.6668732786575, 5091.770870310771, 5143.691378517301, 4536.6824322297125, 4832.661713680009, 5077.39071311445, 5098.1588037973315, 5336.359636843604], "value": 4787.962723665127, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.94358071966326, 314.27089153164655, 318.36803944170833, 320.9743220542358, 328.2466738834375, 4906.803727850891, 5451.073317536018, 5575.581831362649, 5643.520300774434, 5656.292963379583, 5463.241063263056, 5467.917981230285, 5483.451654834515, 5497.340319161696, 5509.696966666832, 3799.924001519968, 3968.702347323948, 4025.2553277643583, 4128.958710412902, 4175.582441755815, 3824.5792962774212, 3888.794473713158, 4063.1557909463495, 4145.647619952292, 4163.396307535406, 3700.9452306092767, 3823.2353529294114, 4129.958700412987, 4149.688773342012, 4169.97915010426, 3517.4723791431234, 3728.217074414349, 3876.7867767272787, 3951.4467974483596, 4105.7331273467125, 3131.230854567162, 3425.6231814500384, 3542.752007359486, 3571.321448924696, 3604.2070744436182, 4222.78886055696, 5279.577633789288, 5319.574434045306, 5325.227841962894, 5406.621536492447, 4616.0, 4659.394278743775, 4762.214234651278, 4767.237242041291, 4771.355866957951, 5496.725163741837, 5763.3948435414095, 5767.5962682612235, 5808.12878068289, 5840.634543010087, 3530.593981692087, 3752.255201331394, 3772.849086036555, 3956.6439020488006, 3969.3450580654157, 5173.3533308336455, 5344.984452953926, 5813.418658134195, 6103.389661033905, 6158.692065396757, 3615.5299811024925, 3787.0, 3816.694664426839, 3941.842326306973, 4003.499562554681, 3775.6035616260447, 4053.1893621275863, 4059.3099173140636, 4083.9387409188885, 4095.8566450174103, 4200.789960501963, 4578.908421831545, 4677.228257337501, 4759.714417134983, 4761.0, 5002.774875130628, 5399.757010934517, 5600.747966341524, 5746.109353050284, 5854.677992710356, 1244.7137158453606, 1313.2120727563386, 1346.064485182808, 1355.9897876082382, 1379.4344318829233, 837.7947402886332, 853.5860107847689, 855.4653341661461, 858.1590041759112, 886.6409104312763, 4297.076128632359, 5045.217991211368, 5167.718498753318, 5364.329458817648, 5401.621886467988, 4996.775145118479, 5516.400243929215, 5663.348714897839, 5890.646561206256, 5911.556633252523, 4452.777361131995, 4516.932246016312, 5170.922436163461, 5284.260203571503, 5417.51242388187, 2932.299266425468, 3099.535069739557, 3104.7360974317435, 3132.2952335724735, 3136.5765621641244, 5433.750237445331, 5716.570857285678, 5815.487973126933, 6087.0, 6222.444388902774, 5425.945740542623, 5483.8338856151595, 5703.7166637506225, 5754.625949313281, 5853.707314634336, 5569.693666848362, 5753.59724819267, 6182.959623324202, 6203.410675985774, 6232.594881332699, 4926.438252108955, 5227.065985585357, 5705.202861098741, 5927.525797936241, 5933.881322373615, 5043.823466178666, 5310.070737620978, 5571.9442805571425, 6026.608270462406, 6063.272407311151, 5953.374895635896, 6302.180716506825, 6310.52671049664, 6315.4947604192475, 6326.43062124411, 3413.0, 3419.606745224331, 3855.9036024099623, 4016.8995775105855, 4025.315696331572, 5174.7153906535505, 5946.375630558729, 6082.878342433215, 6102.938970610237, 6108.739766286502, 5456.727163641723, 5877.0, 5877.94122058774, 5904.52763778888, 5955.821325360246, 5565.526930210977, 5836.883262334814, 5859.44335288147, 5918.348981611933, 5926.496247818984, 5175.404828444777, 5284.603654725834, 5359.732013399393, 5619.0, 5688.639214725842, 4481.529439408815, 4912.508749125059, 5057.039162559102, 5822.534197264294, 5850.297964244318, 5662.8301150965535, 5692.743826527733, 5747.0, 5747.48272655463, 5755.057785417002], "value": 4173.130982512649, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.8259728574644, 655.3479288108333, 701.5439964023387, 724.5254358395252, 734.8530293941213, 14092.43630254791, 14928.0, 15364.385424583017, 15555.922220388911, 15556.911016228869, 14187.006909516338, 14292.999490035701, 14294.571162865132, 14306.713865722679, 14787.112773233586, 884.2395539835752, 913.2693844924034, 935.5369092299287, 937.4843835890267, 939.7086903060039, 723.0528008309105, 891.7114769158568, 905.7690288976302, 911.9908800912006, 919.9586018629178, 894.9239314658262, 963.0081016552962, 974.9805003899918, 977.8533220017018, 978.7014960437064, 947.7772723409993, 965.9951700241525, 968.0271327316037, 968.8982656821073, 969.6460791811008, 690.6926417744106, 697.6267696782248, 704.2007321689867, 718.9934092270811, 720.9819754506127, 14757.926210368987, 14823.18472484013, 14856.405743770236, 15205.695886082216, 15264.618384540365, 12257.080718946114, 12296.262224266484, 12297.385130743427, 12366.381680915918, 12639.304838233893, 9905.752356191153, 9989.450580218085, 10093.495325233709, 10432.895671043269, 10887.183461240438, 3437.74216933731, 3461.238527523941, 3479.860805567774, 3540.274243780019, 3566.35805555, 75172.62413687952, 79975.0, 85701.57149214215, 86018.56990715068, 86287.56856215741, 8526.701565445179, 9083.545822708838, 9181.908180918106, 9306.72079837606, 9509.714708558755, 18830.623387532174, 21797.237096701858, 22361.664575031387, 22897.427564311027, 22899.0, 7404.481686282016, 7587.924120758832, 7605.923940760632, 7734.651940662684, 7813.648385822538, 3878.2437424702475, 3881.7865017424315, 3895.454636350913, 3984.1633257015774, 3992.5208974922616, 3451.913702157416, 3453.0, 3525.0, 3548.769329993542, 3554.608993010767, 639.7824739588563, 643.1895811277824, 652.4780175859294, 659.120074700271, 662.8906230472014, 493.7876713013367, 533.7438029745666, 581.4534337722528, 606.659421005826, 627.3506920337429, 7991.360691144694, 8195.139510351446, 8201.42590018693, 8353.54055526952, 8389.496630202208, 497.9402471703419, 556.4852511426914, 577.6418620455261, 588.2969851027981, 606.4299558415075, 3898.532176138825, 3934.2131573684806, 3980.3034468967817, 4002.779847108437, 4084.4281800547947, 88756.0, 90543.0, 91822.54088729514, 92023.0, 97885.0, 76176.0, 77907.44185116266, 78586.60706696544, 78644.85420583113, 80320.0, 64422.033669494995, 65509.0, 66368.34079147964, 72507.63746181235, 72726.63636681782, 8251.628676709443, 8279.782378209984, 8348.165183481604, 8418.579071046546, 8486.448380855225, 42371.0, 42788.0, 42828.175879496775, 43364.56635433605, 45544.54455455403, 52261.17085901975, 52554.47445525649, 56279.718601406734, 56838.43161568497, 59870.50323741941, 10684.786304274026, 11015.339079655247, 11123.054540363835, 11135.99776020162, 11414.315141091562, 10627.628033019117, 11763.705907352385, 11796.2332448394, 11875.762484750085, 12324.938375308066, 10887.673369798918, 11452.656420307405, 11498.54005839757, 11649.825252621387, 11668.299902005907, 11424.657260282205, 11546.364949927834, 11554.711132221762, 11638.88361116378, 11807.881921180679, 11235.213535052468, 11309.66071017838, 11372.20394572372, 11644.825327619923, 11728.824067638821, 9573.234141268542, 9586.808263834544, 9765.853512197466, 9852.064053914866, 10179.338343007681, 9383.718488445358, 9509.429434233969, 10098.754231077968, 10103.35340917552, 10231.386116833013], "value": 6843.100302096004, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1602.7000000000005, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 169.0, 132.0, 118.0, 97.0, 171.0, 160.0, 136.0, 120.0, 118.0], "value": 138.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 121.0, 142.0, 201.0, 119.0, 137.0, 154.0, 147.0, 171.0, 141.0], "value": 148.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 239.0, 261.0, 226.0, 197.0, 202.0, 200.0, 196.0, 196.0, 197.0], "value": 211.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 82.0, 75.0, 173.0, 58.0, 63.0, 62.0, 66.0, 135.0, 57.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 144.0, 77.0, 80.0, 80.0, 121.0, 83.0, 81.0, 124.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 91.0, 90.0, 91.0, 87.0, 92.0, 89.0, 92.0, 86.0], "value": 89.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 97.0, 110.0, 98.0, 97.0, 97.0, 97.0, 97.0, 97.0, 97.0], "value": 103.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 148.0, 143.0, 91.0, 90.0, 92.0, 92.0, 90.0, 128.0, 138.0], "value": 109.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 61.0, 60.0, 59.0, 59.0, 58.0, 120.0, 59.0, 57.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 75.0, 77.0, 77.0, 75.0, 67.0, 69.0, 69.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 86.0, 84.0, 86.0, 86.0, 89.0, 107.0, 95.0, 88.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 142.0, 139.0, 148.0, 136.0, 135.0, 135.0, 147.0, 216.0, 152.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 219.0, 165.0, 161.0, 169.0, 165.0, 204.0, 161.0, 164.0, 181.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 65.0, 66.0, 68.0, 65.0, 68.0, 78.0, 83.0, 82.0], "value": 70.9, "unit": "score"}]}]} 05:10:43 INFO - Return code: 0 05:10:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:10:43 ERROR - # TBPL SUCCESS # 05:10:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:10:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:10:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:10:43 INFO - 2016-05-13 05:10:43.670 screenresolution[1969:12623] starting screenresolution argv=screenresolution get 05:10:43 INFO - 2016-05-13 05:10:43.672 screenresolution[1969:12623] Display 0: 1600x1200x32@60 05:10:43 INFO - 2016-05-13 05:10:43.678 screenresolution[1970:12626] starting screenresolution argv=screenresolution list 05:10:43 INFO - Available Modes on Display 0 05:10:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:10:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:10:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:10:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:10:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:10:43 INFO - Intel Iris: 05:10:43 INFO - Chipset Model: Intel Iris 05:10:43 INFO - Type: GPU 05:10:43 INFO - Bus: Built-In 05:10:43 INFO - VRAM (Dynamic, Max): 1536 MB 05:10:43 INFO - Vendor: Intel (0x8086) 05:10:43 INFO - Device ID: 0x0a2e 05:10:43 INFO - Revision ID: 0x0009 05:10:43 INFO - Displays: 05:10:43 INFO - Display: 05:10:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:10:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:10:43 INFO - Display Serial Number: 1600x1200 60 05:10:43 INFO - Main Display: Yes 05:10:43 INFO - Mirror: Off 05:10:43 INFO - Online: Yes 05:10:43 INFO - Rotation: Supported 05:10:43 INFO - Return code: 0 05:10:43 INFO - Running post-action listener: _resource_record_post_action 05:10:43 INFO - ##### 05:10:43 INFO - ##### Finished run-tests step (success) 05:10:43 INFO - ##### 05:10:43 INFO - Running post-run listener: _resource_record_post_run 05:10:44 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 1851392; Write bytes: 695423488; Read time: 18; Write time: 1891 05:10:44 INFO - TinderboxPrint: CPU usage
54.7% 05:10:44 INFO - TinderboxPrint: I/O read bytes / time
1,851,392 / 18 05:10:44 INFO - TinderboxPrint: I/O write bytes / time
695,423,488 / 1,891 05:10:44 INFO - TinderboxPrint: CPU idle
2,192.7 (45.3%) 05:10:44 INFO - TinderboxPrint: CPU system
981.0 (20.3%) 05:10:44 INFO - TinderboxPrint: CPU user
1,668.0 (34.5%) 05:10:44 INFO - TinderboxPrint: Swap in / out
397,627,392 / 0 05:10:44 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 394863104; Write bytes: 389452288; Read time: 29891; Write time: 748 05:10:44 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 991232; Write bytes: 297054208; Read time: 14; Write time: 1110 05:10:44 INFO - Running post-run listener: _upload_blobber_files 05:10:44 INFO - Blob upload gear active. 05:10:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:10:44 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 05:10:44 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'] 05:10:44 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 05:10:44 INFO - (blobuploader) - INFO - Open directory for files ... 05:10:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:10:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:10:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:45 INFO - (blobuploader) - INFO - Done attempting. 05:10:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:10:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:10:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:46 INFO - (blobuploader) - INFO - Done attempting. 05:10:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:10:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:10:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:49 INFO - (blobuploader) - INFO - Done attempting. 05:10:49 INFO - (blobuploader) - INFO - Iteration through files over. 05:10:49 INFO - Return code: 0 05:10:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:10:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:10:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6d0fb780f7ab3dc48052c9bb73a973320e5a8e7b68d18bc9ffbe821b00e4c37bf498ee0a45211dec89e641d0bb32d8f7c61692b8d6e4cbe082749426493c8e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a157f18bb1b9fd863fd48e7b6191239402b0bb53140ef104a6a2aafa1c59ce984d0628dc1f2471ea9a0df29f9674e87d632eddce7d687aed798fd7e90e973bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8221534bc443ab09015f8dd744502fe7c2bb007c8fe92ad9b9d16f4c505c3c994f34190e96de8edb75de591faac9fbfe9ac96191ff287c24a681f58a9fd64a2a"} 05:10:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:10:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:10:49 INFO - Contents: 05:10:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b6d0fb780f7ab3dc48052c9bb73a973320e5a8e7b68d18bc9ffbe821b00e4c37bf498ee0a45211dec89e641d0bb32d8f7c61692b8d6e4cbe082749426493c8e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a157f18bb1b9fd863fd48e7b6191239402b0bb53140ef104a6a2aafa1c59ce984d0628dc1f2471ea9a0df29f9674e87d632eddce7d687aed798fd7e90e973bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8221534bc443ab09015f8dd744502fe7c2bb007c8fe92ad9b9d16f4c505c3c994f34190e96de8edb75de591faac9fbfe9ac96191ff287c24a681f58a9fd64a2a"} 05:10:49 INFO - Running post-run listener: copy_logs_to_upload_dir 05:10:49 INFO - Copying logs to upload dir... 05:10:49 INFO - mkdir: /builds/slave/test/build/upload/logs 05:10:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.423608 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-05-13 05:10:49.558860) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 05:10:49.566416) ========= 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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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/b6d0fb780f7ab3dc48052c9bb73a973320e5a8e7b68d18bc9ffbe821b00e4c37bf498ee0a45211dec89e641d0bb32d8f7c61692b8d6e4cbe082749426493c8e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a157f18bb1b9fd863fd48e7b6191239402b0bb53140ef104a6a2aafa1c59ce984d0628dc1f2471ea9a0df29f9674e87d632eddce7d687aed798fd7e90e973bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8221534bc443ab09015f8dd744502fe7c2bb007c8fe92ad9b9d16f4c505c3c994f34190e96de8edb75de591faac9fbfe9ac96191ff287c24a681f58a9fd64a2a"} build_url:https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/cy1J9mdqQgOhYf3Y4L9dgQ/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/b6d0fb780f7ab3dc48052c9bb73a973320e5a8e7b68d18bc9ffbe821b00e4c37bf498ee0a45211dec89e641d0bb32d8f7c61692b8d6e4cbe082749426493c8e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a157f18bb1b9fd863fd48e7b6191239402b0bb53140ef104a6a2aafa1c59ce984d0628dc1f2471ea9a0df29f9674e87d632eddce7d687aed798fd7e90e973bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8221534bc443ab09015f8dd744502fe7c2bb007c8fe92ad9b9d16f4c505c3c994f34190e96de8edb75de591faac9fbfe9ac96191ff287c24a681f58a9fd64a2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 05:10:49.597068) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 05:10:49.597360) ========= 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.bFTrHg3q9Y/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.NABjDBxc4P/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.005115 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 05:10:49.644438) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 05:10:49.644712) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 05:10:49.645019) ========= ========= Total master_lag: 0.61 =========