builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0138 starttime: 1463159756.75 results: success (0) buildid: 20160513073835 builduid: 56397e5e982c44d29ede311779dcfd50 revision: c7942b0606ada54b06f6c241e1431e9c677a443f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 10:15:56.750606) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 10:15:56.751072) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 10:15:56.751376) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 10:15:56.884576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:15:56.884971) ========= 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.cEa4e6rt6s/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.DbDPIwwfha/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-13 10:15:56-- 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% 143M=0s 2016-05-13 10:15:57 (143 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.634029 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:15:57.541306) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:15:57.541573) ========= 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.cEa4e6rt6s/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.DbDPIwwfha/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.026877 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:15:57.589806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 10:15:57.590172) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c7942b0606ada54b06f6c241e1431e9c677a443f --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 c7942b0606ada54b06f6c241e1431e9c677a443f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cEa4e6rt6s/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.DbDPIwwfha/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-13 10:15:57,669 truncating revision to first 12 chars 2016-05-13 10:15:57,670 Setting DEBUG logging. 2016-05-13 10:15:57,670 attempt 1/10 2016-05-13 10:15:57,670 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c7942b0606ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 10:15:58,733 unpacking tar archive at: fx-team-c7942b0606ad/testing/mozharness/ program finished with exit code 0 elapsedTime=1.309342 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-13 10:15:58.916006) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 10:15:58.916332) ========= script_repo_revision: c7942b0606ada54b06f6c241e1431e9c677a443f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 10:15:58.916718) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 10:15:58.917219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 10:15:58.932387) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-05-13 10:15:58.932817) ========= /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.cEa4e6rt6s/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.DbDPIwwfha/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:15:59 INFO - MultiFileLogger online at 20160513 10:15:59 in /builds/slave/test 10:15:59 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 10:15:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:59 INFO - {'append_to_log': False, 10:15:59 INFO - 'base_work_dir': '/builds/slave/test', 10:15:59 INFO - 'blob_upload_branch': 'Fx-Team', 10:15:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:59 INFO - 'branch': 'Fx-Team', 10:15:59 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:59 INFO - 'config_files': ('talos/mac_config.py',), 10:15:59 INFO - 'default_actions': ('clobber', 10:15:59 INFO - 'read-buildbot-config', 10:15:59 INFO - 'download-and-extract', 10:15:59 INFO - 'populate-webroot', 10:15:59 INFO - 'create-virtualenv', 10:15:59 INFO - 'install', 10:15:59 INFO - 'run-tests'), 10:15:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:59 INFO - 'download_minidump_stackwalk': True, 10:15:59 INFO - 'download_symbols': 'ondemand', 10:15:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:59 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:59 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:59 INFO - 'installer_path': 'installer.exe', 10:15:59 INFO - 'log_level': 'info', 10:15:59 INFO - 'log_name': 'talos', 10:15:59 INFO - 'log_to_console': True, 10:15:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:15:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:15:59 INFO - 'opt_config_files': (), 10:15:59 INFO - 'pip_index': False, 10:15:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:15:59 INFO - 'cmd': ('bash', 10:15:59 INFO - '-c', 10:15:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:15:59 INFO - 'enabled': True, 10:15:59 INFO - 'halt_on_failure': False, 10:15:59 INFO - 'name': 'check_screen_resolution'},), 10:15:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:15:59 INFO - 'cmd': ('bash', 10:15:59 INFO - '-c', 10:15:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:15:59 INFO - 'enabled': True, 10:15:59 INFO - 'halt_on_failure': False, 10:15:59 INFO - 'name': 'check_screen_resolution'},), 10:15:59 INFO - 'run_cmd_checks_enabled': True, 10:15:59 INFO - 'sps_profile': False, 10:15:59 INFO - 'sps_profile_interval': 0, 10:15:59 INFO - 'suite': 'dromaeojs-e10s', 10:15:59 INFO - 'system_bits': '32', 10:15:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:59 INFO - 'title': 't-yosemite-r7-0138', 10:15:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:59 INFO - 'use_talos_json': True, 10:15:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:59 INFO - 'work_dir': 'build'} 10:15:59 INFO - ##### 10:15:59 INFO - ##### Running clobber step. 10:15:59 INFO - ##### 10:15:59 INFO - Running pre-action listener: _resource_record_pre_action 10:15:59 INFO - Running main action method: clobber 10:15:59 INFO - rmtree: /builds/slave/test/build 10:15:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:16:01 INFO - Running post-action listener: _resource_record_post_action 10:16:01 INFO - ##### 10:16:01 INFO - ##### Finished clobber step (success) 10:16:01 INFO - ##### 10:16:01 INFO - ##### 10:16:01 INFO - ##### Running read-buildbot-config step. 10:16:01 INFO - ##### 10:16:01 INFO - Running pre-action listener: _resource_record_pre_action 10:16:01 INFO - Running main action method: read_buildbot_config 10:16:01 INFO - Using buildbot properties: 10:16:01 INFO - { 10:16:01 INFO - "project": "", 10:16:01 INFO - "product": "firefox", 10:16:01 INFO - "script_repo_revision": "production", 10:16:01 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:16:01 INFO - "repository": "", 10:16:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:16:01 INFO - "buildid": "20160513073835", 10:16:01 INFO - "pgo_build": "False", 10:16:01 INFO - "basedir": "/builds/slave/test", 10:16:01 INFO - "buildnumber": 4, 10:16:01 INFO - "slavename": "t-yosemite-r7-0138", 10:16:01 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:16:01 INFO - "platform": "yosemite_r7", 10:16:01 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 10:16:01 INFO - "branch": "fx-team", 10:16:01 INFO - "repo_path": "integration/fx-team", 10:16:01 INFO - "revision": "c7942b0606ada54b06f6c241e1431e9c677a443f", 10:16:01 INFO - "stage_platform": "macosx64", 10:16:01 INFO - "builduid": "56397e5e982c44d29ede311779dcfd50", 10:16:01 INFO - "slavebuilddir": "test" 10:16:01 INFO - } 10:16:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 10:16:01 INFO - Running post-action listener: _resource_record_post_action 10:16:01 INFO - ##### 10:16:01 INFO - ##### Finished read-buildbot-config step (success) 10:16:01 INFO - ##### 10:16:01 INFO - ##### 10:16:01 INFO - ##### Running download-and-extract step. 10:16:01 INFO - ##### 10:16:01 INFO - Running pre-action listener: _resource_record_pre_action 10:16:01 INFO - Running main action method: download_and_extract 10:16:01 INFO - mkdir: /builds/slave/test/build/tests 10:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:01 INFO - https://queue.taskcluster.net/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:16:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 10:16:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 10:16:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 10:16:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 10:16:29 INFO - Downloaded 1199 bytes. 10:16:29 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 10:16:29 INFO - Using the following test package requirements: 10:16:29 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 10:16:29 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:16:29 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 10:16:29 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:16:29 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 10:16:29 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:16:29 INFO - u'jsshell-mac.zip'], 10:16:29 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:16:29 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 10:16:29 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 10:16:29 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:16:29 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 10:16:29 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:16:29 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 10:16:29 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:16:29 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 10:16:29 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:16:29 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 10:16:29 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:29 INFO - https://queue.taskcluster.net/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:16:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:16:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:16:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:16:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:16:37 INFO - Downloaded 18153905 bytes. 10:16:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:16:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:16:40 INFO - Return code: 0 10:16:40 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:40 INFO - https://queue.taskcluster.net/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:16:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:16:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:16:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:16:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:16:42 INFO - Downloaded 18153905 bytes. 10:16:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:16:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:16:46 INFO - Return code: 0 10:16: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')]} 10:16:46 INFO - https://queue.taskcluster.net/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:16:47 INFO - Downloaded 10840239 bytes. 10:16:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:16:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:16:47 INFO - Return code: 0 10:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:47 INFO - https://queue.taskcluster.net/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:16:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:16:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:16:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 10:16:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 10:16:50 INFO - Downloaded 110072541 bytes. 10:16:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:16:50 INFO - mkdir: /builds/slave/test/properties 10:16:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:16:50 INFO - Writing to file /builds/slave/test/properties/build_url 10:16:50 INFO - Contents: 10:16:50 INFO - build_url:https://queue.taskcluster.net/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:16:51 INFO - Running post-action listener: _resource_record_post_action 10:16:51 INFO - Running post-action listener: set_extra_try_arguments 10:16:51 INFO - ##### 10:16:51 INFO - ##### Finished download-and-extract step (success) 10:16:51 INFO - ##### 10:16:51 INFO - ##### 10:16:51 INFO - ##### Running populate-webroot step. 10:16:51 INFO - ##### 10:16:51 INFO - Running pre-action listener: _resource_record_pre_action 10:16:51 INFO - Running main action method: populate_webroot 10:16:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:16:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:16:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:16:51 INFO - '--tppagecycles', 10:16:51 INFO - '7'], 10:16:51 INFO - 'tests': ['tsvgm']}}, 10:16:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:16:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:16:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:16:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:16:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:16:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:16:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:51 INFO - 'talos_options': ['--disable-e10s'], 10:16:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:16:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:51 INFO - 'talos_options': ['--disable-e10s'], 10:16:51 INFO - 'tests': ['damp', 'tps']}, 10:16:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:51 INFO - 'tests': ['damp', 'tps']}, 10:16:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:16:51 INFO - 'tests': ['dromaeo_dom']}, 10:16:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:16:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:16:51 INFO - 'tests': ['a11yr', 10:16:51 INFO - 'ts_paint', 10:16:51 INFO - 'tpaint', 10:16:51 INFO - 'sessionrestore', 10:16:51 INFO - 'sessionrestore_no_auto_restore', 10:16:51 INFO - 'tabpaint']}, 10:16:51 INFO - 'other-e10s': {'tests': ['a11yr', 10:16:51 INFO - 'ts_paint', 10:16:51 INFO - 'tpaint', 10:16:51 INFO - 'sessionrestore', 10:16:51 INFO - 'sessionrestore_no_auto_restore', 10:16:51 INFO - 'tabpaint']}, 10:16:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:16:51 INFO - 'ts_paint', 10:16:51 INFO - 'tpaint', 10:16:51 INFO - 'sessionrestore', 10:16:51 INFO - 'sessionrestore_no_auto_restore', 10:16:51 INFO - 'tabpaint']}, 10:16:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:16:51 INFO - 'ts_paint', 10:16:51 INFO - 'tpaint', 10:16:51 INFO - 'sessionrestore', 10:16:51 INFO - 'sessionrestore_no_auto_restore', 10:16:51 INFO - 'tabpaint']}, 10:16:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:16:51 INFO - 'tests': ['a11yr', 10:16:51 INFO - 'ts_paint', 10:16:51 INFO - 'tpaint', 10:16:51 INFO - 'sessionrestore', 10:16:51 INFO - 'sessionrestore_no_auto_restore', 10:16:51 INFO - 'tabpaint']}, 10:16:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:16:51 INFO - 'tests': ['a11yr', 10:16:51 INFO - 'ts_paint', 10:16:51 INFO - 'tpaint', 10:16:51 INFO - 'sessionrestore', 10:16:51 INFO - 'sessionrestore_no_auto_restore', 10:16:51 INFO - 'tabpaint']}, 10:16:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:16:51 INFO - 'tests': ['tsvgx', 10:16:51 INFO - 'tsvgr_opacity', 10:16:51 INFO - 'tart', 10:16:51 INFO - 'tscrollx', 10:16:51 INFO - 'cart']}, 10:16:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:16:51 INFO - 'tsvgr_opacity', 10:16:51 INFO - 'tart', 10:16:51 INFO - 'tscrollx', 10:16:51 INFO - 'cart']}, 10:16:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:51 INFO - 'talos_options': ['--disable-e10s'], 10:16:51 INFO - 'tests': ['tp5o']}, 10:16:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:51 INFO - 'tests': ['tp5o']}, 10:16:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:51 INFO - 'talos_options': ['--disable-e10s', 10:16:51 INFO - '--xperf_path', 10:16:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:51 INFO - 'tests': ['tp5n']}, 10:16:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:16:51 INFO - 'talos_options': ['--xperf_path', 10:16:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:16:51 INFO - 'tests': ['tp5n']}}, 10:16:51 INFO - 'talos.zip': {'path': '', 10:16:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:16:51 INFO - Running post-action listener: _resource_record_post_action 10:16:51 INFO - ##### 10:16:51 INFO - ##### Finished populate-webroot step (success) 10:16:51 INFO - ##### 10:16:51 INFO - ##### 10:16:51 INFO - ##### Running create-virtualenv step. 10:16:51 INFO - ##### 10:16:51 INFO - Running pre-action listener: _resource_record_pre_action 10:16:51 INFO - Running main action method: create_virtualenv 10:16:51 INFO - Creating virtualenv /builds/slave/test/build/venv 10:16:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:16:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:16:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:16:51 INFO - Using real prefix '/tools/python27' 10:16:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:16:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:16:55 INFO - Installing pip.................done. 10:16:55 INFO - Return code: 0 10:16:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:55 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 0x102326a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6a24c68e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cad30>, '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 0x101feedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021c1b20>, '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.cEa4e6rt6s/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.DbDPIwwfha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:16:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cEa4e6rt6s/Render', 10:16:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:55 INFO - 'HOME': '/Users/cltbld', 10:16:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:55 INFO - 'LOGNAME': 'cltbld', 10:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:55 INFO - 'MOZ_NO_REMOTE': '1', 10:16:55 INFO - 'NO_EM_RESTART': '1', 10:16:55 INFO - 'PAGER': '/bin/cat', 10:16:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:55 INFO - 'PWD': '/builds/slave/test', 10:16:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:55 INFO - 'SHELL': '/bin/bash', 10:16:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbDPIwwfha/Listeners', 10:16:55 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 10:16:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:55 INFO - 'USER': 'cltbld', 10:16:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:55 INFO - 'XPC_FLAGS': '0x0', 10:16:55 INFO - 'XPC_SERVICE_NAME': '0', 10:16:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:16:55 INFO - Cleaning up... 10:16:55 INFO - Return code: 0 10:16:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:16:55 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 0x102326a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6a24c68e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cad30>, '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 0x101feedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021c1b20>, '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.cEa4e6rt6s/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.DbDPIwwfha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:16:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:16:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:16:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cEa4e6rt6s/Render', 10:16:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:16:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:16:55 INFO - 'HOME': '/Users/cltbld', 10:16:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:16:55 INFO - 'LOGNAME': 'cltbld', 10:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:55 INFO - 'MOZ_NO_REMOTE': '1', 10:16:55 INFO - 'NO_EM_RESTART': '1', 10:16:55 INFO - 'PAGER': '/bin/cat', 10:16:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:55 INFO - 'PWD': '/builds/slave/test', 10:16:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:16:55 INFO - 'SHELL': '/bin/bash', 10:16:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbDPIwwfha/Listeners', 10:16:55 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 10:16:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:16:55 INFO - 'USER': 'cltbld', 10:16:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:16:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:55 INFO - 'XPC_FLAGS': '0x0', 10:16:55 INFO - 'XPC_SERVICE_NAME': '0', 10:16:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:16:55 INFO - Downloading/unpacking psutil>=3.1.1 10:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:16:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:16:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:16:58 INFO - Installing collected packages: psutil 10:16:58 INFO - Running setup.py install for psutil 10:16:58 INFO - building 'psutil._psutil_osx' extension 10:16:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:16:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:16:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:16:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:16:59 INFO - building 'psutil._psutil_posix' extension 10:16:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:16:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:16:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:16:59 INFO - ^ 10:16:59 INFO - 1 warning generated. 10:16:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:16:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:16:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:00 INFO - Successfully installed psutil 10:17:00 INFO - Cleaning up... 10:17:00 INFO - Return code: 0 10:17:00 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 10:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102326a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6a24c68e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cad30>, '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 0x101feedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021c1b20>, '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.cEa4e6rt6s/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.DbDPIwwfha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.1'] in /builds/slave/test/build 10:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.1 10:17:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cEa4e6rt6s/Render', 10:17:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:00 INFO - 'HOME': '/Users/cltbld', 10:17:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:00 INFO - 'LOGNAME': 'cltbld', 10:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:00 INFO - 'MOZ_NO_REMOTE': '1', 10:17:00 INFO - 'NO_EM_RESTART': '1', 10:17:00 INFO - 'PAGER': '/bin/cat', 10:17:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:00 INFO - 'PWD': '/builds/slave/test', 10:17:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:00 INFO - 'SHELL': '/bin/bash', 10:17:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbDPIwwfha/Listeners', 10:17:00 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 10:17:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:00 INFO - 'USER': 'cltbld', 10:17:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:00 INFO - 'XPC_FLAGS': '0x0', 10:17:00 INFO - 'XPC_SERVICE_NAME': '0', 10:17:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:00 INFO - Downloading/unpacking mozsystemmonitor==0.1 10:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:03 INFO - Downloading mozsystemmonitor-0.1.tar.gz 10:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 10:17:03 INFO - Installing collected packages: mozsystemmonitor 10:17:03 INFO - Running setup.py install for mozsystemmonitor 10:17:03 INFO - Successfully installed mozsystemmonitor 10:17:03 INFO - Cleaning up... 10:17:03 INFO - Return code: 0 10:17:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102326a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6a24c68e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cad30>, '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 0x101feedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021c1b20>, '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.cEa4e6rt6s/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.DbDPIwwfha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:17:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cEa4e6rt6s/Render', 10:17:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:03 INFO - 'HOME': '/Users/cltbld', 10:17:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:03 INFO - 'LOGNAME': 'cltbld', 10:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:03 INFO - 'MOZ_NO_REMOTE': '1', 10:17:03 INFO - 'NO_EM_RESTART': '1', 10:17:03 INFO - 'PAGER': '/bin/cat', 10:17:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:04 INFO - 'PWD': '/builds/slave/test', 10:17:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:04 INFO - 'SHELL': '/bin/bash', 10:17:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbDPIwwfha/Listeners', 10:17:04 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 10:17:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:04 INFO - 'USER': 'cltbld', 10:17:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:04 INFO - 'XPC_FLAGS': '0x0', 10:17:04 INFO - 'XPC_SERVICE_NAME': '0', 10:17:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:04 INFO - Downloading/unpacking blobuploader==1.2.4 10:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:06 INFO - Downloading blobuploader-1.2.4.tar.gz 10:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:17:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:17:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:07 INFO - Downloading docopt-0.6.1.tar.gz 10:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:17:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:17:07 INFO - Running setup.py install for blobuploader 10:17:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:17:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:17:08 INFO - Running setup.py install for requests 10:17:08 INFO - Running setup.py install for docopt 10:17:08 INFO - Successfully installed blobuploader requests docopt 10:17:08 INFO - Cleaning up... 10:17:08 INFO - Return code: 0 10:17:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:08 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 0x102326a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6a24c68e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cad30>, '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 0x101feedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021c1b20>, '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.cEa4e6rt6s/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.DbDPIwwfha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:17:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cEa4e6rt6s/Render', 10:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:08 INFO - 'HOME': '/Users/cltbld', 10:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:08 INFO - 'LOGNAME': 'cltbld', 10:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:08 INFO - 'MOZ_NO_REMOTE': '1', 10:17:08 INFO - 'NO_EM_RESTART': '1', 10:17:08 INFO - 'PAGER': '/bin/cat', 10:17:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:08 INFO - 'PWD': '/builds/slave/test', 10:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:08 INFO - 'SHELL': '/bin/bash', 10:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbDPIwwfha/Listeners', 10:17:08 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 10:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:08 INFO - 'USER': 'cltbld', 10:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:08 INFO - 'XPC_FLAGS': '0x0', 10:17:08 INFO - 'XPC_SERVICE_NAME': '0', 10:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:09 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-9Ul1n8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:09 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-vOzGCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:09 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-f_zkdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:09 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-oXeGNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:09 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-GJGyjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:09 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-ENAHoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:09 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-2J0mjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:09 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-2svlRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:09 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-k7yUHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:09 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-GFCYJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:10 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-tyoTAt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:10 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-0lzp3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:10 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-VCvx_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:10 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-n1sR9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:10 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-N43gfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:10 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-Sjczmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:10 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-56dfyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:17:10 INFO - Running setup.py install for manifestparser 10:17:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:17:10 INFO - Running setup.py install for mozcrash 10:17:11 INFO - Running setup.py install for mozdebug 10:17:11 INFO - Running setup.py install for mozdevice 10:17:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:17:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:17:11 INFO - Running setup.py install for mozfile 10:17:11 INFO - Running setup.py install for mozhttpd 10:17:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:17:11 INFO - Running setup.py install for mozinfo 10:17:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:17:11 INFO - Running setup.py install for mozInstall 10:17:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:17:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:17:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:17:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:17:11 INFO - Running setup.py install for mozleak 10:17:12 INFO - Running setup.py install for mozlog 10:17:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:17:12 INFO - Running setup.py install for moznetwork 10:17:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:17:12 INFO - Running setup.py install for mozprocess 10:17:12 INFO - Running setup.py install for mozprofile 10:17:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:17:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:17:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:17:12 INFO - Running setup.py install for mozrunner 10:17:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:17:12 INFO - Running setup.py install for mozscreenshot 10:17:13 INFO - Running setup.py install for moztest 10:17:13 INFO - Running setup.py install for mozversion 10:17:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:17:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:17:13 INFO - Cleaning up... 10:17:13 INFO - Return code: 0 10:17:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:13 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 0x102326a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6a24c68e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cad30>, '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 0x101feedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021c1b20>, '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.cEa4e6rt6s/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.DbDPIwwfha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:17:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cEa4e6rt6s/Render', 10:17:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:13 INFO - 'HOME': '/Users/cltbld', 10:17:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:13 INFO - 'LOGNAME': 'cltbld', 10:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:13 INFO - 'MOZ_NO_REMOTE': '1', 10:17:13 INFO - 'NO_EM_RESTART': '1', 10:17:13 INFO - 'PAGER': '/bin/cat', 10:17:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:13 INFO - 'PWD': '/builds/slave/test', 10:17:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:13 INFO - 'SHELL': '/bin/bash', 10:17:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbDPIwwfha/Listeners', 10:17:13 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 10:17:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:13 INFO - 'USER': 'cltbld', 10:17:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:13 INFO - 'XPC_FLAGS': '0x0', 10:17:13 INFO - 'XPC_SERVICE_NAME': '0', 10:17:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:13 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-vxoWUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:13 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-pybZ4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:13 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-Lr2GJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-O9c62a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-C5daY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-OYMOd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-48AZ7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-nsg_k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-OLISOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-Pl4qrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-CehXXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-rFyv7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:14 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-ycYZNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-qPL1Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-LjK1sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-jZH2Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:17:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:15 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-6Hvs7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:17:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:17 INFO - Downloading blessings-1.6.tar.gz 10:17:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:17:18 INFO - Installing collected packages: blessings 10:17:18 INFO - Running setup.py install for blessings 10:17:18 INFO - Successfully installed blessings 10:17:18 INFO - Cleaning up... 10:17:18 INFO - Return code: 0 10:17:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:17:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:18 INFO - Reading from file tmpfile_stdout 10:17:18 INFO - Current package versions: 10:17:18 INFO - blessings == 1.6 10:17:18 INFO - blobuploader == 1.2.4 10:17:18 INFO - docopt == 0.6.1 10:17:18 INFO - manifestparser == 1.1 10:17:18 INFO - mozInstall == 1.12 10:17:18 INFO - mozcrash == 0.17 10:17:18 INFO - mozdebug == 0.1 10:17:18 INFO - mozdevice == 0.48 10:17:18 INFO - mozfile == 1.2 10:17:18 INFO - mozhttpd == 0.7 10:17:18 INFO - mozinfo == 0.9 10:17:18 INFO - mozleak == 0.1 10:17:18 INFO - mozlog == 3.2 10:17:18 INFO - moznetwork == 0.27 10:17:18 INFO - mozprocess == 0.22 10:17:18 INFO - mozprofile == 0.28 10:17:18 INFO - mozrunner == 6.11 10:17:18 INFO - mozscreenshot == 0.1 10:17:18 INFO - mozsystemmonitor == 0.1 10:17:18 INFO - moztest == 0.7 10:17:18 INFO - mozversion == 1.4 10:17:18 INFO - psutil == 3.1.1 10:17:18 INFO - requests == 1.2.3 10:17:18 INFO - wsgiref == 0.1.2 10:17:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:18 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 0x102326a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6a24c68e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cad30>, '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 0x101feedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021c1b20>, '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.cEa4e6rt6s/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.DbDPIwwfha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cEa4e6rt6s/Render', 10:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:18 INFO - 'HOME': '/Users/cltbld', 10:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:18 INFO - 'LOGNAME': 'cltbld', 10:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:18 INFO - 'MOZ_NO_REMOTE': '1', 10:17:18 INFO - 'NO_EM_RESTART': '1', 10:17:18 INFO - 'PAGER': '/bin/cat', 10:17:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:18 INFO - 'PWD': '/builds/slave/test', 10:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:18 INFO - 'SHELL': '/bin/bash', 10:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbDPIwwfha/Listeners', 10:17:18 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 10:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:18 INFO - 'USER': 'cltbld', 10:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:18 INFO - 'XPC_FLAGS': '0x0', 10:17:18 INFO - 'XPC_SERVICE_NAME': '0', 10:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:17:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:17:18 INFO - Cleaning up... 10:17:18 INFO - Return code: 0 10:17:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:18 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 0x102326a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6a24c68e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cad30>, '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 0x101feedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021c1b20>, '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.cEa4e6rt6s/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.DbDPIwwfha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:17:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cEa4e6rt6s/Render', 10:17:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:18 INFO - 'HOME': '/Users/cltbld', 10:17:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:18 INFO - 'LOGNAME': 'cltbld', 10:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:18 INFO - 'MOZ_NO_REMOTE': '1', 10:17:18 INFO - 'NO_EM_RESTART': '1', 10:17:18 INFO - 'PAGER': '/bin/cat', 10:17:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:18 INFO - 'PWD': '/builds/slave/test', 10:17:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:18 INFO - 'SHELL': '/bin/bash', 10:17:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbDPIwwfha/Listeners', 10:17:18 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 10:17:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:18 INFO - 'USER': 'cltbld', 10:17:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:18 INFO - 'XPC_FLAGS': '0x0', 10:17:18 INFO - 'XPC_SERVICE_NAME': '0', 10:17:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:19 INFO - Downloading/unpacking jsonschema 10:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:17:21 INFO - Downloading/unpacking functools32 (from jsonschema) 10:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:21 INFO - Downloading functools32-3.2.3-2.tar.gz 10:17:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:17:22 INFO - warning: no files found matching '*.txt' 10:17:22 INFO - no previously-included directories found matching 'build' 10:17:22 INFO - no previously-included directories found matching 'dist' 10:17:22 INFO - no previously-included directories found matching '.git*' 10:17:22 INFO - Installing collected packages: jsonschema, functools32 10:17:22 INFO - Running setup.py install for functools32 10:17:22 INFO - warning: no files found matching '*.txt' 10:17:22 INFO - no previously-included directories found matching 'build' 10:17:22 INFO - no previously-included directories found matching 'dist' 10:17:22 INFO - no previously-included directories found matching '.git*' 10:17:22 INFO - Successfully installed jsonschema functools32 10:17:22 INFO - Cleaning up... 10:17:22 INFO - Return code: 0 10:17:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102326a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff6a24c68e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021cad30>, '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 0x101feedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021c1b20>, '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.cEa4e6rt6s/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.DbDPIwwfha/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:17:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cEa4e6rt6s/Render', 10:17:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:22 INFO - 'HOME': '/Users/cltbld', 10:17:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:22 INFO - 'LOGNAME': 'cltbld', 10:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:22 INFO - 'MOZ_NO_REMOTE': '1', 10:17:22 INFO - 'NO_EM_RESTART': '1', 10:17:22 INFO - 'PAGER': '/bin/cat', 10:17:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:22 INFO - 'PWD': '/builds/slave/test', 10:17:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:22 INFO - 'SHELL': '/bin/bash', 10:17:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbDPIwwfha/Listeners', 10:17:22 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 10:17:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:22 INFO - 'USER': 'cltbld', 10:17:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:22 INFO - 'XPC_FLAGS': '0x0', 10:17:22 INFO - 'XPC_SERVICE_NAME': '0', 10:17:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:22 INFO - Downloading/unpacking flake8 10:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:17:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:17:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:17:26 INFO - no previously-included directories found matching 'docs/_build' 10:17:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:17:26 INFO - Running setup.py install for pep8 10:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:17:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:17:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:17:26 INFO - no previously-included directories found matching 'docs/_build' 10:17:26 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:17:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:17:26 INFO - Cleaning up... 10:17:26 INFO - Return code: 0 10:17:26 INFO - Running post-action listener: _resource_record_post_action 10:17:26 INFO - Running post-action listener: _start_resource_monitoring 10:17:26 INFO - Starting resource monitoring. 10:17:26 INFO - ##### 10:17:26 INFO - ##### Finished create-virtualenv step (success) 10:17:26 INFO - ##### 10:17:26 INFO - ##### 10:17:26 INFO - ##### Running install step. 10:17:26 INFO - ##### 10:17:26 INFO - Running pre-action listener: _resource_record_pre_action 10:17:26 INFO - Running main action method: install 10:17:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:26 INFO - Reading from file tmpfile_stdout 10:17:26 INFO - Detecting whether we're running mozinstall >=1.0... 10:17:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:17:26 INFO - Reading from file tmpfile_stdout 10:17:26 INFO - Output received: 10:17:26 INFO - Usage: mozinstall [options] installer 10:17:26 INFO - Options: 10:17:26 INFO - -h, --help show this help message and exit 10:17:26 INFO - -d DEST, --destination=DEST 10:17:26 INFO - Directory to install application into. [default: 10:17:26 INFO - "/builds/slave/test"] 10:17:26 INFO - --app=APP Application being installed. [default: firefox] 10:17:26 INFO - mkdir: /builds/slave/test/build/application 10:17:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:18:00 INFO - Reading from file tmpfile_stdout 10:18:00 INFO - Output received: 10:18:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:18:00 INFO - Running post-action listener: _resource_record_post_action 10:18:00 INFO - ##### 10:18:00 INFO - ##### Finished install step (success) 10:18:00 INFO - ##### 10:18:00 INFO - ##### 10:18:00 INFO - ##### Running run-tests step. 10:18:00 INFO - ##### 10:18:00 INFO - Running pre-action listener: _resource_record_pre_action 10:18:00 INFO - Running main action method: run_tests 10:18:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:18:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:18:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:18:00 INFO - 2016-05-13 10:18:00.675 screenresolution[1651:9545] starting screenresolution argv=screenresolution get 10:18:00 INFO - 2016-05-13 10:18:00.678 screenresolution[1651:9545] Display 0: 1600x1200x32@60 10:18:00 INFO - 2016-05-13 10:18:00.685 screenresolution[1652:9547] starting screenresolution argv=screenresolution list 10:18:00 INFO - Available Modes on Display 0 10:18:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:18:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:18:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:18:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:18:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:18:00 INFO - Intel Iris: 10:18:00 INFO - Chipset Model: Intel Iris 10:18:00 INFO - Type: GPU 10:18:00 INFO - Bus: Built-In 10:18:00 INFO - VRAM (Dynamic, Max): 1536 MB 10:18:00 INFO - Vendor: Intel (0x8086) 10:18:00 INFO - Device ID: 0x0a2e 10:18:00 INFO - Revision ID: 0x0009 10:18:00 INFO - Displays: 10:18:00 INFO - Display: 10:18:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:18:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:18:00 INFO - Display Serial Number: 1600x1200 60 10:18:00 INFO - Main Display: Yes 10:18:00 INFO - Mirror: Off 10:18:00 INFO - Online: Yes 10:18:00 INFO - Rotation: Supported 10:18:00 INFO - Return code: 0 10:18:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:18:00 INFO - Python 2.7.3 10:18:00 INFO - Return code: 0 10:18:00 INFO - grabbing minidump binary from tooltool 10:18:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:00 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 0x1021cad30>, '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 0x101feedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1021c1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:18:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:18:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:18:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:18:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:18:01 INFO - Return code: 0 10:18:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:18:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:18:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:18:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:18:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:18:02 INFO - Return code: 0 10:18:02 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/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:18:02 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/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0138 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:18:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cEa4e6rt6s/Render', 10:18:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:02 INFO - 'HOME': '/Users/cltbld', 10:18:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:02 INFO - 'LOGNAME': 'cltbld', 10:18:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:18:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:02 INFO - 'MOZ_NO_REMOTE': '1', 10:18:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:18:02 INFO - 'NO_EM_RESTART': '1', 10:18:02 INFO - 'PAGER': '/bin/cat', 10:18:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:02 INFO - 'PWD': '/builds/slave/test', 10:18:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:18:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:02 INFO - 'SHELL': '/bin/bash', 10:18:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.DbDPIwwfha/Listeners', 10:18:02 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 10:18:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:02 INFO - 'USER': 'cltbld', 10:18:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:02 INFO - 'XPC_FLAGS': '0x0', 10:18:02 INFO - 'XPC_SERVICE_NAME': '0', 10:18:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:02 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/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:18:02 INFO - mozversion application_buildid: 20160513073835 10:18:02 INFO - mozversion application_changeset: c7942b0606ada54b06f6c241e1431e9c677a443f 10:18:02 INFO - mozversion application_display_name: Nightly 10:18:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:18:02 INFO - mozversion application_name: Firefox 10:18:02 INFO - mozversion application_remotingname: firefox 10:18:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:18:02 INFO - mozversion application_vendor: Mozilla 10:18:02 INFO - mozversion application_version: 49.0a1 10:18:02 INFO - mozversion platform_buildid: 20160513073835 10:18:02 INFO - mozversion platform_changeset: c7942b0606ada54b06f6c241e1431e9c677a443f 10:18:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:18:02 INFO - mozversion platform_version: 49.0a1 10:18:02 INFO - using testdate: 1463159882 10:18:02 INFO - actual date: 1463159882 10:18:02 INFO - starting webserver on 'localhost:49272' 10:18:02 INFO - SUITE-START | Running 2 tests 10:18:02 INFO - TEST-START | dromaeo_css 10:18:02 INFO - operating with platform_type : mac_ 10:18:02 INFO - Initialising browser for dromaeo_css test... 10:18:02 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpzP73LE/profile http://localhost:49272/getInfo.html) 10:18:05 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 10:18:05 INFO - PROCESS | 1670 | colorDepth:24 10:18:05 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 10:18:05 INFO - PROCESS | 1670 | __metrics 10:18:05 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 10:18:06 INFO - TEST-INFO | 1670: exit 0 10:18:06 INFO - Browser initialized. 10:18:06 INFO - Running cycle 1/1 for dromaeo_css test... 10:18:06 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpzP73LE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:18 INFO - PROCESS | 1674 | RSS: Main: 249921536 10:18:18 INFO - PROCESS | 1674 | 10:19:07 INFO - PROCESS | 1674 | 1463159947815 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:21:18 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 10:21:19 INFO - PROCESS | 1674 | RSS: Main: 261369856 10:21:19 INFO - PROCESS | 1674 | 10:24:22 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 10:24:22 INFO - PROCESS | 1674 | RSS: Main: 273293312 10:24:22 INFO - PROCESS | 1674 | 10:27:24 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 10:27:25 INFO - PROCESS | 1674 | RSS: Main: 274903040 10:27:25 INFO - PROCESS | 1674 | 10:30:26 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 10:30:27 INFO - PROCESS | 1674 | RSS: Main: 276881408 10:30:27 INFO - PROCESS | 1674 | 10:33:30 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 10:33:30 INFO - PROCESS | 1674 | RSS: Main: 279830528 10:33:30 INFO - PROCESS | 1674 | 10:36:33 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 10:36:33 INFO - PROCESS | 1674 | RSS: Main: 280731648 10:36:33 INFO - PROCESS | 1674 | 10:36:33 INFO - PROCESS | 1674 | __start_tp_report 10:36:33 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 10:36:33 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 10:36:33 INFO - PROCESS | 1674 | |i|pagename|runs| 10:36:33 INFO - PROCESS | 1674 | |0;dojo.html;3380.1380647934775;3411.317736452709;3415.1462134466383;3461.342344954459;3506.351325004874;5613.158026296058;5629.0993441049495;5660.179274005277;5730.484256416921;5746.310442746876;5573.888522229563;5632.3804381518;5682.602217844753;5705.457981491762;5727.541796656268;5020.899582008357;5067.265246539249;5145.0158907833365;5186.948130518703;5257.211418287249;5174.637775355726;5303.787848486056;5324.148136298193;5350.598705097113;5365.409804921455;3758.981205093957;5082.186850103965;5086.618503612207;5134.691918484884;5176.896462070757;5094.598985279041;5115.744212789383;5122.129238029544;5143.177091665316;5143.639945203838;4203.43253660758;5138.58891288696;5172.456892026358;5197.324347834758;5264.394594621591;5066.442691303953;5652.406497317764;5664.886702265972;5674.829755107354;5676.631018983753;6087.1173679816175;6134.846628834271;6185.84535386619;6198.876022479571;6218.440340369389;6143.232095988002;6253.562250642457;6257.968710156466;6278.4035516625845;6303.495720342407;5758.568107391962;5803.477687008147;5807.274090738658;5916.112583112482;5921.14143449206;6266.840634482635;6304.65324407162;6308.3060863305;6322.367763223733;6322.9051564226575;6013.9699301503215;6123.08153776937;6183.5671502994355;6206.565540412218;6239.157713708682;5966.075258334965;6159.722812473449;6202.069689546604;6252.406021428048;6274.215723034621;6065.60573562717;6072.180255665517;6099.491378240913;6135.785247516315;6180.381961803873;5972.432618901197;6094.573379863367;6121.117656725397;6142.9864072427545;6156.353582873823;4868.756562171877;4910.926336104962;4916.3362946001835;4928.531789479994;4954.529319714621;4031.737937034142;4063.5733248008532;4416.205083085011;4465.553444655508;4493.348464472699;5608.46719561641;5761.193432919395;5763.452472015152;5803.158542011384;5812.534997200214;6269.811905642838;6278.4035516625845;6284.528660350492;6288.52836037299;6291.811245662638;5837.708114594253;5839.941600584025;5848.093545500455;5875.089361149029;5933.021051526536;5233.293505376725;5367.3827509836865;5393.110136827458;5405.081136206854;5431;6345.397187267202;6406.67966601668;6423.903641445382;6452.774152904626;6452.9677351612945;6264.404881536247;6299.149614801943;6300.495960323255;6324.525660575383;6345.8730825384155;6223.439890409703;6257.4681152102585;6287.276963149114;6318.842028949313;6395.040743888454;6153.7393167692335;6193.81418557444;6208.565400421927;6215.751369945332;6238.6880655966115;5298.4171741107675;6122.672617327995;6288.308286088618;6305.842353941188;6319.652419116809;5972.313183983897;6037.003894357382;6096.878062438637;6115.6330620162935;6125.663088530174;6053.576249662481;6061.818145455643;6090.878182436238;6112.17485639433;6118.47992920589;5564.55483561306;5893.823185304448;5913.231279933581;5932.228810254639;5946.970265148647;5992.370801065826;6005.939940600713;6022.247219097613;6034.396560344106;6117.265928088658;5825.854353641193;5888.911666325094;5905.763769449346;5914.822555323347;5925.970370148121 10:36:33 INFO - PROCESS | 1674 | |1;ext.html;495.9479254678259;499.76011514473055;555.4084899581945;557.7155650618183;576.3256989322492;40326.798366008166;42952.35571466431;43042;43048;43064.78467607661;42658.57341426585;43247.702568922905;43385.56614433855;43485.6954291371;43489.7825510872;9661.46861922594;9822.901770982306;9826.803463930753;9853.458059806708;9902.306838521306;8589.312854971588;9709.417434953926;9828.606855725762;9846.950765246163;9872.901270987306;9854.852177217348;9868.703938881808;9869.851952220723;9875.061869122423;9892.356996795184;9784.217262618973;9838.508074596277;9841.360311579725;9842.60629574816;9842.90157098427;9625;9694.61221551144;9709.514524273829;9764.951175244078;9765.365251258716;40429.584964526395;40689.593104068874;40709.79645101785;40735.796321018206;40759;2951.8228906265695;3100.147459448647;3117.8908738194054;3361.210115622827;3386.9661303386897;29451.558226626617;29457.968971086124;29849.55225671595;30189.698103019127;30253;2746.6841313248833;2762.1713485954333;2834.63149790528;2844.431113777253;2890.089621769157;489494;489577;494246;494769;495852;34052.82973585116;34893.825530872185;34939.4759078614;36121.277574448366;66271.33728662651;36501.63498365036;36543;37350.25299493995;37395.439068413994;37410.8129459351;15436;15540;15583.220838958006;15624.531264062096;15653.904226704022;12725;13092.934535327453;13112.803307950388;13142.27717475548;13195.20828750278;7401.629918504161;8017.037955445384;8326.875096873551;8329.583520823935;8432;3425.2978139481347;3457.481377793351;3459.6540345965204;3479.495473156378;3504.5093686883856;927.7773334399695;1006.3157053203892;1009.7627057641448;1074.1782536359692;1082.6156714366443;30211.546826797614;30287;30578.847105764773;30765.344033289017;31208;1099.5272033025876;1103.1340397787699;1113.6046703420332;1152.8040233160382;1204.476052916984;12827.767970362193;15639.452619158275;15777.211139442981;15942.362305507882;16039.599010024842;577524.8990040435;657352;670970;671335;674933;62694.68652656708;64534.354656453776;64636;64738.676306619105;64753;1468.6695493514087;1472.8968972172058;1484.1985327923016;1492.0152699218681;1505.4204131409267;25561.616575751006;25580.872095639403;26144.8692756535;27030.594541082293;28620.57069144006;42416.57583424126;55493.167602485184;55924.440755591924;55997.16004260021;56038.439615603325;595016;606460;608277;609499;609614;27799;28187.57718634263;28209.43581128325;28261.57607635928;28353;47171;47276;47629.332973345765;47820;48262.27606585974;32834.835825820715;38734.22531549297;38870;39237.8038109819;40024.799876000434;33466.49800253047;35296.647033529334;38198;38890.61109388983;38926.83219503419;37698.869033929026;37915.62084379121;38431.80784096174;38506.6149338503;38680;27670.5849412263;28421.00526481563;32782.83608581942;32793.18017049593;34327.31345373028;25011.74988250167;25401.237962861145;25455.799793034683;25652.871735641947;26009 10:36:33 INFO - PROCESS | 1674 | |2;jquery.html;353.4909729988816;355.8629927477921;382.1764098368018;392.17838628074185;399.87204094689673;20208.494787630298;21109.261175858846;21230.57538849222;21793.782062179394;21806.672899906513;16330.918345408287;21583.24458643944;21789.673154902688;21986.89006554965;22137.778622213773;5601.663900165982;5870.559708021894;5982.551308651847;5993.490553302974;6005.789797357093;5042.142835717918;5887.440693134166;5957.017092179785;5972.940270597303;6014.0678194879865;5637.605367624268;5885.970570147143;5887.558433117512;5888.5289176865745;5889.057750759879;5674.659520428788;5718.399568045337;5848.590598658075;5864.794732184374;5875.941240587582;5137.33214682089;5162.97418512905;5164.793408263665;5168.53483186515;5175.792968281265;12755.744885102245;13500.122492037986;13527;13595.592132236048;26567.867160664075;1996.8402527797741;2072.3990042887544;2207.194374053475;2357.5520651076413;2436.5857804173334;10279.691609251735;10279.743006424824;10308.123809476203;10495.42275174865;10545.947270263676;1741.5123765345597;1761.6124452620404;1784.14536741213;1839.7976222615503;1845.418693111679;110170.89829101767;118538.40730796377;124883;125252;140959.29520352333;17089.572760680832;18115.36596219126;20758.273460428813;21828.89085554594;21941.341759746912;31969.72121115176;34679;36724.81637591795;36742.63257367392;36758;10978.847221041675;11306.265092768943;11377.2604780689;11404.543818247177;11540.596079137189;8242.134575869568;9127.452352858849;9245.583948722324;9334.20659243972;9376.906230937604;8134.959325203455;10089.192864570818;10184.185265178769;10249.38503689781;10398.480075996169;3189.9043028709175;3497.720182385403;3915.256101340736;3997.480327557399;4115.859752928521;722;791.9128895821455;939.9812003759887;940.3981451870808;1040.3185913226848;20198.697019544717;20823.08968439577;21022;21241.468963275733;21528.78471215268;860.4493124400389;952.2953014769021;1024.4621573673733;1051.3796859852723;1063.5373612478597;10852.67441976742;11078.723031924266;11160.441977901073;11225.045871100885;11238.38188899602;622514;622585;629723;632052;636469;138299.15952941598;139512.30243848715;139940;140814;142874.85687714483;1004.9799004019878;1012.21047582884;1027.1012863744224;1028.100412139378;1029.9279050466396;18699.626007480045;18818.623627527646;18854.3400980965;18912.621747564695;18936.715949260495;52000.73999629977;52519.68700782511;53140.67148321323;53198.468015319355;54423;75835.62082189554;76177.23822761701;76364;76434;79193.60403197947;7183.461240407095;8191.467554609169;8399;8516.489010659381;8582.227599516074;9167.266618670357;11953.760924781282;12440.315782632042;12896.48414063427;13032.348382580643;9291.76770580741;10766.407847568145;10832;11163.49764260594;11400.771984560428;9834.819821621166;10782.245242832927;10837.837432438677;10998;11121.944390277997;10600.098991585493;11412.657620271406;11477.253978491706;11483.48324325424;11752.76494470123;7525.397968162643;8341.915550978334;8401.369897257608;8488.151184881463;8533.146685331418;8566.957165214135;9868.605255789975;10767.084797792275;11197.944010280222;11444.313341199555 10:36:33 INFO - PROCESS | 1674 | |3;mootools.html;1604.775331453596;1638.4511188751767;1885.9905700471495;1957.3834242213711;1992.3624440179149;8266.173382661731;8896.332775041874;8912.910870891305;9422.952885235563;9444.386114902534;9039.954800225989;9102.088561402114;9270.026647202048;9272.304577156707;9280.30397720172;2426.5025669737706;2462.655228268044;2462.9876850615724;2464.309993201897;2473.6536884836137;2426.575349313872;2485.030837973192;2489.3403248139166;2490.140901389018;2490.56415127352;2439.1584903208363;2451.4361696809747;2470.641756945242;2471.789897858684;2479.1075212923333;2417.891194896234;2441.694788151472;2446.1438496526252;2457.5699252630807;2459.4712136890566;1908.9236430542762;2231.252530402301;2242.2824696097255;2244.517428752826;2435.281591930367;9088.091190880925;9167.679131230376;9256.398334108262;9256.537173141383;9276.397034192756;5414.835810300765;5527.364353099405;5584.93886161628;5609.663420194802;5630.071038278679;3611.1152767571853;3637.4725664778457;3641.890743277706;3681.4845921571;3701.8519259229597;1037.3868634273701;1039.719275795531;1043.342694102718;1045.968620941373;1048.916086713061;11821.231619944676;12149.817752733716;12197.20718153326;12315;12317.322547259897;3887.7667339959125;4906.656534042583;5034.647574669738;5040.218766091261;5062.7468626568525;10466.790664186674;10470.47647617616;10488.26582139243;10492.947535262274;10506;4838.491958344393;5589.692566908859;5603.243562119062;5616.6068375213345;5648;4531.116432295671;4919.7540122993705;5066.9746651266505;5114.079465696211;5119.411267704188;4102.989120937781;4122.958770412258;4131.277026520407;4151.14901445203;4187.120704651997;1334.219481603273;1336.3919416665394;1337.9356995066066;1338.9531366402323;1348.528015194674;919.1497864475467;931.4411353188168;936.6253498600614;943.3915124744501;943.6461327002374;5512.173174023848;6040.486558642477;6151.2618485781095;6206.472449841814;6214.564980451325;444.5820928327362;456.59135074108485;467.5277969251013;469.5609605019318;472.6502388232752;4024.054347228399;4051.716379853441;4056.148208876169;4088.856890008895;4128.814203360856;10842.512086955949;11186.272892261977;11265.605703800327;11270.774584508265;11294.265872718248;11133.832992505118;11228.887711122785;11252.43737813106;11256.268342557707;11268.71828204285;8166;8485.448445851;8530.530820804792;8556.871646925301;8603.827923441371;4963.70217786934;6182.752689892354;6202.193714817045;6283.59156654816;6374.203224596926;10107.191424686154;10119.291649584753;10411.843822342822;10427.739306517398;10590.364578125336;9303.348765586614;10173.336782821443;10571.101456375987;10787.298825576312;10821.621243256448;7194.496385252982;7627.771166865003;7774.727884524014;7803.765887023398;7949.205079492004;8771.605277762643;8777.824443510966;8845.734627961172;8854.867176992222;8881.467111973303;7604;7769.8834517481155;7834.960825196065;7846.607669616382;7852.136265010959;7545.811354716176;7597.924020759721;7628.46600737943;7650.923490765021;7793.532388056735;7288.344049035612;7322.926770732224;7384.852302954018;7385.113786345673;7419.517731347445;4968.478309777566;5107.591392688501;5146.3309769731195;5158.690478571298;5173.870653233549;5142.1772516397195;5159;5224.529792318557;5374.811881584125;5404.648697834628 10:36:33 INFO - PROCESS | 1674 | |4;prototype.html;303.45984148216166;313.96546379898206;318.5079052863326;322.22504875773774;322.8821480159742;4307.6123148916595;5238.685678859261;5435.189856976574;5459.481349271823;5651.095824668059;4989.65072444929;5126.436436886748;5456.727163641822;5470.507654311111;5505.9724701376435;3630.6369363063613;4084.937106761089;4128.8761337159785;4156.625903668669;4188.2251783420015;3946.743461674982;4035.556088830226;4171.916561668765;4179.26862799009;4208.2845916194165;3455.447128459447;4117.711760176789;4129.2360913231;4147;4150.294449943502;3619.475176099464;3659.323025240339;4154.459920210384;4158.563350848178;4182.33082706767;3017.2909366298904;3424.520567120605;3619.2580520993133;3631.201135750157;3633.6729694327373;4996.575291100225;5086.34693724541;5211.791528338862;5254.8160814371695;5312.645275454773;3993.800309984489;4177.811998460076;4615.976920115411;4671.855395428108;4785.282207668843;5000.949420853277;5102.413222479426;5511.4213007634025;5835.766569337221;5862.618929769551;3361.8487168077495;3733.1040550268012;3811.2187001664593;3970.3647416413237;3995.5205375355144;4884.632302955179;5970.1343305220935;6032.396760323976;6067.817965461043;6076.635401875901;4034.293998550242;4041.9595804041583;4043.332850079763;4048;4054.432379466877;3405.182756138509;3446.913827154341;3820.2741479118877;4050.210209009215;4066.573009833925;3945.8421663133154;4163.791810409467;4679.4618618858585;4741.952580474152;4773.307870358779;4395.164918665443;4537.818487260539;5722.7982123753645;5723.513501352349;5775.971120144456;1196.7606478704295;1373.8214032175754;1396.6019684390103;1398.4056775870215;1408.6548795545157;821.7370441458676;850.2050582705191;863.9913600864037;879.8108406692592;886.0165216609687;4076.9196163016823;4241.830326786956;4536.455625324982;4537.727736335764;4617.284320930261;4376.978115109468;4701.905961880743;4769.976150119297;4906.754662266872;4915.827946021872;3988.7918246249906;3988.8205030773684;4407.382966384709;4599.425071866017;4659.767011649404;2438.2685194441597;2479.9752002479745;2541.9872900635746;2638.3667919699133;2682.463507298548;4331.935020974688;4716.372851366273;5034.993001399735;5095.897802269134;5158.716270605153;4366.214081465367;4468.776561171929;5069.746512674352;5180.611454140954;5195.389429276936;5011.699298042129;5675.772969081273;6020.608660437058;6234.2830574484515;6288.119663247057;5811.87866428742;6002.969985150046;6067.089936509382;6080.543959202989;6088.847778805565;5119.308893299357;5705.515031222227;5913.763449461973;5943.108533719977;5985.65322802366;5310.840674779763;5377.3816011159215;6290.654014029273;6300.117983482224;6339.461145802658;3662.5788034376387;4118.567550407164;4174.373843923436;4178.164367126647;4180.4147419361925;5009.073321435546;5114.028334616411;5248.868778280574;5592.524635405874;6048.697565121638;4919.581835544019;4939.135651260943;5717.313922329347;5826.814944395852;5841.970790146022;4795.968866693677;5118.462561430996;5199.974000130126;5351.3043304370185;5880.794172203952;5202.739863006759;5526.80656177048;5680.523064003306;5718.685472299064;5722.456366645162;5070.847874563769;5341.866453338697;5725.427457254241;5769.797762241996;5874.5887787854435;4524.054656497606;4624.44506659203;5039.622028347815;5402.703351195763;5735.763052409647 10:36:33 INFO - PROCESS | 1674 | |5;yui.html;662.393909572741;704.2499737779265;712.5510928115286;738.5494848142636;759.1383779410368;15012.77480837787;15321.463748768796;15426.305816238268;15549.45576904807;15741.842581574181;14533.49132780353;14610.050346727456;14687.706245875075;14702;14720.263986800644;720.0711082703307;781.6873250699708;903.2728653433983;926.8517037274038;942.3827393057559;938.1790932933683;941.924646028316;942.3262367407302;942.9245660347156;944.9291303152256;980.8822941247024;985.4875464758321;1000.1748557440104;1002.3234316836143;1006.4514839412537;979.5445118020119;992.3995982430598;993.2054356514832;994.9104580587746;997.0278977996431;731.4660297982502;732.7948174511146;733.1641928201855;733.6405161470894;735.1619154164257;15027.699446011018;15162.696746065018;15172.317245723858;15203.467878624306;15210.467633632881;12628.558000469939;12652.873471265353;12702.174358666656;12791.872081279254;13134.080614356999;8664.653413863438;9801.803963920682;10116.848247276297;10176.440295783728;10249.743756406075;3501.8424170912117;3508.6666766657127;3521.683048525645;3537.7523573349877;3580.087077795172;58148;64783.676081619764;89088;91209.17581648396;93488;9364.578593963288;9366.95316523413;9553.379030363005;9556.665516706882;9722.076402741728;18076.909615451837;22689.773102268766;22714.886425567765;22814.65778013331;22902.08391664348;7256.8911466328045;7404.074490688664;7425.331720145105;7483.438742094365;7744.457887947902;3908.022994251437;3926.2736393767245;3944.4083387491532;3967.7420967637013;3982.3628219484744;3554.4668299755244;3612.3317186320614;3634.127809325743;3644.599094099647;3644.7630903991158;612.5834432585884;635.9633796911005;636.5512313818747;644.3041515163612;646.0922404022356;536.5171345788822;581.6617198860557;585.4387056627256;595.9020578947149;618.7339444039106;7860.136105822589;8169.183081691784;8302.54336011525;8352.8329433411;8378.748637540884;509.68399592252297;569.63827969239;570.5150621971292;592.5111782779225;602.7378090530633;3722.962770372316;3889.124946886928;3940.901477463029;3955.861544845917;3993.4009898515455;92795;96182.51908740411;96420.51789741007;97219;97833.5324970126;81423;83596;83678;84051;84261;68163.65918170377;72187;72516;72592;72687.63656181685;7580.658870350958;7603.9619801900635;7646.541207527566;7753.1859154787935;7829.435820066052;38449.6155038446;41333;44824.32763508615;45200.77399612981;45499.54500454953;61637;64217;64466.35533644604;64647.35352646413;65513;10279.897201028192;10574.629887954192;10594.894051059699;10640.308379955279;10692.786144276915;9292.303077269096;11173.273737207055;11217.887821121685;11377.54489820398;11435.714107147387;10139.340942838988;10499.94750026245;10664.680059598224;10851.186161038111;10852.67441976742;10445.634402795866;10535.789284214427;10540.104091152338;10728.570857165625;10739.409332486788;9809.509524523888;10096.646617368357;10173.338732982333;10214.54034568461;10762;8818.514981675813;8840.867386989072;8958.622549362404;8991.23574496149;9120.133587309196;6935.549189302679;8726.65093396257;8866.73399798007;8950.483614840407;9067.818643626959 10:36:33 INFO - PROCESS | 1674 | __end_tp_report 10:36:33 INFO - PROCESS | 1674 | __start_cc_report 10:36:33 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,410 10:36:33 INFO - PROCESS | 1674 | __end_cc_report 10:36:33 INFO - PROCESS | 1674 | __startTimestamp1463160993737__endTimestamp 10:36:33 INFO - PROCESS | 1674 | 10:36:33 INFO - PROCESS | 1674 | ------- Summary: start ------- 10:36:33 INFO - PROCESS | 1674 | Number of tests: 6 10:36:33 INFO - PROCESS | 1674 | 10:36:33 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5712.63 Median:5925.97 stddev:671.75 (11.3%) stddev-sans-first:648.41 10:36:33 INFO - PROCESS | 1674 | Values: 3380.1 3411.3 3415.1 3461.3 3506.4 5613.2 5629.1 5660.2 5730.5 5746.3 5573.9 5632.4 5682.6 5705.5 5727.5 5020.9 5067.3 5145.0 5186.9 5257.2 5174.6 5303.8 5324.1 5350.6 5365.4 3759.0 5082.2 5086.6 5134.7 5176.9 5094.6 5115.7 5122.1 5143.2 5143.6 4203.4 5138.6 5172.5 5197.3 5264.4 5066.4 5652.4 5664.9 5674.8 5676.6 6087.1 6134.8 6185.8 6198.9 6218.4 6143.2 6253.6 6258.0 6278.4 6303.5 5758.6 5803.5 5807.3 5916.1 5921.1 6266.8 6304.7 6308.3 6322.4 6322.9 6014.0 6123.1 6183.6 6206.6 6239.2 5966.1 6159.7 6202.1 6252.4 6274.2 6065.6 6072.2 6099.5 6135.8 6180.4 5972.4 6094.6 6121.1 6143.0 6156.4 4868.8 4910.9 4916.3 4928.5 4954.5 4031.7 4063.6 4416.2 4465.6 4493.3 5608.5 5761.2 5763.5 5803.2 5812.5 6269.8 6278.4 6284.5 6288.5 6291.8 5837.7 5839.9 5848.1 5875.1 5933.0 5233.3 5367.4 5393.1 5405.1 5431.0 6345.4 6406.7 6423.9 6452.8 6453.0 6264.4 6299.1 6300.5 6324.5 6345.9 6223.4 6257.5 6287.3 6318.8 6395.0 6153.7 6193.8 6208.6 6215.8 6238.7 5298.4 6122.7 6288.3 6305.8 6319.7 5972.3 6037.0 6096.9 6115.6 6125.7 6053.6 6061.8 6090.9 6112.2 6118.5 5564.6 5893.8 5913.2 5932.2 5947.0 5992.4 6005.9 6022.2 6034.4 6117.3 5825.9 5888.9 5905.8 5914.8 5926.0 10:36:33 INFO - PROCESS | 1674 | 10:36:33 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:69950.43 Median:38593.31 stddev:157351.07 (407.7%) stddev-sans-first:157706.07 10:36:33 INFO - PROCESS | 1674 | Values: 495.9 499.8 555.4 557.7 576.3 40326.8 42952.4 43042.0 43048.0 43064.8 42658.6 43247.7 43385.6 43485.7 43489.8 9661.5 9822.9 9826.8 9853.5 9902.3 8589.3 9709.4 9828.6 9847.0 9872.9 9854.9 9868.7 9869.9 9875.1 9892.4 9784.2 9838.5 9841.4 9842.6 9842.9 9625.0 9694.6 9709.5 9765.0 9765.4 40429.6 40689.6 40709.8 40735.8 40759.0 2951.8 3100.1 3117.9 3361.2 3387.0 29451.6 29458.0 29849.6 30189.7 30253.0 2746.7 2762.2 2834.6 2844.4 2890.1 489494.0 489577.0 494246.0 494769.0 495852.0 34052.8 34893.8 34939.5 36121.3 66271.3 36501.6 36543.0 37350.3 37395.4 37410.8 15436.0 15540.0 15583.2 15624.5 15653.9 12725.0 13092.9 13112.8 13142.3 13195.2 7401.6 8017.0 8326.9 8329.6 8432.0 3425.3 3457.5 3459.7 3479.5 3504.5 927.8 1006.3 1009.8 1074.2 1082.6 30211.5 30287.0 30578.8 30765.3 31208.0 1099.5 1103.1 1113.6 1152.8 1204.5 12827.8 15639.5 15777.2 15942.4 16039.6 577524.9 657352.0 670970.0 671335.0 674933.0 62694.7 64534.4 64636.0 64738.7 64753.0 1468.7 1472.9 1484.2 1492.0 1505.4 25561.6 25580.9 26144.9 27030.6 28620.6 42416.6 55493.2 55924.4 55997.2 56038.4 595016.0 606460.0 608277.0 609499.0 609614.0 27799.0 28187.6 28209.4 28261.6 28353.0 47171.0 47276.0 47629.3 47820.0 48262.3 32834.8 38734.2 38870.0 39237.8 40024.8 33466.5 35296.6 38198.0 38890.6 38926.8 37698.9 37915.6 38431.8 38506.6 38680.0 27670.6 28421.0 32782.8 32793.2 34327.3 25011.7 25401.2 25455.8 25652.9 26009.0 10:36:33 INFO - PROCESS | 1674 | 10:36:33 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:37181.05 Median:21885.12 stddev:104967.24 (479.6%) stddev-sans-first:105225.28 10:36:33 INFO - PROCESS | 1674 | Values: 353.5 355.9 382.2 392.2 399.9 20208.5 21109.3 21230.6 21793.8 21806.7 16330.9 21583.2 21789.7 21986.9 22137.8 5601.7 5870.6 5982.6 5993.5 6005.8 5042.1 5887.4 5957.0 5972.9 6014.1 5637.6 5886.0 5887.6 5888.5 5889.1 5674.7 5718.4 5848.6 5864.8 5875.9 5137.3 5163.0 5164.8 5168.5 5175.8 12755.7 13500.1 13527.0 13595.6 26567.9 1996.8 2072.4 2207.2 2357.6 2436.6 10279.7 10279.7 10308.1 10495.4 10545.9 1741.5 1761.6 1784.1 1839.8 1845.4 110170.9 118538.4 124883.0 125252.0 140959.3 17089.6 18115.4 20758.3 21828.9 21941.3 31969.7 34679.0 36724.8 36742.6 36758.0 10978.8 11306.3 11377.3 11404.5 11540.6 8242.1 9127.5 9245.6 9334.2 9376.9 8135.0 10089.2 10184.2 10249.4 10398.5 3189.9 3497.7 3915.3 3997.5 4115.9 722.0 791.9 940.0 940.4 1040.3 20198.7 20823.1 21022.0 21241.5 21528.8 860.4 952.3 1024.5 1051.4 1063.5 10852.7 11078.7 11160.4 11225.0 11238.4 622514.0 622585.0 629723.0 632052.0 636469.0 138299.2 139512.3 139940.0 140814.0 142874.9 1005.0 1012.2 1027.1 1028.1 1029.9 18699.6 18818.6 18854.3 18912.6 18936.7 52000.7 52519.7 53140.7 53198.5 54423.0 75835.6 76177.2 76364.0 76434.0 79193.6 7183.5 8191.5 8399.0 8516.5 8582.2 9167.3 11953.8 12440.3 12896.5 13032.3 9291.8 10766.4 10832.0 11163.5 11400.8 9834.8 10782.2 10837.8 10998.0 11121.9 10600.1 11412.7 11477.3 11483.5 11752.8 7525.4 8341.9 8401.4 8488.2 8533.1 8567.0 9868.6 10767.1 11197.9 11444.3 10:36:33 INFO - PROCESS | 1674 | 10:36:33 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:5930.78 Median:2655.57 stddev:3370.50 (126.9%) stddev-sans-first:3364.27 10:36:33 INFO - PROCESS | 1674 | Values: 1604.8 1638.5 1886.0 1957.4 1992.4 8266.2 8896.3 8912.9 9423.0 9444.4 9040.0 9102.1 9270.0 9272.3 9280.3 2426.5 2462.7 2463.0 2464.3 2473.7 2426.6 2485.0 2489.3 2490.1 2490.6 2439.2 2451.4 2470.6 2471.8 2479.1 2417.9 2441.7 2446.1 2457.6 2459.5 1908.9 2231.3 2242.3 2244.5 2435.3 9088.1 9167.7 9256.4 9256.5 9276.4 5414.8 5527.4 5584.9 5609.7 5630.1 3611.1 3637.5 3641.9 3681.5 3701.9 1037.4 1039.7 1043.3 1046.0 1048.9 11821.2 12149.8 12197.2 12315.0 12317.3 3887.8 4906.7 5034.6 5040.2 5062.7 10466.8 10470.5 10488.3 10492.9 10506.0 4838.5 5589.7 5603.2 5616.6 5648.0 4531.1 4919.8 5067.0 5114.1 5119.4 4103.0 4123.0 4131.3 4151.1 4187.1 1334.2 1336.4 1337.9 1339.0 1348.5 919.1 931.4 936.6 943.4 943.6 5512.2 6040.5 6151.3 6206.5 6214.6 444.6 456.6 467.5 469.6 472.7 4024.1 4051.7 4056.1 4088.9 4128.8 10842.5 11186.3 11265.6 11270.8 11294.3 11133.8 11228.9 11252.4 11256.3 11268.7 8166.0 8485.4 8530.5 8556.9 8603.8 4963.7 6182.8 6202.2 6283.6 6374.2 10107.2 10119.3 10411.8 10427.7 10590.4 9303.3 10173.3 10571.1 10787.3 10821.6 7194.5 7627.8 7774.7 7803.8 7949.2 8771.6 8777.8 8845.7 8854.9 8881.5 7604.0 7769.9 7835.0 7846.6 7852.1 7545.8 7597.9 7628.5 7650.9 7793.5 7288.3 7322.9 7384.9 7385.1 7419.5 4968.5 5107.6 5146.3 5158.7 5173.9 5142.2 5159.0 5224.5 5374.8 5404.6 10:36:33 INFO - PROCESS | 1674 | 10:36:33 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:4456.09 Median:4779.30 stddev:1387.32 (29.0%) stddev-sans-first:1355.75 10:36:33 INFO - PROCESS | 1674 | Values: 303.5 314.0 318.5 322.2 322.9 4307.6 5238.7 5435.2 5459.5 5651.1 4989.7 5126.4 5456.7 5470.5 5506.0 3630.6 4084.9 4128.9 4156.6 4188.2 3946.7 4035.6 4171.9 4179.3 4208.3 3455.4 4117.7 4129.2 4147.0 4150.3 3619.5 3659.3 4154.5 4158.6 4182.3 3017.3 3424.5 3619.3 3631.2 3633.7 4996.6 5086.3 5211.8 5254.8 5312.6 3993.8 4177.8 4616.0 4671.9 4785.3 5000.9 5102.4 5511.4 5835.8 5862.6 3361.8 3733.1 3811.2 3970.4 3995.5 4884.6 5970.1 6032.4 6067.8 6076.6 4034.3 4042.0 4043.3 4048.0 4054.4 3405.2 3446.9 3820.3 4050.2 4066.6 3945.8 4163.8 4679.5 4742.0 4773.3 4395.2 4537.8 5722.8 5723.5 5776.0 1196.8 1373.8 1396.6 1398.4 1408.7 821.7 850.2 864.0 879.8 886.0 4076.9 4241.8 4536.5 4537.7 4617.3 4377.0 4701.9 4770.0 4906.8 4915.8 3988.8 3988.8 4407.4 4599.4 4659.8 2438.3 2480.0 2542.0 2638.4 2682.5 4331.9 4716.4 5035.0 5095.9 5158.7 4366.2 4468.8 5069.7 5180.6 5195.4 5011.7 5675.8 6020.6 6234.3 6288.1 5811.9 6003.0 6067.1 6080.5 6088.8 5119.3 5705.5 5913.8 5943.1 5985.7 5310.8 5377.4 6290.7 6300.1 6339.5 3662.6 4118.6 4174.4 4178.2 4180.4 5009.1 5114.0 5248.9 5592.5 6048.7 4919.6 4939.1 5717.3 5826.8 5842.0 4796.0 5118.5 5200.0 5351.3 5880.8 5202.7 5526.8 5680.5 5718.7 5722.5 5070.8 5341.9 5725.4 5769.8 5874.6 4524.1 4624.4 5039.6 5402.7 5735.8 10:36:33 INFO - PROCESS | 1674 | 10:36:33 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18124.14 Median:31127.87 stddev:26138.04 (84.0%) stddev-sans-first:26178.48 10:36:33 INFO - PROCESS | 1674 | Values: 662.4 704.2 712.6 738.5 759.1 15012.8 15321.5 15426.3 15549.5 15741.8 14533.5 14610.1 14687.7 14702.0 14720.3 720.1 781.7 903.3 926.9 942.4 938.2 941.9 942.3 942.9 944.9 980.9 985.5 1000.2 1002.3 1006.5 979.5 992.4 993.2 994.9 997.0 731.5 732.8 733.2 733.6 735.2 15027.7 15162.7 15172.3 15203.5 15210.5 12628.6 12652.9 12702.2 12791.9 13134.1 8664.7 9801.8 10116.8 10176.4 10249.7 3501.8 3508.7 3521.7 3537.8 3580.1 58148.0 64783.7 89088.0 91209.2 93488.0 9364.6 9367.0 9553.4 9556.7 9722.1 18076.9 22689.8 22714.9 22814.7 22902.1 7256.9 7404.1 7425.3 7483.4 7744.5 3908.0 3926.3 3944.4 3967.7 3982.4 3554.5 3612.3 3634.1 3644.6 3644.8 612.6 636.0 636.6 644.3 646.1 536.5 581.7 585.4 595.9 618.7 7860.1 8169.2 8302.5 8352.8 8378.7 509.7 569.6 570.5 592.5 602.7 3723.0 3889.1 3940.9 3955.9 3993.4 92795.0 96182.5 96420.5 97219.0 97833.5 81423.0 83596.0 83678.0 84051.0 84261.0 68163.7 72187.0 72516.0 72592.0 72687.6 7580.7 7604.0 7646.5 7753.2 7829.4 38449.6 41333.0 44824.3 45200.8 45499.5 61637.0 64217.0 64466.4 64647.4 65513.0 10279.9 10574.6 10594.9 10640.3 10692.8 9292.3 11173.3 11217.9 11377.5 11435.7 10139.3 10499.9 10664.7 10851.2 10852.7 10445.6 10535.8 10540.1 10728.6 10739.4 9809.5 10096.6 10173.3 10214.5 10762.0 8818.5 8840.9 8958.6 8991.2 9120.1 6935.5 8726.7 8866.7 8950.5 9067.8 10:36:33 INFO - PROCESS | 1674 | -------- Summary: end -------- 10:36:33 INFO - PROCESS | 1674 | 10:36:34 INFO - TEST-INFO | 1674: exit 0 10:36:34 INFO - TEST-OK | dromaeo_css | took 1111926ms 10:36:34 INFO - TEST-START | kraken 10:36:34 INFO - operating with platform_type : mac_ 10:36:34 INFO - Initialising browser for kraken test... 10:36:34 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpkEBQpK/profile http://localhost:49272/getInfo.html) 10:36:37 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 10:36:37 INFO - PROCESS | 1684 | colorDepth:24 10:36:37 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 10:36:37 INFO - PROCESS | 1684 | __metrics 10:36:37 ERROR - PROCESS | 1684 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 10:36:37 INFO - TEST-INFO | 1684: exit 0 10:36:37 INFO - Browser initialized. 10:36:37 INFO - Running cycle 1/1 for kraken test... 10:36:37 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpkEBQpK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:36:50 INFO - PROCESS | 1687 | RSS: Main: 249860096 10:36:50 INFO - PROCESS | 1687 | 10:36:52 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 10:36:53 INFO - PROCESS | 1687 | RSS: Main: 261664768 10:36:53 INFO - PROCESS | 1687 | 10:36:56 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 10:36:57 INFO - PROCESS | 1687 | RSS: Main: 266362880 10:36:57 INFO - PROCESS | 1687 | 10:37:00 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 10:37:01 INFO - PROCESS | 1687 | RSS: Main: 266731520 10:37:01 INFO - PROCESS | 1687 | 10:37:03 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 10:37:04 INFO - PROCESS | 1687 | RSS: Main: 267411456 10:37:04 INFO - PROCESS | 1687 | 10:37:06 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:37:07 INFO - PROCESS | 1687 | RSS: Main: 267882496 10:37:07 INFO - PROCESS | 1687 | 10:37:10 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 10:37:10 INFO - PROCESS | 1687 | RSS: Main: 267976704 10:37:10 INFO - PROCESS | 1687 | 10:37:14 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 10:37:14 INFO - PROCESS | 1687 | RSS: Main: 269324288 10:37:14 INFO - PROCESS | 1687 | 10:37:17 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 10:37:18 INFO - PROCESS | 1687 | RSS: Main: 268644352 10:37:18 INFO - PROCESS | 1687 | 10:37:20 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:37:20 INFO - PROCESS | 1687 | RSS: Main: 268165120 10:37:20 INFO - PROCESS | 1687 | 10:37:22 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:37:23 INFO - PROCESS | 1687 | RSS: Main: 268185600 10:37:23 INFO - PROCESS | 1687 | 10:37:25 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:37:26 INFO - PROCESS | 1687 | RSS: Main: 268431360 10:37:26 INFO - PROCESS | 1687 | 10:37:29 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:37:30 INFO - PROCESS | 1687 | RSS: Main: 268599296 10:37:30 INFO - PROCESS | 1687 | 10:37:32 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:37:33 INFO - PROCESS | 1687 | RSS: Main: 268517376 10:37:33 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 10:37:35 INFO - PROCESS | 1687 | RSS: Main: 271114240 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | __start_tp_report 10:37:35 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 10:37:35 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 10:37:35 INFO - PROCESS | 1687 | |i|pagename|runs| 10:37:35 INFO - PROCESS | 1687 | |0;ai-astar;113;117;108;116;120;163;109;132;99;97 10:37:35 INFO - PROCESS | 1687 | |1;audio-beat-detection;174;118;156;254;116;161;164;148;196;148 10:37:35 INFO - PROCESS | 1687 | |2;audio-dft;207;227;193;202;195;199;203;197;205;199 10:37:35 INFO - PROCESS | 1687 | |3;audio-fft;63;108;108;208;81;59;67;61;130;130 10:37:35 INFO - PROCESS | 1687 | |4;audio-oscillator;84;68;167;114;116;115;130;82;80;120 10:37:35 INFO - PROCESS | 1687 | |5;imaging-gaussian-blur;89;86;89;85;89;87;91;112;90;135 10:37:35 INFO - PROCESS | 1687 | |6;imaging-darkroom;95;142;137;95;122;98;133;113;97;149 10:37:35 INFO - PROCESS | 1687 | |7;imaging-desaturate;90;92;92;89;93;99;141;89;97;122 10:37:35 INFO - PROCESS | 1687 | |8;json-parse-financial;57;58;58;58;61;57;58;120;59;57 10:37:35 INFO - PROCESS | 1687 | |9;json-stringify-tinderbox;66;68;64;79;115;87;68;68;69;67 10:37:35 INFO - PROCESS | 1687 | |10;stanford-crypto-aes;86;85;86;82;87;86;87;86;85;89 10:37:35 INFO - PROCESS | 1687 | |11;stanford-crypto-ccm;162;153;145;149;141;135;136;138;217;142 10:37:35 INFO - PROCESS | 1687 | |12;stanford-crypto-pbkdf2;167;167;193;172;171;165;166;164;169;166 10:37:35 INFO - PROCESS | 1687 | |13;stanford-crypto-sha256-iterative;64;66;64;62;68;59;57;58;69;71 10:37:35 INFO - PROCESS | 1687 | __end_tp_report 10:37:35 INFO - PROCESS | 1687 | __start_cc_report 10:37:35 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,1077 10:37:35 INFO - PROCESS | 1687 | __end_cc_report 10:37:35 INFO - PROCESS | 1687 | __startTimestamp1463161055540__endTimestamp 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | ------- Summary: start ------- 10:37:35 INFO - PROCESS | 1687 | Number of tests: 14 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#0] ai-astar Cycles:10 Average:117.40 Median:126.00 stddev:18.96 (15.0%) stddev-sans-first:20.04 10:37:35 INFO - PROCESS | 1687 | Values: 113.0 117.0 108.0 116.0 120.0 163.0 109.0 132.0 99.0 97.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#1] audio-beat-detection Cycles:10 Average:163.50 Median:162.50 stddev:39.76 (24.5%) stddev-sans-first:41.99 10:37:35 INFO - PROCESS | 1687 | Values: 174.0 118.0 156.0 254.0 116.0 161.0 164.0 148.0 196.0 148.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#2] audio-dft Cycles:10 Average:202.70 Median:202.50 stddev:9.59 (4.7%) stddev-sans-first:10.05 10:37:35 INFO - PROCESS | 1687 | Values: 207.0 227.0 193.0 202.0 195.0 199.0 203.0 197.0 205.0 199.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#3] audio-fft Cycles:10 Average:101.50 Median:60.00 stddev:46.66 (77.8%) stddev-sans-first:47.36 10:37:35 INFO - PROCESS | 1687 | Values: 63.0 108.0 108.0 208.0 81.0 59.0 67.0 61.0 130.0 130.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#4] audio-oscillator Cycles:10 Average:107.60 Median:117.50 stddev:29.61 (25.2%) stddev-sans-first:30.15 10:37:35 INFO - PROCESS | 1687 | Values: 84.0 68.0 167.0 114.0 116.0 115.0 130.0 82.0 80.0 120.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#5] imaging-gaussian-blur Cycles:10 Average:95.30 Median:89.00 stddev:15.92 (17.9%) stddev-sans-first:16.73 10:37:35 INFO - PROCESS | 1687 | Values: 89.0 86.0 89.0 85.0 89.0 87.0 91.0 112.0 90.0 135.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#6] imaging-darkroom Cycles:10 Average:118.10 Median:122.00 stddev:21.25 (17.4%) stddev-sans-first:20.83 10:37:35 INFO - PROCESS | 1687 | Values: 95.0 142.0 137.0 95.0 122.0 98.0 133.0 113.0 97.0 149.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#7] imaging-desaturate Cycles:10 Average:100.40 Median:92.00 stddev:17.30 (18.8%) stddev-sans-first:17.93 10:37:35 INFO - PROCESS | 1687 | Values: 90.0 92.0 92.0 89.0 93.0 99.0 141.0 89.0 97.0 122.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:58.00 stddev:19.61 (33.8%) stddev-sans-first:20.62 10:37:35 INFO - PROCESS | 1687 | Values: 57.0 58.0 58.0 58.0 61.0 57.0 58.0 120.0 59.0 57.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#9] json-stringify-tinderbox Cycles:10 Average:75.10 Median:68.00 stddev:15.67 (23.0%) stddev-sans-first:16.27 10:37:35 INFO - PROCESS | 1687 | Values: 66.0 68.0 64.0 79.0 115.0 87.0 68.0 68.0 69.0 67.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:1.79 (2.1%) stddev-sans-first:1.90 10:37:35 INFO - PROCESS | 1687 | Values: 86.0 85.0 86.0 82.0 87.0 86.0 87.0 86.0 85.0 89.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:147.00 stddev:24.37 (16.6%) stddev-sans-first:25.57 10:37:35 INFO - PROCESS | 1687 | Values: 162.0 153.0 145.0 149.0 141.0 135.0 136.0 138.0 217.0 142.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:168.00 stddev:8.47 (5.0%) stddev-sans-first:8.92 10:37:35 INFO - PROCESS | 1687 | Values: 167.0 167.0 193.0 172.0 171.0 165.0 166.0 164.0 169.0 166.0 10:37:35 INFO - PROCESS | 1687 | 10:37:35 INFO - PROCESS | 1687 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:65.00 stddev:4.80 (7.4%) stddev-sans-first:5.09 10:37:35 INFO - PROCESS | 1687 | Values: 64.0 66.0 64.0 62.0 68.0 59.0 57.0 58.0 69.0 71.0 10:37:35 INFO - PROCESS | 1687 | -------- Summary: end -------- 10:37:35 INFO - PROCESS | 1687 | 10:37:36 INFO - TEST-INFO | 1687: exit 0 10:37:36 INFO - TEST-OK | kraken | took 61998ms 10:37:36 INFO - SUITE-END | took 1173s 10:37:36 INFO - Completed test suite (00:19:34) 10:37:36 INFO - javascript benchmark 10:37:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7209.3809892699055, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3380.1380647934775, 3411.317736452709, 3415.1462134466383, 3461.342344954459, 3506.351325004874, 5613.158026296058, 5629.0993441049495, 5660.179274005277, 5730.484256416921, 5746.310442746876, 5573.888522229563, 5632.3804381518, 5682.602217844753, 5705.457981491762, 5727.541796656268, 5020.899582008357, 5067.265246539249, 5145.0158907833365, 5186.948130518703, 5257.211418287249, 5174.637775355726, 5303.787848486056, 5324.148136298193, 5350.598705097113, 5365.409804921455, 3758.981205093957, 5082.186850103965, 5086.618503612207, 5134.691918484884, 5176.896462070757, 5094.598985279041, 5115.744212789383, 5122.129238029544, 5143.177091665316, 5143.639945203838, 4203.43253660758, 5138.58891288696, 5172.456892026358, 5197.324347834758, 5264.394594621591, 5066.442691303953, 5652.406497317764, 5664.886702265972, 5674.829755107354, 5676.631018983753, 6087.1173679816175, 6134.846628834271, 6185.84535386619, 6198.876022479571, 6218.440340369389, 6143.232095988002, 6253.562250642457, 6257.968710156466, 6278.4035516625845, 6303.495720342407, 5758.568107391962, 5803.477687008147, 5807.274090738658, 5916.112583112482, 5921.14143449206, 6266.840634482635, 6304.65324407162, 6308.3060863305, 6322.367763223733, 6322.9051564226575, 6013.9699301503215, 6123.08153776937, 6183.5671502994355, 6206.565540412218, 6239.157713708682, 5966.075258334965, 6159.722812473449, 6202.069689546604, 6252.406021428048, 6274.215723034621, 6065.60573562717, 6072.180255665517, 6099.491378240913, 6135.785247516315, 6180.381961803873, 5972.432618901197, 6094.573379863367, 6121.117656725397, 6142.9864072427545, 6156.353582873823, 4868.756562171877, 4910.926336104962, 4916.3362946001835, 4928.531789479994, 4954.529319714621, 4031.737937034142, 4063.5733248008532, 4416.205083085011, 4465.553444655508, 4493.348464472699, 5608.46719561641, 5761.193432919395, 5763.452472015152, 5803.158542011384, 5812.534997200214, 6269.811905642838, 6278.4035516625845, 6284.528660350492, 6288.52836037299, 6291.811245662638, 5837.708114594253, 5839.941600584025, 5848.093545500455, 5875.089361149029, 5933.021051526536, 5233.293505376725, 5367.3827509836865, 5393.110136827458, 5405.081136206854, 5431.0, 6345.397187267202, 6406.67966601668, 6423.903641445382, 6452.774152904626, 6452.9677351612945, 6264.404881536247, 6299.149614801943, 6300.495960323255, 6324.525660575383, 6345.8730825384155, 6223.439890409703, 6257.4681152102585, 6287.276963149114, 6318.842028949313, 6395.040743888454, 6153.7393167692335, 6193.81418557444, 6208.565400421927, 6215.751369945332, 6238.6880655966115, 5298.4171741107675, 6122.672617327995, 6288.308286088618, 6305.842353941188, 6319.652419116809, 5972.313183983897, 6037.003894357382, 6096.878062438637, 6115.6330620162935, 6125.663088530174, 6053.576249662481, 6061.818145455643, 6090.878182436238, 6112.17485639433, 6118.47992920589, 5564.55483561306, 5893.823185304448, 5913.231279933581, 5932.228810254639, 5946.970265148647, 5992.370801065826, 6005.939940600713, 6022.247219097613, 6034.396560344106, 6117.265928088658, 5825.854353641193, 5888.911666325094, 5905.763769449346, 5914.822555323347, 5925.970370148121], "value": 5669.210878730963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.9479254678259, 499.76011514473055, 555.4084899581945, 557.7155650618183, 576.3256989322492, 40326.798366008166, 42952.35571466431, 43042.0, 43048.0, 43064.78467607661, 42658.57341426585, 43247.702568922905, 43385.56614433855, 43485.6954291371, 43489.7825510872, 9661.46861922594, 9822.901770982306, 9826.803463930753, 9853.458059806708, 9902.306838521306, 8589.312854971588, 9709.417434953926, 9828.606855725762, 9846.950765246163, 9872.901270987306, 9854.852177217348, 9868.703938881808, 9869.851952220723, 9875.061869122423, 9892.356996795184, 9784.217262618973, 9838.508074596277, 9841.360311579725, 9842.60629574816, 9842.90157098427, 9625.0, 9694.61221551144, 9709.514524273829, 9764.951175244078, 9765.365251258716, 40429.584964526395, 40689.593104068874, 40709.79645101785, 40735.796321018206, 40759.0, 2951.8228906265695, 3100.147459448647, 3117.8908738194054, 3361.210115622827, 3386.9661303386897, 29451.558226626617, 29457.968971086124, 29849.55225671595, 30189.698103019127, 30253.0, 2746.6841313248833, 2762.1713485954333, 2834.63149790528, 2844.431113777253, 2890.089621769157, 489494.0, 489577.0, 494246.0, 494769.0, 495852.0, 34052.82973585116, 34893.825530872185, 34939.4759078614, 36121.277574448366, 66271.33728662651, 36501.63498365036, 36543.0, 37350.25299493995, 37395.439068413994, 37410.8129459351, 15436.0, 15540.0, 15583.220838958006, 15624.531264062096, 15653.904226704022, 12725.0, 13092.934535327453, 13112.803307950388, 13142.27717475548, 13195.20828750278, 7401.629918504161, 8017.037955445384, 8326.875096873551, 8329.583520823935, 8432.0, 3425.2978139481347, 3457.481377793351, 3459.6540345965204, 3479.495473156378, 3504.5093686883856, 927.7773334399695, 1006.3157053203892, 1009.7627057641448, 1074.1782536359692, 1082.6156714366443, 30211.546826797614, 30287.0, 30578.847105764773, 30765.344033289017, 31208.0, 1099.5272033025876, 1103.1340397787699, 1113.6046703420332, 1152.8040233160382, 1204.476052916984, 12827.767970362193, 15639.452619158275, 15777.211139442981, 15942.362305507882, 16039.599010024842, 577524.8990040435, 657352.0, 670970.0, 671335.0, 674933.0, 62694.68652656708, 64534.354656453776, 64636.0, 64738.676306619105, 64753.0, 1468.6695493514087, 1472.8968972172058, 1484.1985327923016, 1492.0152699218681, 1505.4204131409267, 25561.616575751006, 25580.872095639403, 26144.8692756535, 27030.594541082293, 28620.57069144006, 42416.57583424126, 55493.167602485184, 55924.440755591924, 55997.16004260021, 56038.439615603325, 595016.0, 606460.0, 608277.0, 609499.0, 609614.0, 27799.0, 28187.57718634263, 28209.43581128325, 28261.57607635928, 28353.0, 47171.0, 47276.0, 47629.332973345765, 47820.0, 48262.27606585974, 32834.835825820715, 38734.22531549297, 38870.0, 39237.8038109819, 40024.799876000434, 33466.49800253047, 35296.647033529334, 38198.0, 38890.61109388983, 38926.83219503419, 37698.869033929026, 37915.62084379121, 38431.80784096174, 38506.6149338503, 38680.0, 27670.5849412263, 28421.00526481563, 32782.83608581942, 32793.18017049593, 34327.31345373028, 25011.74988250167, 25401.237962861145, 25455.799793034683, 25652.871735641947, 26009.0], "value": 18750.758359403502, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.4909729988816, 355.8629927477921, 382.1764098368018, 392.17838628074185, 399.87204094689673, 20208.494787630298, 21109.261175858846, 21230.57538849222, 21793.782062179394, 21806.672899906513, 16330.918345408287, 21583.24458643944, 21789.673154902688, 21986.89006554965, 22137.778622213773, 5601.663900165982, 5870.559708021894, 5982.551308651847, 5993.490553302974, 6005.789797357093, 5042.142835717918, 5887.440693134166, 5957.017092179785, 5972.940270597303, 6014.0678194879865, 5637.605367624268, 5885.970570147143, 5887.558433117512, 5888.5289176865745, 5889.057750759879, 5674.659520428788, 5718.399568045337, 5848.590598658075, 5864.794732184374, 5875.941240587582, 5137.33214682089, 5162.97418512905, 5164.793408263665, 5168.53483186515, 5175.792968281265, 12755.744885102245, 13500.122492037986, 13527.0, 13595.592132236048, 26567.867160664075, 1996.8402527797741, 2072.3990042887544, 2207.194374053475, 2357.5520651076413, 2436.5857804173334, 10279.691609251735, 10279.743006424824, 10308.123809476203, 10495.42275174865, 10545.947270263676, 1741.5123765345597, 1761.6124452620404, 1784.14536741213, 1839.7976222615503, 1845.418693111679, 110170.89829101767, 118538.40730796377, 124883.0, 125252.0, 140959.29520352333, 17089.572760680832, 18115.36596219126, 20758.273460428813, 21828.89085554594, 21941.341759746912, 31969.72121115176, 34679.0, 36724.81637591795, 36742.63257367392, 36758.0, 10978.847221041675, 11306.265092768943, 11377.2604780689, 11404.543818247177, 11540.596079137189, 8242.134575869568, 9127.452352858849, 9245.583948722324, 9334.20659243972, 9376.906230937604, 8134.959325203455, 10089.192864570818, 10184.185265178769, 10249.38503689781, 10398.480075996169, 3189.9043028709175, 3497.720182385403, 3915.256101340736, 3997.480327557399, 4115.859752928521, 722.0, 791.9128895821455, 939.9812003759887, 940.3981451870808, 1040.3185913226848, 20198.697019544717, 20823.08968439577, 21022.0, 21241.468963275733, 21528.78471215268, 860.4493124400389, 952.2953014769021, 1024.4621573673733, 1051.3796859852723, 1063.5373612478597, 10852.67441976742, 11078.723031924266, 11160.441977901073, 11225.045871100885, 11238.38188899602, 622514.0, 622585.0, 629723.0, 632052.0, 636469.0, 138299.15952941598, 139512.30243848715, 139940.0, 140814.0, 142874.85687714483, 1004.9799004019878, 1012.21047582884, 1027.1012863744224, 1028.100412139378, 1029.9279050466396, 18699.626007480045, 18818.623627527646, 18854.3400980965, 18912.621747564695, 18936.715949260495, 52000.73999629977, 52519.68700782511, 53140.67148321323, 53198.468015319355, 54423.0, 75835.62082189554, 76177.23822761701, 76364.0, 76434.0, 79193.60403197947, 7183.461240407095, 8191.467554609169, 8399.0, 8516.489010659381, 8582.227599516074, 9167.266618670357, 11953.760924781282, 12440.315782632042, 12896.48414063427, 13032.348382580643, 9291.76770580741, 10766.407847568145, 10832.0, 11163.49764260594, 11400.771984560428, 9834.819821621166, 10782.245242832927, 10837.837432438677, 10998.0, 11121.944390277997, 10600.098991585493, 11412.657620271406, 11477.253978491706, 11483.48324325424, 11752.76494470123, 7525.397968162643, 8341.915550978334, 8401.369897257608, 8488.151184881463, 8533.146685331418, 8566.957165214135, 9868.605255789975, 10767.084797792275, 11197.944010280222, 11444.313341199555], "value": 10337.524516845473, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1604.775331453596, 1638.4511188751767, 1885.9905700471495, 1957.3834242213711, 1992.3624440179149, 8266.173382661731, 8896.332775041874, 8912.910870891305, 9422.952885235563, 9444.386114902534, 9039.954800225989, 9102.088561402114, 9270.026647202048, 9272.304577156707, 9280.30397720172, 2426.5025669737706, 2462.655228268044, 2462.9876850615724, 2464.309993201897, 2473.6536884836137, 2426.575349313872, 2485.030837973192, 2489.3403248139166, 2490.140901389018, 2490.56415127352, 2439.1584903208363, 2451.4361696809747, 2470.641756945242, 2471.789897858684, 2479.1075212923333, 2417.891194896234, 2441.694788151472, 2446.1438496526252, 2457.5699252630807, 2459.4712136890566, 1908.9236430542762, 2231.252530402301, 2242.2824696097255, 2244.517428752826, 2435.281591930367, 9088.091190880925, 9167.679131230376, 9256.398334108262, 9256.537173141383, 9276.397034192756, 5414.835810300765, 5527.364353099405, 5584.93886161628, 5609.663420194802, 5630.071038278679, 3611.1152767571853, 3637.4725664778457, 3641.890743277706, 3681.4845921571, 3701.8519259229597, 1037.3868634273701, 1039.719275795531, 1043.342694102718, 1045.968620941373, 1048.916086713061, 11821.231619944676, 12149.817752733716, 12197.20718153326, 12315.0, 12317.322547259897, 3887.7667339959125, 4906.656534042583, 5034.647574669738, 5040.218766091261, 5062.7468626568525, 10466.790664186674, 10470.47647617616, 10488.26582139243, 10492.947535262274, 10506.0, 4838.491958344393, 5589.692566908859, 5603.243562119062, 5616.6068375213345, 5648.0, 4531.116432295671, 4919.7540122993705, 5066.9746651266505, 5114.079465696211, 5119.411267704188, 4102.989120937781, 4122.958770412258, 4131.277026520407, 4151.14901445203, 4187.120704651997, 1334.219481603273, 1336.3919416665394, 1337.9356995066066, 1338.9531366402323, 1348.528015194674, 919.1497864475467, 931.4411353188168, 936.6253498600614, 943.3915124744501, 943.6461327002374, 5512.173174023848, 6040.486558642477, 6151.2618485781095, 6206.472449841814, 6214.564980451325, 444.5820928327362, 456.59135074108485, 467.5277969251013, 469.5609605019318, 472.6502388232752, 4024.054347228399, 4051.716379853441, 4056.148208876169, 4088.856890008895, 4128.814203360856, 10842.512086955949, 11186.272892261977, 11265.605703800327, 11270.774584508265, 11294.265872718248, 11133.832992505118, 11228.887711122785, 11252.43737813106, 11256.268342557707, 11268.71828204285, 8166.0, 8485.448445851, 8530.530820804792, 8556.871646925301, 8603.827923441371, 4963.70217786934, 6182.752689892354, 6202.193714817045, 6283.59156654816, 6374.203224596926, 10107.191424686154, 10119.291649584753, 10411.843822342822, 10427.739306517398, 10590.364578125336, 9303.348765586614, 10173.336782821443, 10571.101456375987, 10787.298825576312, 10821.621243256448, 7194.496385252982, 7627.771166865003, 7774.727884524014, 7803.765887023398, 7949.205079492004, 8771.605277762643, 8777.824443510966, 8845.734627961172, 8854.867176992222, 8881.467111973303, 7604.0, 7769.8834517481155, 7834.960825196065, 7846.607669616382, 7852.136265010959, 7545.811354716176, 7597.924020759721, 7628.46600737943, 7650.923490765021, 7793.532388056735, 7288.344049035612, 7322.926770732224, 7384.852302954018, 7385.113786345673, 7419.517731347445, 4968.478309777566, 5107.591392688501, 5146.3309769731195, 5158.690478571298, 5173.870653233549, 5142.1772516397195, 5159.0, 5224.529792318557, 5374.811881584125, 5404.648697834628], "value": 4670.447983090745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.45984148216166, 313.96546379898206, 318.5079052863326, 322.22504875773774, 322.8821480159742, 4307.6123148916595, 5238.685678859261, 5435.189856976574, 5459.481349271823, 5651.095824668059, 4989.65072444929, 5126.436436886748, 5456.727163641822, 5470.507654311111, 5505.9724701376435, 3630.6369363063613, 4084.937106761089, 4128.8761337159785, 4156.625903668669, 4188.2251783420015, 3946.743461674982, 4035.556088830226, 4171.916561668765, 4179.26862799009, 4208.2845916194165, 3455.447128459447, 4117.711760176789, 4129.2360913231, 4147.0, 4150.294449943502, 3619.475176099464, 3659.323025240339, 4154.459920210384, 4158.563350848178, 4182.33082706767, 3017.2909366298904, 3424.520567120605, 3619.2580520993133, 3631.201135750157, 3633.6729694327373, 4996.575291100225, 5086.34693724541, 5211.791528338862, 5254.8160814371695, 5312.645275454773, 3993.800309984489, 4177.811998460076, 4615.976920115411, 4671.855395428108, 4785.282207668843, 5000.949420853277, 5102.413222479426, 5511.4213007634025, 5835.766569337221, 5862.618929769551, 3361.8487168077495, 3733.1040550268012, 3811.2187001664593, 3970.3647416413237, 3995.5205375355144, 4884.632302955179, 5970.1343305220935, 6032.396760323976, 6067.817965461043, 6076.635401875901, 4034.293998550242, 4041.9595804041583, 4043.332850079763, 4048.0, 4054.432379466877, 3405.182756138509, 3446.913827154341, 3820.2741479118877, 4050.210209009215, 4066.573009833925, 3945.8421663133154, 4163.791810409467, 4679.4618618858585, 4741.952580474152, 4773.307870358779, 4395.164918665443, 4537.818487260539, 5722.7982123753645, 5723.513501352349, 5775.971120144456, 1196.7606478704295, 1373.8214032175754, 1396.6019684390103, 1398.4056775870215, 1408.6548795545157, 821.7370441458676, 850.2050582705191, 863.9913600864037, 879.8108406692592, 886.0165216609687, 4076.9196163016823, 4241.830326786956, 4536.455625324982, 4537.727736335764, 4617.284320930261, 4376.978115109468, 4701.905961880743, 4769.976150119297, 4906.754662266872, 4915.827946021872, 3988.7918246249906, 3988.8205030773684, 4407.382966384709, 4599.425071866017, 4659.767011649404, 2438.2685194441597, 2479.9752002479745, 2541.9872900635746, 2638.3667919699133, 2682.463507298548, 4331.935020974688, 4716.372851366273, 5034.993001399735, 5095.897802269134, 5158.716270605153, 4366.214081465367, 4468.776561171929, 5069.746512674352, 5180.611454140954, 5195.389429276936, 5011.699298042129, 5675.772969081273, 6020.608660437058, 6234.2830574484515, 6288.119663247057, 5811.87866428742, 6002.969985150046, 6067.089936509382, 6080.543959202989, 6088.847778805565, 5119.308893299357, 5705.515031222227, 5913.763449461973, 5943.108533719977, 5985.65322802366, 5310.840674779763, 5377.3816011159215, 6290.654014029273, 6300.117983482224, 6339.461145802658, 3662.5788034376387, 4118.567550407164, 4174.373843923436, 4178.164367126647, 4180.4147419361925, 5009.073321435546, 5114.028334616411, 5248.868778280574, 5592.524635405874, 6048.697565121638, 4919.581835544019, 4939.135651260943, 5717.313922329347, 5826.814944395852, 5841.970790146022, 4795.968866693677, 5118.462561430996, 5199.974000130126, 5351.3043304370185, 5880.794172203952, 5202.739863006759, 5526.80656177048, 5680.523064003306, 5718.685472299064, 5722.456366645162, 5070.847874563769, 5341.866453338697, 5725.427457254241, 5769.797762241996, 5874.5887787854435, 4524.054656497606, 4624.44506659203, 5039.622028347815, 5402.703351195763, 5735.763052409647], "value": 4023.8855190224604, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.393909572741, 704.2499737779265, 712.5510928115286, 738.5494848142636, 759.1383779410368, 15012.77480837787, 15321.463748768796, 15426.305816238268, 15549.45576904807, 15741.842581574181, 14533.49132780353, 14610.050346727456, 14687.706245875075, 14702.0, 14720.263986800644, 720.0711082703307, 781.6873250699708, 903.2728653433983, 926.8517037274038, 942.3827393057559, 938.1790932933683, 941.924646028316, 942.3262367407302, 942.9245660347156, 944.9291303152256, 980.8822941247024, 985.4875464758321, 1000.1748557440104, 1002.3234316836143, 1006.4514839412537, 979.5445118020119, 992.3995982430598, 993.2054356514832, 994.9104580587746, 997.0278977996431, 731.4660297982502, 732.7948174511146, 733.1641928201855, 733.6405161470894, 735.1619154164257, 15027.699446011018, 15162.696746065018, 15172.317245723858, 15203.467878624306, 15210.467633632881, 12628.558000469939, 12652.873471265353, 12702.174358666656, 12791.872081279254, 13134.080614356999, 8664.653413863438, 9801.803963920682, 10116.848247276297, 10176.440295783728, 10249.743756406075, 3501.8424170912117, 3508.6666766657127, 3521.683048525645, 3537.7523573349877, 3580.087077795172, 58148.0, 64783.676081619764, 89088.0, 91209.17581648396, 93488.0, 9364.578593963288, 9366.95316523413, 9553.379030363005, 9556.665516706882, 9722.076402741728, 18076.909615451837, 22689.773102268766, 22714.886425567765, 22814.65778013331, 22902.08391664348, 7256.8911466328045, 7404.074490688664, 7425.331720145105, 7483.438742094365, 7744.457887947902, 3908.022994251437, 3926.2736393767245, 3944.4083387491532, 3967.7420967637013, 3982.3628219484744, 3554.4668299755244, 3612.3317186320614, 3634.127809325743, 3644.599094099647, 3644.7630903991158, 612.5834432585884, 635.9633796911005, 636.5512313818747, 644.3041515163612, 646.0922404022356, 536.5171345788822, 581.6617198860557, 585.4387056627256, 595.9020578947149, 618.7339444039106, 7860.136105822589, 8169.183081691784, 8302.54336011525, 8352.8329433411, 8378.748637540884, 509.68399592252297, 569.63827969239, 570.5150621971292, 592.5111782779225, 602.7378090530633, 3722.962770372316, 3889.124946886928, 3940.901477463029, 3955.861544845917, 3993.4009898515455, 92795.0, 96182.51908740411, 96420.51789741007, 97219.0, 97833.5324970126, 81423.0, 83596.0, 83678.0, 84051.0, 84261.0, 68163.65918170377, 72187.0, 72516.0, 72592.0, 72687.63656181685, 7580.658870350958, 7603.9619801900635, 7646.541207527566, 7753.1859154787935, 7829.435820066052, 38449.6155038446, 41333.0, 44824.32763508615, 45200.77399612981, 45499.54500454953, 61637.0, 64217.0, 64466.35533644604, 64647.35352646413, 65513.0, 10279.897201028192, 10574.629887954192, 10594.894051059699, 10640.308379955279, 10692.786144276915, 9292.303077269096, 11173.273737207055, 11217.887821121685, 11377.54489820398, 11435.714107147387, 10139.340942838988, 10499.94750026245, 10664.680059598224, 10851.186161038111, 10852.67441976742, 10445.634402795866, 10535.789284214427, 10540.104091152338, 10728.570857165625, 10739.409332486788, 9809.509524523888, 10096.646617368357, 10173.338732982333, 10214.54034568461, 10762.0, 8818.514981675813, 8840.867386989072, 8958.622549362404, 8991.23574496149, 9120.133587309196, 6935.549189302679, 8726.65093396257, 8866.73399798007, 8950.483614840407, 9067.818643626959], "value": 6797.99086774222, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1617.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 108.0, 116.0, 120.0, 163.0, 109.0, 132.0, 99.0, 97.0], "value": 117.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 118.0, 156.0, 254.0, 116.0, 161.0, 164.0, 148.0, 196.0, 148.0], "value": 163.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 227.0, 193.0, 202.0, 195.0, 199.0, 203.0, 197.0, 205.0, 199.0], "value": 202.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 108.0, 108.0, 208.0, 81.0, 59.0, 67.0, 61.0, 130.0, 130.0], "value": 101.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 68.0, 167.0, 114.0, 116.0, 115.0, 130.0, 82.0, 80.0, 120.0], "value": 107.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 85.0, 89.0, 87.0, 91.0, 112.0, 90.0, 135.0], "value": 95.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 142.0, 137.0, 95.0, 122.0, 98.0, 133.0, 113.0, 97.0, 149.0], "value": 118.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 92.0, 89.0, 93.0, 99.0, 141.0, 89.0, 97.0, 122.0], "value": 100.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 61.0, 57.0, 58.0, 120.0, 59.0, 57.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 64.0, 79.0, 115.0, 87.0, 68.0, 68.0, 69.0, 67.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 82.0, 87.0, 86.0, 87.0, 86.0, 85.0, 89.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 153.0, 145.0, 149.0, 141.0, 135.0, 136.0, 138.0, 217.0, 142.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 193.0, 172.0, 171.0, 165.0, 166.0, 164.0, 169.0, 166.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 62.0, 68.0, 59.0, 57.0, 58.0, 69.0, 71.0], "value": 63.8, "unit": "score"}]}]} 10:37:36 INFO - Return code: 0 10:37:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:37:36 ERROR - # TBPL SUCCESS # 10:37:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:37:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:37:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:37:36 INFO - 2016-05-13 10:37:36.835 screenresolution[1692:12419] starting screenresolution argv=screenresolution get 10:37:36 INFO - 2016-05-13 10:37:36.837 screenresolution[1692:12419] Display 0: 1600x1200x32@60 10:37:36 INFO - 2016-05-13 10:37:36.843 screenresolution[1693:12422] starting screenresolution argv=screenresolution list 10:37:36 INFO - Available Modes on Display 0 10:37:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:37:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:37:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:37:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:37:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:37:37 INFO - Intel Iris: 10:37:37 INFO - Chipset Model: Intel Iris 10:37:37 INFO - Type: GPU 10:37:37 INFO - Bus: Built-In 10:37:37 INFO - VRAM (Dynamic, Max): 1536 MB 10:37:37 INFO - Vendor: Intel (0x8086) 10:37:37 INFO - Device ID: 0x0a2e 10:37:37 INFO - Revision ID: 0x0009 10:37:37 INFO - Displays: 10:37:37 INFO - Display: 10:37:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:37:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:37:37 INFO - Display Serial Number: 1600x1200 60 10:37:37 INFO - Main Display: Yes 10:37:37 INFO - Mirror: Off 10:37:37 INFO - Online: Yes 10:37:37 INFO - Rotation: Supported 10:37:37 INFO - Return code: 0 10:37:37 INFO - Running post-action listener: _resource_record_post_action 10:37:37 INFO - ##### 10:37:37 INFO - ##### Finished run-tests step (success) 10:37:37 INFO - ##### 10:37:37 INFO - Running post-run listener: _resource_record_post_run 10:37:37 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32402944; Write bytes: 699045376; Read time: 320; Write time: 2337 10:37:37 INFO - TinderboxPrint: CPU usage
54.5% 10:37:37 INFO - TinderboxPrint: I/O read bytes / time
32,402,944 / 320 10:37:37 INFO - TinderboxPrint: I/O write bytes / time
699,045,376 / 2,337 10:37:37 INFO - TinderboxPrint: CPU idle
2,204.1 (45.5%) 10:37:37 INFO - TinderboxPrint: CPU system
974.5 (20.1%) 10:37:37 INFO - TinderboxPrint: CPU user
1,663.1 (34.3%) 10:37:37 INFO - TinderboxPrint: Swap in / out
423,497,728 / 0 10:37:37 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 395743744; Write bytes: 398438912; Read time: 29551; Write time: 849 10:37:37 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 30612992; Write bytes: 299758592; Read time: 301; Write time: 1486 10:37:37 INFO - Running post-run listener: _upload_blobber_files 10:37:37 INFO - Blob upload gear active. 10:37:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:37:37 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:37:37 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'] 10:37:37 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 10:37:38 INFO - (blobuploader) - INFO - Open directory for files ... 10:37:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:37:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:37:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:39 INFO - (blobuploader) - INFO - Done attempting. 10:37:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:37:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:37:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:40 INFO - (blobuploader) - INFO - Done attempting. 10:37:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:37:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:37:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:37:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:37:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:37:42 INFO - (blobuploader) - INFO - Done attempting. 10:37:42 INFO - (blobuploader) - INFO - Iteration through files over. 10:37:42 INFO - Return code: 0 10:37:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:37:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:37:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c633fb175e71bfc34388e2114c4c2e462ca6af7c5c51202d5200a6f5d88dfa3bb16fe99c01135ea5e5707b605d483ef1801eeb8c5a3737baedf9e1bc5fd481f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3733c913add4afd527c0dff56077300485ad89806fba2ba0edc0718d8b2eb30811ad19221a771899e411d47f5093408c4ab7d412cdf26ea07e6369b518f2cf17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c02c362d703e5877c5ab277bd9ef42d896bf79a16044bb41848cdac821e09d41ed60774f542d6d1035e2b51b3c6637ce64971ad1207987859e918a781fa53819"} 10:37:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:37:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:37:42 INFO - Contents: 10:37:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c633fb175e71bfc34388e2114c4c2e462ca6af7c5c51202d5200a6f5d88dfa3bb16fe99c01135ea5e5707b605d483ef1801eeb8c5a3737baedf9e1bc5fd481f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3733c913add4afd527c0dff56077300485ad89806fba2ba0edc0718d8b2eb30811ad19221a771899e411d47f5093408c4ab7d412cdf26ea07e6369b518f2cf17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c02c362d703e5877c5ab277bd9ef42d896bf79a16044bb41848cdac821e09d41ed60774f542d6d1035e2b51b3c6637ce64971ad1207987859e918a781fa53819"} 10:37:42 INFO - Running post-run listener: copy_logs_to_upload_dir 10:37:42 INFO - Copying logs to upload dir... 10:37:42 INFO - mkdir: /builds/slave/test/build/upload/logs 10:37:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1303.522764 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-05-13 10:37:42.498077) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 10:37:42.501626) ========= 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.cEa4e6rt6s/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.DbDPIwwfha/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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/c633fb175e71bfc34388e2114c4c2e462ca6af7c5c51202d5200a6f5d88dfa3bb16fe99c01135ea5e5707b605d483ef1801eeb8c5a3737baedf9e1bc5fd481f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3733c913add4afd527c0dff56077300485ad89806fba2ba0edc0718d8b2eb30811ad19221a771899e411d47f5093408c4ab7d412cdf26ea07e6369b518f2cf17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c02c362d703e5877c5ab277bd9ef42d896bf79a16044bb41848cdac821e09d41ed60774f542d6d1035e2b51b3c6637ce64971ad1207987859e918a781fa53819"} build_url:https://queue.taskcluster.net/v1/task/DYwKlyyYTT-IV9XyJaEIOw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011037 build_url: 'https://queue.taskcluster.net/v1/task/DYwKlyyYTT-IV9XyJaEIOw/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/c633fb175e71bfc34388e2114c4c2e462ca6af7c5c51202d5200a6f5d88dfa3bb16fe99c01135ea5e5707b605d483ef1801eeb8c5a3737baedf9e1bc5fd481f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3733c913add4afd527c0dff56077300485ad89806fba2ba0edc0718d8b2eb30811ad19221a771899e411d47f5093408c4ab7d412cdf26ea07e6369b518f2cf17", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c02c362d703e5877c5ab277bd9ef42d896bf79a16044bb41848cdac821e09d41ed60774f542d6d1035e2b51b3c6637ce64971ad1207987859e918a781fa53819"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 10:37:42.529988) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:37:42.530330) ========= 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.cEa4e6rt6s/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.DbDPIwwfha/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.005173 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 10:37:42.579287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 10:37:42.579634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 10:37:42.580101) ========= ========= Total master_lag: 0.16 =========