builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0025 starttime: 1463714694.69 results: success (0) buildid: 20160519184214 builduid: 4f59cb535d784b79bd21e16870009839 revision: 466d5c96f43964d4122959e5ab19131237bdc6fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 20:24:54.689082) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-19 20:24:54.689647) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 20:24:54.689968) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-19 20:24:54.711718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 20:24:54.712101) ========= 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.xHtm2Hkmu2/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.dHitFXqK51/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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-19 20:24:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.7M=0.001s 2016-05-19 20:24:54 (19.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.126417 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 20:24:54.858241) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 20:24:54.858616) ========= 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.xHtm2Hkmu2/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.dHitFXqK51/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.028181 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 20:24:54.907471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 20:24:54.907907) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 466d5c96f43964d4122959e5ab19131237bdc6fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 466d5c96f43964d4122959e5ab19131237bdc6fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xHtm2Hkmu2/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.dHitFXqK51/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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-19 20:24:54,975 truncating revision to first 12 chars 2016-05-19 20:24:54,975 Setting DEBUG logging. 2016-05-19 20:24:54,975 attempt 1/10 2016-05-19 20:24:54,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/466d5c96f439?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-19 20:24:56,345 unpacking tar archive at: fx-team-466d5c96f439/testing/mozharness/ program finished with exit code 0 elapsedTime=1.614524 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-19 20:24:56.542490) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 20:24:56.542848) ========= script_repo_revision: 466d5c96f43964d4122959e5ab19131237bdc6fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-19 20:24:56.543250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 20:24:56.543624) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-19 20:24:56.558975) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-05-19 20:24:56.559377) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xHtm2Hkmu2/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.dHitFXqK51/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 20:24:56 INFO - MultiFileLogger online at 20160519 20:24:56 in /builds/slave/test 20:24:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:24:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:24:56 INFO - {'append_to_log': False, 20:24:56 INFO - 'base_work_dir': '/builds/slave/test', 20:24:56 INFO - 'blob_upload_branch': 'Fx-Team', 20:24:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:24:56 INFO - 'branch': 'Fx-Team', 20:24:56 INFO - 'buildbot_json_path': 'buildprops.json', 20:24:56 INFO - 'config_files': ('talos/mac_config.py',), 20:24:56 INFO - 'default_actions': ('clobber', 20:24:56 INFO - 'read-buildbot-config', 20:24:56 INFO - 'download-and-extract', 20:24:56 INFO - 'populate-webroot', 20:24:56 INFO - 'create-virtualenv', 20:24:56 INFO - 'install', 20:24:56 INFO - 'run-tests'), 20:24:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:24:56 INFO - 'download_minidump_stackwalk': True, 20:24:56 INFO - 'download_symbols': 'ondemand', 20:24:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:24:56 INFO - 'tooltool.py': '/tools/tooltool.py', 20:24:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:24:56 INFO - '/tools/misc-python/virtualenv.py')}, 20:24:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:24:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:24:56 INFO - 'installer_path': 'installer.exe', 20:24:56 INFO - 'log_level': 'info', 20:24:56 INFO - 'log_name': 'talos', 20:24:56 INFO - 'log_to_console': True, 20:24:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:24:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:24:56 INFO - 'opt_config_files': (), 20:24:56 INFO - 'pip_index': False, 20:24:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:24:56 INFO - 'cmd': ('bash', 20:24:56 INFO - '-c', 20:24:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:24:56 INFO - 'enabled': True, 20:24:56 INFO - 'halt_on_failure': False, 20:24:56 INFO - 'name': 'check_screen_resolution'},), 20:24:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:24:56 INFO - 'cmd': ('bash', 20:24:56 INFO - '-c', 20:24:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:24:56 INFO - 'enabled': True, 20:24:56 INFO - 'halt_on_failure': False, 20:24:56 INFO - 'name': 'check_screen_resolution'},), 20:24:56 INFO - 'run_cmd_checks_enabled': True, 20:24:56 INFO - 'sps_profile': False, 20:24:56 INFO - 'sps_profile_interval': 0, 20:24:56 INFO - 'suite': 'dromaeojs-e10s', 20:24:56 INFO - 'system_bits': '32', 20:24:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:24:56 INFO - 'title': 't-yosemite-r7-0025', 20:24:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:24:56 INFO - 'use_talos_json': True, 20:24:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:24:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:24:56 INFO - 'work_dir': 'build'} 20:24:56 INFO - ##### 20:24:56 INFO - ##### Running clobber step. 20:24:56 INFO - ##### 20:24:56 INFO - Running pre-action listener: _resource_record_pre_action 20:24:56 INFO - Running main action method: clobber 20:24:56 INFO - rmtree: /builds/slave/test/build 20:24:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:24:58 INFO - Running post-action listener: _resource_record_post_action 20:24:58 INFO - ##### 20:24:58 INFO - ##### Finished clobber step (success) 20:24:58 INFO - ##### 20:24:58 INFO - ##### 20:24:58 INFO - ##### Running read-buildbot-config step. 20:24:58 INFO - ##### 20:24:58 INFO - Running pre-action listener: _resource_record_pre_action 20:24:58 INFO - Running main action method: read_buildbot_config 20:24:58 INFO - Using buildbot properties: 20:24:58 INFO - { 20:24:58 INFO - "project": "", 20:24:58 INFO - "product": "firefox", 20:24:58 INFO - "script_repo_revision": "production", 20:24:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 20:24:58 INFO - "repository": "", 20:24:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 20:24:58 INFO - "buildid": "20160519184214", 20:24:58 INFO - "pgo_build": "False", 20:24:58 INFO - "basedir": "/builds/slave/test", 20:24:58 INFO - "buildnumber": 2, 20:24:58 INFO - "slavename": "t-yosemite-r7-0025", 20:24:58 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 20:24:58 INFO - "platform": "yosemite_r7", 20:24:58 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 20:24:58 INFO - "branch": "fx-team", 20:24:58 INFO - "repo_path": "integration/fx-team", 20:24:58 INFO - "revision": "466d5c96f43964d4122959e5ab19131237bdc6fa", 20:24:58 INFO - "stage_platform": "macosx64", 20:24:58 INFO - "builduid": "4f59cb535d784b79bd21e16870009839", 20:24:58 INFO - "slavebuilddir": "test" 20:24:58 INFO - } 20:24:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 20:24:58 INFO - Running post-action listener: _resource_record_post_action 20:24:58 INFO - ##### 20:24:58 INFO - ##### Finished read-buildbot-config step (success) 20:24:58 INFO - ##### 20:24:58 INFO - ##### 20:24:58 INFO - ##### Running download-and-extract step. 20:24:58 INFO - ##### 20:24:58 INFO - Running pre-action listener: _resource_record_pre_action 20:24:58 INFO - Running main action method: download_and_extract 20:24:58 INFO - mkdir: /builds/slave/test/build/tests 20:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:58 INFO - https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 20:24:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 20:24:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 20:24:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 20:24:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 20:24:59 INFO - Downloaded 1199 bytes. 20:24:59 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 20:24:59 INFO - Using the following test package requirements: 20:24:59 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 20:24:59 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:24:59 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 20:24:59 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:24:59 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 20:24:59 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:24:59 INFO - u'jsshell-mac.zip'], 20:24:59 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:24:59 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 20:24:59 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 20:24:59 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:24:59 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 20:24:59 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:24:59 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 20:24:59 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:24:59 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 20:24:59 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:24:59 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 20:24:59 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:24:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:24:59 INFO - https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:24:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:24:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:24:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:24:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:25:00 INFO - Downloaded 18630387 bytes. 20:25:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:25:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:25:03 INFO - Return code: 0 20:25:03 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:25: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')]} 20:25:03 INFO - https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:25:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:25:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:25:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:25:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:25:04 INFO - Downloaded 18630387 bytes. 20:25:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:25:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:25:08 INFO - Return code: 0 20:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:08 INFO - https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:25:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 20:25:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 20:25:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 20:25:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:25:09 INFO - Downloaded 10840359 bytes. 20:25:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:25:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 20:25:09 INFO - Return code: 0 20:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:09 INFO - https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:25:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:25:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:25:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 20:25:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 20:25:12 INFO - Downloaded 110156853 bytes. 20:25:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:25:12 INFO - mkdir: /builds/slave/test/properties 20:25:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:25:12 INFO - Writing to file /builds/slave/test/properties/build_url 20:25:12 INFO - Contents: 20:25:12 INFO - build_url:https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:25:13 INFO - Running post-action listener: _resource_record_post_action 20:25:13 INFO - Running post-action listener: set_extra_try_arguments 20:25:13 INFO - ##### 20:25:13 INFO - ##### Finished download-and-extract step (success) 20:25:13 INFO - ##### 20:25:13 INFO - ##### 20:25:13 INFO - ##### Running populate-webroot step. 20:25:13 INFO - ##### 20:25:13 INFO - Running pre-action listener: _resource_record_pre_action 20:25:13 INFO - Running main action method: populate_webroot 20:25:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:25:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:25:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:25:13 INFO - '--tppagecycles', 20:25:13 INFO - '7'], 20:25:13 INFO - 'tests': ['tsvgm']}}, 20:25:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:25:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:25:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:25:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:25:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:25:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:25:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:25:13 INFO - 'talos_options': ['--disable-e10s'], 20:25:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:25:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:25:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:25:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:25:13 INFO - 'talos_options': ['--disable-e10s'], 20:25:13 INFO - 'tests': ['damp', 'tps']}, 20:25:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:25:13 INFO - 'tests': ['damp', 'tps']}, 20:25:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:25:13 INFO - 'tests': ['dromaeo_dom']}, 20:25:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:25:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:25:13 INFO - 'tests': ['a11yr', 20:25:13 INFO - 'ts_paint', 20:25:13 INFO - 'tpaint', 20:25:13 INFO - 'sessionrestore', 20:25:13 INFO - 'sessionrestore_no_auto_restore', 20:25:13 INFO - 'tabpaint']}, 20:25:13 INFO - 'other-e10s': {'tests': ['a11yr', 20:25:13 INFO - 'ts_paint', 20:25:13 INFO - 'tpaint', 20:25:13 INFO - 'sessionrestore', 20:25:13 INFO - 'sessionrestore_no_auto_restore', 20:25:13 INFO - 'tabpaint']}, 20:25:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:25:13 INFO - 'ts_paint', 20:25:13 INFO - 'tpaint', 20:25:13 INFO - 'sessionrestore', 20:25:13 INFO - 'sessionrestore_no_auto_restore', 20:25:13 INFO - 'tabpaint']}, 20:25:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:25:13 INFO - 'ts_paint', 20:25:13 INFO - 'tpaint', 20:25:13 INFO - 'sessionrestore', 20:25:13 INFO - 'sessionrestore_no_auto_restore', 20:25:13 INFO - 'tabpaint']}, 20:25:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:25:13 INFO - 'tests': ['a11yr', 20:25:13 INFO - 'ts_paint', 20:25:13 INFO - 'tpaint', 20:25:13 INFO - 'sessionrestore', 20:25:13 INFO - 'sessionrestore_no_auto_restore', 20:25:13 INFO - 'tabpaint']}, 20:25:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:25:13 INFO - 'tests': ['a11yr', 20:25:13 INFO - 'ts_paint', 20:25:13 INFO - 'tpaint', 20:25:13 INFO - 'sessionrestore', 20:25:13 INFO - 'sessionrestore_no_auto_restore', 20:25:13 INFO - 'tabpaint']}, 20:25:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:25:13 INFO - 'tests': ['tsvgx', 20:25:13 INFO - 'tsvgr_opacity', 20:25:13 INFO - 'tart', 20:25:13 INFO - 'tscrollx', 20:25:13 INFO - 'cart']}, 20:25:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:25:13 INFO - 'tsvgr_opacity', 20:25:13 INFO - 'tart', 20:25:13 INFO - 'tscrollx', 20:25:13 INFO - 'cart']}, 20:25:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:25:13 INFO - 'talos_options': ['--disable-e10s'], 20:25:13 INFO - 'tests': ['tp5o']}, 20:25:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:25:13 INFO - 'tests': ['tp5o']}, 20:25:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:25:13 INFO - 'talos_options': ['--disable-e10s', 20:25:13 INFO - '--xperf_path', 20:25:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:25:13 INFO - 'tests': ['tp5n']}, 20:25:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:25:13 INFO - 'talos_options': ['--xperf_path', 20:25:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:25:13 INFO - 'tests': ['tp5n']}}, 20:25:13 INFO - 'talos.zip': {'path': '', 20:25:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:25:13 INFO - Running post-action listener: _resource_record_post_action 20:25:13 INFO - ##### 20:25:13 INFO - ##### Finished populate-webroot step (success) 20:25:13 INFO - ##### 20:25:13 INFO - ##### 20:25:13 INFO - ##### Running create-virtualenv step. 20:25:13 INFO - ##### 20:25:13 INFO - Running pre-action listener: _resource_record_pre_action 20:25:13 INFO - Running main action method: create_virtualenv 20:25:13 INFO - Creating virtualenv /builds/slave/test/build/venv 20:25:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:25:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:25:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:25:14 INFO - Using real prefix '/tools/python27' 20:25:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:25:14 INFO - Installing distribute.............................................................................................................................................................................................done. 20:25:17 INFO - Installing pip.................done. 20:25:17 INFO - Return code: 0 20:25:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:17 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 0x10b663a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b669570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24b5895b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b507d30>, '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 0x10b32bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4feb20>, '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.xHtm2Hkmu2/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.dHitFXqK51/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:25:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHtm2Hkmu2/Render', 20:25:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:17 INFO - 'HOME': '/Users/cltbld', 20:25:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:17 INFO - 'LOGNAME': 'cltbld', 20:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:17 INFO - 'MOZ_NO_REMOTE': '1', 20:25:17 INFO - 'NO_EM_RESTART': '1', 20:25:17 INFO - 'PAGER': '/bin/cat', 20:25:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:17 INFO - 'PWD': '/builds/slave/test', 20:25:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:17 INFO - 'SHELL': '/bin/bash', 20:25:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dHitFXqK51/Listeners', 20:25:17 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 20:25:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:17 INFO - 'USER': 'cltbld', 20:25:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:17 INFO - 'XPC_FLAGS': '0x0', 20:25:17 INFO - 'XPC_SERVICE_NAME': '0', 20:25:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:25:17 INFO - Cleaning up... 20:25:17 INFO - Return code: 0 20:25:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:17 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 0x10b663a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b669570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24b5895b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b507d30>, '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 0x10b32bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4feb20>, '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.xHtm2Hkmu2/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.dHitFXqK51/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:25:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHtm2Hkmu2/Render', 20:25:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:17 INFO - 'HOME': '/Users/cltbld', 20:25:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:17 INFO - 'LOGNAME': 'cltbld', 20:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:17 INFO - 'MOZ_NO_REMOTE': '1', 20:25:17 INFO - 'NO_EM_RESTART': '1', 20:25:17 INFO - 'PAGER': '/bin/cat', 20:25:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:17 INFO - 'PWD': '/builds/slave/test', 20:25:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:17 INFO - 'SHELL': '/bin/bash', 20:25:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dHitFXqK51/Listeners', 20:25:17 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 20:25:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:17 INFO - 'USER': 'cltbld', 20:25:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:17 INFO - 'XPC_FLAGS': '0x0', 20:25:17 INFO - 'XPC_SERVICE_NAME': '0', 20:25:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:18 INFO - Downloading/unpacking psutil>=3.1.1 20:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:25:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:25:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:25:21 INFO - Installing collected packages: psutil 20:25:21 INFO - Running setup.py install for psutil 20:25:21 INFO - building 'psutil._psutil_osx' extension 20:25:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 20:25:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 20:25:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 20:25:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 20:25:22 INFO - building 'psutil._psutil_posix' extension 20:25:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 20:25:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:25:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:25:22 INFO - ^ 20:25:22 INFO - 1 warning generated. 20:25:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 20:25:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:25:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:25:22 INFO - Successfully installed psutil 20:25:22 INFO - Cleaning up... 20:25:22 INFO - Return code: 0 20:25:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b663a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b669570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24b5895b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b507d30>, '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 0x10b32bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4feb20>, '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.xHtm2Hkmu2/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.dHitFXqK51/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:25:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:25:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:25:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHtm2Hkmu2/Render', 20:25:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:22 INFO - 'HOME': '/Users/cltbld', 20:25:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:22 INFO - 'LOGNAME': 'cltbld', 20:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:22 INFO - 'MOZ_NO_REMOTE': '1', 20:25:22 INFO - 'NO_EM_RESTART': '1', 20:25:22 INFO - 'PAGER': '/bin/cat', 20:25:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:22 INFO - 'PWD': '/builds/slave/test', 20:25:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:22 INFO - 'SHELL': '/bin/bash', 20:25:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dHitFXqK51/Listeners', 20:25:22 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 20:25:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:22 INFO - 'USER': 'cltbld', 20:25:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:22 INFO - 'XPC_FLAGS': '0x0', 20:25:22 INFO - 'XPC_SERVICE_NAME': '0', 20:25:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:25:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:25:25 INFO - Installing collected packages: mozsystemmonitor 20:25:25 INFO - Running setup.py install for mozsystemmonitor 20:25:25 INFO - Successfully installed mozsystemmonitor 20:25:25 INFO - Cleaning up... 20:25:25 INFO - Return code: 0 20:25:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:25: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')]} 20:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25: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')]} 20:25:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25: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', '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 0x10b663a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b669570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24b5895b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b507d30>, '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 0x10b32bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4feb20>, '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.xHtm2Hkmu2/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.dHitFXqK51/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:25: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 blobuploader==1.2.4 20:25:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHtm2Hkmu2/Render', 20:25:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:25 INFO - 'HOME': '/Users/cltbld', 20:25:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:25 INFO - 'LOGNAME': 'cltbld', 20:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:25 INFO - 'MOZ_NO_REMOTE': '1', 20:25:25 INFO - 'NO_EM_RESTART': '1', 20:25:25 INFO - 'PAGER': '/bin/cat', 20:25:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:25 INFO - 'PWD': '/builds/slave/test', 20:25:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:25 INFO - 'SHELL': '/bin/bash', 20:25:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dHitFXqK51/Listeners', 20:25:25 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 20:25:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:25 INFO - 'USER': 'cltbld', 20:25:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:25 INFO - 'XPC_FLAGS': '0x0', 20:25:25 INFO - 'XPC_SERVICE_NAME': '0', 20:25:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:25 INFO - Downloading/unpacking blobuploader==1.2.4 20:25: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 20:25: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 20:25: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 20:25: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 20:25: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 20:25: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 20:25:28 INFO - Downloading blobuploader-1.2.4.tar.gz 20:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:25:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:25: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 20:25: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 20:25: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 20:25: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 20:25: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 20:25: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 20:25:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:25:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:25: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 20:25: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 20:25: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 20:25: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 20:25: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 20:25: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 20:25:29 INFO - Downloading docopt-0.6.1.tar.gz 20:25:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:25:29 INFO - Installing collected packages: blobuploader, requests, docopt 20:25:29 INFO - Running setup.py install for blobuploader 20:25:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:25:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:25:29 INFO - Running setup.py install for requests 20:25:30 INFO - Running setup.py install for docopt 20:25:30 INFO - Successfully installed blobuploader requests docopt 20:25:30 INFO - Cleaning up... 20:25:30 INFO - Return code: 0 20:25:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:30 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 0x10b663a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b669570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24b5895b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b507d30>, '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 0x10b32bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4feb20>, '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.xHtm2Hkmu2/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.dHitFXqK51/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:25:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:25:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:25:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHtm2Hkmu2/Render', 20:25:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:30 INFO - 'HOME': '/Users/cltbld', 20:25:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:30 INFO - 'LOGNAME': 'cltbld', 20:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:30 INFO - 'MOZ_NO_REMOTE': '1', 20:25:30 INFO - 'NO_EM_RESTART': '1', 20:25:30 INFO - 'PAGER': '/bin/cat', 20:25:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:30 INFO - 'PWD': '/builds/slave/test', 20:25:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:30 INFO - 'SHELL': '/bin/bash', 20:25:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dHitFXqK51/Listeners', 20:25:30 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 20:25:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:30 INFO - 'USER': 'cltbld', 20:25:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:30 INFO - 'XPC_FLAGS': '0x0', 20:25:30 INFO - 'XPC_SERVICE_NAME': '0', 20:25:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:25:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-9ulrao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:25:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-oQaFuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:25:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-b0l78k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:25:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:25:30 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-AjhaFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:25:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-5ffaSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:25:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Q0mhNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:25:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-aPLO_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:25:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-NqlCpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:25:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-UCYzGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:25:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-9O6906-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:25:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-PLFCqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:25:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-TlOGsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:25:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-lQNDuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:25:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:25:31 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-vbHkmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:25:32 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-UnTaH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:25:32 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-Ve2Gfj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:25:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:25:32 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-JgTblN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:25:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:25:32 INFO - Running setup.py install for manifestparser 20:25:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:25:32 INFO - Running setup.py install for mozcrash 20:25:32 INFO - Running setup.py install for mozdebug 20:25:32 INFO - Running setup.py install for mozdevice 20:25:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:25:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:25:32 INFO - Running setup.py install for mozfile 20:25:33 INFO - Running setup.py install for mozhttpd 20:25:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:25:33 INFO - Running setup.py install for mozinfo 20:25:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:25:33 INFO - Running setup.py install for mozInstall 20:25:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:25:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:25:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:25:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:25:33 INFO - Running setup.py install for mozleak 20:25:33 INFO - Running setup.py install for mozlog 20:25:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:25:33 INFO - Running setup.py install for moznetwork 20:25:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:25:34 INFO - Running setup.py install for mozprocess 20:25:34 INFO - Running setup.py install for mozprofile 20:25:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:25:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:25:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:25:34 INFO - Running setup.py install for mozrunner 20:25:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:25:34 INFO - Running setup.py install for mozscreenshot 20:25:34 INFO - Running setup.py install for moztest 20:25:34 INFO - Running setup.py install for mozversion 20:25:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:25:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:25:34 INFO - Cleaning up... 20:25:34 INFO - Return code: 0 20:25:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:34 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 0x10b663a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b669570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24b5895b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b507d30>, '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 0x10b32bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4feb20>, '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.xHtm2Hkmu2/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.dHitFXqK51/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:25:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:25:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHtm2Hkmu2/Render', 20:25:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:34 INFO - 'HOME': '/Users/cltbld', 20:25:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:34 INFO - 'LOGNAME': 'cltbld', 20:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:34 INFO - 'MOZ_NO_REMOTE': '1', 20:25:34 INFO - 'NO_EM_RESTART': '1', 20:25:34 INFO - 'PAGER': '/bin/cat', 20:25:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:34 INFO - 'PWD': '/builds/slave/test', 20:25:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:34 INFO - 'SHELL': '/bin/bash', 20:25:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dHitFXqK51/Listeners', 20:25:34 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 20:25:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:34 INFO - 'USER': 'cltbld', 20:25:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:34 INFO - 'XPC_FLAGS': '0x0', 20:25:34 INFO - 'XPC_SERVICE_NAME': '0', 20:25:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:25:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-4FPIGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:25:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-ww1X07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:25:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-uI8FCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:25:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-8C6C8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:25:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-dtZSPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:25:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-qCWGoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:25:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-NtDIKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:25:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:25:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:25:35 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-4C8Mxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:25:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-RSOluz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:25:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-0bG6Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:25:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-JJJ0Rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:25:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-6zUD8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:25:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-veL834-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:25:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-luZbv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:25:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-ofwmxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:25:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-EcxxlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:25:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:25:36 INFO - Running setup.py (path:/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/pip-tuPEAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:25:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:25:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:39 INFO - Downloading blessings-1.6.tar.gz 20:25:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:25:39 INFO - Installing collected packages: blessings 20:25:39 INFO - Running setup.py install for blessings 20:25:39 INFO - Successfully installed blessings 20:25:39 INFO - Cleaning up... 20:25:39 INFO - Return code: 0 20:25:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:25:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:25:40 INFO - Reading from file tmpfile_stdout 20:25:40 INFO - Current package versions: 20:25:40 INFO - blessings == 1.6 20:25:40 INFO - blobuploader == 1.2.4 20:25:40 INFO - docopt == 0.6.1 20:25:40 INFO - manifestparser == 1.1 20:25:40 INFO - mozInstall == 1.12 20:25:40 INFO - mozcrash == 0.17 20:25:40 INFO - mozdebug == 0.1 20:25:40 INFO - mozdevice == 0.48 20:25:40 INFO - mozfile == 1.2 20:25:40 INFO - mozhttpd == 0.7 20:25:40 INFO - mozinfo == 0.9 20:25:40 INFO - mozleak == 0.1 20:25:40 INFO - mozlog == 3.2 20:25:40 INFO - moznetwork == 0.27 20:25:40 INFO - mozprocess == 0.22 20:25:40 INFO - mozprofile == 0.28 20:25:40 INFO - mozrunner == 6.11 20:25:40 INFO - mozscreenshot == 0.1 20:25:40 INFO - mozsystemmonitor == 0.3 20:25:40 INFO - moztest == 0.7 20:25:40 INFO - mozversion == 1.4 20:25:40 INFO - psutil == 3.1.1 20:25:40 INFO - requests == 1.2.3 20:25:40 INFO - wsgiref == 0.1.2 20:25:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:40 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 0x10b663a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b669570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24b5895b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b507d30>, '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 0x10b32bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4feb20>, '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.xHtm2Hkmu2/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.dHitFXqK51/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:25:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHtm2Hkmu2/Render', 20:25:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:40 INFO - 'HOME': '/Users/cltbld', 20:25:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:40 INFO - 'LOGNAME': 'cltbld', 20:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:40 INFO - 'MOZ_NO_REMOTE': '1', 20:25:40 INFO - 'NO_EM_RESTART': '1', 20:25:40 INFO - 'PAGER': '/bin/cat', 20:25:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:40 INFO - 'PWD': '/builds/slave/test', 20:25:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:40 INFO - 'SHELL': '/bin/bash', 20:25:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dHitFXqK51/Listeners', 20:25:40 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 20:25:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:40 INFO - 'USER': 'cltbld', 20:25:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:40 INFO - 'XPC_FLAGS': '0x0', 20:25:40 INFO - 'XPC_SERVICE_NAME': '0', 20:25:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:25:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:25:40 INFO - Cleaning up... 20:25:40 INFO - Return code: 0 20:25:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:40 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 0x10b663a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b669570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24b5895b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b507d30>, '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 0x10b32bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4feb20>, '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.xHtm2Hkmu2/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.dHitFXqK51/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:25:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:25:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:25:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHtm2Hkmu2/Render', 20:25:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:40 INFO - 'HOME': '/Users/cltbld', 20:25:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:40 INFO - 'LOGNAME': 'cltbld', 20:25:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:40 INFO - 'MOZ_NO_REMOTE': '1', 20:25:40 INFO - 'NO_EM_RESTART': '1', 20:25:40 INFO - 'PAGER': '/bin/cat', 20:25:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:40 INFO - 'PWD': '/builds/slave/test', 20:25:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:40 INFO - 'SHELL': '/bin/bash', 20:25:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dHitFXqK51/Listeners', 20:25:40 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 20:25:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:40 INFO - 'USER': 'cltbld', 20:25:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:40 INFO - 'XPC_FLAGS': '0x0', 20:25:40 INFO - 'XPC_SERVICE_NAME': '0', 20:25:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:40 INFO - Downloading/unpacking jsonschema 20:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:25:43 INFO - Downloading/unpacking functools32 (from jsonschema) 20:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:43 INFO - Downloading functools32-3.2.3-2.tar.gz 20:25:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:25:43 INFO - warning: no files found matching '*.txt' 20:25:43 INFO - no previously-included directories found matching 'build' 20:25:43 INFO - no previously-included directories found matching 'dist' 20:25:43 INFO - no previously-included directories found matching '.git*' 20:25:43 INFO - Installing collected packages: jsonschema, functools32 20:25:43 INFO - Running setup.py install for functools32 20:25:43 INFO - warning: no files found matching '*.txt' 20:25:43 INFO - no previously-included directories found matching 'build' 20:25:43 INFO - no previously-included directories found matching 'dist' 20:25:43 INFO - no previously-included directories found matching '.git*' 20:25:43 INFO - Successfully installed jsonschema functools32 20:25:43 INFO - Cleaning up... 20:25:43 INFO - Return code: 0 20:25:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:25:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b663a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b669570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd24b5895b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b507d30>, '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 0x10b32bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4feb20>, '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.xHtm2Hkmu2/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.dHitFXqK51/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 20:25:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:25:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:25:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHtm2Hkmu2/Render', 20:25:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:43 INFO - 'HOME': '/Users/cltbld', 20:25:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:43 INFO - 'LOGNAME': 'cltbld', 20:25:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:43 INFO - 'MOZ_NO_REMOTE': '1', 20:25:43 INFO - 'NO_EM_RESTART': '1', 20:25:43 INFO - 'PAGER': '/bin/cat', 20:25:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:43 INFO - 'PWD': '/builds/slave/test', 20:25:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:43 INFO - 'SHELL': '/bin/bash', 20:25:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dHitFXqK51/Listeners', 20:25:43 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 20:25:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:43 INFO - 'USER': 'cltbld', 20:25:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:43 INFO - 'XPC_FLAGS': '0x0', 20:25:43 INFO - 'XPC_SERVICE_NAME': '0', 20:25:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:44 INFO - Downloading/unpacking flake8 20:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:25:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:25:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:25:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:25:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:25:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:25:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:25:47 INFO - no previously-included directories found matching 'docs/_build' 20:25:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:25:47 INFO - Running setup.py install for pep8 20:25:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:25:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:25:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:25:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:25:47 INFO - no previously-included directories found matching 'docs/_build' 20:25:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:25:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:25:48 INFO - Cleaning up... 20:25:48 INFO - Return code: 0 20:25:48 INFO - Running post-action listener: _resource_record_post_action 20:25:48 INFO - Running post-action listener: _start_resource_monitoring 20:25:48 INFO - Starting resource monitoring. 20:25:48 INFO - ##### 20:25:48 INFO - ##### Finished create-virtualenv step (success) 20:25:48 INFO - ##### 20:25:48 INFO - ##### 20:25:48 INFO - ##### Running install step. 20:25:48 INFO - ##### 20:25:48 INFO - Running pre-action listener: _resource_record_pre_action 20:25:48 INFO - Running main action method: install 20:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:25:48 INFO - Reading from file tmpfile_stdout 20:25:48 INFO - Detecting whether we're running mozinstall >=1.0... 20:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:25:48 INFO - Reading from file tmpfile_stdout 20:25:48 INFO - Output received: 20:25:48 INFO - Usage: mozinstall [options] installer 20:25:48 INFO - Options: 20:25:48 INFO - -h, --help show this help message and exit 20:25:48 INFO - -d DEST, --destination=DEST 20:25:48 INFO - Directory to install application into. [default: 20:25:48 INFO - "/builds/slave/test"] 20:25:48 INFO - --app=APP Application being installed. [default: firefox] 20:25:48 INFO - mkdir: /builds/slave/test/build/application 20:25:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:25:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:26:21 INFO - Reading from file tmpfile_stdout 20:26:21 INFO - Output received: 20:26:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:26:21 INFO - Running post-action listener: _resource_record_post_action 20:26:21 INFO - ##### 20:26:21 INFO - ##### Finished install step (success) 20:26:21 INFO - ##### 20:26:21 INFO - ##### 20:26:21 INFO - ##### Running run-tests step. 20:26:21 INFO - ##### 20:26:21 INFO - Running pre-action listener: _resource_record_pre_action 20:26:21 INFO - Running main action method: run_tests 20:26:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:26:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:26:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:26:21 INFO - 2016-05-19 20:26:21.988 screenresolution[1636:7656] starting screenresolution argv=screenresolution get 20:26:21 INFO - 2016-05-19 20:26:21.990 screenresolution[1636:7656] Display 0: 1600x1200x32@60 20:26:21 INFO - 2016-05-19 20:26:21.996 screenresolution[1637:7658] starting screenresolution argv=screenresolution list 20:26:21 INFO - Available Modes on Display 0 20:26:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:26:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:26:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:26:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:26:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:26:22 INFO - Intel Iris: 20:26:22 INFO - Chipset Model: Intel Iris 20:26:22 INFO - Type: GPU 20:26:22 INFO - Bus: Built-In 20:26:22 INFO - VRAM (Dynamic, Max): 1536 MB 20:26:22 INFO - Vendor: Intel (0x8086) 20:26:22 INFO - Device ID: 0x0a2e 20:26:22 INFO - Revision ID: 0x0009 20:26:22 INFO - Displays: 20:26:22 INFO - Display: 20:26:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:26:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:26:22 INFO - Display Serial Number: 1600x1200 60 20:26:22 INFO - Main Display: Yes 20:26:22 INFO - Mirror: Off 20:26:22 INFO - Online: Yes 20:26:22 INFO - Rotation: Supported 20:26:22 INFO - Return code: 0 20:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:26:22 INFO - Python 2.7.3 20:26:22 INFO - Return code: 0 20:26:22 INFO - grabbing minidump binary from tooltool 20:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:26:22 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 0x10b507d30>, '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 0x10b32bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4feb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:26:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:26:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 20:26:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:26:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:26:22 INFO - Return code: 0 20:26:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:26:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:26:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:26:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:26:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:26:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:26:23 INFO - Return code: 0 20:26:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:26:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0025 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:26:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xHtm2Hkmu2/Render', 20:26:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:26:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:26:23 INFO - 'HOME': '/Users/cltbld', 20:26:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:26:23 INFO - 'LOGNAME': 'cltbld', 20:26:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:26:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:26:23 INFO - 'MOZ_NO_REMOTE': '1', 20:26:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:26:23 INFO - 'NO_EM_RESTART': '1', 20:26:23 INFO - 'PAGER': '/bin/cat', 20:26:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:26:23 INFO - 'PWD': '/builds/slave/test', 20:26:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:26:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:26:23 INFO - 'SHELL': '/bin/bash', 20:26:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dHitFXqK51/Listeners', 20:26:23 INFO - 'TMPDIR': '/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/', 20:26:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:26:23 INFO - 'USER': 'cltbld', 20:26:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:26:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:26:23 INFO - 'XPC_FLAGS': '0x0', 20:26:23 INFO - 'XPC_SERVICE_NAME': '0', 20:26:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:26:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0025', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:26:23 INFO - mozversion application_buildid: 20160519184214 20:26:23 INFO - mozversion application_changeset: 466d5c96f43964d4122959e5ab19131237bdc6fa 20:26:23 INFO - mozversion application_display_name: Nightly 20:26:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:26:23 INFO - mozversion application_name: Firefox 20:26:23 INFO - mozversion application_remotingname: firefox 20:26:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:26:23 INFO - mozversion application_vendor: Mozilla 20:26:23 INFO - mozversion application_version: 49.0a1 20:26:23 INFO - mozversion platform_buildid: 20160519184214 20:26:23 INFO - mozversion platform_changeset: 466d5c96f43964d4122959e5ab19131237bdc6fa 20:26:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:26:23 INFO - mozversion platform_version: 49.0a1 20:26:23 INFO - using testdate: 1463714783 20:26:23 INFO - actual date: 1463714783 20:26:23 INFO - starting webserver on 'localhost:49276' 20:26:23 INFO - SUITE-START | Running 2 tests 20:26:23 INFO - TEST-START | dromaeo_css 20:26:23 INFO - operating with platform_type : mac_ 20:26:23 INFO - Initialising browser for dromaeo_css test... 20:26:23 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpqFn6mY/profile http://localhost:49276/getInfo.html) 20:26:26 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 20:26:26 INFO - PROCESS | 1655 | colorDepth:24 20:26:26 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 20:26:26 INFO - PROCESS | 1655 | __metrics 20:26:26 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:26:27 INFO - TEST-INFO | 1655: exit 0 20:26:27 INFO - Browser initialized. 20:26:27 INFO - Running cycle 1/1 for dromaeo_css test... 20:26:27 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpqFn6mY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:26:39 INFO - PROCESS | 1658 | RSS: Main: 249823232 20:26:39 INFO - PROCESS | 1658 | 20:27:28 INFO - PROCESS | 1658 | 1463714848950 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:29:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 20:29:41 INFO - PROCESS | 1658 | RSS: Main: 260902912 20:29:41 INFO - PROCESS | 1658 | 20:32:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 20:32:44 INFO - PROCESS | 1658 | RSS: Main: 273256448 20:32:44 INFO - PROCESS | 1658 | 20:35:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 20:35:47 INFO - PROCESS | 1658 | RSS: Main: 275685376 20:35:47 INFO - PROCESS | 1658 | 20:38:49 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 20:38:49 INFO - PROCESS | 1658 | RSS: Main: 277012480 20:38:49 INFO - PROCESS | 1658 | 20:41:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 20:41:52 INFO - PROCESS | 1658 | RSS: Main: 279871488 20:41:52 INFO - PROCESS | 1658 | 20:44:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 20:44:55 INFO - PROCESS | 1658 | RSS: Main: 281042944 20:44:55 INFO - PROCESS | 1658 | 20:44:55 INFO - PROCESS | 1658 | __start_tp_report 20:44:55 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 20:44:55 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 20:44:55 INFO - PROCESS | 1658 | |i|pagename|runs| 20:44:55 INFO - PROCESS | 1658 | |0;dojo.html;3521.066917266924;3530.858765649374;3545.7517973741833;3573.624769399213;3580.907823113951;5850.853728656785;5884.941150588498;5917.757270973096;5996.220491336131;6075.270967483897;5760.7695692172265;5880.882382352351;5881.117832325153;5919.319278282998;5994.820155395345;5235.240890070937;5285.2600635911;5356.38401583819;5384.326959130109;5426.538744206747;414.2003469508511;4283.464566929134;5354.5716342692685;5368.194770784375;5407.864803379927;5291.841244762663;5295.761690723907;5303.416624171357;5331.946680533222;5350.5452036576935;5246.029484545371;5357.8392648220615;5385.676859388449;5405.297311349499;5490.752916118784;5220.530152286313;5244.003639308519;5250.947490525123;5276.287701160332;5276.3140791697215;4972.975135124301;5218.321618189649;5785.971070144665;5892.116182572606;5910.586258961875;6238.781642642532;6270.31026587075;6286.119943207955;6302.621842689453;6355.968220158916;6325.9051114233325;6400.135981642466;6412.5190610704385;6415.390537898892;6426.935730642727;6082.847928801771;6107.083937409379;6125.540584456184;6128.958077126899;6134.96932515339;6257.812265632038;6319.24169099711;6356.332585078592;6382.648954307465;6520.804375868732;6291.087792270096;6293.811185664437;6310.305866354697;6323.30443651198;6333.904991425133;6327.367263273728;6352.809415717536;6360.204974378203;6377.266614339411;6383.265924418752;6167.444929956326;6260.686965651699;6265.373462653698;6306.779262725782;6350.174477317919;5423.18652202165;6031.8539477499135;6200.193974783249;6201.96899015502;6214.751409943642;5018.422881368616;5070.264811602297;5079.8984020319385;5080;5081.673316720632;4475.507694153641;4481.305397663367;4484.596386325246;4553.658475614342;4563.0873825235085;5822.854428639233;5961.552883533753;5993.880122397528;6012.278526576839;6019.668918209453;6224.937750622526;6348.047792831112;6386.680665966683;6387.680615969183;6400.967995159995;5975.641461512323;6017.06735456005;6026.126211699279;6038.607490513103;6068.362821903636;4944.975275123601;5470.933168032275;5545.473180047889;5554.416786237468;5554.50009499147;6273.560850740404;6359.4276515112015;6565.310642382481;6606.603603783885;6619.834504137435;6209.59637623553;6252.249730032243;6321.715522801393;6326.4622507087415;6340.1440805490665;6385.106085148176;6424.453921416732;6426.710798014007;6427.260865000398;6447.9355206447335;6107.206063211754;6143.696113957266;6157.076438534255;6175.320714721467;6198.597091189058;6291.213598300213;6311.147995020613;6314.052892066226;6327.430531252209;6346.7143978522;5280.7359632019015;5573.665580065047;6157.784477543264;6167.938320616737;6198.349173336915;6047.425494578008;6070.332263450929;6101.481374083252;6115.755369785159;6151.938480615316;5994.970025149846;6079.209702738615;6108.888502348341;6143.815685529441;6148.16999705052;6236.327650265475;6274.058891166179;6282.937170628235;6294.433500984934;6313.021481670165;5944.613600115978;6027.698615069141;6063.878722425615;6076.756929722762;6109.969450152721 20:44:55 INFO - PROCESS | 1658 | |1;ext.html;500.74962518740654;523.4503771040407;535.0289225056523;549.7636016512901;566.0942492012782;39243.21513569727;42050.78974605127;42053.78973105138;42094.579054209484;42196.36705449421;43226.487072952455;43614.127717445714;43793.343099853526;43906.56093439065;43980.560194398044;9490.335676502647;9582.329236953416;9692.75768105796;9724.56239469222;9726.708198754013;9560.856587151198;9561.80876382472;9569.856452153188;9577.329586928918;9700.611975520971;9644.324897257195;9660.951695241514;9706.272029597772;9728.75678108046;9738.367006144614;9618.470984095942;9631.181349585258;9665.951670241639;9695.70912872615;9711;9578.377405468693;9657.71026869195;9671.226301895831;9678.419294842262;9687.225021998223;39582;39612.60387396118;39633.40549891754;39640.60359396398;40073.39889901654;3189.266468712186;3205.1506350817053;3328.1014126186037;3422.9144271393166;3511.7015053720465;27923;29411.41177176466;29531.966381176557;29538.70461295381;30733.231669208224;2738.4523095380805;2748.7938404619536;2802.6776920654183;2824.887004519817;2876.2953076496183;457578;458279;460109;464616;466868;34645.826770865984;35442.82278588642;35574;61534.69232653898;61851;35254.64745352565;35701.46447803285;35791.4631280531;36258.63741362606;36273.455898161024;14429.422823087169;14628.780568291484;14848.851511484963;14976.326065327086;15014.849851501564;12272;12491;12644.747105057848;12647.367631618383;12658.303793291274;7672;7893.447458677952;7942.324902383362;7952.324052455606;7993.840123197503;3345.9498107528407;3356.3455126250633;3363.8486268117995;3367.1413789484013;3403.3533628610485;879.4195830751673;988.5551501824208;1074.6453670288786;1075.7687097273968;1089.934603923767;27708;28238.576421353697;29441.263968400963;29598.852005740264;30417.543736843963;1050.5902697947806;1067.8932106789414;1088.7985722641338;1107.6067995861515;1111.56093343129;15612.063276203464;16033.438829640907;16214.027158370536;16377;16650.417235396704;679369;688760;691848;696502;697062;61817.07274390888;62141.06788398178;62592;62821.37178628246;62856.74286514244;1382.523029554802;1406.3601061516986;1453.3387308774481;1454.8690617844234;1455.0614853419486;29614.703852962055;29647.110586682433;29710.257243569085;30147.849260753555;30463.390732184787;51880;52450.737746311024;52518.47481525136;53254.73372633112;53503.73248133734;628649;635422;639818;643220;643791;25347.493050138524;25895;25942.962281509284;26144.60783088293;26235.868820655774;44018.779906100266;45232.32151517796;45887.311690324;45915;46389.072218554764;33306.833465833486;36844.26311473702;38830.223395531364;39036.80481597574;39155.60844391634;30972.451377431487;37211;37609.059773505884;37905.05237369088;39026.804865975486;29203.41593168082;37330.44004339991;37943.62056379511;38160.618393815705;39395.40906886457;31869.8845540405;33800.323993520484;34015.70581869744;34365.828170858986;34431.65568344285;25030.62454063227;25089;25196.87401563054;25487.853046613316;25578.360540986625 20:44:55 INFO - PROCESS | 1658 | |2;jquery.html;385.7762497751306;387.8429236159355;389.91032062625595;391.1472988884235;412.4411422522482;16019.519414417586;19818.306359277427;20447.488812779688;21084.05121769522;21094.367168984936;20153.496162595944;20156.798432015676;20621;21091.2618058368;21102.944852757377;5718.42815718429;5867.735951882176;5892.2929248490245;5911.73397197125;5933;5022.522860328281;5424.810131645393;5803.810218905114;6045.7883974060915;6085.0263957766765;5585.329760428734;5845.970770146143;5852.122181672762;5858.8242352729485;5862.384449632791;6394.168758061469;6494.253160886511;6581.2760596334365;6592.439642630334;6593.472522198213;5475.698836564027;5771.884562308773;5776.97111514444;5795.594308398414;5800.187973683687;13092.410841512155;13186.274754888478;13321.000924930571;13463.057585968985;13492.460301587924;2089.1643342662906;2152.4726442021647;2204.8015678588845;2261.479859632294;2271.8523295985706;9755.36590121647;9894.406335619886;9925.90074099257;10134.949325253327;10162.9491852541;1709.8204688507776;1719.8108208097099;1745.467632372126;1777.79555351135;1785.0628420079433;122679;124933;126706.99999999908;127084;127797;11114.499847506882;11304.604338848265;11492.367919764327;11624.88375116255;11722.765544689059;12807.359632018362;13518.25649589282;14006.929965350108;14687;14745;8199.344052475788;8330.958345208235;8374.371922105867;8468.872966905501;8632.266257368194;8312.709055183039;8551.444156129832;8569.871451928226;8608.698695545625;8612.48325100496;3561.893143205708;4357.215701173819;4436.711613745097;4576.977115114403;4622.537746225351;1903.4670292318174;1969.1631056800802;1978.871373360727;1981.51452894039;1981.5541503161674;883.9436872936778;895.785011597212;944.8724422203052;974.8635191073114;984.3257368702461;16629.6674066518;18775.530611734815;19111.90444047771;19678.70481942772;19999;902.8961669408102;962.3504134709043;963.7831487915163;983.5918093990914;1051.9474026298653;10123.44692581194;10405.115565177044;10416.375017498975;10418.947905260426;10506.842397364046;560479.1856244238;626911;628750;640341;642030;88545;113322;149032.25483872512;151917;154386;1014.6753039027587;1023.6621914768109;1048.564845589072;1099.1591432554103;1100.9724756880983;17528.298868045644;17776.022318772593;17791.110444477465;17969.460916172535;18079.909600451912;44042;46737.83155421005;52239.95520089501;53014.734926326666;53639.46360536501;78811.60594197222;80586.38827223306;80757;82674.58662706648;86376;5105.642605017613;5677.943220567907;7322.560646361236;7432.851342973002;7978.840423191387;11692.532298707956;12478.750424991631;12658.746825063632;12707.618771436872;12946.870531294944;9405;10635.680929572125;10723.142148628247;10956.068734157367;10996.90030996894;10406.323588966692;10635.14918806478;10885.510152043336;11023;11036.834447483454;9155.397805384164;11121.221514493907;11122.777544449227;11172.776544469227;11187.608433704781;6584.617230381674;7300.16048154469;7396.55620662762;7424.183339832722;7453.142888567884;10698.197635177237;10943;10982.830957836253;11117.444127793417;11228.157888158257 20:44:55 INFO - PROCESS | 1658 | |3;mootools.html;1451.9128852268861;1581.57297529667;1816.1101060480369;1924.4996300961755;1950.8536859735523;8002.919970800291;8577.571121443927;8581.39930204886;9054.909450905498;9061.411008284456;8638.352123590725;8742.082081381459;8860.158284962934;8877.467351958887;8882.733517994455;2371.1700904683353;2377.239283429303;2380.7619238076227;2418.383312255381;2420.1287536486852;2344.742078371378;2373.6083546214854;2379.7501262367377;2395.2574701842486;2396.95206095878;2351.576716191085;2402.1712509184304;2404.350825277174;2406.831521793475;2421.8546887186735;2366.5503554324796;2372.50177462733;2389.354874183969;2390.043982407042;2395.197608801054;2004.629143608437;2270.625346817773;2296.0471404367167;2296.3799774061076;2336.6027775278244;8727.563621818947;8736.3447741419;8776.341774366949;8893.421927574687;8896.733098007071;5253.842384728464;5372.811951581715;5434.157705555645;5436.3476382833915;5521.723913804293;3519.4896739972814;3528.012156596157;3539.07983924179;3603.9459408108637;3608.440691692792;916.1617120334886;1024.3956065921143;1029.176658673066;1033.219918961187;1034.534459493231;11634.70913227176;11712.941435292854;11747;11762.529498820037;11778.823317650242;4670.53294670537;4736.73947932867;4791.185498465269;4841.975790121027;4850.854474365775;9800.26498012652;9941.453220072965;9942.453165075991;9955.701328960144;9974.002599739968;5312.415634280226;5325.3609566851455;5373;5411.323584551931;5412.458754124635;4163.604457576525;4403.9779801100785;4575.0392417592675;4931.161702510582;4948.727819969864;3706.499622550975;3973.5430425501436;4028.1540876415693;4099.651529620016;4102.077032667686;1118.3392661897076;1304.1718508746824;1314.9802752958522;1316.967075823093;1322.8677132286693;805.79049447143;819.9631016604267;873.9606717697719;913.4701872913694;981.6711401680517;4857.757112144379;5746.626469279484;5933.614315069507;6074.936886044925;6212.0371342441995;931.9580618872167;990.2424645146468;993.60752502761;999.3903718731568;999.8200323941614;3756.6431189037;3970.1861118470642;4059.6752259819145;4093.529244136903;4097.651699605567;9156.404833685923;10498.42258675765;10942.562297508011;10942.960418760205;10986.285891417032;10590.364578125336;10625.787484250272;10899.673009809718;10900.890991090146;10912.345259284468;8209.79475513105;8253.669853205925;8323.625436855356;8435.451695639886;8436.831263374821;4490.416245888014;5588.077967135378;5834.124881267844;5889.469947704727;5972.044472884491;9912.851307230254;9917.752056198653;9920.652777152765;10129.290949633749;10156.746081348025;9945.602175913173;10103.797924041331;10300.639477618248;10542.209334300112;10621.256512044083;6522.641254731036;6878.243393226641;7091.6099614519635;7117.074780278531;7291.562506249642;8418.579071046546;8431;8465.98408191021;8503.277221436;8532.573371331533;7395.778126656209;7558.13081495613;7603.429742769204;7627.351675107678;7676.577788221478;7292.052033235857;7314.780556583311;7367.594782287026;7425.665845036879;7447.404207663482;6920.204176519765;6932;6978;7035.894461583182;7061.152661680631;4787.8563643090765;4835.178019736582;4926.187179115406;5031.396232452129;5137.948620513747;4985.626078044089;5043.218301163325;5056.873578160576;5089.592832573459;5288.9471105289995 20:44:55 INFO - PROCESS | 1658 | |4;prototype.html;299.60003395467066;311.3554941271568;315.5314358178105;317.1263169966741;320.7482126530674;4951.801927922887;5125.205593133061;5208.00539689678;5379.488948549892;5511;4768.403949506312;5423.349198096224;5480.150576660614;5532.3914369419335;5569.053260945639;3840.98213973298;3847.826847791856;4149.170165966819;4174.916501669964;4182.6235638792505;3532.4566312255265;3576.159602493412;3582.982085089571;3851.7852234964867;4119.917601647965;3282.3271229397915;3882.650561449469;3985.02366920105;4094.2016306820183;4098.754074755524;3165.2432899740866;4109.445224894645;4137.834486620532;4142.606452387018;4156.210320039183;3277.6886195811358;3548.254866478043;3565.1265439967115;3586.4799604057266;3596.892093237207;4946.8763280918265;5205.074122574634;5222.947770522284;5236.371635403776;5270.92093618596;3875.418687196915;4217.072244106292;4423.1153769246275;4732.408448943882;4773.689710168828;5237.769124255797;5691.946989806899;5777.508911742507;5780.7687692492245;5870.97064514679;3495.370833250014;3733.7386382953205;3902.551206611248;3926.0577461409057;3934.2524920265346;5504.559635229172;6088.6042407243385;6127.713180232112;6131.233595800525;6154.446099851035;3925.8429662813737;3957.821898014539;3965.8810235692977;3966.6231707988272;3994.0414300568236;3539.5398598182073;3892;4003.7197396181987;4023.3160362738404;4030.355143177136;4123.525794533667;4310.202612516695;4694.835680751157;4710;4741.881452963704;5120.618912205842;5823.679697616587;5844;5863.120531920246;5919.585629005928;1239.7768401687783;1355.8169647097714;1364.467857535562;1366.3168415792104;1369.821923149984;811.3022800391658;818.3126174013858;832.8042909916165;842.7471758472557;846.7883029242689;4176.644985176234;4297.505786834491;4507.414036175276;4559.224931761609;4589.862304130815;4219.767912764827;4652.511486293958;4986.301917731521;5034.697918124851;5061.924071138936;4382.342648602735;4516.486976862788;4544.840930567414;4548.6361091113295;4567.602008945264;2106.104905415192;2190.452386903274;2474.6614449345557;2572.382628169263;2618.947621047568;4068.5117785865295;4585.633149348044;4602.907941841211;5241.479970808423;5357.946420535823;4382.912341753147;4641.373414589055;5128.282040514331;5129.307543481582;5174.741262936838;5595.398139864982;6291.842703932438;6309.589876658002;6310.340002798366;6342.5243106767175;5752.6836024019085;6009.579329446897;6055.364186760503;6092.268927728701;6126.724297406538;5822.621529600562;5888.823335299948;5995.850103747442;6055.303640081447;6164.907526387197;5673.659580425187;6170.575330691509;6253.312135664983;6303.306636269915;6320.399562041599;3929.58739332366;3958.267720471722;3966.900827479336;3976.6421022108148;3982.761034337949;5710.257666503494;5792.53659707214;6052.455279024909;6102.941543873275;6140.17107690456;4922.8769280768265;5322.520973112283;5558.3607885092115;5789.3921138279875;5823.7379317929945;4864.513548645107;5320.813771517978;5345.625806193529;5748.712564371848;5847.26909136358;5359.651622644516;5667.4332566743;5688.516476099578;5694.886102278014;5734.885302294014;5239.135542635422;5617;5746.626469279484;5759.766571569977;5784.971075144597;4985.6510044298;5617.297837770278;5683.75491680792;5687.77248910039;5694.402087780889 20:44:55 INFO - PROCESS | 1658 | |5;yui.html;632.6172665537349;633.4900405173839;673.4410439335355;723.5586292361659;747.3162056718103;14705.926470367633;15056.548303550897;15212.391504339826;15247.16140612266;15507.45723899665;14255.073420227704;14347.995640305182;14365.209913454755;14365.425382984695;14378.281085945688;717.9425645948312;886.813769108488;899.703097977669;923.1875949164726;924.3344791749929;922.2529750901757;925.2782829393084;931.4318265857821;931.6739141300559;933.2114363362947;837.924586787189;956.8756061711968;974.5565767575736;977.3354119198942;978.061061381075;949.6533765175661;964.763632909938;965.7006328038295;966.0243154414057;966.6954909203579;709.1773542690454;716.323074694414;717.2755516927888;717.6878058044767;720.8990741296222;13527;13734.313284335743;14923.776143357858;14992.175430351326;15135;12539.498420063186;12621.242725436503;12663.11358204926;12694.492220311176;12878.613641590768;7253.637318134125;9735.17251033663;10029.29794914349;10036.197104231644;10084.344517606332;3336.9165770855925;3392.6437724039115;3410.9658903410896;3415.9316813663836;3417.8974630761118;66016;85574.57212713896;87372;87720;88883.55558222233;9454.33819632619;9459.337846350827;9462.858057129148;9523.952380238054;9704.02959704024;22126.88936555307;22834.42913927165;23160.3051908443;23162.3051308461;23214.41963950881;7363.153237377663;7389.113306403266;7405.7778266652085;7663.060833466377;7819.68721251155;3911.1395492991496;3930.567637559866;3936;3952.2293152834923;3954.3870700040966;3597.5503062117236;3602.6217247189193;3649.361361761681;3651.634836516327;3716.0709822544363;636.2937139774846;649.8115546491465;656.924453687832;667.112730156372;690.8169335126196;557.2115456628906;586.8562202260473;593.4658807073582;601.2214182633413;610.5848023344168;7849.215078492105;8083.636236369378;8229.46508476947;8278.716798896181;8280.378971577156;566.2723400430427;571.3686376553932;575.7035126909645;609.1106983803608;631.1479502671449;3217.935641287161;3866.8399480156404;3909.237698648736;3914.3345631242755;3919.980400097981;81226.37547249022;94419.52790236005;102709.45935810969;103841;104266;71247;87559;89434;90272.54863725639;90343;63552.36447635557;81475.18524814794;82289;82736.75894861582;83847.5807620958;7504.549727016397;7671.156172821097;7687.961560192163;7713.267239612228;7861.8034549134445;47847.76076119597;48543;49391.25913111378;49646.50353496419;50016.74958126076;60835.47911302253;66790;70388;71328;71611.56776864329;10166;10243.282970192313;10280.383177009404;10319.574565735888;10423;10734.570617175226;11111;11522.366269855238;11524.308541487537;11822.704432389259;8564.871526926976;10381.480925953521;10749.193810464403;10753.516091775733;10834.512446939749;10134.746631334276;10516;10588.947055264982;10612.734681633021;10672.519736611715;9976.700698979042;10520;10525.526351314056;10538;10546.683599492027;8729.65081396737;8763.649454021768;8787.692430765148;9055.818883622422;9287.62849486013;7615.238476152341;8796.956015219883;8875.423097498642;8882.600282987152;8980.820383592421 20:44:55 INFO - PROCESS | 1658 | __end_tp_report 20:44:55 INFO - PROCESS | 1658 | __start_cc_report 20:44:55 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,426 20:44:55 INFO - PROCESS | 1658 | __end_cc_report 20:44:55 INFO - PROCESS | 1658 | __startTimestamp1463715895902__endTimestamp 20:44:55 INFO - PROCESS | 1658 | 20:44:55 INFO - PROCESS | 1658 | ------- Summary: start ------- 20:44:55 INFO - PROCESS | 1658 | Number of tests: 6 20:44:55 INFO - PROCESS | 1658 | 20:44:55 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5815.33 Median:6082.85 stddev:771.26 (12.7%) stddev-sans-first:752.34 20:44:55 INFO - PROCESS | 1658 | Values: 3521.1 3530.9 3545.8 3573.6 3580.9 5850.9 5884.9 5917.8 5996.2 6075.3 5760.8 5880.9 5881.1 5919.3 5994.8 5235.2 5285.3 5356.4 5384.3 5426.5 414.2 4283.5 5354.6 5368.2 5407.9 5291.8 5295.8 5303.4 5331.9 5350.5 5246.0 5357.8 5385.7 5405.3 5490.8 5220.5 5244.0 5250.9 5276.3 5276.3 4973.0 5218.3 5786.0 5892.1 5910.6 6238.8 6270.3 6286.1 6302.6 6356.0 6325.9 6400.1 6412.5 6415.4 6426.9 6082.8 6107.1 6125.5 6129.0 6135.0 6257.8 6319.2 6356.3 6382.6 6520.8 6291.1 6293.8 6310.3 6323.3 6333.9 6327.4 6352.8 6360.2 6377.3 6383.3 6167.4 6260.7 6265.4 6306.8 6350.2 5423.2 6031.9 6200.2 6202.0 6214.8 5018.4 5070.3 5079.9 5080.0 5081.7 4475.5 4481.3 4484.6 4553.7 4563.1 5822.9 5961.6 5993.9 6012.3 6019.7 6224.9 6348.0 6386.7 6387.7 6401.0 5975.6 6017.1 6026.1 6038.6 6068.4 4945.0 5470.9 5545.5 5554.4 5554.5 6273.6 6359.4 6565.3 6606.6 6619.8 6209.6 6252.2 6321.7 6326.5 6340.1 6385.1 6424.5 6426.7 6427.3 6447.9 6107.2 6143.7 6157.1 6175.3 6198.6 6291.2 6311.1 6314.1 6327.4 6346.7 5280.7 5573.7 6157.8 6167.9 6198.3 6047.4 6070.3 6101.5 6115.8 6151.9 5995.0 6079.2 6108.9 6143.8 6148.2 6236.3 6274.1 6282.9 6294.4 6313.0 5944.6 6027.7 6063.9 6076.8 6110.0 20:44:55 INFO - PROCESS | 1658 | 20:44:55 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:70959.72 Median:38495.42 stddev:162384.50 (421.8%) stddev-sans-first:162753.86 20:44:55 INFO - PROCESS | 1658 | Values: 500.7 523.5 535.0 549.8 566.1 39243.2 42050.8 42053.8 42094.6 42196.4 43226.5 43614.1 43793.3 43906.6 43980.6 9490.3 9582.3 9692.8 9724.6 9726.7 9560.9 9561.8 9569.9 9577.3 9700.6 9644.3 9661.0 9706.3 9728.8 9738.4 9618.5 9631.2 9666.0 9695.7 9711.0 9578.4 9657.7 9671.2 9678.4 9687.2 39582.0 39612.6 39633.4 39640.6 40073.4 3189.3 3205.2 3328.1 3422.9 3511.7 27923.0 29411.4 29532.0 29538.7 30733.2 2738.5 2748.8 2802.7 2824.9 2876.3 457578.0 458279.0 460109.0 464616.0 466868.0 34645.8 35442.8 35574.0 61534.7 61851.0 35254.6 35701.5 35791.5 36258.6 36273.5 14429.4 14628.8 14848.9 14976.3 15014.8 12272.0 12491.0 12644.7 12647.4 12658.3 7672.0 7893.4 7942.3 7952.3 7993.8 3345.9 3356.3 3363.8 3367.1 3403.4 879.4 988.6 1074.6 1075.8 1089.9 27708.0 28238.6 29441.3 29598.9 30417.5 1050.6 1067.9 1088.8 1107.6 1111.6 15612.1 16033.4 16214.0 16377.0 16650.4 679369.0 688760.0 691848.0 696502.0 697062.0 61817.1 62141.1 62592.0 62821.4 62856.7 1382.5 1406.4 1453.3 1454.9 1455.1 29614.7 29647.1 29710.3 30147.8 30463.4 51880.0 52450.7 52518.5 53254.7 53503.7 628649.0 635422.0 639818.0 643220.0 643791.0 25347.5 25895.0 25943.0 26144.6 26235.9 44018.8 45232.3 45887.3 45915.0 46389.1 33306.8 36844.3 38830.2 39036.8 39155.6 30972.5 37211.0 37609.1 37905.1 39026.8 29203.4 37330.4 37943.6 38160.6 39395.4 31869.9 33800.3 34015.7 34365.8 34431.7 25030.6 25089.0 25196.9 25487.9 25578.4 20:44:55 INFO - PROCESS | 1658 | 20:44:55 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:35400.98 Median:11627.71 stddev:103852.60 (893.1%) stddev-sans-first:104110.65 20:44:55 INFO - PROCESS | 1658 | Values: 385.8 387.8 389.9 391.1 412.4 16019.5 19818.3 20447.5 21084.1 21094.4 20153.5 20156.8 20621.0 21091.3 21102.9 5718.4 5867.7 5892.3 5911.7 5933.0 5022.5 5424.8 5803.8 6045.8 6085.0 5585.3 5846.0 5852.1 5858.8 5862.4 6394.2 6494.3 6581.3 6592.4 6593.5 5475.7 5771.9 5777.0 5795.6 5800.2 13092.4 13186.3 13321.0 13463.1 13492.5 2089.2 2152.5 2204.8 2261.5 2271.9 9755.4 9894.4 9925.9 10134.9 10162.9 1709.8 1719.8 1745.5 1777.8 1785.1 122679.0 124933.0 126707.0 127084.0 127797.0 11114.5 11304.6 11492.4 11624.9 11722.8 12807.4 13518.3 14006.9 14687.0 14745.0 8199.3 8331.0 8374.4 8468.9 8632.3 8312.7 8551.4 8569.9 8608.7 8612.5 3561.9 4357.2 4436.7 4577.0 4622.5 1903.5 1969.2 1978.9 1981.5 1981.6 883.9 895.8 944.9 974.9 984.3 16629.7 18775.5 19111.9 19678.7 19999.0 902.9 962.4 963.8 983.6 1051.9 10123.4 10405.1 10416.4 10418.9 10506.8 560479.2 626911.0 628750.0 640341.0 642030.0 88545.0 113322.0 149032.3 151917.0 154386.0 1014.7 1023.7 1048.6 1099.2 1101.0 17528.3 17776.0 17791.1 17969.5 18079.9 44042.0 46737.8 52240.0 53014.7 53639.5 78811.6 80586.4 80757.0 82674.6 86376.0 5105.6 5677.9 7322.6 7432.9 7978.8 11692.5 12478.8 12658.7 12707.6 12946.9 9405.0 10635.7 10723.1 10956.1 10996.9 10406.3 10635.1 10885.5 11023.0 11036.8 9155.4 11121.2 11122.8 11172.8 11187.6 6584.6 7300.2 7396.6 7424.2 7453.1 10698.2 10943.0 10982.8 11117.4 11228.2 20:44:55 INFO - PROCESS | 1658 | 20:44:55 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5720.90 Median:5037.31 stddev:3209.93 (63.7%) stddev-sans-first:3202.90 20:44:55 INFO - PROCESS | 1658 | Values: 1451.9 1581.6 1816.1 1924.5 1950.9 8002.9 8577.6 8581.4 9054.9 9061.4 8638.4 8742.1 8860.2 8877.5 8882.7 2371.2 2377.2 2380.8 2418.4 2420.1 2344.7 2373.6 2379.8 2395.3 2397.0 2351.6 2402.2 2404.4 2406.8 2421.9 2366.6 2372.5 2389.4 2390.0 2395.2 2004.6 2270.6 2296.0 2296.4 2336.6 8727.6 8736.3 8776.3 8893.4 8896.7 5253.8 5372.8 5434.2 5436.3 5521.7 3519.5 3528.0 3539.1 3603.9 3608.4 916.2 1024.4 1029.2 1033.2 1034.5 11634.7 11712.9 11747.0 11762.5 11778.8 4670.5 4736.7 4791.2 4842.0 4850.9 9800.3 9941.5 9942.5 9955.7 9974.0 5312.4 5325.4 5373.0 5411.3 5412.5 4163.6 4404.0 4575.0 4931.2 4948.7 3706.5 3973.5 4028.2 4099.7 4102.1 1118.3 1304.2 1315.0 1317.0 1322.9 805.8 820.0 874.0 913.5 981.7 4857.8 5746.6 5933.6 6074.9 6212.0 932.0 990.2 993.6 999.4 999.8 3756.6 3970.2 4059.7 4093.5 4097.7 9156.4 10498.4 10942.6 10943.0 10986.3 10590.4 10625.8 10899.7 10900.9 10912.3 8209.8 8253.7 8323.6 8435.5 8436.8 4490.4 5588.1 5834.1 5889.5 5972.0 9912.9 9917.8 9920.7 10129.3 10156.7 9945.6 10103.8 10300.6 10542.2 10621.3 6522.6 6878.2 7091.6 7117.1 7291.6 8418.6 8431.0 8466.0 8503.3 8532.6 7395.8 7558.1 7603.4 7627.4 7676.6 7292.1 7314.8 7367.6 7425.7 7447.4 6920.2 6932.0 6978.0 7035.9 7061.2 4787.9 4835.2 4926.2 5031.4 5137.9 4985.6 5043.2 5056.9 5089.6 5288.9 20:44:55 INFO - PROCESS | 1658 | 20:44:55 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4528.53 Median:4949.34 stddev:1457.11 (29.4%) stddev-sans-first:1426.20 20:44:55 INFO - PROCESS | 1658 | Values: 299.6 311.4 315.5 317.1 320.7 4951.8 5125.2 5208.0 5379.5 5511.0 4768.4 5423.3 5480.2 5532.4 5569.1 3841.0 3847.8 4149.2 4174.9 4182.6 3532.5 3576.2 3583.0 3851.8 4119.9 3282.3 3882.7 3985.0 4094.2 4098.8 3165.2 4109.4 4137.8 4142.6 4156.2 3277.7 3548.3 3565.1 3586.5 3596.9 4946.9 5205.1 5222.9 5236.4 5270.9 3875.4 4217.1 4423.1 4732.4 4773.7 5237.8 5691.9 5777.5 5780.8 5871.0 3495.4 3733.7 3902.6 3926.1 3934.3 5504.6 6088.6 6127.7 6131.2 6154.4 3925.8 3957.8 3965.9 3966.6 3994.0 3539.5 3892.0 4003.7 4023.3 4030.4 4123.5 4310.2 4694.8 4710.0 4741.9 5120.6 5823.7 5844.0 5863.1 5919.6 1239.8 1355.8 1364.5 1366.3 1369.8 811.3 818.3 832.8 842.7 846.8 4176.6 4297.5 4507.4 4559.2 4589.9 4219.8 4652.5 4986.3 5034.7 5061.9 4382.3 4516.5 4544.8 4548.6 4567.6 2106.1 2190.5 2474.7 2572.4 2618.9 4068.5 4585.6 4602.9 5241.5 5357.9 4382.9 4641.4 5128.3 5129.3 5174.7 5595.4 6291.8 6309.6 6310.3 6342.5 5752.7 6009.6 6055.4 6092.3 6126.7 5822.6 5888.8 5995.9 6055.3 6164.9 5673.7 6170.6 6253.3 6303.3 6320.4 3929.6 3958.3 3966.9 3976.6 3982.8 5710.3 5792.5 6052.5 6102.9 6140.2 4922.9 5322.5 5558.4 5789.4 5823.7 4864.5 5320.8 5345.6 5748.7 5847.3 5359.7 5667.4 5688.5 5694.9 5734.9 5239.1 5617.0 5746.6 5759.8 5785.0 4985.7 5617.3 5683.8 5687.8 5694.4 20:44:55 INFO - PROCESS | 1658 | 20:44:55 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:18781.38 Median:633.05 stddev:27485.89 (4341.8%) stddev-sans-first:27529.22 20:44:55 INFO - PROCESS | 1658 | Values: 632.6 633.5 673.4 723.6 747.3 14705.9 15056.5 15212.4 15247.2 15507.5 14255.1 14348.0 14365.2 14365.4 14378.3 717.9 886.8 899.7 923.2 924.3 922.3 925.3 931.4 931.7 933.2 837.9 956.9 974.6 977.3 978.1 949.7 964.8 965.7 966.0 966.7 709.2 716.3 717.3 717.7 720.9 13527.0 13734.3 14923.8 14992.2 15135.0 12539.5 12621.2 12663.1 12694.5 12878.6 7253.6 9735.2 10029.3 10036.2 10084.3 3336.9 3392.6 3411.0 3415.9 3417.9 66016.0 85574.6 87372.0 87720.0 88883.6 9454.3 9459.3 9462.9 9524.0 9704.0 22126.9 22834.4 23160.3 23162.3 23214.4 7363.2 7389.1 7405.8 7663.1 7819.7 3911.1 3930.6 3936.0 3952.2 3954.4 3597.6 3602.6 3649.4 3651.6 3716.1 636.3 649.8 656.9 667.1 690.8 557.2 586.9 593.5 601.2 610.6 7849.2 8083.6 8229.5 8278.7 8280.4 566.3 571.4 575.7 609.1 631.1 3217.9 3866.8 3909.2 3914.3 3920.0 81226.4 94419.5 102709.5 103841.0 104266.0 71247.0 87559.0 89434.0 90272.5 90343.0 63552.4 81475.2 82289.0 82736.8 83847.6 7504.5 7671.2 7688.0 7713.3 7861.8 47847.8 48543.0 49391.3 49646.5 50016.7 60835.5 66790.0 70388.0 71328.0 71611.6 10166.0 10243.3 10280.4 10319.6 10423.0 10734.6 11111.0 11522.4 11524.3 11822.7 8564.9 10381.5 10749.2 10753.5 10834.5 10134.7 10516.0 10588.9 10612.7 10672.5 9976.7 10520.0 10525.5 10538.0 10546.7 8729.7 8763.6 8787.7 9055.8 9287.6 7615.2 8797.0 8875.4 8882.6 8980.8 20:44:55 INFO - PROCESS | 1658 | -------- Summary: end -------- 20:44:55 INFO - PROCESS | 1658 | 20:44:56 INFO - TEST-INFO | 1658: exit 0 20:44:56 INFO - TEST-OK | dromaeo_css | took 1112794ms 20:44:56 INFO - TEST-START | kraken 20:44:56 INFO - operating with platform_type : mac_ 20:44:56 INFO - Initialising browser for kraken test... 20:44:56 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpi9giAF/profile http://localhost:49276/getInfo.html) 20:44:59 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 20:44:59 INFO - PROCESS | 1670 | colorDepth:24 20:44:59 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 20:44:59 INFO - PROCESS | 1670 | __metrics 20:44:59 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:44:59 INFO - TEST-INFO | 1670: exit 0 20:44:59 INFO - Browser initialized. 20:44:59 INFO - Running cycle 1/1 for kraken test... 20:44:59 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/T/tmpi9giAF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:45:12 INFO - PROCESS | 1673 | RSS: Main: 249851904 20:45:12 INFO - PROCESS | 1673 | 20:45:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 20:45:15 INFO - PROCESS | 1673 | RSS: Main: 261701632 20:45:15 INFO - PROCESS | 1673 | 20:45:18 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 20:45:19 INFO - PROCESS | 1673 | RSS: Main: 266317824 20:45:19 INFO - PROCESS | 1673 | 20:45:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 20:45:23 INFO - PROCESS | 1673 | RSS: Main: 266682368 20:45:23 INFO - PROCESS | 1673 | 20:45:25 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 20:45:26 INFO - PROCESS | 1673 | RSS: Main: 267939840 20:45:26 INFO - PROCESS | 1673 | 20:45:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:45:28 INFO - PROCESS | 1673 | RSS: Main: 267935744 20:45:28 INFO - PROCESS | 1673 | 20:45:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 20:45:32 INFO - PROCESS | 1673 | RSS: Main: 269635584 20:45:32 INFO - PROCESS | 1673 | 20:45:35 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 20:45:36 INFO - PROCESS | 1673 | RSS: Main: 270970880 20:45:36 INFO - PROCESS | 1673 | 20:45:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 20:45:40 INFO - PROCESS | 1673 | RSS: Main: 270708736 20:45:40 INFO - PROCESS | 1673 | 20:45:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:45:42 INFO - PROCESS | 1673 | RSS: Main: 270688256 20:45:42 INFO - PROCESS | 1673 | 20:45:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:45:45 INFO - PROCESS | 1673 | RSS: Main: 270200832 20:45:45 INFO - PROCESS | 1673 | 20:45:47 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:45:48 INFO - PROCESS | 1673 | RSS: Main: 270315520 20:45:48 INFO - PROCESS | 1673 | 20:45:51 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:45:51 INFO - PROCESS | 1673 | RSS: Main: 270381056 20:45:51 INFO - PROCESS | 1673 | 20:45:54 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:45:55 INFO - PROCESS | 1673 | RSS: Main: 270319616 20:45:55 INFO - PROCESS | 1673 | 20:45:56 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 20:45:57 INFO - PROCESS | 1673 | RSS: Main: 272117760 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | __start_tp_report 20:45:57 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 20:45:57 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 20:45:57 INFO - PROCESS | 1673 | |i|pagename|runs| 20:45:57 INFO - PROCESS | 1673 | |0;ai-astar;111;115;107;115;124;113;105;115;113;111 20:45:57 INFO - PROCESS | 1673 | |1;audio-beat-detection;169;114;172;249;120;142;135;124;165;120 20:45:57 INFO - PROCESS | 1673 | |2;audio-dft;206;229;195;198;198;193;193;192;200;196 20:45:57 INFO - PROCESS | 1673 | |3;audio-fft;72;81;74;171;58;57;59;58;147;81 20:45:57 INFO - PROCESS | 1673 | |4;audio-oscillator;99;123;206;104;82;81;122;79;83;121 20:45:57 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;90;87;90;87;90;87;91;89;91;98 20:45:57 INFO - PROCESS | 1673 | |6;imaging-darkroom;150;89;96;96;94;95;96;95;96;96 20:45:57 INFO - PROCESS | 1673 | |7;imaging-desaturate;90;90;91;124;84;148;149;90;113;145 20:45:57 INFO - PROCESS | 1673 | |8;json-parse-financial;58;61;63;72;90;90;87;123;62;62 20:45:57 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;66;68;67;69;95;76;77;69;68;70 20:45:57 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;87;86;86;86;89;90;87;91;104;107 20:45:57 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;161;137;139;141;135;139;135;140;216;139 20:45:57 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;164;170;167;167;165;167;166;168;165;166 20:45:57 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;68;66;68;66;67;66;73;85;67;65 20:45:57 INFO - PROCESS | 1673 | __end_tp_report 20:45:57 INFO - PROCESS | 1673 | __start_cc_report 20:45:57 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1088 20:45:57 INFO - PROCESS | 1673 | __end_cc_report 20:45:57 INFO - PROCESS | 1673 | __startTimestamp1463715957190__endTimestamp 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | ------- Summary: start ------- 20:45:57 INFO - PROCESS | 1673 | Number of tests: 14 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:5.17 (4.5%) stddev-sans-first:5.44 20:45:57 INFO - PROCESS | 1673 | Values: 111.0 115.0 107.0 115.0 124.0 113.0 105.0 115.0 113.0 111.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:151.00 Median:153.50 stddev:40.72 (26.5%) stddev-sans-first:42.66 20:45:57 INFO - PROCESS | 1673 | Values: 169.0 114.0 172.0 249.0 120.0 142.0 135.0 124.0 165.0 120.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:200.00 Median:198.00 stddev:10.99 (5.6%) stddev-sans-first:11.45 20:45:57 INFO - PROCESS | 1673 | Values: 206.0 229.0 195.0 198.0 198.0 193.0 193.0 192.0 200.0 196.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:85.80 Median:65.50 stddev:40.10 (61.2%) stddev-sans-first:42.22 20:45:57 INFO - PROCESS | 1673 | Values: 72.0 81.0 74.0 171.0 58.0 57.0 59.0 58.0 147.0 81.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:80.00 stddev:38.18 (47.7%) stddev-sans-first:40.29 20:45:57 INFO - PROCESS | 1673 | Values: 99.0 123.0 206.0 104.0 82.0 81.0 122.0 79.0 83.0 121.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:90.00 stddev:3.23 (3.6%) stddev-sans-first:3.43 20:45:57 INFO - PROCESS | 1673 | Values: 90.0 87.0 90.0 87.0 90.0 87.0 91.0 89.0 91.0 98.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:100.30 Median:96.00 stddev:17.59 (18.3%) stddev-sans-first:2.28 20:45:57 INFO - PROCESS | 1673 | Values: 150.0 89.0 96.0 96.0 94.0 95.0 96.0 95.0 96.0 96.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:112.40 Median:87.00 stddev:27.03 (31.1%) stddev-sans-first:27.42 20:45:57 INFO - PROCESS | 1673 | Values: 90.0 90.0 91.0 124.0 84.0 148.0 149.0 90.0 113.0 145.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:76.80 Median:67.50 stddev:20.66 (30.6%) stddev-sans-first:20.76 20:45:57 INFO - PROCESS | 1673 | Values: 58.0 61.0 63.0 72.0 90.0 90.0 87.0 123.0 62.0 62.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:69.50 stddev:8.71 (12.5%) stddev-sans-first:8.91 20:45:57 INFO - PROCESS | 1673 | Values: 66.0 68.0 67.0 69.0 95.0 76.0 77.0 69.0 68.0 70.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:87.00 stddev:7.72 (8.9%) stddev-sans-first:8.03 20:45:57 INFO - PROCESS | 1673 | Values: 87.0 86.0 86.0 86.0 89.0 90.0 87.0 91.0 104.0 107.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:139.50 stddev:24.96 (17.9%) stddev-sans-first:26.04 20:45:57 INFO - PROCESS | 1673 | Values: 161.0 137.0 139.0 141.0 135.0 139.0 135.0 140.0 216.0 139.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:167.00 stddev:1.72 (1.0%) stddev-sans-first:1.56 20:45:57 INFO - PROCESS | 1673 | Values: 164.0 170.0 167.0 167.0 165.0 167.0 166.0 168.0 165.0 166.0 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:67.50 stddev:6.01 (8.9%) stddev-sans-first:6.36 20:45:57 INFO - PROCESS | 1673 | Values: 68.0 66.0 68.0 66.0 67.0 66.0 73.0 85.0 67.0 65.0 20:45:57 INFO - PROCESS | 1673 | -------- Summary: end -------- 20:45:57 INFO - PROCESS | 1673 | 20:45:57 INFO - TEST-INFO | 1673: exit 0 20:45:58 INFO - TEST-OK | kraken | took 61539ms 20:45:58 INFO - SUITE-END | took 1174s 20:45:58 INFO - Completed test suite (00:19:34) 20:45:58 INFO - javascript benchmark 20:45:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7091.9437655082065, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3521.066917266924, 3530.858765649374, 3545.7517973741833, 3573.624769399213, 3580.907823113951, 5850.853728656785, 5884.941150588498, 5917.757270973096, 5996.220491336131, 6075.270967483897, 5760.7695692172265, 5880.882382352351, 5881.117832325153, 5919.319278282998, 5994.820155395345, 5235.240890070937, 5285.2600635911, 5356.38401583819, 5384.326959130109, 5426.538744206747, 414.2003469508511, 4283.464566929134, 5354.5716342692685, 5368.194770784375, 5407.864803379927, 5291.841244762663, 5295.761690723907, 5303.416624171357, 5331.946680533222, 5350.5452036576935, 5246.029484545371, 5357.8392648220615, 5385.676859388449, 5405.297311349499, 5490.752916118784, 5220.530152286313, 5244.003639308519, 5250.947490525123, 5276.287701160332, 5276.3140791697215, 4972.975135124301, 5218.321618189649, 5785.971070144665, 5892.116182572606, 5910.586258961875, 6238.781642642532, 6270.31026587075, 6286.119943207955, 6302.621842689453, 6355.968220158916, 6325.9051114233325, 6400.135981642466, 6412.5190610704385, 6415.390537898892, 6426.935730642727, 6082.847928801771, 6107.083937409379, 6125.540584456184, 6128.958077126899, 6134.96932515339, 6257.812265632038, 6319.24169099711, 6356.332585078592, 6382.648954307465, 6520.804375868732, 6291.087792270096, 6293.811185664437, 6310.305866354697, 6323.30443651198, 6333.904991425133, 6327.367263273728, 6352.809415717536, 6360.204974378203, 6377.266614339411, 6383.265924418752, 6167.444929956326, 6260.686965651699, 6265.373462653698, 6306.779262725782, 6350.174477317919, 5423.18652202165, 6031.8539477499135, 6200.193974783249, 6201.96899015502, 6214.751409943642, 5018.422881368616, 5070.264811602297, 5079.8984020319385, 5080.0, 5081.673316720632, 4475.507694153641, 4481.305397663367, 4484.596386325246, 4553.658475614342, 4563.0873825235085, 5822.854428639233, 5961.552883533753, 5993.880122397528, 6012.278526576839, 6019.668918209453, 6224.937750622526, 6348.047792831112, 6386.680665966683, 6387.680615969183, 6400.967995159995, 5975.641461512323, 6017.06735456005, 6026.126211699279, 6038.607490513103, 6068.362821903636, 4944.975275123601, 5470.933168032275, 5545.473180047889, 5554.416786237468, 5554.50009499147, 6273.560850740404, 6359.4276515112015, 6565.310642382481, 6606.603603783885, 6619.834504137435, 6209.59637623553, 6252.249730032243, 6321.715522801393, 6326.4622507087415, 6340.1440805490665, 6385.106085148176, 6424.453921416732, 6426.710798014007, 6427.260865000398, 6447.9355206447335, 6107.206063211754, 6143.696113957266, 6157.076438534255, 6175.320714721467, 6198.597091189058, 6291.213598300213, 6311.147995020613, 6314.052892066226, 6327.430531252209, 6346.7143978522, 5280.7359632019015, 5573.665580065047, 6157.784477543264, 6167.938320616737, 6198.349173336915, 6047.425494578008, 6070.332263450929, 6101.481374083252, 6115.755369785159, 6151.938480615316, 5994.970025149846, 6079.209702738615, 6108.888502348341, 6143.815685529441, 6148.16999705052, 6236.327650265475, 6274.058891166179, 6282.937170628235, 6294.433500984934, 6313.021481670165, 5944.613600115978, 6027.698615069141, 6063.878722425615, 6076.756929722762, 6109.969450152721], "value": 5768.474994630139, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.74962518740654, 523.4503771040407, 535.0289225056523, 549.7636016512901, 566.0942492012782, 39243.21513569727, 42050.78974605127, 42053.78973105138, 42094.579054209484, 42196.36705449421, 43226.487072952455, 43614.127717445714, 43793.343099853526, 43906.56093439065, 43980.560194398044, 9490.335676502647, 9582.329236953416, 9692.75768105796, 9724.56239469222, 9726.708198754013, 9560.856587151198, 9561.80876382472, 9569.856452153188, 9577.329586928918, 9700.611975520971, 9644.324897257195, 9660.951695241514, 9706.272029597772, 9728.75678108046, 9738.367006144614, 9618.470984095942, 9631.181349585258, 9665.951670241639, 9695.70912872615, 9711.0, 9578.377405468693, 9657.71026869195, 9671.226301895831, 9678.419294842262, 9687.225021998223, 39582.0, 39612.60387396118, 39633.40549891754, 39640.60359396398, 40073.39889901654, 3189.266468712186, 3205.1506350817053, 3328.1014126186037, 3422.9144271393166, 3511.7015053720465, 27923.0, 29411.41177176466, 29531.966381176557, 29538.70461295381, 30733.231669208224, 2738.4523095380805, 2748.7938404619536, 2802.6776920654183, 2824.887004519817, 2876.2953076496183, 457578.0, 458279.0, 460109.0, 464616.0, 466868.0, 34645.826770865984, 35442.82278588642, 35574.0, 61534.69232653898, 61851.0, 35254.64745352565, 35701.46447803285, 35791.4631280531, 36258.63741362606, 36273.455898161024, 14429.422823087169, 14628.780568291484, 14848.851511484963, 14976.326065327086, 15014.849851501564, 12272.0, 12491.0, 12644.747105057848, 12647.367631618383, 12658.303793291274, 7672.0, 7893.447458677952, 7942.324902383362, 7952.324052455606, 7993.840123197503, 3345.9498107528407, 3356.3455126250633, 3363.8486268117995, 3367.1413789484013, 3403.3533628610485, 879.4195830751673, 988.5551501824208, 1074.6453670288786, 1075.7687097273968, 1089.934603923767, 27708.0, 28238.576421353697, 29441.263968400963, 29598.852005740264, 30417.543736843963, 1050.5902697947806, 1067.8932106789414, 1088.7985722641338, 1107.6067995861515, 1111.56093343129, 15612.063276203464, 16033.438829640907, 16214.027158370536, 16377.0, 16650.417235396704, 679369.0, 688760.0, 691848.0, 696502.0, 697062.0, 61817.07274390888, 62141.06788398178, 62592.0, 62821.37178628246, 62856.74286514244, 1382.523029554802, 1406.3601061516986, 1453.3387308774481, 1454.8690617844234, 1455.0614853419486, 29614.703852962055, 29647.110586682433, 29710.257243569085, 30147.849260753555, 30463.390732184787, 51880.0, 52450.737746311024, 52518.47481525136, 53254.73372633112, 53503.73248133734, 628649.0, 635422.0, 639818.0, 643220.0, 643791.0, 25347.493050138524, 25895.0, 25942.962281509284, 26144.60783088293, 26235.868820655774, 44018.779906100266, 45232.32151517796, 45887.311690324, 45915.0, 46389.072218554764, 33306.833465833486, 36844.26311473702, 38830.223395531364, 39036.80481597574, 39155.60844391634, 30972.451377431487, 37211.0, 37609.059773505884, 37905.05237369088, 39026.804865975486, 29203.41593168082, 37330.44004339991, 37943.62056379511, 38160.618393815705, 39395.40906886457, 31869.8845540405, 33800.323993520484, 34015.70581869744, 34365.828170858986, 34431.65568344285, 25030.62454063227, 25089.0, 25196.87401563054, 25487.853046613316, 25578.360540986625], "value": 18633.767257862623, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.7762497751306, 387.8429236159355, 389.91032062625595, 391.1472988884235, 412.4411422522482, 16019.519414417586, 19818.306359277427, 20447.488812779688, 21084.05121769522, 21094.367168984936, 20153.496162595944, 20156.798432015676, 20621.0, 21091.2618058368, 21102.944852757377, 5718.42815718429, 5867.735951882176, 5892.2929248490245, 5911.73397197125, 5933.0, 5022.522860328281, 5424.810131645393, 5803.810218905114, 6045.7883974060915, 6085.0263957766765, 5585.329760428734, 5845.970770146143, 5852.122181672762, 5858.8242352729485, 5862.384449632791, 6394.168758061469, 6494.253160886511, 6581.2760596334365, 6592.439642630334, 6593.472522198213, 5475.698836564027, 5771.884562308773, 5776.97111514444, 5795.594308398414, 5800.187973683687, 13092.410841512155, 13186.274754888478, 13321.000924930571, 13463.057585968985, 13492.460301587924, 2089.1643342662906, 2152.4726442021647, 2204.8015678588845, 2261.479859632294, 2271.8523295985706, 9755.36590121647, 9894.406335619886, 9925.90074099257, 10134.949325253327, 10162.9491852541, 1709.8204688507776, 1719.8108208097099, 1745.467632372126, 1777.79555351135, 1785.0628420079433, 122679.0, 124933.0, 126706.99999999908, 127084.0, 127797.0, 11114.499847506882, 11304.604338848265, 11492.367919764327, 11624.88375116255, 11722.765544689059, 12807.359632018362, 13518.25649589282, 14006.929965350108, 14687.0, 14745.0, 8199.344052475788, 8330.958345208235, 8374.371922105867, 8468.872966905501, 8632.266257368194, 8312.709055183039, 8551.444156129832, 8569.871451928226, 8608.698695545625, 8612.48325100496, 3561.893143205708, 4357.215701173819, 4436.711613745097, 4576.977115114403, 4622.537746225351, 1903.4670292318174, 1969.1631056800802, 1978.871373360727, 1981.51452894039, 1981.5541503161674, 883.9436872936778, 895.785011597212, 944.8724422203052, 974.8635191073114, 984.3257368702461, 16629.6674066518, 18775.530611734815, 19111.90444047771, 19678.70481942772, 19999.0, 902.8961669408102, 962.3504134709043, 963.7831487915163, 983.5918093990914, 1051.9474026298653, 10123.44692581194, 10405.115565177044, 10416.375017498975, 10418.947905260426, 10506.842397364046, 560479.1856244238, 626911.0, 628750.0, 640341.0, 642030.0, 88545.0, 113322.0, 149032.25483872512, 151917.0, 154386.0, 1014.6753039027587, 1023.6621914768109, 1048.564845589072, 1099.1591432554103, 1100.9724756880983, 17528.298868045644, 17776.022318772593, 17791.110444477465, 17969.460916172535, 18079.909600451912, 44042.0, 46737.83155421005, 52239.95520089501, 53014.734926326666, 53639.46360536501, 78811.60594197222, 80586.38827223306, 80757.0, 82674.58662706648, 86376.0, 5105.642605017613, 5677.943220567907, 7322.560646361236, 7432.851342973002, 7978.840423191387, 11692.532298707956, 12478.750424991631, 12658.746825063632, 12707.618771436872, 12946.870531294944, 9405.0, 10635.680929572125, 10723.142148628247, 10956.068734157367, 10996.90030996894, 10406.323588966692, 10635.14918806478, 10885.510152043336, 11023.0, 11036.834447483454, 9155.397805384164, 11121.221514493907, 11122.777544449227, 11172.776544469227, 11187.608433704781, 6584.617230381674, 7300.16048154469, 7396.55620662762, 7424.183339832722, 7453.142888567884, 10698.197635177237, 10943.0, 10982.830957836253, 11117.444127793417, 11228.157888158257], "value": 9271.663706529747, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1451.9128852268861, 1581.57297529667, 1816.1101060480369, 1924.4996300961755, 1950.8536859735523, 8002.919970800291, 8577.571121443927, 8581.39930204886, 9054.909450905498, 9061.411008284456, 8638.352123590725, 8742.082081381459, 8860.158284962934, 8877.467351958887, 8882.733517994455, 2371.1700904683353, 2377.239283429303, 2380.7619238076227, 2418.383312255381, 2420.1287536486852, 2344.742078371378, 2373.6083546214854, 2379.7501262367377, 2395.2574701842486, 2396.95206095878, 2351.576716191085, 2402.1712509184304, 2404.350825277174, 2406.831521793475, 2421.8546887186735, 2366.5503554324796, 2372.50177462733, 2389.354874183969, 2390.043982407042, 2395.197608801054, 2004.629143608437, 2270.625346817773, 2296.0471404367167, 2296.3799774061076, 2336.6027775278244, 8727.563621818947, 8736.3447741419, 8776.341774366949, 8893.421927574687, 8896.733098007071, 5253.842384728464, 5372.811951581715, 5434.157705555645, 5436.3476382833915, 5521.723913804293, 3519.4896739972814, 3528.012156596157, 3539.07983924179, 3603.9459408108637, 3608.440691692792, 916.1617120334886, 1024.3956065921143, 1029.176658673066, 1033.219918961187, 1034.534459493231, 11634.70913227176, 11712.941435292854, 11747.0, 11762.529498820037, 11778.823317650242, 4670.53294670537, 4736.73947932867, 4791.185498465269, 4841.975790121027, 4850.854474365775, 9800.26498012652, 9941.453220072965, 9942.453165075991, 9955.701328960144, 9974.002599739968, 5312.415634280226, 5325.3609566851455, 5373.0, 5411.323584551931, 5412.458754124635, 4163.604457576525, 4403.9779801100785, 4575.0392417592675, 4931.161702510582, 4948.727819969864, 3706.499622550975, 3973.5430425501436, 4028.1540876415693, 4099.651529620016, 4102.077032667686, 1118.3392661897076, 1304.1718508746824, 1314.9802752958522, 1316.967075823093, 1322.8677132286693, 805.79049447143, 819.9631016604267, 873.9606717697719, 913.4701872913694, 981.6711401680517, 4857.757112144379, 5746.626469279484, 5933.614315069507, 6074.936886044925, 6212.0371342441995, 931.9580618872167, 990.2424645146468, 993.60752502761, 999.3903718731568, 999.8200323941614, 3756.6431189037, 3970.1861118470642, 4059.6752259819145, 4093.529244136903, 4097.651699605567, 9156.404833685923, 10498.42258675765, 10942.562297508011, 10942.960418760205, 10986.285891417032, 10590.364578125336, 10625.787484250272, 10899.673009809718, 10900.890991090146, 10912.345259284468, 8209.79475513105, 8253.669853205925, 8323.625436855356, 8435.451695639886, 8436.831263374821, 4490.416245888014, 5588.077967135378, 5834.124881267844, 5889.469947704727, 5972.044472884491, 9912.851307230254, 9917.752056198653, 9920.652777152765, 10129.290949633749, 10156.746081348025, 9945.602175913173, 10103.797924041331, 10300.639477618248, 10542.209334300112, 10621.256512044083, 6522.641254731036, 6878.243393226641, 7091.6099614519635, 7117.074780278531, 7291.562506249642, 8418.579071046546, 8431.0, 8465.98408191021, 8503.277221436, 8532.573371331533, 7395.778126656209, 7558.13081495613, 7603.429742769204, 7627.351675107678, 7676.577788221478, 7292.052033235857, 7314.780556583311, 7367.594782287026, 7425.665845036879, 7447.404207663482, 6920.204176519765, 6932.0, 6978.0, 7035.894461583182, 7061.152661680631, 4787.8563643090765, 4835.178019736582, 4926.187179115406, 5031.396232452129, 5137.948620513747, 4985.626078044089, 5043.218301163325, 5056.873578160576, 5089.592832573459, 5288.9471105289995], "value": 4599.832962959783, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.60003395467066, 311.3554941271568, 315.5314358178105, 317.1263169966741, 320.7482126530674, 4951.801927922887, 5125.205593133061, 5208.00539689678, 5379.488948549892, 5511.0, 4768.403949506312, 5423.349198096224, 5480.150576660614, 5532.3914369419335, 5569.053260945639, 3840.98213973298, 3847.826847791856, 4149.170165966819, 4174.916501669964, 4182.6235638792505, 3532.4566312255265, 3576.159602493412, 3582.982085089571, 3851.7852234964867, 4119.917601647965, 3282.3271229397915, 3882.650561449469, 3985.02366920105, 4094.2016306820183, 4098.754074755524, 3165.2432899740866, 4109.445224894645, 4137.834486620532, 4142.606452387018, 4156.210320039183, 3277.6886195811358, 3548.254866478043, 3565.1265439967115, 3586.4799604057266, 3596.892093237207, 4946.8763280918265, 5205.074122574634, 5222.947770522284, 5236.371635403776, 5270.92093618596, 3875.418687196915, 4217.072244106292, 4423.1153769246275, 4732.408448943882, 4773.689710168828, 5237.769124255797, 5691.946989806899, 5777.508911742507, 5780.7687692492245, 5870.97064514679, 3495.370833250014, 3733.7386382953205, 3902.551206611248, 3926.0577461409057, 3934.2524920265346, 5504.559635229172, 6088.6042407243385, 6127.713180232112, 6131.233595800525, 6154.446099851035, 3925.8429662813737, 3957.821898014539, 3965.8810235692977, 3966.6231707988272, 3994.0414300568236, 3539.5398598182073, 3892.0, 4003.7197396181987, 4023.3160362738404, 4030.355143177136, 4123.525794533667, 4310.202612516695, 4694.835680751157, 4710.0, 4741.881452963704, 5120.618912205842, 5823.679697616587, 5844.0, 5863.120531920246, 5919.585629005928, 1239.7768401687783, 1355.8169647097714, 1364.467857535562, 1366.3168415792104, 1369.821923149984, 811.3022800391658, 818.3126174013858, 832.8042909916165, 842.7471758472557, 846.7883029242689, 4176.644985176234, 4297.505786834491, 4507.414036175276, 4559.224931761609, 4589.862304130815, 4219.767912764827, 4652.511486293958, 4986.301917731521, 5034.697918124851, 5061.924071138936, 4382.342648602735, 4516.486976862788, 4544.840930567414, 4548.6361091113295, 4567.602008945264, 2106.104905415192, 2190.452386903274, 2474.6614449345557, 2572.382628169263, 2618.947621047568, 4068.5117785865295, 4585.633149348044, 4602.907941841211, 5241.479970808423, 5357.946420535823, 4382.912341753147, 4641.373414589055, 5128.282040514331, 5129.307543481582, 5174.741262936838, 5595.398139864982, 6291.842703932438, 6309.589876658002, 6310.340002798366, 6342.5243106767175, 5752.6836024019085, 6009.579329446897, 6055.364186760503, 6092.268927728701, 6126.724297406538, 5822.621529600562, 5888.823335299948, 5995.850103747442, 6055.303640081447, 6164.907526387197, 5673.659580425187, 6170.575330691509, 6253.312135664983, 6303.306636269915, 6320.399562041599, 3929.58739332366, 3958.267720471722, 3966.900827479336, 3976.6421022108148, 3982.761034337949, 5710.257666503494, 5792.53659707214, 6052.455279024909, 6102.941543873275, 6140.17107690456, 4922.8769280768265, 5322.520973112283, 5558.3607885092115, 5789.3921138279875, 5823.7379317929945, 4864.513548645107, 5320.813771517978, 5345.625806193529, 5748.712564371848, 5847.26909136358, 5359.651622644516, 5667.4332566743, 5688.516476099578, 5694.886102278014, 5734.885302294014, 5239.135542635422, 5617.0, 5746.626469279484, 5759.766571569977, 5784.971075144597, 4985.6510044298, 5617.297837770278, 5683.75491680792, 5687.77248910039, 5694.402087780889], "value": 4063.6490777441873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [632.6172665537349, 633.4900405173839, 673.4410439335355, 723.5586292361659, 747.3162056718103, 14705.926470367633, 15056.548303550897, 15212.391504339826, 15247.16140612266, 15507.45723899665, 14255.073420227704, 14347.995640305182, 14365.209913454755, 14365.425382984695, 14378.281085945688, 717.9425645948312, 886.813769108488, 899.703097977669, 923.1875949164726, 924.3344791749929, 922.2529750901757, 925.2782829393084, 931.4318265857821, 931.6739141300559, 933.2114363362947, 837.924586787189, 956.8756061711968, 974.5565767575736, 977.3354119198942, 978.061061381075, 949.6533765175661, 964.763632909938, 965.7006328038295, 966.0243154414057, 966.6954909203579, 709.1773542690454, 716.323074694414, 717.2755516927888, 717.6878058044767, 720.8990741296222, 13527.0, 13734.313284335743, 14923.776143357858, 14992.175430351326, 15135.0, 12539.498420063186, 12621.242725436503, 12663.11358204926, 12694.492220311176, 12878.613641590768, 7253.637318134125, 9735.17251033663, 10029.29794914349, 10036.197104231644, 10084.344517606332, 3336.9165770855925, 3392.6437724039115, 3410.9658903410896, 3415.9316813663836, 3417.8974630761118, 66016.0, 85574.57212713896, 87372.0, 87720.0, 88883.55558222233, 9454.33819632619, 9459.337846350827, 9462.858057129148, 9523.952380238054, 9704.02959704024, 22126.88936555307, 22834.42913927165, 23160.3051908443, 23162.3051308461, 23214.41963950881, 7363.153237377663, 7389.113306403266, 7405.7778266652085, 7663.060833466377, 7819.68721251155, 3911.1395492991496, 3930.567637559866, 3936.0, 3952.2293152834923, 3954.3870700040966, 3597.5503062117236, 3602.6217247189193, 3649.361361761681, 3651.634836516327, 3716.0709822544363, 636.2937139774846, 649.8115546491465, 656.924453687832, 667.112730156372, 690.8169335126196, 557.2115456628906, 586.8562202260473, 593.4658807073582, 601.2214182633413, 610.5848023344168, 7849.215078492105, 8083.636236369378, 8229.46508476947, 8278.716798896181, 8280.378971577156, 566.2723400430427, 571.3686376553932, 575.7035126909645, 609.1106983803608, 631.1479502671449, 3217.935641287161, 3866.8399480156404, 3909.237698648736, 3914.3345631242755, 3919.980400097981, 81226.37547249022, 94419.52790236005, 102709.45935810969, 103841.0, 104266.0, 71247.0, 87559.0, 89434.0, 90272.54863725639, 90343.0, 63552.36447635557, 81475.18524814794, 82289.0, 82736.75894861582, 83847.5807620958, 7504.549727016397, 7671.156172821097, 7687.961560192163, 7713.267239612228, 7861.8034549134445, 47847.76076119597, 48543.0, 49391.25913111378, 49646.50353496419, 50016.74958126076, 60835.47911302253, 66790.0, 70388.0, 71328.0, 71611.56776864329, 10166.0, 10243.282970192313, 10280.383177009404, 10319.574565735888, 10423.0, 10734.570617175226, 11111.0, 11522.366269855238, 11524.308541487537, 11822.704432389259, 8564.871526926976, 10381.480925953521, 10749.193810464403, 10753.516091775733, 10834.512446939749, 10134.746631334276, 10516.0, 10588.947055264982, 10612.734681633021, 10672.519736611715, 9976.700698979042, 10520.0, 10525.526351314056, 10538.0, 10546.683599492027, 8729.65081396737, 8763.649454021768, 8787.692430765148, 9055.818883622422, 9287.62849486013, 7615.238476152341, 8796.956015219883, 8875.423097498642, 8882.600282987152, 8980.820383592421], "value": 6829.221683538589, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1586.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 107.0, 115.0, 124.0, 113.0, 105.0, 115.0, 113.0, 111.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 114.0, 172.0, 249.0, 120.0, 142.0, 135.0, 124.0, 165.0, 120.0], "value": 151.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 229.0, 195.0, 198.0, 198.0, 193.0, 193.0, 192.0, 200.0, 196.0], "value": 200.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 81.0, 74.0, 171.0, 58.0, 57.0, 59.0, 58.0, 147.0, 81.0], "value": 85.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 123.0, 206.0, 104.0, 82.0, 81.0, 122.0, 79.0, 83.0, 121.0], "value": 110.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 90.0, 87.0, 90.0, 87.0, 91.0, 89.0, 91.0, 98.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 89.0, 96.0, 96.0, 94.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 100.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 91.0, 124.0, 84.0, 148.0, 149.0, 90.0, 113.0, 145.0], "value": 112.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 63.0, 72.0, 90.0, 90.0, 87.0, 123.0, 62.0, 62.0], "value": 76.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 69.0, 95.0, 76.0, 77.0, 69.0, 68.0, 70.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 86.0, 89.0, 90.0, 87.0, 91.0, 104.0, 107.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 137.0, 139.0, 141.0, 135.0, 139.0, 135.0, 140.0, 216.0, 139.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 170.0, 167.0, 167.0, 165.0, 167.0, 166.0, 168.0, 165.0, 166.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 66.0, 67.0, 66.0, 73.0, 85.0, 67.0, 65.0], "value": 69.1, "unit": "score"}]}]} 20:45:58 INFO - Return code: 0 20:45:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:45:58 ERROR - # TBPL SUCCESS # 20:45:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:45:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:45:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:45:58 INFO - 2016-05-19 20:45:58.539 screenresolution[1678:10605] starting screenresolution argv=screenresolution get 20:45:58 INFO - 2016-05-19 20:45:58.541 screenresolution[1678:10605] Display 0: 1600x1200x32@60 20:45:58 INFO - 2016-05-19 20:45:58.547 screenresolution[1679:10608] starting screenresolution argv=screenresolution list 20:45:58 INFO - Available Modes on Display 0 20:45:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:45:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:45:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:45:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:45:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:45:58 INFO - Intel Iris: 20:45:58 INFO - Chipset Model: Intel Iris 20:45:58 INFO - Type: GPU 20:45:58 INFO - Bus: Built-In 20:45:58 INFO - VRAM (Dynamic, Max): 1536 MB 20:45:58 INFO - Vendor: Intel (0x8086) 20:45:58 INFO - Device ID: 0x0a2e 20:45:58 INFO - Revision ID: 0x0009 20:45:58 INFO - Displays: 20:45:58 INFO - Display: 20:45:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:45:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:45:58 INFO - Display Serial Number: 1600x1200 60 20:45:58 INFO - Main Display: Yes 20:45:58 INFO - Mirror: Off 20:45:58 INFO - Online: Yes 20:45:58 INFO - Rotation: Supported 20:45:58 INFO - Return code: 0 20:45:58 INFO - Running post-action listener: _resource_record_post_action 20:45:58 INFO - ##### 20:45:58 INFO - ##### Finished run-tests step (success) 20:45:58 INFO - ##### 20:45:58 INFO - Running post-run listener: _resource_record_post_run 20:45:58 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37705216; Write bytes: 699164672; Read time: 392; Write time: 1815 20:45:58 INFO - TinderboxPrint: CPU usage
54.4% 20:45:58 INFO - TinderboxPrint: I/O read bytes / time
37,705,216 / 392 20:45:58 INFO - TinderboxPrint: I/O write bytes / time
699,164,672 / 1,815 20:45:58 INFO - TinderboxPrint: CPU idle
2,209.7 (45.6%) 20:45:58 INFO - TinderboxPrint: CPU system
979.2 (20.2%) 20:45:58 INFO - TinderboxPrint: CPU user
1,652.8 (34.1%) 20:45:58 INFO - TinderboxPrint: Swap in / out
433,930,240 / 0 20:45:58 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 377649664; Write bytes: 371456000; Read time: 28009; Write time: 708 20:45:58 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36750848; Write bytes: 300642304; Read time: 378; Write time: 1051 20:45:59 INFO - Running post-run listener: _upload_blobber_files 20:45:59 INFO - Blob upload gear active. 20:45:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:45:59 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 20:45:59 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:45:59 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:45:59 INFO - (blobuploader) - INFO - Open directory for files ... 20:45:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:45:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:45:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:46:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:46:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:46:00 INFO - (blobuploader) - INFO - Done attempting. 20:46:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:46:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:46:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:46:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:46:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:46:01 INFO - (blobuploader) - INFO - Done attempting. 20:46:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:46:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:46:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:46:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:46:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:46:04 INFO - (blobuploader) - INFO - Done attempting. 20:46:04 INFO - (blobuploader) - INFO - Iteration through files over. 20:46:04 INFO - Return code: 0 20:46:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:46:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:46:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6d9300b9286cd04c194cf2eefc1c68ee6d75ab58d0d5fcf100350facf4d362cbe8e9ea397b7191eb5cc74240e59448f369a7c87a390d1637e8a6b00313d5a89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/062563e94f8fc3a93b9c2218ac145e31a1b45f7ac594f495a17d5e28f2273e9bb38d1408e738ed0820d9173aaff9748b563245ade4af9600b216aab656974f39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d60cd0cfcf5ce9fb12c7c175104d41c04e5a41067b5d8f19472809651c53c61cb5c31a3097f7b588ee30ed787ed81aa8ccd15753786381d94034345cc1466ab6"} 20:46:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:46:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:46:04 INFO - Contents: 20:46:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6d9300b9286cd04c194cf2eefc1c68ee6d75ab58d0d5fcf100350facf4d362cbe8e9ea397b7191eb5cc74240e59448f369a7c87a390d1637e8a6b00313d5a89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/062563e94f8fc3a93b9c2218ac145e31a1b45f7ac594f495a17d5e28f2273e9bb38d1408e738ed0820d9173aaff9748b563245ade4af9600b216aab656974f39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d60cd0cfcf5ce9fb12c7c175104d41c04e5a41067b5d8f19472809651c53c61cb5c31a3097f7b588ee30ed787ed81aa8ccd15753786381d94034345cc1466ab6"} 20:46:04 INFO - Running post-run listener: copy_logs_to_upload_dir 20:46:04 INFO - Copying logs to upload dir... 20:46:04 INFO - mkdir: /builds/slave/test/build/upload/logs 20:46:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.748266 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-05-19 20:46:04.345735) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 20:46:04.349775) ========= 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.xHtm2Hkmu2/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.dHitFXqK51/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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/Fx-Team/sha512/a6d9300b9286cd04c194cf2eefc1c68ee6d75ab58d0d5fcf100350facf4d362cbe8e9ea397b7191eb5cc74240e59448f369a7c87a390d1637e8a6b00313d5a89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/062563e94f8fc3a93b9c2218ac145e31a1b45f7ac594f495a17d5e28f2273e9bb38d1408e738ed0820d9173aaff9748b563245ade4af9600b216aab656974f39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d60cd0cfcf5ce9fb12c7c175104d41c04e5a41067b5d8f19472809651c53c61cb5c31a3097f7b588ee30ed787ed81aa8ccd15753786381d94034345cc1466ab6"} build_url:https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011212 build_url: 'https://queue.taskcluster.net/v1/task/GtSwxerDQ_6cM7uqt4cpoQ/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a6d9300b9286cd04c194cf2eefc1c68ee6d75ab58d0d5fcf100350facf4d362cbe8e9ea397b7191eb5cc74240e59448f369a7c87a390d1637e8a6b00313d5a89", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/062563e94f8fc3a93b9c2218ac145e31a1b45f7ac594f495a17d5e28f2273e9bb38d1408e738ed0820d9173aaff9748b563245ade4af9600b216aab656974f39", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d60cd0cfcf5ce9fb12c7c175104d41c04e5a41067b5d8f19472809651c53c61cb5c31a3097f7b588ee30ed787ed81aa8ccd15753786381d94034345cc1466ab6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-19 20:46:04.383201) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 20:46:04.383979) ========= 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.xHtm2Hkmu2/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.dHitFXqK51/Listeners TMPDIR=/var/folders/_s/hn69_n6x2qs1n90vl425w26w00000w/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.005230 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-19 20:46:04.437566) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 20:46:04.438185) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-19 20:46:04.438880) ========= ========= Total master_lag: 0.17 =========