builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0390 starttime: 1463627940.01 results: success (0) buildid: 20160518172746 builduid: 6061971e4f2143fb821a97bb10053a7f revision: e0fa395e4982a5225e73908a4a0816932043440d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 20:19:00.005741) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-18 20:19:00.006273) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 20:19:00.006593) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-18 20:19:00.027394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 20:19:00.027781) ========= 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.IHTlkqM1cV/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.cgmpNzYehT/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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-18 20:19:00-- 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% 57.0M=0s 2016-05-18 20:19:00 (57.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.136578 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 20:19:00.182232) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 20:19:00.182541) ========= 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.IHTlkqM1cV/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.cgmpNzYehT/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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.025475 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 20:19:00.231212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 20:19:00.231645) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e0fa395e4982a5225e73908a4a0816932043440d --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 e0fa395e4982a5225e73908a4a0816932043440d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IHTlkqM1cV/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.cgmpNzYehT/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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-18 20:19:00,314 truncating revision to first 12 chars 2016-05-18 20:19:00,314 Setting DEBUG logging. 2016-05-18 20:19:00,314 attempt 1/10 2016-05-18 20:19:00,314 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e0fa395e4982?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-18 20:19:01,343 unpacking tar archive at: fx-team-e0fa395e4982/testing/mozharness/ program finished with exit code 0 elapsedTime=1.288310 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-18 20:19:01.538469) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 20:19:01.538933) ========= script_repo_revision: e0fa395e4982a5225e73908a4a0816932043440d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-18 20:19:01.539448) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 20:19:01.539820) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-18 20:19:01.555153) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-05-18 20:19:01.555665) ========= /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.IHTlkqM1cV/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.cgmpNzYehT/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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:19:01 INFO - MultiFileLogger online at 20160518 20:19:01 in /builds/slave/test 20:19:01 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:19:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:19:01 INFO - {'append_to_log': False, 20:19:01 INFO - 'base_work_dir': '/builds/slave/test', 20:19:01 INFO - 'blob_upload_branch': 'Fx-Team', 20:19:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:19:01 INFO - 'branch': 'Fx-Team', 20:19:01 INFO - 'buildbot_json_path': 'buildprops.json', 20:19:01 INFO - 'config_files': ('talos/mac_config.py',), 20:19:01 INFO - 'default_actions': ('clobber', 20:19:01 INFO - 'read-buildbot-config', 20:19:01 INFO - 'download-and-extract', 20:19:01 INFO - 'populate-webroot', 20:19:01 INFO - 'create-virtualenv', 20:19:01 INFO - 'install', 20:19:01 INFO - 'run-tests'), 20:19:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:19:01 INFO - 'download_minidump_stackwalk': True, 20:19:01 INFO - 'download_symbols': 'ondemand', 20:19:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:19:01 INFO - 'tooltool.py': '/tools/tooltool.py', 20:19:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:19:01 INFO - '/tools/misc-python/virtualenv.py')}, 20:19:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:19:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:19:01 INFO - 'installer_path': 'installer.exe', 20:19:01 INFO - 'log_level': 'info', 20:19:01 INFO - 'log_name': 'talos', 20:19:01 INFO - 'log_to_console': True, 20:19:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:19:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:19:01 INFO - 'opt_config_files': (), 20:19:01 INFO - 'pip_index': False, 20:19:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:19:01 INFO - 'cmd': ('bash', 20:19:01 INFO - '-c', 20:19:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:19:01 INFO - 'enabled': True, 20:19:01 INFO - 'halt_on_failure': False, 20:19:01 INFO - 'name': 'check_screen_resolution'},), 20:19:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:19:01 INFO - 'cmd': ('bash', 20:19:01 INFO - '-c', 20:19:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:19:01 INFO - 'enabled': True, 20:19:01 INFO - 'halt_on_failure': False, 20:19:01 INFO - 'name': 'check_screen_resolution'},), 20:19:01 INFO - 'run_cmd_checks_enabled': True, 20:19:01 INFO - 'sps_profile': False, 20:19:01 INFO - 'sps_profile_interval': 0, 20:19:01 INFO - 'suite': 'dromaeojs-e10s', 20:19:01 INFO - 'system_bits': '32', 20:19:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:19:01 INFO - 'title': 't-yosemite-r7-0390', 20:19:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:19:01 INFO - 'use_talos_json': True, 20:19:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:19:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:19:01 INFO - 'work_dir': 'build'} 20:19:01 INFO - ##### 20:19:01 INFO - ##### Running clobber step. 20:19:01 INFO - ##### 20:19:01 INFO - Running pre-action listener: _resource_record_pre_action 20:19:01 INFO - Running main action method: clobber 20:19:01 INFO - rmtree: /builds/slave/test/build 20:19:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:19:03 INFO - Running post-action listener: _resource_record_post_action 20:19:03 INFO - ##### 20:19:03 INFO - ##### Finished clobber step (success) 20:19:03 INFO - ##### 20:19:03 INFO - ##### 20:19:03 INFO - ##### Running read-buildbot-config step. 20:19:03 INFO - ##### 20:19:03 INFO - Running pre-action listener: _resource_record_pre_action 20:19:03 INFO - Running main action method: read_buildbot_config 20:19:03 INFO - Using buildbot properties: 20:19:03 INFO - { 20:19:03 INFO - "project": "", 20:19:03 INFO - "product": "firefox", 20:19:03 INFO - "script_repo_revision": "production", 20:19:03 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 20:19:03 INFO - "repository": "", 20:19:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 20:19:03 INFO - "buildid": "20160518172746", 20:19:03 INFO - "pgo_build": "False", 20:19:03 INFO - "basedir": "/builds/slave/test", 20:19:03 INFO - "buildnumber": 9, 20:19:03 INFO - "slavename": "t-yosemite-r7-0390", 20:19:03 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 20:19:03 INFO - "platform": "yosemite_r7", 20:19:03 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 20:19:03 INFO - "branch": "fx-team", 20:19:03 INFO - "repo_path": "integration/fx-team", 20:19:03 INFO - "revision": "e0fa395e4982a5225e73908a4a0816932043440d", 20:19:03 INFO - "stage_platform": "macosx64", 20:19:03 INFO - "builduid": "6061971e4f2143fb821a97bb10053a7f", 20:19:03 INFO - "slavebuilddir": "test" 20:19:03 INFO - } 20:19:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 20:19:03 INFO - Running post-action listener: _resource_record_post_action 20:19:03 INFO - ##### 20:19:03 INFO - ##### Finished read-buildbot-config step (success) 20:19:03 INFO - ##### 20:19:03 INFO - ##### 20:19:03 INFO - ##### Running download-and-extract step. 20:19:03 INFO - ##### 20:19:03 INFO - Running pre-action listener: _resource_record_pre_action 20:19:03 INFO - Running main action method: download_and_extract 20:19:03 INFO - mkdir: /builds/slave/test/build/tests 20:19: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:19:03 INFO - https://queue.taskcluster.net/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 20:19:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 20:19:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 20:19:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/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:19:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/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:19:04 INFO - Downloaded 1199 bytes. 20:19:04 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 20:19:04 INFO - Using the following test package requirements: 20:19:04 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 20:19:04 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:19:04 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 20:19:04 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:19:04 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 20:19:04 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:19:04 INFO - u'jsshell-mac.zip'], 20:19:04 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:19:04 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 20:19:04 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 20:19:04 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:19:04 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 20:19:04 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:19:04 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 20:19:04 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:19:04 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 20:19:04 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 20:19:04 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 20:19:04 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:04 INFO - https://queue.taskcluster.net/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:19:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:19:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:19:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/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:19:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/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:19:07 INFO - Downloaded 18629048 bytes. 20:19:07 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:19:07 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:19:10 INFO - Return code: 0 20:19:10 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:19:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:10 INFO - https://queue.taskcluster.net/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:19:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:19:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 20:19:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/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:19:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/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:19:11 INFO - Downloaded 18629048 bytes. 20:19:11 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:19:11 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:19:14 INFO - Return code: 0 20:19:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:14 INFO - https://queue.taskcluster.net/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:19:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 20:19:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 20:19:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/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:19:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/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:19:15 INFO - Downloaded 10840194 bytes. 20:19:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:19:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 20:19:15 INFO - Return code: 0 20:19:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:15 INFO - https://queue.taskcluster.net/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:19:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:19:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:19:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 20:19:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BEsdONOvQoGpnrPL64Hm1w/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:19:18 INFO - Downloaded 110317337 bytes. 20:19:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:19:18 INFO - mkdir: /builds/slave/test/properties 20:19:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:19:18 INFO - Writing to file /builds/slave/test/properties/build_url 20:19:18 INFO - Contents: 20:19:18 INFO - build_url:https://queue.taskcluster.net/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 20:19:19 INFO - Running post-action listener: _resource_record_post_action 20:19:19 INFO - Running post-action listener: set_extra_try_arguments 20:19:19 INFO - ##### 20:19:19 INFO - ##### Finished download-and-extract step (success) 20:19:19 INFO - ##### 20:19:19 INFO - ##### 20:19:19 INFO - ##### Running populate-webroot step. 20:19:19 INFO - ##### 20:19:19 INFO - Running pre-action listener: _resource_record_pre_action 20:19:19 INFO - Running main action method: populate_webroot 20:19:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:19:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:19:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:19:19 INFO - '--tppagecycles', 20:19:19 INFO - '7'], 20:19:19 INFO - 'tests': ['tsvgm']}}, 20:19:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:19:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:19:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:19:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:19:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:19:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:19:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:19 INFO - 'talos_options': ['--disable-e10s'], 20:19:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:19:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:19:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:19 INFO - 'talos_options': ['--disable-e10s'], 20:19:19 INFO - 'tests': ['damp', 'tps']}, 20:19:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:19 INFO - 'tests': ['damp', 'tps']}, 20:19:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:19:19 INFO - 'tests': ['dromaeo_dom']}, 20:19:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:19:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:19:19 INFO - 'tests': ['a11yr', 20:19:19 INFO - 'ts_paint', 20:19:19 INFO - 'tpaint', 20:19:19 INFO - 'sessionrestore', 20:19:19 INFO - 'sessionrestore_no_auto_restore', 20:19:19 INFO - 'tabpaint']}, 20:19:19 INFO - 'other-e10s': {'tests': ['a11yr', 20:19:19 INFO - 'ts_paint', 20:19:19 INFO - 'tpaint', 20:19:19 INFO - 'sessionrestore', 20:19:19 INFO - 'sessionrestore_no_auto_restore', 20:19:19 INFO - 'tabpaint']}, 20:19:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:19:19 INFO - 'ts_paint', 20:19:19 INFO - 'tpaint', 20:19:19 INFO - 'sessionrestore', 20:19:19 INFO - 'sessionrestore_no_auto_restore', 20:19:19 INFO - 'tabpaint']}, 20:19:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:19:19 INFO - 'ts_paint', 20:19:19 INFO - 'tpaint', 20:19:19 INFO - 'sessionrestore', 20:19:19 INFO - 'sessionrestore_no_auto_restore', 20:19:19 INFO - 'tabpaint']}, 20:19:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:19:19 INFO - 'tests': ['a11yr', 20:19:19 INFO - 'ts_paint', 20:19:19 INFO - 'tpaint', 20:19:19 INFO - 'sessionrestore', 20:19:19 INFO - 'sessionrestore_no_auto_restore', 20:19:19 INFO - 'tabpaint']}, 20:19:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:19:19 INFO - 'tests': ['a11yr', 20:19:19 INFO - 'ts_paint', 20:19:19 INFO - 'tpaint', 20:19:19 INFO - 'sessionrestore', 20:19:19 INFO - 'sessionrestore_no_auto_restore', 20:19:19 INFO - 'tabpaint']}, 20:19:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:19:19 INFO - 'tests': ['tsvgx', 20:19:19 INFO - 'tsvgr_opacity', 20:19:19 INFO - 'tart', 20:19:19 INFO - 'tscrollx', 20:19:19 INFO - 'cart']}, 20:19:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:19:19 INFO - 'tsvgr_opacity', 20:19:19 INFO - 'tart', 20:19:19 INFO - 'tscrollx', 20:19:19 INFO - 'cart']}, 20:19:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:19 INFO - 'talos_options': ['--disable-e10s'], 20:19:19 INFO - 'tests': ['tp5o']}, 20:19:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:19 INFO - 'tests': ['tp5o']}, 20:19:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:19 INFO - 'talos_options': ['--disable-e10s', 20:19:19 INFO - '--xperf_path', 20:19:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:19:19 INFO - 'tests': ['tp5n']}, 20:19:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:19:19 INFO - 'talos_options': ['--xperf_path', 20:19:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:19:19 INFO - 'tests': ['tp5n']}}, 20:19:19 INFO - 'talos.zip': {'path': '', 20:19:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:19:19 INFO - Running post-action listener: _resource_record_post_action 20:19:19 INFO - ##### 20:19:19 INFO - ##### Finished populate-webroot step (success) 20:19:19 INFO - ##### 20:19:19 INFO - ##### 20:19:19 INFO - ##### Running create-virtualenv step. 20:19:19 INFO - ##### 20:19:19 INFO - Running pre-action listener: _resource_record_pre_action 20:19:19 INFO - Running main action method: create_virtualenv 20:19:19 INFO - Creating virtualenv /builds/slave/test/build/venv 20:19:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:19:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:19:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:19:20 INFO - Using real prefix '/tools/python27' 20:19:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:19:20 INFO - Installing distribute.............................................................................................................................................................................................done. 20:19:23 INFO - Installing pip.................done. 20:19:23 INFO - Return code: 0 20:19:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e4aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95d8dabb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ceed30>, '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 0x105b12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ce5b20>, '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.IHTlkqM1cV/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.cgmpNzYehT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IHTlkqM1cV/Render', 20:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:19:23 INFO - 'HOME': '/Users/cltbld', 20:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:19:23 INFO - 'LOGNAME': 'cltbld', 20:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:23 INFO - 'MOZ_NO_REMOTE': '1', 20:19:23 INFO - 'NO_EM_RESTART': '1', 20:19:23 INFO - 'PAGER': '/bin/cat', 20:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:23 INFO - 'PWD': '/builds/slave/test', 20:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:19:23 INFO - 'SHELL': '/bin/bash', 20:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cgmpNzYehT/Listeners', 20:19:23 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 20:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:19:23 INFO - 'USER': 'cltbld', 20:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:23 INFO - 'XPC_FLAGS': '0x0', 20:19:23 INFO - 'XPC_SERVICE_NAME': '0', 20:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:19:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:23 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:19:23 INFO - Cleaning up... 20:19:23 INFO - Return code: 0 20:19:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e4aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95d8dabb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ceed30>, '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 0x105b12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ce5b20>, '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.IHTlkqM1cV/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.cgmpNzYehT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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:19:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:19:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:19:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IHTlkqM1cV/Render', 20:19:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:19:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:19:23 INFO - 'HOME': '/Users/cltbld', 20:19:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:19:23 INFO - 'LOGNAME': 'cltbld', 20:19:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:23 INFO - 'MOZ_NO_REMOTE': '1', 20:19:23 INFO - 'NO_EM_RESTART': '1', 20:19:23 INFO - 'PAGER': '/bin/cat', 20:19:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:19:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:23 INFO - 'PWD': '/builds/slave/test', 20:19:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:19:23 INFO - 'SHELL': '/bin/bash', 20:19:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cgmpNzYehT/Listeners', 20:19:23 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 20:19:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:19:23 INFO - 'USER': 'cltbld', 20:19:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:19:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:19:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:23 INFO - 'XPC_FLAGS': '0x0', 20:19:23 INFO - 'XPC_SERVICE_NAME': '0', 20:19:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:24 INFO - Downloading/unpacking psutil>=3.1.1 20:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:19:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:19:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:19:27 INFO - Installing collected packages: psutil 20:19:27 INFO - Running setup.py install for psutil 20:19:27 INFO - building 'psutil._psutil_osx' extension 20:19:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 20:19:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 20:19:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 20:19:27 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 20:19:27 INFO - building 'psutil._psutil_posix' extension 20:19:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 20:19:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:19:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:19:28 INFO - ^ 20:19:28 INFO - 1 warning generated. 20:19:28 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:19:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:19:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:19:28 INFO - Successfully installed psutil 20:19:28 INFO - Cleaning up... 20:19:28 INFO - Return code: 0 20:19:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e4aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95d8dabb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ceed30>, '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 0x105b12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ce5b20>, '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.IHTlkqM1cV/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.cgmpNzYehT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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:19:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:19:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:19:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IHTlkqM1cV/Render', 20:19:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:19:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:19:28 INFO - 'HOME': '/Users/cltbld', 20:19:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:19:28 INFO - 'LOGNAME': 'cltbld', 20:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:28 INFO - 'MOZ_NO_REMOTE': '1', 20:19:28 INFO - 'NO_EM_RESTART': '1', 20:19:28 INFO - 'PAGER': '/bin/cat', 20:19:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:28 INFO - 'PWD': '/builds/slave/test', 20:19:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:19:28 INFO - 'SHELL': '/bin/bash', 20:19:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cgmpNzYehT/Listeners', 20:19:28 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 20:19:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:19:28 INFO - 'USER': 'cltbld', 20:19:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:19:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:28 INFO - 'XPC_FLAGS': '0x0', 20:19:28 INFO - 'XPC_SERVICE_NAME': '0', 20:19:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:19: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:19: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:19: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:19: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:19: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:19: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:19:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:19:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:19:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:19:31 INFO - Installing collected packages: mozsystemmonitor 20:19:31 INFO - Running setup.py install for mozsystemmonitor 20:19:31 INFO - Successfully installed mozsystemmonitor 20:19:31 INFO - Cleaning up... 20:19:31 INFO - Return code: 0 20:19:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e4aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95d8dabb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ceed30>, '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 0x105b12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ce5b20>, '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.IHTlkqM1cV/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.cgmpNzYehT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:19:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IHTlkqM1cV/Render', 20:19:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:19:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:19:31 INFO - 'HOME': '/Users/cltbld', 20:19:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:19:31 INFO - 'LOGNAME': 'cltbld', 20:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:31 INFO - 'MOZ_NO_REMOTE': '1', 20:19:31 INFO - 'NO_EM_RESTART': '1', 20:19:31 INFO - 'PAGER': '/bin/cat', 20:19:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:31 INFO - 'PWD': '/builds/slave/test', 20:19:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:19:31 INFO - 'SHELL': '/bin/bash', 20:19:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cgmpNzYehT/Listeners', 20:19:31 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 20:19:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:19:31 INFO - 'USER': 'cltbld', 20:19:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:19:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:31 INFO - 'XPC_FLAGS': '0x0', 20:19:31 INFO - 'XPC_SERVICE_NAME': '0', 20:19:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:19:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:31 INFO - Downloading/unpacking blobuploader==1.2.4 20:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:34 INFO - Downloading blobuploader-1.2.4.tar.gz 20:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:19:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:19:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:35 INFO - Downloading docopt-0.6.1.tar.gz 20:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:19:35 INFO - Installing collected packages: blobuploader, requests, docopt 20:19:35 INFO - Running setup.py install for blobuploader 20:19:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:19:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:19:35 INFO - Running setup.py install for requests 20:19:36 INFO - Running setup.py install for docopt 20:19:36 INFO - Successfully installed blobuploader requests docopt 20:19:36 INFO - Cleaning up... 20:19:36 INFO - Return code: 0 20:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:36 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:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:36 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:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:36 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 0x105e4aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95d8dabb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ceed30>, '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 0x105b12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ce5b20>, '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.IHTlkqM1cV/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.cgmpNzYehT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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:19:36 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:19:36 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:19:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IHTlkqM1cV/Render', 20:19:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:19:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:19:36 INFO - 'HOME': '/Users/cltbld', 20:19:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:19:36 INFO - 'LOGNAME': 'cltbld', 20:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:36 INFO - 'MOZ_NO_REMOTE': '1', 20:19:36 INFO - 'NO_EM_RESTART': '1', 20:19:36 INFO - 'PAGER': '/bin/cat', 20:19:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:36 INFO - 'PWD': '/builds/slave/test', 20:19:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:19:36 INFO - 'SHELL': '/bin/bash', 20:19:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cgmpNzYehT/Listeners', 20:19:36 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 20:19:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:19:36 INFO - 'USER': 'cltbld', 20:19:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:19:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:36 INFO - 'XPC_FLAGS': '0x0', 20:19:36 INFO - 'XPC_SERVICE_NAME': '0', 20:19:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:19:36 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-_AG6J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:19:36 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-aTI7iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:19:36 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-iYZSyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:19:36 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-ktJ_aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:19:36 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-gtxMxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:19:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-V7auQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:19:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-8VImq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:19:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-HZ1WwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:19:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-71GMmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:19:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-6B_ga_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:19:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-24p4Ir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:19:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-0uL1TS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:19:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-0x6yIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:19:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-knBH7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:37 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-bnzyVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:19:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-I6JeI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:19:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:19:38 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-_XXJlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:19:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:19:38 INFO - Running setup.py install for manifestparser 20:19:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:19:38 INFO - Running setup.py install for mozcrash 20:19:38 INFO - Running setup.py install for mozdebug 20:19:38 INFO - Running setup.py install for mozdevice 20:19:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:19:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:19:38 INFO - Running setup.py install for mozfile 20:19:39 INFO - Running setup.py install for mozhttpd 20:19:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:19:39 INFO - Running setup.py install for mozinfo 20:19:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:19:39 INFO - Running setup.py install for mozInstall 20:19:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:19:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:19:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:19:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:19:39 INFO - Running setup.py install for mozleak 20:19:39 INFO - Running setup.py install for mozlog 20:19:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:19:39 INFO - Running setup.py install for moznetwork 20:19:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:19:39 INFO - Running setup.py install for mozprocess 20:19:40 INFO - Running setup.py install for mozprofile 20:19:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:19:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:19:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:19:40 INFO - Running setup.py install for mozrunner 20:19:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:19:40 INFO - Running setup.py install for mozscreenshot 20:19:40 INFO - Running setup.py install for moztest 20:19:40 INFO - Running setup.py install for mozversion 20:19:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:19:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:19:40 INFO - Cleaning up... 20:19:40 INFO - Return code: 0 20:19:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19: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:19:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19: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:19:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e4aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95d8dabb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ceed30>, '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 0x105b12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ce5b20>, '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.IHTlkqM1cV/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.cgmpNzYehT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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:19:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:19:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:19:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IHTlkqM1cV/Render', 20:19:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:19:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:19:40 INFO - 'HOME': '/Users/cltbld', 20:19:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:19:40 INFO - 'LOGNAME': 'cltbld', 20:19:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:40 INFO - 'MOZ_NO_REMOTE': '1', 20:19:40 INFO - 'NO_EM_RESTART': '1', 20:19:40 INFO - 'PAGER': '/bin/cat', 20:19:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:19:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:40 INFO - 'PWD': '/builds/slave/test', 20:19:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:19:40 INFO - 'SHELL': '/bin/bash', 20:19:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cgmpNzYehT/Listeners', 20:19:40 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 20:19:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:19:40 INFO - 'USER': 'cltbld', 20:19:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:19:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:19:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:40 INFO - 'XPC_FLAGS': '0x0', 20:19:40 INFO - 'XPC_SERVICE_NAME': '0', 20:19:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:19:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:19:41 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-s6lvIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:19:41 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:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:19:41 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-gbUt6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:19:41 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:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:19:41 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-eOmy_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:19:41 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-8DhkbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:19:41 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-t3NlZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:19:41 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-oQPp4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:19:41 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-eTxgqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:19:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:19:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:19:41 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-c5L1Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:19:42 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:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:19:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-GZBUHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:19:42 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:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:19:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-X8nBSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:19:42 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:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:19:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-TihP9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:19:42 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:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:19:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-YT_uio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:19:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-hMhfYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:19:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-tpCsFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-1aKRO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:19:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-eqCoAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:19:42 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-Q7oX2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:19:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:19:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:45 INFO - Downloading blessings-1.6.tar.gz 20:19:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:19:45 INFO - Installing collected packages: blessings 20:19:45 INFO - Running setup.py install for blessings 20:19:45 INFO - Successfully installed blessings 20:19:45 INFO - Cleaning up... 20:19:45 INFO - Return code: 0 20:19:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:19:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:19:46 INFO - Reading from file tmpfile_stdout 20:19:46 INFO - Current package versions: 20:19:46 INFO - blessings == 1.6 20:19:46 INFO - blobuploader == 1.2.4 20:19:46 INFO - docopt == 0.6.1 20:19:46 INFO - manifestparser == 1.1 20:19:46 INFO - mozInstall == 1.12 20:19:46 INFO - mozcrash == 0.17 20:19:46 INFO - mozdebug == 0.1 20:19:46 INFO - mozdevice == 0.48 20:19:46 INFO - mozfile == 1.2 20:19:46 INFO - mozhttpd == 0.7 20:19:46 INFO - mozinfo == 0.9 20:19:46 INFO - mozleak == 0.1 20:19:46 INFO - mozlog == 3.2 20:19:46 INFO - moznetwork == 0.27 20:19:46 INFO - mozprocess == 0.22 20:19:46 INFO - mozprofile == 0.28 20:19:46 INFO - mozrunner == 6.11 20:19:46 INFO - mozscreenshot == 0.1 20:19:46 INFO - mozsystemmonitor == 0.3 20:19:46 INFO - moztest == 0.7 20:19:46 INFO - mozversion == 1.4 20:19:46 INFO - psutil == 3.1.1 20:19:46 INFO - requests == 1.2.3 20:19:46 INFO - wsgiref == 0.1.2 20:19:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:46 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 0x105e4aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95d8dabb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ceed30>, '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 0x105b12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ce5b20>, '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.IHTlkqM1cV/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.cgmpNzYehT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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:19:46 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:19:46 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:19:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IHTlkqM1cV/Render', 20:19:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:19:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:19:46 INFO - 'HOME': '/Users/cltbld', 20:19:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:19:46 INFO - 'LOGNAME': 'cltbld', 20:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:46 INFO - 'MOZ_NO_REMOTE': '1', 20:19:46 INFO - 'NO_EM_RESTART': '1', 20:19:46 INFO - 'PAGER': '/bin/cat', 20:19:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:46 INFO - 'PWD': '/builds/slave/test', 20:19:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:19:46 INFO - 'SHELL': '/bin/bash', 20:19:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cgmpNzYehT/Listeners', 20:19:46 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 20:19:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:19:46 INFO - 'USER': 'cltbld', 20:19:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:19:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:46 INFO - 'XPC_FLAGS': '0x0', 20:19:46 INFO - 'XPC_SERVICE_NAME': '0', 20:19:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:46 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:19:46 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:19:46 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:19:46 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:19:46 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:19:46 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:19:46 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:19:46 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:19:46 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:19:46 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:19:46 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:19:46 INFO - Cleaning up... 20:19:46 INFO - Return code: 0 20:19:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e4aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95d8dabb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ceed30>, '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 0x105b12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ce5b20>, '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.IHTlkqM1cV/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.cgmpNzYehT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:19:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IHTlkqM1cV/Render', 20:19:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:19:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:19:46 INFO - 'HOME': '/Users/cltbld', 20:19:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:19:46 INFO - 'LOGNAME': 'cltbld', 20:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:46 INFO - 'MOZ_NO_REMOTE': '1', 20:19:46 INFO - 'NO_EM_RESTART': '1', 20:19:46 INFO - 'PAGER': '/bin/cat', 20:19:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:46 INFO - 'PWD': '/builds/slave/test', 20:19:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:19:46 INFO - 'SHELL': '/bin/bash', 20:19:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cgmpNzYehT/Listeners', 20:19:46 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 20:19:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:19:46 INFO - 'USER': 'cltbld', 20:19:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:19:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:46 INFO - 'XPC_FLAGS': '0x0', 20:19:46 INFO - 'XPC_SERVICE_NAME': '0', 20:19:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:19:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:46 INFO - Downloading/unpacking jsonschema 20:19: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:19: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:19: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:19: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:19: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:19: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:19:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:19:48 INFO - Downloading/unpacking functools32 (from jsonschema) 20:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:49 INFO - Downloading functools32-3.2.3-2.tar.gz 20:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:19:49 INFO - warning: no files found matching '*.txt' 20:19:49 INFO - no previously-included directories found matching 'build' 20:19:49 INFO - no previously-included directories found matching 'dist' 20:19:49 INFO - no previously-included directories found matching '.git*' 20:19:49 INFO - Installing collected packages: jsonschema, functools32 20:19:49 INFO - Running setup.py install for functools32 20:19:49 INFO - warning: no files found matching '*.txt' 20:19:49 INFO - no previously-included directories found matching 'build' 20:19:49 INFO - no previously-included directories found matching 'dist' 20:19:49 INFO - no previously-included directories found matching '.git*' 20:19:49 INFO - Successfully installed jsonschema functools32 20:19:49 INFO - Cleaning up... 20:19:49 INFO - Return code: 0 20:19:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:19:49 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 0x105e4aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e50570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f95d8dabb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ceed30>, '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 0x105b12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ce5b20>, '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.IHTlkqM1cV/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.cgmpNzYehT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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:19:49 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:19:49 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:19:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IHTlkqM1cV/Render', 20:19:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:19:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:19:49 INFO - 'HOME': '/Users/cltbld', 20:19:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:19:49 INFO - 'LOGNAME': 'cltbld', 20:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:19:49 INFO - 'MOZ_NO_REMOTE': '1', 20:19:49 INFO - 'NO_EM_RESTART': '1', 20:19:49 INFO - 'PAGER': '/bin/cat', 20:19:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:19:49 INFO - 'PWD': '/builds/slave/test', 20:19:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:19:49 INFO - 'SHELL': '/bin/bash', 20:19:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cgmpNzYehT/Listeners', 20:19:49 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 20:19:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:19:49 INFO - 'USER': 'cltbld', 20:19:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:19:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:19:49 INFO - 'XPC_FLAGS': '0x0', 20:19:49 INFO - 'XPC_SERVICE_NAME': '0', 20:19:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:19:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:19:49 INFO - Downloading/unpacking flake8 20:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:19:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:19:52 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:19:52 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:19:52 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:19:52 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:19:52 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:19:52 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:19:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:19:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:19:52 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:19:52 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:19:52 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:19:52 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:19:52 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:19:52 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:19:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:19:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:19:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:19:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:19:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:19:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:19:53 INFO - no previously-included directories found matching 'docs/_build' 20:19:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:19:53 INFO - Running setup.py install for pep8 20:19:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:19:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:19:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:19:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:19:53 INFO - no previously-included directories found matching 'docs/_build' 20:19:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:19:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:19:54 INFO - Cleaning up... 20:19:54 INFO - Return code: 0 20:19:54 INFO - Running post-action listener: _resource_record_post_action 20:19:54 INFO - Running post-action listener: _start_resource_monitoring 20:19:54 INFO - Starting resource monitoring. 20:19:54 INFO - ##### 20:19:54 INFO - ##### Finished create-virtualenv step (success) 20:19:54 INFO - ##### 20:19:54 INFO - ##### 20:19:54 INFO - ##### Running install step. 20:19:54 INFO - ##### 20:19:54 INFO - Running pre-action listener: _resource_record_pre_action 20:19:54 INFO - Running main action method: install 20:19:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:19:54 INFO - Reading from file tmpfile_stdout 20:19:54 INFO - Detecting whether we're running mozinstall >=1.0... 20:19:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:19:54 INFO - Reading from file tmpfile_stdout 20:19:54 INFO - Output received: 20:19:54 INFO - Usage: mozinstall [options] installer 20:19:54 INFO - Options: 20:19:54 INFO - -h, --help show this help message and exit 20:19:54 INFO - -d DEST, --destination=DEST 20:19:54 INFO - Directory to install application into. [default: 20:19:54 INFO - "/builds/slave/test"] 20:19:54 INFO - --app=APP Application being installed. [default: firefox] 20:19:54 INFO - mkdir: /builds/slave/test/build/application 20:19:54 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:19:54 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:20:28 INFO - Reading from file tmpfile_stdout 20:20:28 INFO - Output received: 20:20:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:20:28 INFO - Running post-action listener: _resource_record_post_action 20:20:28 INFO - ##### 20:20:28 INFO - ##### Finished install step (success) 20:20:28 INFO - ##### 20:20:28 INFO - ##### 20:20:28 INFO - ##### Running run-tests step. 20:20:28 INFO - ##### 20:20:28 INFO - Running pre-action listener: _resource_record_pre_action 20:20:28 INFO - Running main action method: run_tests 20:20:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:20:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:20:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:20:28 INFO - 2016-05-18 20:20:28.342 screenresolution[1652:7406] starting screenresolution argv=screenresolution get 20:20:28 INFO - 2016-05-18 20:20:28.345 screenresolution[1652:7406] Display 0: 1600x1200x32@60 20:20:28 INFO - 2016-05-18 20:20:28.351 screenresolution[1653:7413] starting screenresolution argv=screenresolution list 20:20:28 INFO - Available Modes on Display 0 20:20:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:20:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:20:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:20:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:20:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:20:28 INFO - Intel Iris: 20:20:28 INFO - Chipset Model: Intel Iris 20:20:28 INFO - Type: GPU 20:20:28 INFO - Bus: Built-In 20:20:28 INFO - VRAM (Dynamic, Max): 1536 MB 20:20:28 INFO - Vendor: Intel (0x8086) 20:20:28 INFO - Device ID: 0x0a2e 20:20:28 INFO - Revision ID: 0x0009 20:20:28 INFO - Displays: 20:20:28 INFO - Display: 20:20:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:20:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:20:28 INFO - Display Serial Number: 1600x1200 60 20:20:28 INFO - Main Display: Yes 20:20:28 INFO - Mirror: Off 20:20:28 INFO - Online: Yes 20:20:28 INFO - Rotation: Supported 20:20:28 INFO - Return code: 0 20:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:20:28 INFO - Python 2.7.3 20:20:28 INFO - Return code: 0 20:20:28 INFO - grabbing minidump binary from tooltool 20:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:20:28 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 0x105ceed30>, '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 0x105b12db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105ce5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:20:28 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:20:28 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:20:28 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:20:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:20:28 INFO - Return code: 0 20:20:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:20:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:20:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:20:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:20:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:20:29 INFO - Return code: 0 20:20:29 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/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0390', '--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:20:29 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/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0390 --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:20:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IHTlkqM1cV/Render', 20:20:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:20:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:20:29 INFO - 'HOME': '/Users/cltbld', 20:20:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:20:29 INFO - 'LOGNAME': 'cltbld', 20:20:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:20:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:20:29 INFO - 'MOZ_NO_REMOTE': '1', 20:20:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:20:29 INFO - 'NO_EM_RESTART': '1', 20:20:29 INFO - 'PAGER': '/bin/cat', 20:20:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:20:29 INFO - 'PWD': '/builds/slave/test', 20:20:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:20:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:20:29 INFO - 'SHELL': '/bin/bash', 20:20:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cgmpNzYehT/Listeners', 20:20:29 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 20:20:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:20:29 INFO - 'USER': 'cltbld', 20:20:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:20:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:20:29 INFO - 'XPC_FLAGS': '0x0', 20:20:29 INFO - 'XPC_SERVICE_NAME': '0', 20:20:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:20:29 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/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0390', '--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:20:30 INFO - mozversion application_buildid: 20160518172746 20:20:30 INFO - mozversion application_changeset: e0fa395e4982a5225e73908a4a0816932043440d 20:20:30 INFO - mozversion application_display_name: Nightly 20:20:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:20:30 INFO - mozversion application_name: Firefox 20:20:30 INFO - mozversion application_remotingname: firefox 20:20:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:20:30 INFO - mozversion application_vendor: Mozilla 20:20:30 INFO - mozversion application_version: 49.0a1 20:20:30 INFO - mozversion platform_buildid: 20160518172746 20:20:30 INFO - mozversion platform_changeset: e0fa395e4982a5225e73908a4a0816932043440d 20:20:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 20:20:30 INFO - mozversion platform_version: 49.0a1 20:20:30 INFO - using testdate: 1463628030 20:20:30 INFO - actual date: 1463628030 20:20:30 INFO - starting webserver on 'localhost:49270' 20:20:30 INFO - SUITE-START | Running 2 tests 20:20:30 INFO - TEST-START | dromaeo_css 20:20:30 INFO - operating with platform_type : mac_ 20:20:30 INFO - Initialising browser for dromaeo_css test... 20:20:30 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpoZaNJk/profile http://localhost:49270/getInfo.html) 20:20:33 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 20:20:33 INFO - PROCESS | 1671 | colorDepth:24 20:20:33 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 20:20:33 INFO - PROCESS | 1671 | __metrics 20:20:33 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:20:33 INFO - TEST-INFO | 1671: exit 0 20:20:33 INFO - Browser initialized. 20:20:33 INFO - Running cycle 1/1 for dromaeo_css test... 20:20:33 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpoZaNJk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:45 INFO - PROCESS | 1674 | RSS: Main: 249651200 20:20:45 INFO - PROCESS | 1674 | 20:21:35 INFO - PROCESS | 1674 | 1463628095571 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:23:46 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 20:23:48 INFO - PROCESS | 1674 | RSS: Main: 263483392 20:23:48 INFO - PROCESS | 1674 | 20:26:50 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 20:26:50 INFO - PROCESS | 1674 | RSS: Main: 275046400 20:26:50 INFO - PROCESS | 1674 | 20:29:52 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 20:29:53 INFO - PROCESS | 1674 | RSS: Main: 277000192 20:29:53 INFO - PROCESS | 1674 | 20:32:55 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 20:32:55 INFO - PROCESS | 1674 | RSS: Main: 278712320 20:32:55 INFO - PROCESS | 1674 | 20:35:58 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 20:35:59 INFO - PROCESS | 1674 | RSS: Main: 281559040 20:35:59 INFO - PROCESS | 1674 | 20:39:02 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 20:39:02 INFO - PROCESS | 1674 | RSS: Main: 282722304 20:39:02 INFO - PROCESS | 1674 | 20:39:02 INFO - PROCESS | 1674 | __start_tp_report 20:39:02 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 20:39:02 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 20:39:02 INFO - PROCESS | 1674 | |i|pagename|runs| 20:39:02 INFO - PROCESS | 1674 | |0;dojo.html;3205.4453590008843;3223.0008697303824;3479.3215323012005;3509.3332266869293;3562.056055145387;4947.480514545975;5106.438291787905;5514.56621278467;5915.231019967404;5947.345791962881;5776.133579963008;5820.068788993762;5836.416358364161;5925.466707996279;5939.970300148493;5163.922541161885;5232.372115346164;5269.552088072499;5353.892922141555;5408.323959505062;5405.351357837065;5441.918371224435;5493.121100623901;5501.532369748556;5516.834494965137;5201.115810312237;5263.157894736862;5264.447233040514;5285.969235998982;5356;5281.841544753664;5296.788128474856;5299.629025968184;5345.732713364317;5364.7317634118135;5303.893922121536;5326.094563924142;5343.251944727741;5348.679079255218;5393.73031348435;5706.058500347479;5805.535557155417;5822.854428639275;5826;5856.707164641751;6242.5942313749465;6253.74985000604;6287.276963149251;6294.213223347082;6302.086197501382;6197.5351848611535;6270.498360131224;6293.244810622708;6300.495960323163;6320.336364681688;6054.969725151346;6099.9950350032095;6124.442937898176;6126.12073820451;6145.293291271471;6471.223453185554;6476.093346931433;6480.643564603992;6489.318621544764;6499.1876015498065;6157.138000679908;6198.783042593487;6245.18812554365;6246.593971391845;6287.402696743802;6272;6314.936850631527;6335.081413195061;6341.239051313872;6351.396617321347;6165.815025549241;6191.5665903387235;6199.101130336076;6258.186435763413;6267.1539342189135;5319.335083114611;6181.629102253879;6183.350748171467;6247.156633854372;6285.2457705075685;5083.466236045162;5089.898202035939;5093.9490605094215;5102.4642412546145;5147.562457191106;4531.388262584509;4563.771811409416;4591.127685739699;4592.494825569184;4613.192691279013;5221.216817477332;5754.021816291241;5921.792737254175;5973.641581505123;6028.397160284024;5540.390557038722;5653.886922261614;6110.694465276719;6326.335734747877;6365.2998170201245;5938.524918006549;6003.609765365325;6004.7598096076545;6027.57806953509;6037.1246169305205;5446.101393270145;5512.80705175325;5530.861728456821;5550.888982220414;5584.21820945068;6476.319986401454;6618.63597502142;6622.70197841108;6626.966865165739;6632.1709786276715;5388;6256;6379.457746091634;6381.712822923072;6383.425491705769;6376.39424254695;6469.644169570719;6516.869662606816;6606.8017959461295;6612.0743095965645;4769.642276829321;5369.6509726867625;6138.63168209891;6307.716152773228;6347.809565713036;5219.217117432264;6228.159198508143;6299.212598425197;6322.46259067966;6383.521235907233;5664.26364572603;6150.876982460236;6218.595791273553;6231.096491008688;6277.748890044347;5278.841634750964;6260.154879091265;6264.185655864709;6266.843328916813;6291.716872740829;6092.086187071975;6102.816915492543;6226.40849119333;6246;6252.124702541557;5200.2719619252575;6130.612163469634;6177.4749146321265;6265.530085243534;6268.717907694256;6192.164057852132;6213.844653883689;6231.314555398993;6250.3749625037135;6252.562320637512 20:39:02 INFO - PROCESS | 1674 | |1;ext.html;500.67205980083037;522.6550476685387;531.2244123579574;536.3670868375318;538.0610834094506;37627.43558846619;41630.58369416305;41683.79158104205;41822.7908860456;41874;42518.362224566656;42671;42896.57103428965;43188.784056079676;43282.13435731283;9629.855552166706;9753.95123024384;9767.658131965383;9865.062819032217;9872.555734991907;9665.613375464973;9689.127978481934;9757.560909759042;9765.511724413787;9777.657781977632;9784.804303913917;9797.706068817912;9800.754981125458;9824.06671366219;9827.705168844946;9723.611055557769;9778.41329520231;9798.608055677765;9804.754881127958;9829.21366290695;9492.762680933032;9599.376040557341;9619.422834629875;9627.56675949584;9640.276979226586;39315.01712457183;39407.40888886669;39558.60441395578;39820.80089599563;39823.60176398228;3192.361527694447;3282.031800618823;3415.7096646785053;3418.7265018798435;3498.5801703795705;28253.57619635707;28820.694344452393;28827.711722882712;29399.412011759858;29956.251093722614;2740.739629735172;2777.4028583854365;2777.8611069446447;2792.7207279272116;2916.1543152485756;525338;527373.7262627401;530160.3491982555;530583;533776;65053;65206.69586608336;65410;65669.67165164143;65771.34228657748;36348.09129771777;36672.81663591718;37294.62705372911;38369.61630383716;38424.65513707007;16816.327346905986;16939.237734301987;16965.745513817303;16974.811763176458;17001.40495082691;13017.47930082805;13070.673233169247;13139.211647301192;13145.737085258432;13211.14127581704;16536.255868485947;18129.821561598455;18576.164072616764;19864.808111513354;20190;6981.755638552626;8169;8177.304929081095;8272;8307.958460207781;890.550272112579;897.8518544440225;1052.4106500359824;1103.1285284625217;1134.126722423729;26467.808948597358;26479.80840862166;26672.199834005012;27446.313842154104;28194.872205111977;1052.4685034057752;1152.5389844062443;1175.3359351966112;1204.349651188366;1262.949482020709;12222.694432639255;15150.31823567942;15232.390704371923;15400;15569.455069072754;699895;712420;735042;735640;737266.3136684282;58750;60598;60648.361098334244;61165.38834611686;61337;1262.9368531573568;1462.9195394253206;1492.7536956402073;1509.4264179611678;1513.2660659579874;24798;28118.859405703657;28521.714782852738;28939.7106028937;29023.274418139714;49182;49196.75401622969;49538;49539.50460495349;49573;493920;498176;607692;610554.947225261;611815;26404;26595.867020664773;26693.332666683487;26754.732452676002;27082;45354;45871;46214.53785462103;46962.29556556586;47159;36548.81725591461;37745;38215.42676859905;38303.616963830005;38843.446262150326;37018.17351462223;37517.4372384409;37683.246335073694;38106.47574097116;38548.80725596354;37334;37357.813210933775;37936.24127517489;38066.42900356552;38272.42591361076;32882.67117328796;33049.669503304656;33971;34065.659343406245;34092.80675176456;24007.63988540208;25022;25191.37021574402;25259.74740252574;25434.982600695766 20:39:02 INFO - PROCESS | 1674 | |2;jquery.html;392.9449877017218;398.76273617197756;402.39841437051615;406.4391140226487;421.90928950275685;20269.682470639396;20418.183272669114;21028.474288142785;21380.144794208252;21584.244551440705;12140.332281724524;12447.315397653125;19542.902285488588;20804.2718504852;21120.57758844822;5344.118220493614;5579.386267510591;5944.375840536746;5964.165016897616;6014.5188384929315;3637.7453578249533;5747.540196784247;5829.417058294158;6099.024156135019;6111.908321375183;6006.279246490427;6143.600665956698;6144.2319710036245;6154.815355539341;6158.199434073565;5595.300587426572;6706.966465167643;6708.463322934203;6708.563943343692;6718.865622687567;5233.712145831978;5879.617824841414;5930.762769489215;5944.494717948979;5971.835492079046;10471.47642617866;12306.753864922652;13652.317384130853;13873.58379248624;23622.76377236223;2075.294399904025;2119.9788002119935;2188.321620297713;2191.9342419727272;2298.9195378161853;9793.265505087147;9876.654317098866;9965.850512242323;10154.390736555757;10183.388996660224;1435.8492358302333;1675;1730.0484733396581;1813.7732783402075;1835.220031486613;128576;131016;131484.68515314916;133888;134724;11726.824097638542;11831.645050648322;11871.762564748657;11906.583269585522;11949.044076473861;15376.461823836113;15415.997960132556;15461.226938653022;15470.149141797308;15497;7379.6679149438405;8656.8701469478;8832.160944710242;8854.203121719076;9012;8715.477071375737;8717.52053637056;8758.912410875937;8779.341549383695;8894.021657617657;4709.270063140219;4710.505396933341;4764.761761911891;4811.230203167546;4813.590844778163;1647.8269781672752;1806.620021000365;1958.529952811315;2005.7091721700563;2025.6050070236456;864.6541383446672;912.6851236323457;973.2262851033446;1025.2625489941872;1080.7892460970193;17602.647947040987;18019.18913648889;18934.526636833914;20493.2827351042;20654.58690826175;950.7955789505152;952.4428209497383;989.9950500247453;1008.2337423558149;1062.4740753327153;10163.644272450576;10671.46642667879;10873.67680988647;10980.396078215776;11001.394923279297;595394;607480;623039;624842;637693;110998.89506077082;129303.35348323199;129413.35293323472;130269;134880.9767853483;995.7062666513395;1018;1029.2023681646783;1043.7703705184847;1046.2937517175876;15171.468998584996;18261.908690456996;18448.446546603624;18464.907675461538;18472.81527184711;53285.7335713319;54586.727066364416;55227.72386138044;55814;55930;77744.16336603987;77953;77989.61005195165;78910;80426;8147.307478864126;8208.917910820815;8291.626876790438;8507.106753790762;8517.829643406973;11573.594924177612;12540.811887821872;12754.170978886343;12789.488420463078;12973.091883568437;10380.896191037993;10681.145508359468;10753.602031735823;10936.671899843017;11020.228583999364;9735.513224338896;9997.800043999225;10670.786584268426;10991.670249892515;11246.943765281121;10634.627788027381;11032.393218373067;11274.154438417316;11412.942935285271;11511.76976460483;8101.675932962616;8180.304674102768;8254.50989782894;8405.663773448994;8469.872951905603;8312.168783121639;9210.861837072584;10457;11054.889451105386;11321.773564528829 20:39:02 INFO - PROCESS | 1674 | |3;mootools.html;1557.4159690116207;1585.9603509912251;1601.367459853358;1927.1809480970585;1948.1428171604484;7413.666385012674;8254.54599997;8709.477431354124;8935.955320223398;9290.070992900715;8850.026497085315;8952.641894324235;9064.821573195475;9091.363604547685;9111.316651251149;2459.655648209252;2467.383154211447;2498.9250322490266;2508.8996440142373;2543.2878793937634;2447.8531288122767;2485.3165379520597;2486.316263027664;2488.7635674610883;2489.427431690712;2454.5459090068393;2463.285647162321;2479.41733692583;2482.391814005571;2488.5645012122895;2439.280412278373;2454.349597356693;2468.3212116667883;2468.6420469031978;2469.3949982254285;2439.414540510265;2454.8036157107567;2461.2616215135386;2461.2985299189645;2468.333549941524;9020.458772473672;9047.502387368691;9112.316576256808;9125.908740912571;9139.223166030895;5407.188921661782;5513.117901135799;5576.553875689935;5581.74882130301;5583.162525621149;3666.138457462494;3701.7038636908983;3721.423179407196;3732.234891847165;3740.4202348636004;963.8939716631165;1000.489750227382;1059.6238335390979;1061.1457776489922;1064.5528877871313;10104.292699511037;12117.030637548974;12326.32205228712;12341.197822141532;12497.062720296015;4927.728974906415;4943.703377797344;4987.900241995139;5002.624803139706;5057.190849464142;10235.385876847413;10327;10340.121089707309;10345.844812327821;10396.584136634601;5470.370907345627;5503.367112782082;5524.861878452991;5574.944250557523;5604.663720176803;4562.06477672083;4895.804167833318;5016.523430274118;5048.444671086178;5088.414832294259;4100.5899410058755;4127.133302006552;4133.607307305801;4136.090060186814;4151.647109995623;1349.117712754061;1356.8846648035028;1373.7527245095778;1382.5852244326863;1393.6794537256285;769.6151924037981;864.7924498120406;888.8044630181479;918.6141820435433;944.7779771753633;6111.205543279434;6153.5692501525355;6239.719212635442;6304.117423560705;6391.904121438182;946.6450081219542;981.4405788700373;996.6810620601337;1005.0251256281396;1040.942748148844;4045.3527435610163;4108.424820525129;4124.793760312033;4176.373543968369;4184.351425529047;9569.760755981157;11157.051650609788;11159.497822598003;11188.832167517494;11205.495752690986;10624.946875265729;11009.2843965142;11024;11050.005499505083;11143.609973651046;8307.37694672902;8347.373946953881;8424.157584241526;8424.831503369898;8514.106018868053;5446.700431476148;5919.6744179070565;6003.309619393825;6013.579049466495;6209.658468784261;9637.951810241184;10004.699859004242;10203.38779673222;10226.6420675276;10296.485175741032;9917.900820991697;10274.434906080238;10288.897111028793;10389.37663740178;10390.168786496912;6909.032735417146;6948.20095688982;7813.1796161402235;8064.83870322602;8154.918450815416;8564.143585641636;8582.227599516074;8622.094680058504;8639.352048596254;8642.82714345697;7503.887441688488;7652.196519365387;7738.148803631483;7795.103563090317;7798.142204357403;6900.6204658744255;6954.408875245458;7466.514676546007;7524.209957954555;7559.168491465824;7070.010198572307;7076.575405475688;7219.0976127984;7220.025296585104;7234.059572255573;4278.144371125725;4521.367008618862;4578.381918440968;4833.975830120827;5184.502027985132;4908.214685650279;4918.803247870188;5085.46602606721;5197.350331208599;5215.921761173661 20:39:02 INFO - PROCESS | 1674 | |4;prototype.html;318.53175831527653;320.64888946603475;324.65748635189874;325.95599594054795;332.73547529713875;4617.746023968689;4923.55687988081;5083.999999999995;5581.330240371156;5645.12500562413;4590.921133533625;5459.781608735646;5490.725463726818;5521.309836270466;5564.497585651871;3701.519392243111;3984.6613037891816;4003.5387083714454;4211.515675697304;4220.678626755288;3608.458731190316;4136.607022332873;4138.234426631067;4175.937360939588;4204.873853784391;3926.9410958835642;3987.3620220764683;4183.393407955845;4216.578342165774;4221.008063105168;3621.2214373909605;3802.8288727007352;4009.558948515661;4116.9794151029055;4199.572145470524;3553.07620018797;3562.3765840977985;3567.23304489536;3586.2648157127987;3607.1703508193264;4967.850964471072;5267.894642107175;5277.234800953878;5277.525022747971;5288.391834938992;4511;4766.547178018118;4780.928286075712;4783.449903261135;4787.880302992418;5225.923779452033;5469.343678758574;5488.17677348397;5738.622730544681;5795.449432303924;3486.3201675673254;3539.734519911017;3958.8614398495915;3962.2471730371135;4058.3563656719075;5806.65160090396;6083.604565703259;6140.785072522485;6151.415615516519;6166.5375096867465;3448.3965306071336;3849.40334248192;3853.9807300963316;3861.613838616116;4034.576369481221;3733.533308336458;4027.4293025719994;4062.410950412174;4064.349704047338;4078.4494093297026;4774.71351718891;4780.211265141283;4783.832565860248;4786.917690804511;4793.472718001017;5426.918596220981;5855.795047173414;5873.001589729756;5878.794242201588;5919;1365.269580774281;1389.5067251125906;1400.348837790412;1404.1996062244627;1406.9788953165505;820.7045463633087;854.0946596607616;856.7215654912178;862.7963990233715;895.7772640345881;4419.138268037702;4741.976290118528;5041.722705251246;5403.703740718237;5412.621116521885;5875.9118613220835;5992.31088424828;5998.580099393088;6007.729652165663;6014.488768454643;4980.103581355318;5060.671056381397;5194.013137503862;5389.922015596818;5416.864578385493;2793.52510073288;2805.5931889875856;2865.996901084604;2869.909434414909;3138.623365196191;6063.090126610192;6178.505719542426;6184.484801223729;6207.937920620736;6235.937640623536;4796.904061918742;6032.879342413127;6229.750809967551;6247.812565623039;6291.276503202191;5734.942650573525;5873;6277.610090551234;6303.2751233607805;6334.334894836068;4763.809447622057;5401.837944861661;5671.362816290445;5954.243498168137;6021.819345419469;5827.5629327801435;5930.318013428511;5944.762209511571;5963.254593175853;6037.184980027816;5617.792174682463;5748.223989761329;5886.930103236863;6184.907226391698;6266.530010249158;3973;4010.1779135276615;4058.675305975574;4060.5127384714024;4067.1255680028935;5647.971760141173;5738.913916291175;5886.35182148999;6053.093275618166;6091.786787462417;5592.508750760452;5859.794907178229;5906.793262235973;5960.8674351873005;5972.313183983897;5329.866753331198;5890.848396108062;5898.852528686817;5911.645301281937;6007.729652165751;4960.454350021567;5414.675119492843;5786.623869448473;5820.912686309624;5830.854228644318;5167.302414174038;5174.068667639861;5261;5847.473727364558;5906.110044785627;4647.395838541103;4856.975715121402;5096.898062038813;5741.851629673998;5831.329397119385 20:39:02 INFO - PROCESS | 1674 | |5;yui.html;675.533881621681;698.2877464985714;720.6288761287934;723.2116992478198;743.0637396879931;14610.26948652567;14998.625034374147;15112.395504179833;15316.46392376267;15444.22778861058;14362.425502979895;14424.278786060708;14475.638109047279;14476.927615361908;14511;709.6912842913323;723.1936390924108;920.236203950721;920.8250432417852;936.166811537732;890.9331800114985;922.6724512797961;925.047201382577;928.6471140966423;932.5011119051309;936.8220038192756;982.008171746534;986.2455221755328;988.5946761827616;988.8961659025806;926.9304802139833;927.5825878354734;952.9571169297399;959.9376040557377;976.0337266106575;690.4890381117987;691.9965400173018;705.4215543254534;728.1007955175354;730.5251586468785;12516.874831251662;15065.322060507195;15185.088894666356;15206.239688015556;15241.085534867943;12477.251364918135;12635.178713383693;12670.366481675972;12687.619371418872;12787.424565894557;8580.613872375758;9709.805803883954;9838.262130340254;9953.950230248875;10403.47982600867;3455.94816077759;3466.204506065854;3500.6499350065046;3519.3137338219058;3596.478510615946;59206;63917.08248752545;75765.62117189378;80122.19877801205;80726;7860.410469214832;8348.872902158253;9448.669296574724;9561.808763824685;9577.808443831085;22305.219317323816;22315.99578018993;22368;22436.887815560818;22453.887730561244;7377;7481.551106933602;7496.212897645778;7614.619269036526;7782.883256751154;4089.672826173899;4111.5815043809835;4148.128892932457;4150.107726838683;4150.875473735793;3522.0314413536485;3626.2747450510005;3635.4365073413665;3638.7452878298795;3638.9265166775335;632.6299115017766;639.8432384065841;644.1979735229669;649.2566011916424;652.9347065293433;529.9364076310791;537.9004884096455;557.5456003357251;569.2883895131087;576.4322142689448;7090;7727.493138837873;8002.9599852000365;8313.625886835107;8329.6668133274;515.8865049689063;528.8202011316171;555.2171438272017;613.984650383744;618.5113760129448;3645;3810.8948404962252;3881.1849511602313;3948.993006783252;4046.0491784430637;89025.55487222523;89187;89895;90924;92084.53957730168;77377.61311193409;77637.22362776414;78292.60853695695;78336;79171;71379.57240855257;74358.6282068597;75297.62351188209;75363;75946.24053759391;7459.589722565311;7494.437917156126;7700.576468294297;7728.111267204344;7797.321607035733;42966.78516607397;43886.78056609824;44316.778416107714;44809.775951120035;44882.326765097896;49356.75321623369;57598.7120064397;58024.4197558019;59679.70160149172;59894.80210395855;10376.429296388771;10419.583216671248;10510.632127875488;10523;10888.891111088788;10901.890981090088;10932.344059356465;10960.945195273973;11252.831207532057;11398.715032124263;10516.947415263181;10569.894301056891;10819.026287634151;10904.945475272572;10948.288361256493;10404.947975260075;10420.06219440254;10434.582616695247;10784.622538211124;10823.729406764578;10365.9481702591;10372.27394082407;10706.304090234109;10715.303505272132;10728.73178170552;7530.209328020479;8600.311975041857;8625.663022231563;8736.650533978569;8937.642494300155;8389;8452.37738712044;8615.827683446421;8957.955210223907;8961 20:39:02 INFO - PROCESS | 1674 | __end_tp_report 20:39:02 INFO - PROCESS | 1674 | __start_cc_report 20:39:02 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,422 20:39:02 INFO - PROCESS | 1674 | __end_cc_report 20:39:02 INFO - PROCESS | 1674 | __startTimestamp1463629142328__endTimestamp 20:39:02 INFO - PROCESS | 1674 | 20:39:02 INFO - PROCESS | 1674 | ------- Summary: start ------- 20:39:02 INFO - PROCESS | 1674 | Number of tests: 6 20:39:02 INFO - PROCESS | 1674 | 20:39:02 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5816.04 Median:6100.00 stddev:662.13 (10.9%) stddev-sans-first:631.70 20:39:02 INFO - PROCESS | 1674 | Values: 3205.4 3223.0 3479.3 3509.3 3562.1 4947.5 5106.4 5514.6 5915.2 5947.3 5776.1 5820.1 5836.4 5925.5 5940.0 5163.9 5232.4 5269.6 5353.9 5408.3 5405.4 5441.9 5493.1 5501.5 5516.8 5201.1 5263.2 5264.4 5286.0 5356.0 5281.8 5296.8 5299.6 5345.7 5364.7 5303.9 5326.1 5343.3 5348.7 5393.7 5706.1 5805.5 5822.9 5826.0 5856.7 6242.6 6253.7 6287.3 6294.2 6302.1 6197.5 6270.5 6293.2 6300.5 6320.3 6055.0 6100.0 6124.4 6126.1 6145.3 6471.2 6476.1 6480.6 6489.3 6499.2 6157.1 6198.8 6245.2 6246.6 6287.4 6272.0 6314.9 6335.1 6341.2 6351.4 6165.8 6191.6 6199.1 6258.2 6267.2 5319.3 6181.6 6183.4 6247.2 6285.2 5083.5 5089.9 5093.9 5102.5 5147.6 4531.4 4563.8 4591.1 4592.5 4613.2 5221.2 5754.0 5921.8 5973.6 6028.4 5540.4 5653.9 6110.7 6326.3 6365.3 5938.5 6003.6 6004.8 6027.6 6037.1 5446.1 5512.8 5530.9 5550.9 5584.2 6476.3 6618.6 6622.7 6627.0 6632.2 5388.0 6256.0 6379.5 6381.7 6383.4 6376.4 6469.6 6516.9 6606.8 6612.1 4769.6 5369.7 6138.6 6307.7 6347.8 5219.2 6228.2 6299.2 6322.5 6383.5 5664.3 6150.9 6218.6 6231.1 6277.7 5278.8 6260.2 6264.2 6266.8 6291.7 6092.1 6102.8 6226.4 6246.0 6252.1 5200.3 6130.6 6177.5 6265.5 6268.7 6192.2 6213.8 6231.3 6250.4 6252.6 20:39:02 INFO - PROCESS | 1674 | 20:39:02 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:72600.95 Median:38397.14 stddev:164306.46 (427.9%) stddev-sans-first:164678.21 20:39:02 INFO - PROCESS | 1674 | Values: 500.7 522.7 531.2 536.4 538.1 37627.4 41630.6 41683.8 41822.8 41874.0 42518.4 42671.0 42896.6 43188.8 43282.1 9629.9 9754.0 9767.7 9865.1 9872.6 9665.6 9689.1 9757.6 9765.5 9777.7 9784.8 9797.7 9800.8 9824.1 9827.7 9723.6 9778.4 9798.6 9804.8 9829.2 9492.8 9599.4 9619.4 9627.6 9640.3 39315.0 39407.4 39558.6 39820.8 39823.6 3192.4 3282.0 3415.7 3418.7 3498.6 28253.6 28820.7 28827.7 29399.4 29956.3 2740.7 2777.4 2777.9 2792.7 2916.2 525338.0 527373.7 530160.3 530583.0 533776.0 65053.0 65206.7 65410.0 65669.7 65771.3 36348.1 36672.8 37294.6 38369.6 38424.7 16816.3 16939.2 16965.7 16974.8 17001.4 13017.5 13070.7 13139.2 13145.7 13211.1 16536.3 18129.8 18576.2 19864.8 20190.0 6981.8 8169.0 8177.3 8272.0 8308.0 890.6 897.9 1052.4 1103.1 1134.1 26467.8 26479.8 26672.2 27446.3 28194.9 1052.5 1152.5 1175.3 1204.3 1262.9 12222.7 15150.3 15232.4 15400.0 15569.5 699895.0 712420.0 735042.0 735640.0 737266.3 58750.0 60598.0 60648.4 61165.4 61337.0 1262.9 1462.9 1492.8 1509.4 1513.3 24798.0 28118.9 28521.7 28939.7 29023.3 49182.0 49196.8 49538.0 49539.5 49573.0 493920.0 498176.0 607692.0 610554.9 611815.0 26404.0 26595.9 26693.3 26754.7 27082.0 45354.0 45871.0 46214.5 46962.3 47159.0 36548.8 37745.0 38215.4 38303.6 38843.4 37018.2 37517.4 37683.2 38106.5 38548.8 37334.0 37357.8 37936.2 38066.4 38272.4 32882.7 33049.7 33971.0 34065.7 34092.8 24007.6 25022.0 25191.4 25259.7 25435.0 20:39:02 INFO - PROCESS | 1674 | 20:39:02 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:35572.52 Median:21482.19 stddev:103350.60 (481.1%) stddev-sans-first:103606.77 20:39:02 INFO - PROCESS | 1674 | Values: 392.9 398.8 402.4 406.4 421.9 20269.7 20418.2 21028.5 21380.1 21584.2 12140.3 12447.3 19542.9 20804.3 21120.6 5344.1 5579.4 5944.4 5964.2 6014.5 3637.7 5747.5 5829.4 6099.0 6111.9 6006.3 6143.6 6144.2 6154.8 6158.2 5595.3 6707.0 6708.5 6708.6 6718.9 5233.7 5879.6 5930.8 5944.5 5971.8 10471.5 12306.8 13652.3 13873.6 23622.8 2075.3 2120.0 2188.3 2191.9 2298.9 9793.3 9876.7 9965.9 10154.4 10183.4 1435.8 1675.0 1730.0 1813.8 1835.2 128576.0 131016.0 131484.7 133888.0 134724.0 11726.8 11831.6 11871.8 11906.6 11949.0 15376.5 15416.0 15461.2 15470.1 15497.0 7379.7 8656.9 8832.2 8854.2 9012.0 8715.5 8717.5 8758.9 8779.3 8894.0 4709.3 4710.5 4764.8 4811.2 4813.6 1647.8 1806.6 1958.5 2005.7 2025.6 864.7 912.7 973.2 1025.3 1080.8 17602.6 18019.2 18934.5 20493.3 20654.6 950.8 952.4 990.0 1008.2 1062.5 10163.6 10671.5 10873.7 10980.4 11001.4 595394.0 607480.0 623039.0 624842.0 637693.0 110998.9 129303.4 129413.4 130269.0 134881.0 995.7 1018.0 1029.2 1043.8 1046.3 15171.5 18261.9 18448.4 18464.9 18472.8 53285.7 54586.7 55227.7 55814.0 55930.0 77744.2 77953.0 77989.6 78910.0 80426.0 8147.3 8208.9 8291.6 8507.1 8517.8 11573.6 12540.8 12754.2 12789.5 12973.1 10380.9 10681.1 10753.6 10936.7 11020.2 9735.5 9997.8 10670.8 10991.7 11246.9 10634.6 11032.4 11274.2 11412.9 11511.8 8101.7 8180.3 8254.5 8405.7 8469.9 8312.2 9210.9 10457.0 11054.9 11321.8 20:39:02 INFO - PROCESS | 1674 | 20:39:02 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:5859.07 Median:4923.27 stddev:3255.27 (66.1%) stddev-sans-first:3248.35 20:39:02 INFO - PROCESS | 1674 | Values: 1557.4 1586.0 1601.4 1927.2 1948.1 7413.7 8254.5 8709.5 8936.0 9290.1 8850.0 8952.6 9064.8 9091.4 9111.3 2459.7 2467.4 2498.9 2508.9 2543.3 2447.9 2485.3 2486.3 2488.8 2489.4 2454.5 2463.3 2479.4 2482.4 2488.6 2439.3 2454.3 2468.3 2468.6 2469.4 2439.4 2454.8 2461.3 2461.3 2468.3 9020.5 9047.5 9112.3 9125.9 9139.2 5407.2 5513.1 5576.6 5581.7 5583.2 3666.1 3701.7 3721.4 3732.2 3740.4 963.9 1000.5 1059.6 1061.1 1064.6 10104.3 12117.0 12326.3 12341.2 12497.1 4927.7 4943.7 4987.9 5002.6 5057.2 10235.4 10327.0 10340.1 10345.8 10396.6 5470.4 5503.4 5524.9 5574.9 5604.7 4562.1 4895.8 5016.5 5048.4 5088.4 4100.6 4127.1 4133.6 4136.1 4151.6 1349.1 1356.9 1373.8 1382.6 1393.7 769.6 864.8 888.8 918.6 944.8 6111.2 6153.6 6239.7 6304.1 6391.9 946.6 981.4 996.7 1005.0 1040.9 4045.4 4108.4 4124.8 4176.4 4184.4 9569.8 11157.1 11159.5 11188.8 11205.5 10624.9 11009.3 11024.0 11050.0 11143.6 8307.4 8347.4 8424.2 8424.8 8514.1 5446.7 5919.7 6003.3 6013.6 6209.7 9638.0 10004.7 10203.4 10226.6 10296.5 9917.9 10274.4 10288.9 10389.4 10390.2 6909.0 6948.2 7813.2 8064.8 8154.9 8564.1 8582.2 8622.1 8639.4 8642.8 7503.9 7652.2 7738.1 7795.1 7798.1 6900.6 6954.4 7466.5 7524.2 7559.2 7070.0 7076.6 7219.1 7220.0 7234.1 4278.1 4521.4 4578.4 4834.0 5184.5 4908.2 4918.8 5085.5 5197.4 5215.9 20:39:02 INFO - PROCESS | 1674 | 20:39:02 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:4697.06 Median:5264.45 stddev:1471.18 (27.9%) stddev-sans-first:1438.13 20:39:02 INFO - PROCESS | 1674 | Values: 318.5 320.6 324.7 326.0 332.7 4617.7 4923.6 5084.0 5581.3 5645.1 4590.9 5459.8 5490.7 5521.3 5564.5 3701.5 3984.7 4003.5 4211.5 4220.7 3608.5 4136.6 4138.2 4175.9 4204.9 3926.9 3987.4 4183.4 4216.6 4221.0 3621.2 3802.8 4009.6 4117.0 4199.6 3553.1 3562.4 3567.2 3586.3 3607.2 4967.9 5267.9 5277.2 5277.5 5288.4 4511.0 4766.5 4780.9 4783.4 4787.9 5225.9 5469.3 5488.2 5738.6 5795.4 3486.3 3539.7 3958.9 3962.2 4058.4 5806.7 6083.6 6140.8 6151.4 6166.5 3448.4 3849.4 3854.0 3861.6 4034.6 3733.5 4027.4 4062.4 4064.3 4078.4 4774.7 4780.2 4783.8 4786.9 4793.5 5426.9 5855.8 5873.0 5878.8 5919.0 1365.3 1389.5 1400.3 1404.2 1407.0 820.7 854.1 856.7 862.8 895.8 4419.1 4742.0 5041.7 5403.7 5412.6 5875.9 5992.3 5998.6 6007.7 6014.5 4980.1 5060.7 5194.0 5389.9 5416.9 2793.5 2805.6 2866.0 2869.9 3138.6 6063.1 6178.5 6184.5 6207.9 6235.9 4796.9 6032.9 6229.8 6247.8 6291.3 5734.9 5873.0 6277.6 6303.3 6334.3 4763.8 5401.8 5671.4 5954.2 6021.8 5827.6 5930.3 5944.8 5963.3 6037.2 5617.8 5748.2 5886.9 6184.9 6266.5 3973.0 4010.2 4058.7 4060.5 4067.1 5648.0 5738.9 5886.4 6053.1 6091.8 5592.5 5859.8 5906.8 5960.9 5972.3 5329.9 5890.8 5898.9 5911.6 6007.7 4960.5 5414.7 5786.6 5820.9 5830.9 5167.3 5174.1 5261.0 5847.5 5906.1 4647.4 4857.0 5096.9 5741.9 5831.3 20:39:02 INFO - PROCESS | 1674 | 20:39:02 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:17486.83 Median:616.25 stddev:24620.32 (3995.2%) stddev-sans-first:24657.02 20:39:02 INFO - PROCESS | 1674 | Values: 675.5 698.3 720.6 723.2 743.1 14610.3 14998.6 15112.4 15316.5 15444.2 14362.4 14424.3 14475.6 14476.9 14511.0 709.7 723.2 920.2 920.8 936.2 890.9 922.7 925.0 928.6 932.5 936.8 982.0 986.2 988.6 988.9 926.9 927.6 953.0 959.9 976.0 690.5 692.0 705.4 728.1 730.5 12516.9 15065.3 15185.1 15206.2 15241.1 12477.3 12635.2 12670.4 12687.6 12787.4 8580.6 9709.8 9838.3 9954.0 10403.5 3455.9 3466.2 3500.6 3519.3 3596.5 59206.0 63917.1 75765.6 80122.2 80726.0 7860.4 8348.9 9448.7 9561.8 9577.8 22305.2 22316.0 22368.0 22436.9 22453.9 7377.0 7481.6 7496.2 7614.6 7782.9 4089.7 4111.6 4148.1 4150.1 4150.9 3522.0 3626.3 3635.4 3638.7 3638.9 632.6 639.8 644.2 649.3 652.9 529.9 537.9 557.5 569.3 576.4 7090.0 7727.5 8003.0 8313.6 8329.7 515.9 528.8 555.2 614.0 618.5 3645.0 3810.9 3881.2 3949.0 4046.0 89025.6 89187.0 89895.0 90924.0 92084.5 77377.6 77637.2 78292.6 78336.0 79171.0 71379.6 74358.6 75297.6 75363.0 75946.2 7459.6 7494.4 7700.6 7728.1 7797.3 42966.8 43886.8 44316.8 44809.8 44882.3 49356.8 57598.7 58024.4 59679.7 59894.8 10376.4 10419.6 10510.6 10523.0 10888.9 10901.9 10932.3 10960.9 11252.8 11398.7 10516.9 10569.9 10819.0 10904.9 10948.3 10404.9 10420.1 10434.6 10784.6 10823.7 10365.9 10372.3 10706.3 10715.3 10728.7 7530.2 8600.3 8625.7 8736.7 8937.6 8389.0 8452.4 8615.8 8958.0 8961.0 20:39:02 INFO - PROCESS | 1674 | -------- Summary: end -------- 20:39:02 INFO - PROCESS | 1674 | 20:39:02 INFO - TEST-INFO | 1674: exit 0 20:39:02 INFO - TEST-OK | dromaeo_css | took 1112890ms 20:39:02 INFO - TEST-START | kraken 20:39:02 INFO - operating with platform_type : mac_ 20:39:02 INFO - Initialising browser for kraken test... 20:39:02 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpEGibHQ/profile http://localhost:49270/getInfo.html) 20:39:05 INFO - PROCESS | 1687 | __metrics Screen width/height:1600/1200 20:39:05 INFO - PROCESS | 1687 | colorDepth:24 20:39:05 INFO - PROCESS | 1687 | Browser inner width/height: 1024/689 20:39:05 INFO - PROCESS | 1687 | __metrics 20:39:05 ERROR - PROCESS | 1687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 20:39:06 INFO - TEST-INFO | 1687: exit 0 20:39:06 INFO - Browser initialized. 20:39:06 INFO - Running cycle 1/1 for kraken test... 20:39:06 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpEGibHQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:39:18 INFO - PROCESS | 1690 | RSS: Main: 249810944 20:39:18 INFO - PROCESS | 1690 | 20:39:21 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 20:39:22 INFO - PROCESS | 1690 | RSS: Main: 261558272 20:39:22 INFO - PROCESS | 1690 | 20:39:25 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 20:39:25 INFO - PROCESS | 1690 | RSS: Main: 266321920 20:39:25 INFO - PROCESS | 1690 | 20:39:29 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 20:39:30 INFO - PROCESS | 1690 | RSS: Main: 266723328 20:39:30 INFO - PROCESS | 1690 | 20:39:32 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 20:39:32 INFO - PROCESS | 1690 | RSS: Main: 267292672 20:39:32 INFO - PROCESS | 1690 | 20:39:34 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:39:35 INFO - PROCESS | 1690 | RSS: Main: 267780096 20:39:35 INFO - PROCESS | 1690 | 20:39:38 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 20:39:39 INFO - PROCESS | 1690 | RSS: Main: 268337152 20:39:39 INFO - PROCESS | 1690 | 20:39:42 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 20:39:42 INFO - PROCESS | 1690 | RSS: Main: 268681216 20:39:42 INFO - PROCESS | 1690 | 20:39:46 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 20:39:46 INFO - PROCESS | 1690 | RSS: Main: 268730368 20:39:46 INFO - PROCESS | 1690 | 20:39:48 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:39:49 INFO - PROCESS | 1690 | RSS: Main: 268083200 20:39:49 INFO - PROCESS | 1690 | 20:39:50 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:39:51 INFO - PROCESS | 1690 | RSS: Main: 268140544 20:39:51 INFO - PROCESS | 1690 | 20:39:53 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:39:54 INFO - PROCESS | 1690 | RSS: Main: 268509184 20:39:54 INFO - PROCESS | 1690 | 20:39:57 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:39:58 INFO - PROCESS | 1690 | RSS: Main: 268836864 20:39:58 INFO - PROCESS | 1690 | 20:40:01 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:40:01 INFO - PROCESS | 1690 | RSS: Main: 268599296 20:40:01 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 20:40:03 INFO - PROCESS | 1690 | RSS: Main: 271290368 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | __start_tp_report 20:40:03 INFO - PROCESS | 1690 | _x_x_mozilla_page_load 20:40:03 INFO - PROCESS | 1690 | _x_x_mozilla_page_load_details 20:40:03 INFO - PROCESS | 1690 | |i|pagename|runs| 20:40:03 INFO - PROCESS | 1690 | |0;ai-astar;129;170;149;116;115;132;160;155;117;117 20:40:03 INFO - PROCESS | 1690 | |1;audio-beat-detection;154;120;141;214;116;138;139;120;199;138 20:40:03 INFO - PROCESS | 1690 | |2;audio-dft;196;207;271;260;206;273;270;195;201;194 20:40:03 INFO - PROCESS | 1690 | |3;audio-fft;73;85;74;189;77;65;59;65;130;68 20:40:03 INFO - PROCESS | 1690 | |4;audio-oscillator;79;82;134;77;81;88;118;81;83;118 20:40:03 INFO - PROCESS | 1690 | |5;imaging-gaussian-blur;91;87;89;88;126;86;91;86;90;87 20:40:03 INFO - PROCESS | 1690 | |6;imaging-darkroom;95;94;95;98;94;134;119;114;152;151 20:40:03 INFO - PROCESS | 1690 | |7;imaging-desaturate;89;92;90;92;91;118;143;140;91;113 20:40:03 INFO - PROCESS | 1690 | |8;json-parse-financial;57;60;60;60;57;59;60;116;60;76 20:40:03 INFO - PROCESS | 1690 | |9;json-stringify-tinderbox;63;69;75;69;73;69;64;65;65;67 20:40:03 INFO - PROCESS | 1690 | |10;stanford-crypto-aes;85;88;88;87;86;89;92;111;106;106 20:40:03 INFO - PROCESS | 1690 | |11;stanford-crypto-ccm;149;149;141;139;145;147;145;145;244;150 20:40:03 INFO - PROCESS | 1690 | |12;stanford-crypto-pbkdf2;145;173;188;182;144;204;215;188;177;214 20:40:03 INFO - PROCESS | 1690 | |13;stanford-crypto-sha256-iterative;59;83;84;84;75;66;66;65;66;66 20:40:03 INFO - PROCESS | 1690 | __end_tp_report 20:40:03 INFO - PROCESS | 1690 | __start_cc_report 20:40:03 INFO - PROCESS | 1690 | _x_x_mozilla_cycle_collect,1069 20:40:03 INFO - PROCESS | 1690 | __end_cc_report 20:40:03 INFO - PROCESS | 1690 | __startTimestamp1463629203960__endTimestamp 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | ------- Summary: start ------- 20:40:03 INFO - PROCESS | 1690 | Number of tests: 14 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#0] ai-astar Cycles:10 Average:136.00 Median:140.50 stddev:20.79 (14.8%) stddev-sans-first:21.90 20:40:03 INFO - PROCESS | 1690 | Values: 129.0 170.0 149.0 116.0 115.0 132.0 160.0 155.0 117.0 117.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#1] audio-beat-detection Cycles:10 Average:147.90 Median:140.00 stddev:33.19 (23.7%) stddev-sans-first:35.13 20:40:03 INFO - PROCESS | 1690 | Values: 154.0 120.0 141.0 214.0 116.0 138.0 139.0 120.0 199.0 138.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#2] audio-dft Cycles:10 Average:227.30 Median:233.50 stddev:35.87 (15.4%) stddev-sans-first:36.21 20:40:03 INFO - PROCESS | 1690 | Values: 196.0 207.0 271.0 260.0 206.0 273.0 270.0 195.0 201.0 194.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#3] audio-fft Cycles:10 Average:88.50 Median:70.50 stddev:40.57 (57.5%) stddev-sans-first:42.64 20:40:03 INFO - PROCESS | 1690 | Values: 73.0 85.0 74.0 189.0 77.0 65.0 59.0 65.0 130.0 68.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:81.00 stddev:20.83 (25.7%) stddev-sans-first:21.36 20:40:03 INFO - PROCESS | 1690 | Values: 79.0 82.0 134.0 77.0 81.0 88.0 118.0 81.0 83.0 118.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:88.50 stddev:12.06 (13.6%) stddev-sans-first:12.78 20:40:03 INFO - PROCESS | 1690 | Values: 91.0 87.0 89.0 88.0 126.0 86.0 91.0 86.0 90.0 87.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#6] imaging-darkroom Cycles:10 Average:114.60 Median:94.00 stddev:23.60 (25.1%) stddev-sans-first:23.94 20:40:03 INFO - PROCESS | 1690 | Values: 95.0 94.0 95.0 98.0 94.0 134.0 119.0 114.0 152.0 151.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#7] imaging-desaturate Cycles:10 Average:105.90 Median:90.50 stddev:21.36 (23.6%) stddev-sans-first:21.76 20:40:03 INFO - PROCESS | 1690 | Values: 89.0 92.0 90.0 92.0 91.0 118.0 143.0 140.0 91.0 113.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#8] json-parse-financial Cycles:10 Average:66.50 Median:60.00 stddev:18.22 (30.4%) stddev-sans-first:19.00 20:40:03 INFO - PROCESS | 1690 | Values: 57.0 60.0 60.0 60.0 57.0 59.0 60.0 116.0 60.0 76.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:69.00 stddev:3.90 (5.7%) stddev-sans-first:3.71 20:40:03 INFO - PROCESS | 1690 | Values: 63.0 69.0 75.0 69.0 73.0 69.0 64.0 65.0 65.0 67.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#10] stanford-crypto-aes Cycles:10 Average:93.80 Median:87.50 stddev:9.84 (11.2%) stddev-sans-first:9.91 20:40:03 INFO - PROCESS | 1690 | Values: 85.0 88.0 88.0 87.0 86.0 89.0 92.0 111.0 106.0 106.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#11] stanford-crypto-ccm Cycles:10 Average:155.40 Median:148.00 stddev:31.33 (21.2%) stddev-sans-first:33.14 20:40:03 INFO - PROCESS | 1690 | Values: 149.0 149.0 141.0 139.0 145.0 147.0 145.0 145.0 244.0 150.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.00 Median:188.00 stddev:24.90 (13.2%) stddev-sans-first:22.29 20:40:03 INFO - PROCESS | 1690 | Values: 145.0 173.0 188.0 182.0 144.0 204.0 215.0 188.0 177.0 214.0 20:40:03 INFO - PROCESS | 1690 | 20:40:03 INFO - PROCESS | 1690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:70.50 stddev:9.29 (13.2%) stddev-sans-first:8.70 20:40:03 INFO - PROCESS | 1690 | Values: 59.0 83.0 84.0 84.0 75.0 66.0 66.0 65.0 66.0 66.0 20:40:03 INFO - PROCESS | 1690 | -------- Summary: end -------- 20:40:03 INFO - PROCESS | 1690 | 20:40:04 INFO - TEST-INFO | 1690: exit 0 20:40:04 INFO - TEST-OK | kraken | took 61801ms 20:40:04 INFO - SUITE-END | took 1174s 20:40:05 INFO - Completed test suite (00:19:35) 20:40:05 INFO - javascript benchmark 20:40:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7244.2084058762375, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3205.4453590008843, 3223.0008697303824, 3479.3215323012005, 3509.3332266869293, 3562.056055145387, 4947.480514545975, 5106.438291787905, 5514.56621278467, 5915.231019967404, 5947.345791962881, 5776.133579963008, 5820.068788993762, 5836.416358364161, 5925.466707996279, 5939.970300148493, 5163.922541161885, 5232.372115346164, 5269.552088072499, 5353.892922141555, 5408.323959505062, 5405.351357837065, 5441.918371224435, 5493.121100623901, 5501.532369748556, 5516.834494965137, 5201.115810312237, 5263.157894736862, 5264.447233040514, 5285.969235998982, 5356.0, 5281.841544753664, 5296.788128474856, 5299.629025968184, 5345.732713364317, 5364.7317634118135, 5303.893922121536, 5326.094563924142, 5343.251944727741, 5348.679079255218, 5393.73031348435, 5706.058500347479, 5805.535557155417, 5822.854428639275, 5826.0, 5856.707164641751, 6242.5942313749465, 6253.74985000604, 6287.276963149251, 6294.213223347082, 6302.086197501382, 6197.5351848611535, 6270.498360131224, 6293.244810622708, 6300.495960323163, 6320.336364681688, 6054.969725151346, 6099.9950350032095, 6124.442937898176, 6126.12073820451, 6145.293291271471, 6471.223453185554, 6476.093346931433, 6480.643564603992, 6489.318621544764, 6499.1876015498065, 6157.138000679908, 6198.783042593487, 6245.18812554365, 6246.593971391845, 6287.402696743802, 6272.0, 6314.936850631527, 6335.081413195061, 6341.239051313872, 6351.396617321347, 6165.815025549241, 6191.5665903387235, 6199.101130336076, 6258.186435763413, 6267.1539342189135, 5319.335083114611, 6181.629102253879, 6183.350748171467, 6247.156633854372, 6285.2457705075685, 5083.466236045162, 5089.898202035939, 5093.9490605094215, 5102.4642412546145, 5147.562457191106, 4531.388262584509, 4563.771811409416, 4591.127685739699, 4592.494825569184, 4613.192691279013, 5221.216817477332, 5754.021816291241, 5921.792737254175, 5973.641581505123, 6028.397160284024, 5540.390557038722, 5653.886922261614, 6110.694465276719, 6326.335734747877, 6365.2998170201245, 5938.524918006549, 6003.609765365325, 6004.7598096076545, 6027.57806953509, 6037.1246169305205, 5446.101393270145, 5512.80705175325, 5530.861728456821, 5550.888982220414, 5584.21820945068, 6476.319986401454, 6618.63597502142, 6622.70197841108, 6626.966865165739, 6632.1709786276715, 5388.0, 6256.0, 6379.457746091634, 6381.712822923072, 6383.425491705769, 6376.39424254695, 6469.644169570719, 6516.869662606816, 6606.8017959461295, 6612.0743095965645, 4769.642276829321, 5369.6509726867625, 6138.63168209891, 6307.716152773228, 6347.809565713036, 5219.217117432264, 6228.159198508143, 6299.212598425197, 6322.46259067966, 6383.521235907233, 5664.26364572603, 6150.876982460236, 6218.595791273553, 6231.096491008688, 6277.748890044347, 5278.841634750964, 6260.154879091265, 6264.185655864709, 6266.843328916813, 6291.716872740829, 6092.086187071975, 6102.816915492543, 6226.40849119333, 6246.0, 6252.124702541557, 5200.2719619252575, 6130.612163469634, 6177.4749146321265, 6265.530085243534, 6268.717907694256, 6192.164057852132, 6213.844653883689, 6231.314555398993, 6250.3749625037135, 6252.562320637512], "value": 5776.368033725178, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.67205980083037, 522.6550476685387, 531.2244123579574, 536.3670868375318, 538.0610834094506, 37627.43558846619, 41630.58369416305, 41683.79158104205, 41822.7908860456, 41874.0, 42518.362224566656, 42671.0, 42896.57103428965, 43188.784056079676, 43282.13435731283, 9629.855552166706, 9753.95123024384, 9767.658131965383, 9865.062819032217, 9872.555734991907, 9665.613375464973, 9689.127978481934, 9757.560909759042, 9765.511724413787, 9777.657781977632, 9784.804303913917, 9797.706068817912, 9800.754981125458, 9824.06671366219, 9827.705168844946, 9723.611055557769, 9778.41329520231, 9798.608055677765, 9804.754881127958, 9829.21366290695, 9492.762680933032, 9599.376040557341, 9619.422834629875, 9627.56675949584, 9640.276979226586, 39315.01712457183, 39407.40888886669, 39558.60441395578, 39820.80089599563, 39823.60176398228, 3192.361527694447, 3282.031800618823, 3415.7096646785053, 3418.7265018798435, 3498.5801703795705, 28253.57619635707, 28820.694344452393, 28827.711722882712, 29399.412011759858, 29956.251093722614, 2740.739629735172, 2777.4028583854365, 2777.8611069446447, 2792.7207279272116, 2916.1543152485756, 525338.0, 527373.7262627401, 530160.3491982555, 530583.0, 533776.0, 65053.0, 65206.69586608336, 65410.0, 65669.67165164143, 65771.34228657748, 36348.09129771777, 36672.81663591718, 37294.62705372911, 38369.61630383716, 38424.65513707007, 16816.327346905986, 16939.237734301987, 16965.745513817303, 16974.811763176458, 17001.40495082691, 13017.47930082805, 13070.673233169247, 13139.211647301192, 13145.737085258432, 13211.14127581704, 16536.255868485947, 18129.821561598455, 18576.164072616764, 19864.808111513354, 20190.0, 6981.755638552626, 8169.0, 8177.304929081095, 8272.0, 8307.958460207781, 890.550272112579, 897.8518544440225, 1052.4106500359824, 1103.1285284625217, 1134.126722423729, 26467.808948597358, 26479.80840862166, 26672.199834005012, 27446.313842154104, 28194.872205111977, 1052.4685034057752, 1152.5389844062443, 1175.3359351966112, 1204.349651188366, 1262.949482020709, 12222.694432639255, 15150.31823567942, 15232.390704371923, 15400.0, 15569.455069072754, 699895.0, 712420.0, 735042.0, 735640.0, 737266.3136684282, 58750.0, 60598.0, 60648.361098334244, 61165.38834611686, 61337.0, 1262.9368531573568, 1462.9195394253206, 1492.7536956402073, 1509.4264179611678, 1513.2660659579874, 24798.0, 28118.859405703657, 28521.714782852738, 28939.7106028937, 29023.274418139714, 49182.0, 49196.75401622969, 49538.0, 49539.50460495349, 49573.0, 493920.0, 498176.0, 607692.0, 610554.947225261, 611815.0, 26404.0, 26595.867020664773, 26693.332666683487, 26754.732452676002, 27082.0, 45354.0, 45871.0, 46214.53785462103, 46962.29556556586, 47159.0, 36548.81725591461, 37745.0, 38215.42676859905, 38303.616963830005, 38843.446262150326, 37018.17351462223, 37517.4372384409, 37683.246335073694, 38106.47574097116, 38548.80725596354, 37334.0, 37357.813210933775, 37936.24127517489, 38066.42900356552, 38272.42591361076, 32882.67117328796, 33049.669503304656, 33971.0, 34065.659343406245, 34092.80675176456, 24007.63988540208, 25022.0, 25191.37021574402, 25259.74740252574, 25434.982600695766], "value": 19818.879801043535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.9449877017218, 398.76273617197756, 402.39841437051615, 406.4391140226487, 421.90928950275685, 20269.682470639396, 20418.183272669114, 21028.474288142785, 21380.144794208252, 21584.244551440705, 12140.332281724524, 12447.315397653125, 19542.902285488588, 20804.2718504852, 21120.57758844822, 5344.118220493614, 5579.386267510591, 5944.375840536746, 5964.165016897616, 6014.5188384929315, 3637.7453578249533, 5747.540196784247, 5829.417058294158, 6099.024156135019, 6111.908321375183, 6006.279246490427, 6143.600665956698, 6144.2319710036245, 6154.815355539341, 6158.199434073565, 5595.300587426572, 6706.966465167643, 6708.463322934203, 6708.563943343692, 6718.865622687567, 5233.712145831978, 5879.617824841414, 5930.762769489215, 5944.494717948979, 5971.835492079046, 10471.47642617866, 12306.753864922652, 13652.317384130853, 13873.58379248624, 23622.76377236223, 2075.294399904025, 2119.9788002119935, 2188.321620297713, 2191.9342419727272, 2298.9195378161853, 9793.265505087147, 9876.654317098866, 9965.850512242323, 10154.390736555757, 10183.388996660224, 1435.8492358302333, 1675.0, 1730.0484733396581, 1813.7732783402075, 1835.220031486613, 128576.0, 131016.0, 131484.68515314916, 133888.0, 134724.0, 11726.824097638542, 11831.645050648322, 11871.762564748657, 11906.583269585522, 11949.044076473861, 15376.461823836113, 15415.997960132556, 15461.226938653022, 15470.149141797308, 15497.0, 7379.6679149438405, 8656.8701469478, 8832.160944710242, 8854.203121719076, 9012.0, 8715.477071375737, 8717.52053637056, 8758.912410875937, 8779.341549383695, 8894.021657617657, 4709.270063140219, 4710.505396933341, 4764.761761911891, 4811.230203167546, 4813.590844778163, 1647.8269781672752, 1806.620021000365, 1958.529952811315, 2005.7091721700563, 2025.6050070236456, 864.6541383446672, 912.6851236323457, 973.2262851033446, 1025.2625489941872, 1080.7892460970193, 17602.647947040987, 18019.18913648889, 18934.526636833914, 20493.2827351042, 20654.58690826175, 950.7955789505152, 952.4428209497383, 989.9950500247453, 1008.2337423558149, 1062.4740753327153, 10163.644272450576, 10671.46642667879, 10873.67680988647, 10980.396078215776, 11001.394923279297, 595394.0, 607480.0, 623039.0, 624842.0, 637693.0, 110998.89506077082, 129303.35348323199, 129413.35293323472, 130269.0, 134880.9767853483, 995.7062666513395, 1018.0, 1029.2023681646783, 1043.7703705184847, 1046.2937517175876, 15171.468998584996, 18261.908690456996, 18448.446546603624, 18464.907675461538, 18472.81527184711, 53285.7335713319, 54586.727066364416, 55227.72386138044, 55814.0, 55930.0, 77744.16336603987, 77953.0, 77989.61005195165, 78910.0, 80426.0, 8147.307478864126, 8208.917910820815, 8291.626876790438, 8507.106753790762, 8517.829643406973, 11573.594924177612, 12540.811887821872, 12754.170978886343, 12789.488420463078, 12973.091883568437, 10380.896191037993, 10681.145508359468, 10753.602031735823, 10936.671899843017, 11020.228583999364, 9735.513224338896, 9997.800043999225, 10670.786584268426, 10991.670249892515, 11246.943765281121, 10634.627788027381, 11032.393218373067, 11274.154438417316, 11412.942935285271, 11511.76976460483, 8101.675932962616, 8180.304674102768, 8254.50989782894, 8405.663773448994, 8469.872951905603, 8312.168783121639, 9210.861837072584, 10457.0, 11054.889451105386, 11321.773564528829], "value": 9445.116790357115, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.4159690116207, 1585.9603509912251, 1601.367459853358, 1927.1809480970585, 1948.1428171604484, 7413.666385012674, 8254.54599997, 8709.477431354124, 8935.955320223398, 9290.070992900715, 8850.026497085315, 8952.641894324235, 9064.821573195475, 9091.363604547685, 9111.316651251149, 2459.655648209252, 2467.383154211447, 2498.9250322490266, 2508.8996440142373, 2543.2878793937634, 2447.8531288122767, 2485.3165379520597, 2486.316263027664, 2488.7635674610883, 2489.427431690712, 2454.5459090068393, 2463.285647162321, 2479.41733692583, 2482.391814005571, 2488.5645012122895, 2439.280412278373, 2454.349597356693, 2468.3212116667883, 2468.6420469031978, 2469.3949982254285, 2439.414540510265, 2454.8036157107567, 2461.2616215135386, 2461.2985299189645, 2468.333549941524, 9020.458772473672, 9047.502387368691, 9112.316576256808, 9125.908740912571, 9139.223166030895, 5407.188921661782, 5513.117901135799, 5576.553875689935, 5581.74882130301, 5583.162525621149, 3666.138457462494, 3701.7038636908983, 3721.423179407196, 3732.234891847165, 3740.4202348636004, 963.8939716631165, 1000.489750227382, 1059.6238335390979, 1061.1457776489922, 1064.5528877871313, 10104.292699511037, 12117.030637548974, 12326.32205228712, 12341.197822141532, 12497.062720296015, 4927.728974906415, 4943.703377797344, 4987.900241995139, 5002.624803139706, 5057.190849464142, 10235.385876847413, 10327.0, 10340.121089707309, 10345.844812327821, 10396.584136634601, 5470.370907345627, 5503.367112782082, 5524.861878452991, 5574.944250557523, 5604.663720176803, 4562.06477672083, 4895.804167833318, 5016.523430274118, 5048.444671086178, 5088.414832294259, 4100.5899410058755, 4127.133302006552, 4133.607307305801, 4136.090060186814, 4151.647109995623, 1349.117712754061, 1356.8846648035028, 1373.7527245095778, 1382.5852244326863, 1393.6794537256285, 769.6151924037981, 864.7924498120406, 888.8044630181479, 918.6141820435433, 944.7779771753633, 6111.205543279434, 6153.5692501525355, 6239.719212635442, 6304.117423560705, 6391.904121438182, 946.6450081219542, 981.4405788700373, 996.6810620601337, 1005.0251256281396, 1040.942748148844, 4045.3527435610163, 4108.424820525129, 4124.793760312033, 4176.373543968369, 4184.351425529047, 9569.760755981157, 11157.051650609788, 11159.497822598003, 11188.832167517494, 11205.495752690986, 10624.946875265729, 11009.2843965142, 11024.0, 11050.005499505083, 11143.609973651046, 8307.37694672902, 8347.373946953881, 8424.157584241526, 8424.831503369898, 8514.106018868053, 5446.700431476148, 5919.6744179070565, 6003.309619393825, 6013.579049466495, 6209.658468784261, 9637.951810241184, 10004.699859004242, 10203.38779673222, 10226.6420675276, 10296.485175741032, 9917.900820991697, 10274.434906080238, 10288.897111028793, 10389.37663740178, 10390.168786496912, 6909.032735417146, 6948.20095688982, 7813.1796161402235, 8064.83870322602, 8154.918450815416, 8564.143585641636, 8582.227599516074, 8622.094680058504, 8639.352048596254, 8642.82714345697, 7503.887441688488, 7652.196519365387, 7738.148803631483, 7795.103563090317, 7798.142204357403, 6900.6204658744255, 6954.408875245458, 7466.514676546007, 7524.209957954555, 7559.168491465824, 7070.010198572307, 7076.575405475688, 7219.0976127984, 7220.025296585104, 7234.059572255573, 4278.144371125725, 4521.367008618862, 4578.381918440968, 4833.975830120827, 5184.502027985132, 4908.214685650279, 4918.803247870188, 5085.46602606721, 5197.350331208599, 5215.921761173661], "value": 4725.192924791864, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.53175831527653, 320.64888946603475, 324.65748635189874, 325.95599594054795, 332.73547529713875, 4617.746023968689, 4923.55687988081, 5083.999999999995, 5581.330240371156, 5645.12500562413, 4590.921133533625, 5459.781608735646, 5490.725463726818, 5521.309836270466, 5564.497585651871, 3701.519392243111, 3984.6613037891816, 4003.5387083714454, 4211.515675697304, 4220.678626755288, 3608.458731190316, 4136.607022332873, 4138.234426631067, 4175.937360939588, 4204.873853784391, 3926.9410958835642, 3987.3620220764683, 4183.393407955845, 4216.578342165774, 4221.008063105168, 3621.2214373909605, 3802.8288727007352, 4009.558948515661, 4116.9794151029055, 4199.572145470524, 3553.07620018797, 3562.3765840977985, 3567.23304489536, 3586.2648157127987, 3607.1703508193264, 4967.850964471072, 5267.894642107175, 5277.234800953878, 5277.525022747971, 5288.391834938992, 4511.0, 4766.547178018118, 4780.928286075712, 4783.449903261135, 4787.880302992418, 5225.923779452033, 5469.343678758574, 5488.17677348397, 5738.622730544681, 5795.449432303924, 3486.3201675673254, 3539.734519911017, 3958.8614398495915, 3962.2471730371135, 4058.3563656719075, 5806.65160090396, 6083.604565703259, 6140.785072522485, 6151.415615516519, 6166.5375096867465, 3448.3965306071336, 3849.40334248192, 3853.9807300963316, 3861.613838616116, 4034.576369481221, 3733.533308336458, 4027.4293025719994, 4062.410950412174, 4064.349704047338, 4078.4494093297026, 4774.71351718891, 4780.211265141283, 4783.832565860248, 4786.917690804511, 4793.472718001017, 5426.918596220981, 5855.795047173414, 5873.001589729756, 5878.794242201588, 5919.0, 1365.269580774281, 1389.5067251125906, 1400.348837790412, 1404.1996062244627, 1406.9788953165505, 820.7045463633087, 854.0946596607616, 856.7215654912178, 862.7963990233715, 895.7772640345881, 4419.138268037702, 4741.976290118528, 5041.722705251246, 5403.703740718237, 5412.621116521885, 5875.9118613220835, 5992.31088424828, 5998.580099393088, 6007.729652165663, 6014.488768454643, 4980.103581355318, 5060.671056381397, 5194.013137503862, 5389.922015596818, 5416.864578385493, 2793.52510073288, 2805.5931889875856, 2865.996901084604, 2869.909434414909, 3138.623365196191, 6063.090126610192, 6178.505719542426, 6184.484801223729, 6207.937920620736, 6235.937640623536, 4796.904061918742, 6032.879342413127, 6229.750809967551, 6247.812565623039, 6291.276503202191, 5734.942650573525, 5873.0, 6277.610090551234, 6303.2751233607805, 6334.334894836068, 4763.809447622057, 5401.837944861661, 5671.362816290445, 5954.243498168137, 6021.819345419469, 5827.5629327801435, 5930.318013428511, 5944.762209511571, 5963.254593175853, 6037.184980027816, 5617.792174682463, 5748.223989761329, 5886.930103236863, 6184.907226391698, 6266.530010249158, 3973.0, 4010.1779135276615, 4058.675305975574, 4060.5127384714024, 4067.1255680028935, 5647.971760141173, 5738.913916291175, 5886.35182148999, 6053.093275618166, 6091.786787462417, 5592.508750760452, 5859.794907178229, 5906.793262235973, 5960.8674351873005, 5972.313183983897, 5329.866753331198, 5890.848396108062, 5898.852528686817, 5911.645301281937, 6007.729652165751, 4960.454350021567, 5414.675119492843, 5786.623869448473, 5820.912686309624, 5830.854228644318, 5167.302414174038, 5174.068667639861, 5261.0, 5847.473727364558, 5906.110044785627, 4647.395838541103, 4856.975715121402, 5096.898062038813, 5741.851629673998, 5831.329397119385], "value": 4226.2502109739025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.533881621681, 698.2877464985714, 720.6288761287934, 723.2116992478198, 743.0637396879931, 14610.26948652567, 14998.625034374147, 15112.395504179833, 15316.46392376267, 15444.22778861058, 14362.425502979895, 14424.278786060708, 14475.638109047279, 14476.927615361908, 14511.0, 709.6912842913323, 723.1936390924108, 920.236203950721, 920.8250432417852, 936.166811537732, 890.9331800114985, 922.6724512797961, 925.047201382577, 928.6471140966423, 932.5011119051309, 936.8220038192756, 982.008171746534, 986.2455221755328, 988.5946761827616, 988.8961659025806, 926.9304802139833, 927.5825878354734, 952.9571169297399, 959.9376040557377, 976.0337266106575, 690.4890381117987, 691.9965400173018, 705.4215543254534, 728.1007955175354, 730.5251586468785, 12516.874831251662, 15065.322060507195, 15185.088894666356, 15206.239688015556, 15241.085534867943, 12477.251364918135, 12635.178713383693, 12670.366481675972, 12687.619371418872, 12787.424565894557, 8580.613872375758, 9709.805803883954, 9838.262130340254, 9953.950230248875, 10403.47982600867, 3455.94816077759, 3466.204506065854, 3500.6499350065046, 3519.3137338219058, 3596.478510615946, 59206.0, 63917.08248752545, 75765.62117189378, 80122.19877801205, 80726.0, 7860.410469214832, 8348.872902158253, 9448.669296574724, 9561.808763824685, 9577.808443831085, 22305.219317323816, 22315.99578018993, 22368.0, 22436.887815560818, 22453.887730561244, 7377.0, 7481.551106933602, 7496.212897645778, 7614.619269036526, 7782.883256751154, 4089.672826173899, 4111.5815043809835, 4148.128892932457, 4150.107726838683, 4150.875473735793, 3522.0314413536485, 3626.2747450510005, 3635.4365073413665, 3638.7452878298795, 3638.9265166775335, 632.6299115017766, 639.8432384065841, 644.1979735229669, 649.2566011916424, 652.9347065293433, 529.9364076310791, 537.9004884096455, 557.5456003357251, 569.2883895131087, 576.4322142689448, 7090.0, 7727.493138837873, 8002.9599852000365, 8313.625886835107, 8329.6668133274, 515.8865049689063, 528.8202011316171, 555.2171438272017, 613.984650383744, 618.5113760129448, 3645.0, 3810.8948404962252, 3881.1849511602313, 3948.993006783252, 4046.0491784430637, 89025.55487222523, 89187.0, 89895.0, 90924.0, 92084.53957730168, 77377.61311193409, 77637.22362776414, 78292.60853695695, 78336.0, 79171.0, 71379.57240855257, 74358.6282068597, 75297.62351188209, 75363.0, 75946.24053759391, 7459.589722565311, 7494.437917156126, 7700.576468294297, 7728.111267204344, 7797.321607035733, 42966.78516607397, 43886.78056609824, 44316.778416107714, 44809.775951120035, 44882.326765097896, 49356.75321623369, 57598.7120064397, 58024.4197558019, 59679.70160149172, 59894.80210395855, 10376.429296388771, 10419.583216671248, 10510.632127875488, 10523.0, 10888.891111088788, 10901.890981090088, 10932.344059356465, 10960.945195273973, 11252.831207532057, 11398.715032124263, 10516.947415263181, 10569.894301056891, 10819.026287634151, 10904.945475272572, 10948.288361256493, 10404.947975260075, 10420.06219440254, 10434.582616695247, 10784.622538211124, 10823.729406764578, 10365.9481702591, 10372.27394082407, 10706.304090234109, 10715.303505272132, 10728.73178170552, 7530.209328020479, 8600.311975041857, 8625.663022231563, 8736.650533978569, 8937.642494300155, 8389.0, 8452.37738712044, 8615.827683446421, 8957.955210223907, 8961.0], "value": 6692.47325445645, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1644.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 170.0, 149.0, 116.0, 115.0, 132.0, 160.0, 155.0, 117.0, 117.0], "value": 136.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 120.0, 141.0, 214.0, 116.0, 138.0, 139.0, 120.0, 199.0, 138.0], "value": 147.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 207.0, 271.0, 260.0, 206.0, 273.0, 270.0, 195.0, 201.0, 194.0], "value": 227.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 85.0, 74.0, 189.0, 77.0, 65.0, 59.0, 65.0, 130.0, 68.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 134.0, 77.0, 81.0, 88.0, 118.0, 81.0, 83.0, 118.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 89.0, 88.0, 126.0, 86.0, 91.0, 86.0, 90.0, 87.0], "value": 92.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 98.0, 94.0, 134.0, 119.0, 114.0, 152.0, 151.0], "value": 114.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 90.0, 92.0, 91.0, 118.0, 143.0, 140.0, 91.0, 113.0], "value": 105.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 60.0, 60.0, 60.0, 57.0, 59.0, 60.0, 116.0, 60.0, 76.0], "value": 66.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 75.0, 69.0, 73.0, 69.0, 64.0, 65.0, 65.0, 67.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 88.0, 87.0, 86.0, 89.0, 92.0, 111.0, 106.0, 106.0], "value": 93.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 141.0, 139.0, 145.0, 147.0, 145.0, 145.0, 244.0, 150.0], "value": 155.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 173.0, 188.0, 182.0, 144.0, 204.0, 215.0, 188.0, 177.0, 214.0], "value": 183.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 83.0, 84.0, 84.0, 75.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 71.4, "unit": "score"}]}]} 20:40:05 INFO - Return code: 0 20:40:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:40:05 ERROR - # TBPL SUCCESS # 20:40:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:40:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:40:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:40:05 INFO - 2016-05-18 20:40:05.292 screenresolution[1695:10305] starting screenresolution argv=screenresolution get 20:40:05 INFO - 2016-05-18 20:40:05.294 screenresolution[1695:10305] Display 0: 1600x1200x32@60 20:40:05 INFO - 2016-05-18 20:40:05.300 screenresolution[1696:10308] starting screenresolution argv=screenresolution list 20:40:05 INFO - Available Modes on Display 0 20:40:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:40:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:40:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:40:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:40:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:40:05 INFO - Intel Iris: 20:40:05 INFO - Chipset Model: Intel Iris 20:40:05 INFO - Type: GPU 20:40:05 INFO - Bus: Built-In 20:40:05 INFO - VRAM (Dynamic, Max): 1536 MB 20:40:05 INFO - Vendor: Intel (0x8086) 20:40:05 INFO - Device ID: 0x0a2e 20:40:05 INFO - Revision ID: 0x0009 20:40:05 INFO - Displays: 20:40:05 INFO - Display: 20:40:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:40:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:40:05 INFO - Display Serial Number: 1600x1200 60 20:40:05 INFO - Main Display: Yes 20:40:05 INFO - Mirror: Off 20:40:05 INFO - Online: Yes 20:40:05 INFO - Rotation: Supported 20:40:05 INFO - Return code: 0 20:40:05 INFO - Running post-action listener: _resource_record_post_action 20:40:05 INFO - ##### 20:40:05 INFO - ##### Finished run-tests step (success) 20:40:05 INFO - ##### 20:40:05 INFO - Running post-run listener: _resource_record_post_run 20:40:05 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 36386304; Write bytes: 694175744; Read time: 235; Write time: 1915 20:40:05 INFO - TinderboxPrint: CPU usage
54.5% 20:40:05 INFO - TinderboxPrint: I/O read bytes / time
36,386,304 / 235 20:40:05 INFO - TinderboxPrint: I/O write bytes / time
694,175,744 / 1,915 20:40:05 INFO - TinderboxPrint: CPU idle
2,203.0 (45.5%) 20:40:05 INFO - TinderboxPrint: CPU system
974.9 (20.1%) 20:40:05 INFO - TinderboxPrint: CPU user
1,663.8 (34.4%) 20:40:05 INFO - TinderboxPrint: Swap in / out
432,173,056 / 0 20:40:05 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 395819520; Write bytes: 387385344; Read time: 29329; Write time: 780 20:40:05 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 34571776; Write bytes: 295657472; Read time: 220; Write time: 1098 20:40:05 INFO - Running post-run listener: _upload_blobber_files 20:40:05 INFO - Blob upload gear active. 20:40:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:40:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:40:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:40:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:40:06 INFO - (blobuploader) - INFO - Open directory for files ... 20:40:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:40:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:40:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:08 INFO - (blobuploader) - INFO - Done attempting. 20:40:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:40:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:40:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:09 INFO - (blobuploader) - INFO - Done attempting. 20:40:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:40:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:40:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:40:11 INFO - (blobuploader) - INFO - Done attempting. 20:40:11 INFO - (blobuploader) - INFO - Iteration through files over. 20:40:11 INFO - Return code: 0 20:40:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:40:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:40:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/59fcb4426c525bbe7b1b875a60ea3fb9ec306d76c7d1693f63ec83f671260659edcbe4be0182fe42c7bb8acd34180220ac2237d838eb8a80023a1908b215dc10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71bde08374cbd2d8126c15bac9c73eadd74ebd458d1749641bdaf3ccacb021e7b83e1761cb922e76049c6165751289cfd850a77871ef850011cbe454fe19dece", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04cab35f1acc375c110600394da180d822ccd35384747d82e59d8927ac46e4d9e7ab2112c5a83f69c4ffe4abe5a277e992de0aa43567e4400727ad241b6e9521"} 20:40:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:40:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:40:11 INFO - Contents: 20:40:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/59fcb4426c525bbe7b1b875a60ea3fb9ec306d76c7d1693f63ec83f671260659edcbe4be0182fe42c7bb8acd34180220ac2237d838eb8a80023a1908b215dc10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71bde08374cbd2d8126c15bac9c73eadd74ebd458d1749641bdaf3ccacb021e7b83e1761cb922e76049c6165751289cfd850a77871ef850011cbe454fe19dece", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04cab35f1acc375c110600394da180d822ccd35384747d82e59d8927ac46e4d9e7ab2112c5a83f69c4ffe4abe5a277e992de0aa43567e4400727ad241b6e9521"} 20:40:11 INFO - Running post-run listener: copy_logs_to_upload_dir 20:40:11 INFO - Copying logs to upload dir... 20:40:11 INFO - mkdir: /builds/slave/test/build/upload/logs 20:40:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.225361 ========= master_lag: 0.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-05-18 20:40:12.243451) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 20:40:12.246790) ========= 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.IHTlkqM1cV/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.cgmpNzYehT/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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/59fcb4426c525bbe7b1b875a60ea3fb9ec306d76c7d1693f63ec83f671260659edcbe4be0182fe42c7bb8acd34180220ac2237d838eb8a80023a1908b215dc10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71bde08374cbd2d8126c15bac9c73eadd74ebd458d1749641bdaf3ccacb021e7b83e1761cb922e76049c6165751289cfd850a77871ef850011cbe454fe19dece", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04cab35f1acc375c110600394da180d822ccd35384747d82e59d8927ac46e4d9e7ab2112c5a83f69c4ffe4abe5a277e992de0aa43567e4400727ad241b6e9521"} build_url:https://queue.taskcluster.net/v1/task/BEsdONOvQoGpnrPL64Hm1w/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/BEsdONOvQoGpnrPL64Hm1w/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/59fcb4426c525bbe7b1b875a60ea3fb9ec306d76c7d1693f63ec83f671260659edcbe4be0182fe42c7bb8acd34180220ac2237d838eb8a80023a1908b215dc10", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/71bde08374cbd2d8126c15bac9c73eadd74ebd458d1749641bdaf3ccacb021e7b83e1761cb922e76049c6165751289cfd850a77871ef850011cbe454fe19dece", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/04cab35f1acc375c110600394da180d822ccd35384747d82e59d8927ac46e4d9e7ab2112c5a83f69c4ffe4abe5a277e992de0aa43567e4400727ad241b6e9521"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-18 20:40:12.283513) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 20:40:12.284089) ========= 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.IHTlkqM1cV/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.cgmpNzYehT/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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.005066 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-18 20:40:12.333539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 20:40:12.333866) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-18 20:40:12.334263) ========= ========= Total master_lag: 0.59 =========