builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0016 starttime: 1454761909.4 results: success (0) buildid: 20160206043145 builduid: b38ba181eadc429690d9465177dc8579 revision: f5bd25c789b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.402779) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.403298) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.403574) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6llMBBMKIy/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.BMSHkaGDXZ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005508 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.433147) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.433465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.736572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.736838) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6llMBBMKIy/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.BMSHkaGDXZ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.005444 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.796580) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.796922) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.797366) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:49.797688) ========= 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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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-02-06 04:31:49-- 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% 123M=0s 2016-02-06 04:31:50 (123 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.661726 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:50.475632) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:50.475992) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6llMBBMKIy/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.BMSHkaGDXZ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.025428 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:50.526168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 04:31:50.526609) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5bd25c789b6 --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 f5bd25c789b6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6llMBBMKIy/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.BMSHkaGDXZ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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-02-06 04:31:50,454 Setting DEBUG logging. 2016-02-06 04:31:50,454 attempt 1/10 2016-02-06 04:31:50,454 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5bd25c789b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 04:31:52,034 unpacking tar archive at: fx-team-f5bd25c789b6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.811443 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-06 04:31:52.354479) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:52.354962) ========= echo f5bd25c789b6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f5bd25c789b6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.6llMBBMKIy/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.BMSHkaGDXZ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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 f5bd25c789b6 program finished with exit code 0 elapsedTime=0.005610 script_repo_revision: 'f5bd25c789b6' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:52.405286) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:52.405626) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 04:31:52.418855) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-06 04:31:52.419218) ========= /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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:31:52 INFO - MultiFileLogger online at 20160206 04:31:52 in /builds/slave/test 04:31:52 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 04:31:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:52 INFO - {'append_to_log': False, 04:31:52 INFO - 'base_work_dir': '/builds/slave/test', 04:31:52 INFO - 'blob_upload_branch': 'Fx-Team', 04:31:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:52 INFO - 'branch': 'Fx-Team', 04:31:52 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:52 INFO - 'config_files': ('talos/mac_config.py',), 04:31:52 INFO - 'default_actions': ('clobber', 04:31:52 INFO - 'read-buildbot-config', 04:31:52 INFO - 'download-and-extract', 04:31:52 INFO - 'populate-webroot', 04:31:52 INFO - 'create-virtualenv', 04:31:52 INFO - 'install', 04:31:52 INFO - 'run-tests'), 04:31:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:52 INFO - 'download_minidump_stackwalk': True, 04:31:52 INFO - 'download_symbols': 'ondemand', 04:31:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:52 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:52 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:52 INFO - 'installer_path': 'installer.exe', 04:31:52 INFO - 'log_level': 'info', 04:31:52 INFO - 'log_name': 'talos', 04:31:52 INFO - 'log_to_console': True, 04:31:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:31:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:31:52 INFO - 'opt_config_files': (), 04:31:52 INFO - 'pip_index': False, 04:31:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:52 INFO - 'cmd': ('bash', 04:31:52 INFO - '-c', 04:31:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:52 INFO - 'enabled': True, 04:31:52 INFO - 'halt_on_failure': False, 04:31:52 INFO - 'name': 'check_screen_resolution'},), 04:31:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:31:52 INFO - 'cmd': ('bash', 04:31:52 INFO - '-c', 04:31:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:31:52 INFO - 'enabled': True, 04:31:52 INFO - 'halt_on_failure': False, 04:31:52 INFO - 'name': 'check_screen_resolution'},), 04:31:52 INFO - 'run_cmd_checks_enabled': True, 04:31:52 INFO - 'sps_profile': False, 04:31:52 INFO - 'sps_profile_interval': 0, 04:31:52 INFO - 'suite': 'dromaeojs-e10s', 04:31:52 INFO - 'system_bits': '32', 04:31:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:52 INFO - 'title': 't-yosemite-r7-0016', 04:31:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:52 INFO - 'use_talos_json': True, 04:31:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:52 INFO - 'work_dir': 'build'} 04:31:52 INFO - ##### 04:31:52 INFO - ##### Running clobber step. 04:31:52 INFO - ##### 04:31:52 INFO - Running pre-action listener: _resource_record_pre_action 04:31:52 INFO - Running main action method: clobber 04:31:52 INFO - rmtree: /builds/slave/test/build 04:31:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:53 INFO - Running post-action listener: _resource_record_post_action 04:31:53 INFO - ##### 04:31:53 INFO - ##### Running read-buildbot-config step. 04:31:53 INFO - ##### 04:31:53 INFO - Running pre-action listener: _resource_record_pre_action 04:31:53 INFO - Running main action method: read_buildbot_config 04:31:53 INFO - Using buildbot properties: 04:31:53 INFO - { 04:31:53 INFO - "project": "", 04:31:53 INFO - "product": "firefox", 04:31:53 INFO - "script_repo_revision": "production", 04:31:53 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:31:53 INFO - "repository": "", 04:31:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:31:53 INFO - "buildid": "20160206043145", 04:31:53 INFO - "stage_platform": "macosx64", 04:31:53 INFO - "basedir": "/builds/slave/test", 04:31:53 INFO - "buildnumber": 338, 04:31:53 INFO - "platform": "yosemite_r7", 04:31:53 INFO - "mozci_request": { 04:31:53 INFO - "priority": -1, 04:31:53 INFO - "type": "trigger_all_talos_jobs", 04:31:53 INFO - "times": 6 04:31:53 INFO - }, 04:31:53 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:31:53 INFO - "slavebuilddir": "test", 04:31:53 INFO - "branch": "fx-team", 04:31:53 INFO - "revision": "f5bd25c789b6", 04:31:53 INFO - "slavename": "t-yosemite-r7-0016", 04:31:53 INFO - "builduid": "b38ba181eadc429690d9465177dc8579", 04:31:53 INFO - "repo_path": "integration/fx-team" 04:31:53 INFO - } 04:31:53 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg. 04:31:53 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json. 04:31:53 INFO - Running post-action listener: _resource_record_post_action 04:31:53 INFO - ##### 04:31:53 INFO - ##### Running download-and-extract step. 04:31:53 INFO - ##### 04:31:53 INFO - Running pre-action listener: _resource_record_pre_action 04:31:53 INFO - Running main action method: download_and_extract 04:31:53 INFO - mkdir: /builds/slave/test/build/tests 04:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:53 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json 04:31:53 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json to /builds/slave/test/build/test_packages.json 04:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:31:54 INFO - Downloaded 1277 bytes. 04:31:54 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:31:54 INFO - Using the following test package requirements: 04:31:54 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:54 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:54 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:31:54 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:54 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:31:54 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:54 INFO - u'jsshell-mac.zip'], 04:31:54 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:54 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:31:54 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:54 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:54 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:31:54 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:54 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:31:54 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:54 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:31:54 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:31:54 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:31:54 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:31:54 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:54 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:54 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:31:54 INFO - Downloaded 17118738 bytes. 04:31:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:31:57 INFO - Return code: 0 04:31:57 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:57 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:57 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:31:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:31:58 INFO - Downloaded 17118738 bytes. 04:31:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:31:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:32:01 INFO - Return code: 0 04:32: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')]} 04:32:01 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip 04:32:01 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:32:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:32:02 INFO - Downloaded 10706582 bytes. 04:32:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:32:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:32:03 INFO - Return code: 0 04:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:03 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:32:03 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:32:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:32:06 INFO - Downloaded 111115296 bytes. 04:32:06 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:32:06 INFO - mkdir: /builds/slave/test/properties 04:32:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:06 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:06 INFO - Contents: 04:32:06 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg 04:32:06 INFO - Running post-action listener: _resource_record_post_action 04:32:06 INFO - Running post-action listener: set_extra_try_arguments 04:32:06 INFO - ##### 04:32:06 INFO - ##### Running populate-webroot step. 04:32:06 INFO - ##### 04:32:06 INFO - Running pre-action listener: _resource_record_pre_action 04:32:06 INFO - Running main action method: populate_webroot 04:32:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:06 INFO - '--tppagecycles', 04:32:06 INFO - '7'], 04:32:06 INFO - 'tests': ['tsvgm']}}, 04:32:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:32:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:32:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:32:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:32:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:06 INFO - 'talos_options': ['--e10s'], 04:32:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:06 INFO - 'tests': ['damp', 'tps']}, 04:32:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:06 INFO - 'talos_options': ['--e10s'], 04:32:06 INFO - 'tests': ['damp', 'tps']}, 04:32:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:32:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:06 INFO - 'other': {'tests': ['a11yr', 04:32:06 INFO - 'ts_paint', 04:32:06 INFO - 'tpaint', 04:32:06 INFO - 'sessionrestore', 04:32:06 INFO - 'sessionrestore_no_auto_restore']}, 04:32:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:32:06 INFO - 'tests': ['a11yr', 04:32:06 INFO - 'ts_paint', 04:32:06 INFO - 'tpaint', 04:32:06 INFO - 'sessionrestore', 04:32:06 INFO - 'sessionrestore_no_auto_restore']}, 04:32:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:32:06 INFO - 'tests': ['a11yr', 04:32:06 INFO - 'ts_paint', 04:32:06 INFO - 'tpaint', 04:32:06 INFO - 'sessionrestore', 04:32:06 INFO - 'sessionrestore_no_auto_restore']}, 04:32:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:32:06 INFO - 'tests': ['a11yr', 04:32:06 INFO - 'ts_paint', 04:32:06 INFO - 'tpaint', 04:32:06 INFO - 'sessionrestore', 04:32:06 INFO - 'sessionrestore_no_auto_restore']}, 04:32:06 INFO - 'other_l64': {'tests': ['a11yr', 04:32:06 INFO - 'ts_paint', 04:32:06 INFO - 'tpaint', 04:32:06 INFO - 'sessionrestore', 04:32:06 INFO - 'sessionrestore_no_auto_restore']}, 04:32:06 INFO - 'other_nol64': {'tests': ['a11yr', 04:32:06 INFO - 'ts_paint', 04:32:06 INFO - 'tpaint', 04:32:06 INFO - 'sessionrestore', 04:32:06 INFO - 'sessionrestore_no_auto_restore']}, 04:32:06 INFO - 'svgr': {'tests': ['tsvgx', 04:32:06 INFO - 'tsvgr_opacity', 04:32:06 INFO - 'tart', 04:32:06 INFO - 'tscrollx', 04:32:06 INFO - 'cart']}, 04:32:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:32:06 INFO - 'tests': ['tsvgx', 04:32:06 INFO - 'tsvgr_opacity', 04:32:06 INFO - 'tart', 04:32:06 INFO - 'tscrollx', 04:32:06 INFO - 'cart']}, 04:32:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:06 INFO - 'tests': ['tp5o']}, 04:32:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:06 INFO - 'talos_options': ['--e10s'], 04:32:06 INFO - 'tests': ['tp5o']}, 04:32:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:06 INFO - 'talos_options': ['--xperf_path', 04:32:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:06 INFO - 'tests': ['tp5n']}, 04:32:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:32:06 INFO - 'talos_options': ['--e10s', 04:32:06 INFO - '--xperf_path', 04:32:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:06 INFO - 'tests': ['tp5n']}}, 04:32:06 INFO - 'talos.zip': {'path': '', 04:32:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:06 INFO - Running post-action listener: _resource_record_post_action 04:32:06 INFO - ##### 04:32:06 INFO - ##### Running create-virtualenv step. 04:32:06 INFO - ##### 04:32:06 INFO - Running pre-action listener: _resource_record_pre_action 04:32:06 INFO - Running main action method: create_virtualenv 04:32:06 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:32:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:06 INFO - Using real prefix '/tools/python27' 04:32:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:07 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:10 INFO - Installing pip.................done. 04:32:10 INFO - Return code: 0 04:32:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80d86ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10893ed30>, '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 0x1087a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108934b20>, '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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6llMBBMKIy/Render', 04:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:10 INFO - 'HOME': '/Users/cltbld', 04:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:10 INFO - 'LOGNAME': 'cltbld', 04:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:10 INFO - 'MOZ_NO_REMOTE': '1', 04:32:10 INFO - 'NO_EM_RESTART': '1', 04:32:10 INFO - 'PAGER': '/bin/cat', 04:32:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:10 INFO - 'PWD': '/builds/slave/test', 04:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:10 INFO - 'SHELL': '/bin/bash', 04:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BMSHkaGDXZ/Listeners', 04:32:10 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:10 INFO - 'USER': 'cltbld', 04:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:10 INFO - 'XPC_FLAGS': '0x0', 04:32:10 INFO - 'XPC_SERVICE_NAME': '0', 04:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:32:10 INFO - Cleaning up... 04:32:10 INFO - Return code: 0 04:32:10 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80d86ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10893ed30>, '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 0x1087a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108934b20>, '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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:32:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:32:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6llMBBMKIy/Render', 04:32:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:10 INFO - 'HOME': '/Users/cltbld', 04:32:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:10 INFO - 'LOGNAME': 'cltbld', 04:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:10 INFO - 'MOZ_NO_REMOTE': '1', 04:32:10 INFO - 'NO_EM_RESTART': '1', 04:32:10 INFO - 'PAGER': '/bin/cat', 04:32:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:10 INFO - 'PWD': '/builds/slave/test', 04:32:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:10 INFO - 'SHELL': '/bin/bash', 04:32:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BMSHkaGDXZ/Listeners', 04:32:10 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:10 INFO - 'USER': 'cltbld', 04:32:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:10 INFO - 'XPC_FLAGS': '0x0', 04:32:10 INFO - 'XPC_SERVICE_NAME': '0', 04:32:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:10 INFO - Downloading/unpacking psutil>=0.7.1 04:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:14 INFO - Installing collected packages: psutil 04:32:14 INFO - Running setup.py install for psutil 04:32:14 INFO - building 'psutil._psutil_osx' extension 04:32:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:32:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:32:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:32:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:32:15 INFO - building 'psutil._psutil_posix' extension 04:32:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:32:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:15 INFO - ^ 04:32:15 INFO - 1 warning generated. 04:32:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:32:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:15 INFO - Successfully installed psutil 04:32:15 INFO - Cleaning up... 04:32:15 INFO - Return code: 0 04:32:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:15 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80d86ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10893ed30>, '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 0x1087a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108934b20>, '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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:15 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.0.0'] in /builds/slave/test/build 04:32:15 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.0.0 04:32:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6llMBBMKIy/Render', 04:32:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:15 INFO - 'HOME': '/Users/cltbld', 04:32:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:15 INFO - 'LOGNAME': 'cltbld', 04:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:15 INFO - 'MOZ_NO_REMOTE': '1', 04:32:15 INFO - 'NO_EM_RESTART': '1', 04:32:15 INFO - 'PAGER': '/bin/cat', 04:32:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:15 INFO - 'PWD': '/builds/slave/test', 04:32:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:15 INFO - 'SHELL': '/bin/bash', 04:32:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BMSHkaGDXZ/Listeners', 04:32:15 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:15 INFO - 'USER': 'cltbld', 04:32:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:15 INFO - 'XPC_FLAGS': '0x0', 04:32:15 INFO - 'XPC_SERVICE_NAME': '0', 04:32:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32: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 04:32:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:32:18 INFO - Installing collected packages: mozsystemmonitor 04:32:18 INFO - Running setup.py install for mozsystemmonitor 04:32:18 INFO - Successfully installed mozsystemmonitor 04:32:18 INFO - Cleaning up... 04:32:18 INFO - Return code: 0 04:32:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:32: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')]} 04:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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')]} 04:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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', '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 0x108a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80d86ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10893ed30>, '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 0x1087a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108934b20>, '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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:32: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 blobuploader==1.2.4 04:32:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6llMBBMKIy/Render', 04:32:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:18 INFO - 'HOME': '/Users/cltbld', 04:32:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:18 INFO - 'LOGNAME': 'cltbld', 04:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:18 INFO - 'MOZ_NO_REMOTE': '1', 04:32:18 INFO - 'NO_EM_RESTART': '1', 04:32:18 INFO - 'PAGER': '/bin/cat', 04:32:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:18 INFO - 'PWD': '/builds/slave/test', 04:32:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:18 INFO - 'SHELL': '/bin/bash', 04:32:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BMSHkaGDXZ/Listeners', 04:32:18 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:18 INFO - 'USER': 'cltbld', 04:32:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:18 INFO - 'XPC_FLAGS': '0x0', 04:32:18 INFO - 'XPC_SERVICE_NAME': '0', 04:32:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:18 INFO - Downloading/unpacking blobuploader==1.2.4 04:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:21 INFO - Downloading blobuploader-1.2.4.tar.gz 04:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:32:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:32:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:22 INFO - Downloading docopt-0.6.1.tar.gz 04:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:32:22 INFO - Installing collected packages: blobuploader, requests, docopt 04:32:22 INFO - Running setup.py install for blobuploader 04:32:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:32:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:32:22 INFO - Running setup.py install for requests 04:32:22 INFO - Running setup.py install for docopt 04:32:23 INFO - Successfully installed blobuploader requests docopt 04:32:23 INFO - Cleaning up... 04:32:23 INFO - Return code: 0 04:32:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:23 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 0x108a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80d86ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10893ed30>, '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 0x1087a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108934b20>, '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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6llMBBMKIy/Render', 04:32:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:23 INFO - 'HOME': '/Users/cltbld', 04:32:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:23 INFO - 'LOGNAME': 'cltbld', 04:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:23 INFO - 'MOZ_NO_REMOTE': '1', 04:32:23 INFO - 'NO_EM_RESTART': '1', 04:32:23 INFO - 'PAGER': '/bin/cat', 04:32:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:23 INFO - 'PWD': '/builds/slave/test', 04:32:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:23 INFO - 'SHELL': '/bin/bash', 04:32:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BMSHkaGDXZ/Listeners', 04:32:23 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:23 INFO - 'USER': 'cltbld', 04:32:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:23 INFO - 'XPC_FLAGS': '0x0', 04:32:23 INFO - 'XPC_SERVICE_NAME': '0', 04:32:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:23 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-vwObC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:23 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-T_C2m2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:23 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-le_68E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:23 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-L9e4oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:23 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-fJAwlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:23 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-FzF6d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-CPa69o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-uOAPl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-CmaUpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-Tsue4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-bri8yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-yZrFUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-L_62Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-G6Losn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-0ItPag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:24 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-YHOkSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:25 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-gPE8Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:32:25 INFO - Running setup.py install for manifestparser 04:32:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Running setup.py install for mozcrash 04:32:25 INFO - Running setup.py install for mozdebug 04:32:25 INFO - Running setup.py install for mozdevice 04:32:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:32:25 INFO - Running setup.py install for mozfile 04:32:25 INFO - Running setup.py install for mozhttpd 04:32:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Running setup.py install for mozinfo 04:32:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Running setup.py install for mozInstall 04:32:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Running setup.py install for mozleak 04:32:26 INFO - Running setup.py install for mozlog 04:32:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Running setup.py install for moznetwork 04:32:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:32:26 INFO - Running setup.py install for mozprocess 04:32:26 INFO - Running setup.py install for mozprofile 04:32:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:32:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:32:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:32:27 INFO - Running setup.py install for mozrunner 04:32:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:32:27 INFO - Running setup.py install for mozscreenshot 04:32:27 INFO - Running setup.py install for moztest 04:32:27 INFO - Running setup.py install for mozversion 04:32:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:32:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:32:27 INFO - Cleaning up... 04:32:27 INFO - Return code: 0 04:32:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:27 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 0x108a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80d86ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10893ed30>, '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 0x1087a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108934b20>, '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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6llMBBMKIy/Render', 04:32:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:27 INFO - 'HOME': '/Users/cltbld', 04:32:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:27 INFO - 'LOGNAME': 'cltbld', 04:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:27 INFO - 'MOZ_NO_REMOTE': '1', 04:32:27 INFO - 'NO_EM_RESTART': '1', 04:32:27 INFO - 'PAGER': '/bin/cat', 04:32:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:27 INFO - 'PWD': '/builds/slave/test', 04:32:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:27 INFO - 'SHELL': '/bin/bash', 04:32:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BMSHkaGDXZ/Listeners', 04:32:27 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:27 INFO - 'USER': 'cltbld', 04:32:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:27 INFO - 'XPC_FLAGS': '0x0', 04:32:27 INFO - 'XPC_SERVICE_NAME': '0', 04:32:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:32:28 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-W4qJBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:32:28 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-tk4ExL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:32:28 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-l8TcMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:32:28 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-eUDLvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:32:28 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-Py_K1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:32:28 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-M3r7W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:32:28 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-N8TbYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:32:28 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-jiAsBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:32:28 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-kDoWjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:32:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:32:28 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-y_g3WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:32:29 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-5WGufo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:32:29 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-N81f5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:32:29 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-Bn_32C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:32:29 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-FoWa15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:29 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-Ru5c6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:32:29 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-5i4z73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:32:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:32:29 INFO - Running setup.py (path:/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/pip-I0VKd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:32:29 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:29 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:32:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:32 INFO - Downloading blessings-1.6.tar.gz 04:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:32:32 INFO - Installing collected packages: blessings 04:32:32 INFO - Running setup.py install for blessings 04:32:32 INFO - Successfully installed blessings 04:32:32 INFO - Cleaning up... 04:32:32 INFO - Return code: 0 04:32:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:32:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:32 INFO - Reading from file tmpfile_stdout 04:32:32 INFO - Current package versions: 04:32:32 INFO - blessings == 1.6 04:32:32 INFO - blobuploader == 1.2.4 04:32:32 INFO - docopt == 0.6.1 04:32:32 INFO - manifestparser == 1.1 04:32:32 INFO - mozInstall == 1.12 04:32:32 INFO - mozcrash == 0.16 04:32:32 INFO - mozdebug == 0.1 04:32:32 INFO - mozdevice == 0.48 04:32:32 INFO - mozfile == 1.2 04:32:32 INFO - mozhttpd == 0.7 04:32:32 INFO - mozinfo == 0.9 04:32:32 INFO - mozleak == 0.1 04:32:32 INFO - mozlog == 3.1 04:32:32 INFO - moznetwork == 0.27 04:32:32 INFO - mozprocess == 0.22 04:32:32 INFO - mozprofile == 0.28 04:32:32 INFO - mozrunner == 6.11 04:32:32 INFO - mozscreenshot == 0.1 04:32:32 INFO - mozsystemmonitor == 0.0 04:32:32 INFO - moztest == 0.7 04:32:32 INFO - mozversion == 1.4 04:32:32 INFO - psutil == 3.1.1 04:32:32 INFO - requests == 1.2.3 04:32:32 INFO - wsgiref == 0.1.2 04:32:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 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 0x108a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80d86ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10893ed30>, '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 0x1087a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108934b20>, '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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6llMBBMKIy/Render', 04:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:32 INFO - 'HOME': '/Users/cltbld', 04:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:32 INFO - 'LOGNAME': 'cltbld', 04:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:32 INFO - 'MOZ_NO_REMOTE': '1', 04:32:32 INFO - 'NO_EM_RESTART': '1', 04:32:32 INFO - 'PAGER': '/bin/cat', 04:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:32 INFO - 'PWD': '/builds/slave/test', 04:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:32 INFO - 'SHELL': '/bin/bash', 04:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BMSHkaGDXZ/Listeners', 04:32:32 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:32 INFO - 'USER': 'cltbld', 04:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:32 INFO - 'XPC_FLAGS': '0x0', 04:32:32 INFO - 'XPC_SERVICE_NAME': '0', 04:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:32:32 INFO - Cleaning up... 04:32:32 INFO - Return code: 0 04:32:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:32 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 0x108a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80d86ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10893ed30>, '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 0x1087a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108934b20>, '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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:32:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:32:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6llMBBMKIy/Render', 04:32:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:32 INFO - 'HOME': '/Users/cltbld', 04:32:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:32 INFO - 'LOGNAME': 'cltbld', 04:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:32 INFO - 'MOZ_NO_REMOTE': '1', 04:32:32 INFO - 'NO_EM_RESTART': '1', 04:32:32 INFO - 'PAGER': '/bin/cat', 04:32:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:32 INFO - 'PWD': '/builds/slave/test', 04:32:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:32 INFO - 'SHELL': '/bin/bash', 04:32:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BMSHkaGDXZ/Listeners', 04:32:32 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:32 INFO - 'USER': 'cltbld', 04:32:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:32 INFO - 'XPC_FLAGS': '0x0', 04:32:32 INFO - 'XPC_SERVICE_NAME': '0', 04:32:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:33 INFO - Downloading/unpacking jsonschema 04:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:32:35 INFO - Downloading/unpacking functools32 (from jsonschema) 04:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:35 INFO - Downloading functools32-3.2.3-2.tar.gz 04:32:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:32:35 INFO - warning: no files found matching '*.txt' 04:32:35 INFO - no previously-included directories found matching 'build' 04:32:35 INFO - no previously-included directories found matching 'dist' 04:32:35 INFO - no previously-included directories found matching '.git*' 04:32:35 INFO - Installing collected packages: jsonschema, functools32 04:32:36 INFO - Running setup.py install for functools32 04:32:36 INFO - warning: no files found matching '*.txt' 04:32:36 INFO - no previously-included directories found matching 'build' 04:32:36 INFO - no previously-included directories found matching 'dist' 04:32:36 INFO - no previously-included directories found matching '.git*' 04:32:36 INFO - Successfully installed jsonschema functools32 04:32:36 INFO - Cleaning up... 04:32:36 INFO - Return code: 0 04:32:36 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:36 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 0x108a99a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108aa04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fde80d86ab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10893ed30>, '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 0x1087a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108934b20>, '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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:32:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6llMBBMKIy/Render', 04:32:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:36 INFO - 'HOME': '/Users/cltbld', 04:32:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:36 INFO - 'LOGNAME': 'cltbld', 04:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:36 INFO - 'MOZ_NO_REMOTE': '1', 04:32:36 INFO - 'NO_EM_RESTART': '1', 04:32:36 INFO - 'PAGER': '/bin/cat', 04:32:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:36 INFO - 'PWD': '/builds/slave/test', 04:32:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:36 INFO - 'SHELL': '/bin/bash', 04:32:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BMSHkaGDXZ/Listeners', 04:32:36 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:32:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:36 INFO - 'USER': 'cltbld', 04:32:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:36 INFO - 'XPC_FLAGS': '0x0', 04:32:36 INFO - 'XPC_SERVICE_NAME': '0', 04:32:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:36 INFO - Downloading/unpacking flake8 04:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:32:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:32:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:32:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:40 INFO - no previously-included directories found matching 'docs/_build' 04:32:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:32:40 INFO - Running setup.py install for pep8 04:32:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:32:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:32:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:32:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:32:40 INFO - no previously-included directories found matching 'docs/_build' 04:32:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:32:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:32:40 INFO - Cleaning up... 04:32:40 INFO - Return code: 0 04:32:40 INFO - Running post-action listener: _resource_record_post_action 04:32:40 INFO - Running post-action listener: _start_resource_monitoring 04:32:40 INFO - Starting resource monitoring. 04:32:40 INFO - ##### 04:32:40 INFO - ##### Running install step. 04:32:40 INFO - ##### 04:32:40 INFO - Running pre-action listener: _resource_record_pre_action 04:32:40 INFO - Running main action method: install 04:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:32:40 INFO - Reading from file tmpfile_stdout 04:32:40 INFO - Detecting whether we're running mozinstall >=1.0... 04:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:32:40 INFO - Reading from file tmpfile_stdout 04:32:40 INFO - Output received: 04:32:40 INFO - Usage: mozinstall [options] installer 04:32:40 INFO - Options: 04:32:40 INFO - -h, --help show this help message and exit 04:32:40 INFO - -d DEST, --destination=DEST 04:32:40 INFO - Directory to install application into. [default: 04:32:40 INFO - "/builds/slave/test"] 04:32:40 INFO - --app=APP Application being installed. [default: firefox] 04:32:40 INFO - mkdir: /builds/slave/test/build/application 04:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:33:14 INFO - Reading from file tmpfile_stdout 04:33:14 INFO - Output received: 04:33:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:33:14 INFO - Running post-action listener: _resource_record_post_action 04:33:14 INFO - ##### 04:33:14 INFO - ##### Running run-tests step. 04:33:14 INFO - ##### 04:33:14 INFO - Running pre-action listener: _resource_record_pre_action 04:33:14 INFO - Running main action method: run_tests 04:33:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:14 INFO - 2016-02-06 04:33:14.493 screenresolution[1664:8480] starting screenresolution argv=screenresolution get 04:33:14 INFO - 2016-02-06 04:33:14.496 screenresolution[1664:8480] Display 0: 1600x1200x32@60 04:33:14 INFO - 2016-02-06 04:33:14.502 screenresolution[1665:8482] starting screenresolution argv=screenresolution list 04:33:14 INFO - Available Modes on Display 0 04:33:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:14 INFO - Intel Iris: 04:33:14 INFO - Chipset Model: Intel Iris 04:33:14 INFO - Type: GPU 04:33:14 INFO - Bus: Built-In 04:33:14 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:14 INFO - Vendor: Intel (0x8086) 04:33:14 INFO - Device ID: 0x0a2e 04:33:14 INFO - Revision ID: 0x0009 04:33:14 INFO - Displays: 04:33:14 INFO - Display: 04:33:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:14 INFO - Display Serial Number: 1600x1200 60 04:33:14 INFO - Main Display: Yes 04:33:14 INFO - Mirror: Off 04:33:14 INFO - Online: Yes 04:33:14 INFO - Rotation: Supported 04:33:14 INFO - Return code: 0 04:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:14 INFO - Python 2.7.3 04:33:14 INFO - Return code: 0 04:33:14 INFO - grabbing minidump binary from tooltool 04:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:33:14 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10893ed30>, '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 0x1087a1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108934b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:33:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:33:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:14 INFO - Return code: 0 04:33:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:33:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:33:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:33:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:33:16 INFO - Return code: 0 04:33:16 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:33:16 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 http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.6llMBBMKIy/Render', 04:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:16 INFO - 'HOME': '/Users/cltbld', 04:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:16 INFO - 'LOGNAME': 'cltbld', 04:33:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:16 INFO - 'MOZ_NO_REMOTE': '1', 04:33:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:16 INFO - 'NO_EM_RESTART': '1', 04:33:16 INFO - 'PAGER': '/bin/cat', 04:33:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:16 INFO - 'PWD': '/builds/slave/test', 04:33:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:16 INFO - 'SHELL': '/bin/bash', 04:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BMSHkaGDXZ/Listeners', 04:33:16 INFO - 'TMPDIR': '/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/', 04:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:16 INFO - 'USER': 'cltbld', 04:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:16 INFO - 'XPC_FLAGS': '0x0', 04:33:16 INFO - 'XPC_SERVICE_NAME': '0', 04:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:16 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', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:33:16 INFO - mozversion application_buildid: 20160203075643 04:33:16 INFO - mozversion application_changeset: f5bd25c789b6bab468de449782b4985e39239968 04:33:16 INFO - mozversion application_display_name: Nightly 04:33:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:16 INFO - mozversion application_name: Firefox 04:33:16 INFO - mozversion application_remotingname: firefox 04:33:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:33:16 INFO - mozversion application_vendor: Mozilla 04:33:16 INFO - mozversion application_version: 47.0a1 04:33:16 INFO - mozversion platform_buildid: 20160203075643 04:33:16 INFO - mozversion platform_changeset: f5bd25c789b6bab468de449782b4985e39239968 04:33:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:33:16 INFO - mozversion platform_version: 47.0a1 04:33:16 INFO - using testdate: 1454761996 04:33:16 INFO - actual date: 1454761996 04:33:16 INFO - starting webserver on 'localhost:49275' 04:33:16 INFO - SUITE-START | Running 2 tests 04:33:16 INFO - TEST-START | dromaeo_css 04:33:16 INFO - operating with platform_type : mac_ 04:33:16 INFO - Initialising browser for dromaeo_css test... 04:33:16 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpyp7QN_/profile http://localhost:49275/getInfo.html) 04:33:17 INFO - PROCESS | 1683 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:33:19 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 04:33:19 INFO - PROCESS | 1683 | colorDepth:24 04:33:19 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 04:33:19 INFO - PROCESS | 1683 | __metrics 04:33:19 ERROR - PROCESS | 1683 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2830: TypeError: this.tabs is undefined 04:33:20 INFO - PROCESS | 1683 | ************************* 04:33:20 INFO - PROCESS | 1683 | A coding exception was thrown in a Promise resolution callback. 04:33:20 INFO - PROCESS | 1683 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 04:33:20 INFO - PROCESS | 1683 | 04:33:20 ERROR - PROCESS | 1683 | Full message: TypeError: this.tabs is undefined 04:33:20 INFO - PROCESS | 1683 | Full stack: .get@chrome://browser/content/tabbrowser.xml:2830:17 04:33:20 INFO - PROCESS | 1683 | ssi_onClose/<@resource:///modules/sessionstore/SessionStore.jsm:1323:9 04:33:20 INFO - PROCESS | 1683 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 04:33:20 INFO - PROCESS | 1683 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 04:33:20 INFO - PROCESS | 1683 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 04:33:20 INFO - PROCESS | 1683 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 04:33:20 INFO - PROCESS | 1683 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 04:33:20 INFO - PROCESS | 1683 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:146:5 04:33:20 INFO - PROCESS | 1683 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:52:5 04:33:20 INFO - PROCESS | 1683 | receiveMessage@resource:///modules/sessionstore/SessionStore.jsm:734:11 04:33:20 INFO - PROCESS | 1683 | 04:33:20 INFO - PROCESS | 1683 | ************************* 04:33:20 INFO - PROCESS | 1683 | 04:33:20 INFO - PROCESS | 1683 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 04:33:20 INFO - PROCESS | 1683 | 04:33:20 INFO - TEST-INFO | 1683: exit 0 04:33:20 INFO - Browser initialized. 04:33:20 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:20 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpyp7QN_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:32 INFO - PROCESS | 1688 | RSS: Main: 257478656 04:33:32 INFO - PROCESS | 1688 | 04:34:22 INFO - PROCESS | 1688 | 1454762062150 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:36:32 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 04:36:34 INFO - PROCESS | 1688 | RSS: Main: 269672448 04:36:34 INFO - PROCESS | 1688 | 04:39:36 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 04:39:36 INFO - PROCESS | 1688 | RSS: Main: 282357760 04:39:36 INFO - PROCESS | 1688 | 04:42:38 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 04:42:39 INFO - PROCESS | 1688 | RSS: Main: 282779648 04:42:39 INFO - PROCESS | 1688 | 04:45:40 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 04:45:41 INFO - PROCESS | 1688 | RSS: Main: 286040064 04:45:41 INFO - PROCESS | 1688 | 04:48:43 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 04:48:44 INFO - PROCESS | 1688 | RSS: Main: 289058816 04:48:44 INFO - PROCESS | 1688 | 04:51:47 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 04:51:47 INFO - PROCESS | 1688 | RSS: Main: 289951744 04:51:47 INFO - PROCESS | 1688 | 04:51:47 INFO - PROCESS | 1688 | __start_tp_report 04:51:47 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 04:51:47 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 04:51:47 INFO - PROCESS | 1688 | |i|pagename|runs| 04:51:47 INFO - PROCESS | 1688 | |0;dojo.html;2815.690274069852;3513.1744040150543;3514.0512061743348;3539.893803185904;3589.8025608591524;5629.155626656004;5684.374718780936;5689.658620482764;5692.943070569293;5694.5729070319785;4822.541858523435;5186.896262074766;5498.505134537891;5631.63394379365;5645.15322701595;5112.105381558222;5165.457626949173;5190.299309593213;5213.035588416155;5235.947640523603;5194.428612852583;5235.947640523584;5246.081935661263;5276.314079169702;5303.257543943851;4412.75729834859;5226.7647955841885;5262.578993680497;5269.947300526984;5284.180951952453;5026.246063090529;5172.741362931876;5206.76569554371;5210.76551555181;5211.635185537033;5134.306868572732;5158;5165.173572228463;5172.741362931876;5221.765020574046;5394.1908713692865;5508.807191748309;5537.473939975695;5565.554755619541;5582.078956972095;6061.212042434456;6095.481884039862;6113.810786210604;6136.355682653347;6205.131281620576;6234.0960560718895;6244.1570387997945;6247.687615619247;6248.843778905563;6269.059641053833;5629.493345598834;5764.135379692996;5783.21926539916;5783.971080144656;5846.269216347957;6184.474319682788;6198.752049917953;6238.469730072995;6244.718987645567;6265.216847894013;6106.267247930188;6134.44789968896;6144.293406258337;6153.107799369066;6154.753809847645;6077.604955677867;6199.876002479925;6255.12428260044;6258.311585725566;6284.717187726564;5435.347758268954;6111.804454079419;6154.630722156685;6167.629942203482;6170.136180934673;6120.60216085953;6136.417040381246;6209.0996805462955;6209.627422354673;6226.097215903668;4058.6955978301744;4748.881277968009;4805.519448055236;4813.542713442217;4887.437944636341;4382.8904277392685;4384.188925048876;4386.429764130643;4393.055493069006;4419.513853476115;5479.835604931779;5711.914321285184;5758.078707406795;5782.3639399666;5800.39095894925;5153.948460515422;6127.785527506605;6172.197614310201;6262.68686565679;6269.5611307208055;5780.132980053026;5790.392008839095;5797.913031304533;5799.652020878676;5816.912746308809;5341.813036543703;5350.545203657733;5350.678959262379;5363.597730170253;5366.16824392212;6131.437835141539;6214.285357183981;6245.843853903689;6286.025666021866;6292.3078461368295;6235.625862448268;6272.749090036347;6273;6282.120503129474;6299;5573.164025396223;6027.336992930686;6293.244810622755;6306.400891915261;6308.684565771601;6104.732011601694;6109.541784366102;6189.071639253968;6203.844903877439;6212.47193988516;6196.411340922605;6268.937310627018;6278.6546739929745;6295.401936815995;6306.936930630818;5838.474537291664;6008.188894499362;6079.696015199311;6083.726232319645;6088.695565221633;5945.464908158287;5983.760649574142;6026.7946410718905;6035.728392222449;6093.116498107838;4500.909981800281;5555.638883472561;5968.104784282393;5983.431574000463;5988.640681559121;5951.970240148771;6029;6063.090536419572;6126.938730612816;6147.231596050494;5989.3112292085225;6005.819825405245;6012.759489620366;6013.188219590475;6050.788222412194 04:51:47 INFO - PROCESS | 1688 | |1;ext.html;448.6164329498277;500.54700496051066;504.4148787406608;538.7710223155158;569.0809342911199;38000.80999595002;38551.03622409441;38680.41979370305;38766;38779;40899.59100408995;41138.58861411385;41464.58535414645;41510.792446037805;41742.74771756845;9647;9834.803303933917;9862.753431164243;9879.802403951917;9893.060159284893;9755.268354873377;9858.605655773761;9897.703068907907;9898.455584942825;9986.700398988005;9791.06984836443;9856.457894815781;9880.110790028895;9906.65326713565;9916.950415247913;9771.853422198672;9797.510124493747;9821.165200957927;9844;9850.965648606936;9596.76008099803;9743.805123897553;9749.658761943298;9761.121499065048;9780.55987480558;39448;39469;39658;39832.601673983176;39883.60116398857;3370.4607262837826;3374.5613070300706;3411.113110591264;3487.424574945131;3593.1017245688577;28408.289792755346;28540.714592854012;28617.57073643897;28899.56650650242;28937.710622893712;2753.504369213541;2769.321516228517;2791.3719413132085;2809;2850.2304377817873;447704;448361;448501;448779;449331;54125.72937135289;55211.723941380034;62710.68644656747;63439.682801585695;63531;59977.80044399088;60305;60348.69825650931;60902.086468703004;60968.39031609627;15673.608159796097;15835;15944.362225511082;16041.759373609406;16072.75890861638;10281.74295642615;12319.93840030812;12413.689657758448;12680.556180533637;12694.936525317315;19690.70463943042;19779.703304450446;20080.497987550138;20116.497087572927;20131.396058117985;7527.946087547748;8177.182281771775;8288.50268983863;8514.446560973516;8518.148185181557;922.4603606890045;935.9578818953163;971.6356366362614;1036.4247842447514;1075.9677209683723;28785.856070719514;28963.85518072396;29364;29411.558826617616;29550;997.4688852611207;998.0618218874235;1026.6817286641165;1029.9073083422527;1058.4760543530847;13846.63768014649;14068.929655351658;14158.64603384903;14277.571672849832;14312.85687143136;468303;473527;474364;476062;479467;55491.445085549436;55587.444125559035;55623.72188139033;55780.16329755057;55997;1397.475946520055;1405.894557908161;1418.4680744720729;1433.6702558411623;1435.3612642374253;26095.478090438464;27059.91760329565;27255.087811583675;27272.727272727017;27501.31246718768;47747;47909.76045119752;48268.7586562065;48284.75857620689;48442.5155748438;467597;467808;471013;471962;473416;30457.54313685252;32737;33581.496277555365;33583.328333432706;33626.32747345088;38312;39970.00299970096;39982.400263995485;40001.79999099986;40714.79642601768;29788.659510322523;33314.00057998264;35889.46165807567;36352.63647363493;36397.634153779916;35120.12199694926;35170.64829351776;35924.92225233247;35967.460488092176;36238.63761362458;35280.823595881855;35769;35925;35990.28019439544;36160.09599760027;29368.97208597689;29381.706182937898;31992;32079.952404521533;32212.03363898993;23940;24227.152049678883;24615.13847015346;24639;24656.87671561631 04:51:47 INFO - PROCESS | 1688 | |2;jquery.html;319.4346007566607;355.67455777963175;363.72538733256386;364.37873425809;370.88131797824707;15393.307301171446;18231;18609.906950465247;19544.804551954476;20801.583968320625;19824.20703171875;19859.404217873453;20012.29956951507;20166.991650417458;20239.49401264969;5446.319210098738;5508.44915508448;5754;5757.193992841006;5769.04810706233;4074.2055299216663;4270.587118278163;5613;6038.6074905131245;6271.216097987752;6031.336552979169;6233.3143354231;6255.218097737783;6258.87482250357;6268.216472940882;6139.355367686373;6202.038684003964;6207.162033125515;6213.68931553425;6244.625322480666;4660.3941487606735;4786.497417771154;5298.523132918056;5360.892782144335;5380.542653874425;22205;23311.18410855612;23357.065717371286;23373.883130584407;24579;2208.596291112317;2215.878126703031;2284.4745708486976;2353.7646235376496;2418.6372044193336;14336.64158396038;14481.131132132;14633;14652.560423187215;15243.923780381027;1676.9329226830912;1696.8218337074677;1734.9826501735074;1735.3492440334874;1737.730651748981;88510.55744721236;100960.49519752427;102035.48982255116;102525.48737256265;105033;10507.474626268657;10944.726381840359;11088.833667494993;11125.054370378446;11142.777144457066;13307.733845323039;13341.733165336638;13348;13373.39819708096;13373.46506139763;8157.265846073882;8252.092269850311;8286.295664868554;8313.542755148404;8405.747827565183;8345.874811877828;8351.457155284887;8365.24712775841;8389.412741108186;8406.41155119148;3744.288585168864;3955.288048151303;4284.828606855754;4291.785410729451;4373.475182978;1730.3943619732993;1766.2758269109604;1829.0945981739123;1831.6062046660031;1877.6620208362353;844.8225872566707;918.4581097152712;928.1229238369676;980.6567701304486;990.217727994876;14632.780508292384;18627.06864656789;19547.51131221731;21027;21193;848.6690190825583;878.4114643189079;948.7262013814877;971.8687977122997;972.8978457262027;10739.570417183382;10753.731156721145;10821.831714281572;11184.3646130771;11343.602973896039;487029;501833;558536;700537;705268;113150;114610.42694786473;115313.27030094556;115600;115788;483.5575448464686;511.0468975360925;511.16934980657174;1162.604714397109;1209.4194786502528;10707.357558546511;10949.726256843642;10968.725781855517;11001.954814292629;11134.554617815196;33610.487528061785;41874.79062604668;46594.36919707794;47334;48576.75711621419;63570.046449304224;66500;69881;70302.64848675724;70961;7234.16807067194;7340.559566426032;7599.16409194977;7613.733519326797;7638.312551870358;10796.190285728444;10930.070943969851;11215.831762523405;11352.432378381212;11639.418029098342;9852.556634951301;9903.851442228517;10190.847137292798;10298;10356.896431035593;9862.211023118276;10099.69700908974;10392.22058345612;10547.156227501935;10640.148788096778;10387.948060259952;10518.061216334925;10599.205059620714;10664.466776661291;10787.892121078688;7556.319931206218;7640.808979775327;7641.847163056596;7752.496087754504;7759.107702614272;9278.768030799283;9383.436993780395;10369.9481502592;10405.323653962469;10409.479526023517 04:51:47 INFO - PROCESS | 1688 | |3;mootools.html;1527.8395768444313;1549.7133030389375;1735.713607254803;1831.249187832988;1888.6128343689545;7962.52224866507;8071.717489887855;8826.205641492264;8887.777805554857;9005.50469724165;8534.231919127278;8694.956525217382;8793.95603021984;8796.824063518727;8813.823723525526;2443.1815341860497;2482.8758562071916;2484.35406794233;2487.5398051360557;2488.950220995579;2351.4356554426986;2439.280412278373;2444.9511009779794;2447.669564608782;2447.963280550793;2463.1994601754413;2476.368526025861;2487.7387874273213;2498.2755001049673;2500.2874180858457;2453.950920981579;2480.6651102101164;2486.428121532049;2491.6137998610243;2516.4967006598754;2151.537419454809;2468.419921318489;2487.81341399394;2488.415222422729;2493.638422428756;8967.551622418918;9023.323250756219;9032.232260257886;9057.547122643842;9057.728268151901;5389.51494365509;5576.0241957657245;5580.944190558123;5593.580481463907;5599.244102046212;3635.8000309983204;3760.172761992357;3761.492198553215;3795.2978698940783;3800.258949504848;1053.7049626104704;1076.445630500293;1078.8651418572679;1102.8014957307682;1111.9332840029624;12203.69490762738;12239.143259971806;12348.073894457952;12414;12442.751144977141;4089.345704687236;4966.6771659842;5001.349824522861;5057.393112826484;5084.51697088776;10177.440240786827;10458.63394781179;10468.68593942183;10483.0041146091;10486;5548.944510554843;5558.44415558441;5575.470330318694;5611.663300202001;5613.831585052455;4125.401816736557;4439.223135951195;4587.311903214478;4976.8755781105765;5042.873928151826;3812.2375524895133;3860.208657225262;3873.1091848874917;3887.1059656279213;3889.124946886984;1294.9158304710163;1307.3855288014618;1310.102579732886;1310.4037662863375;1310.927898965566;1065.973350666224;1075.5805235957982;1087.7878813631423;1253.924764514132;1358.8641135886332;7723.806904827425;8066.274035336731;8142.063662678749;8157.551334676531;8398.454100483448;518.9922151167735;526.7866514061811;528.8281308574728;529.0186703664647;537.078909669918;6048.243969503812;6194.34959329273;6214.316425193225;6229.906551401733;6287.993920972623;10729.463526823627;11096.167787415814;11141.610043648596;11172.832407513893;11188.440577971069;10726.892731072745;10867.402292873969;11018.559257629766;11048.558057677763;11084.833727494093;7333.376662983706;8262.462939908886;8364.874526882102;8415.70545030921;8539.658413663508;7915.643796029308;7926.326262267541;8047;8061.025048863066;8092.635831387484;9768.609255629695;9944.254180936314;10003.499825008867;10036.19710423179;10153.136983356497;10108.797824043624;10295.588176472857;10322.380657160595;10329.690109296433;10366.740831479274;7627.923720762721;7652.693892244248;7657.425693072931;7743.109542402696;7748.147703752696;7241.927580724126;8225.424220304521;8300.04549476818;8353.54055526952;8466.74599762008;7846.882296765667;7945.0863150736095;8023.6389362479995;8058.274755272054;8063.314618257279;7690.2694244046725;7757.069151701606;7835.608219588884;7872.921270787218;7879.448438609243;7597.430192735456;7879.133295337394;7961.681532738626;8001.079875814356;8024.799380015546;7019.087518622547;7080.964595177197;7094.6097964612445;7098.716051357887;7099.787006389816;7123;7174.928250717426;7219.133703955349;7238.6380680966795;7246.985422041024 04:51:47 INFO - PROCESS | 1688 | |4;prototype.html;325.41425434218405;328.8996855958932;335.75154385754547;339.9660033996602;340.0987383433898;6509.153810004693;6637.701303441345;6648.135742353487;6659.13431253937;6695.296993815652;5409.29679141712;6453.386928241809;6574.704138313776;6624;6656.367645073722;4919.655624106314;4931;4946.15915294399;4946.480619534951;4950.6039516838655;4934.703917764946;4951.133551628469;4954.826581069663;4973.726445045521;4979.601631869442;4623.121606894696;4801.231802911535;4817.277408388734;4820.469748327699;4832.444268909086;4777.928331075037;4802.111609352281;4805.951940480621;4854.951450485485;4876.487968763265;4094.488188976378;4118.073433477473;4119.011437255067;4119.7940102994735;4127.8968025799295;6180.289266734293;6359.65021923794;6376.649284289362;6381.298057213703;6389.233292004989;5743.62666426681;5754.079347304411;5756.280464941882;5764.279465066867;5769.942300577024;5561.58288128392;5716.914246286267;7135.215126336099;7154.499185057048;7164.785056448315;3493.283876805249;3811.104390468238;4436.979494716201;4583.931241031387;4606.815727370901;7295.744648937261;7450.994115794352;7570.205128461543;7623;7634.045744281965;3622.9456558151123;3911.9437751806854;4677.929831052537;4679.719216847;4696.7651617419;4724.960508688083;4755.643326750507;4772.546608072227;4773.284007398848;4774.164521208844;4635.791389387418;5581.720913954286;5704.0588302929555;5718.428157184331;5729.2265544151005;7176.82057948545;7181.138263408425;7202.891956620655;7209.783706488814;7219.628270628564;1534.4706076403622;1587.9841201588067;1599.6720672262159;1647.6375197456541;1652.239969613967;1036.383351905615;1054.8312270036756;1058.0583280880023;1058.30680904008;1068.1348108032519;6704.932950670528;6740.123783908159;6755.3582409671;6762.966185169043;6784;7375.225601311892;7378.667959941816;7395.889061664079;7411.740589079356;7428.9628551856895;6480.351964803482;6724.798256052229;6739;6751.594904305757;6759.188897332351;3347.832608369572;3905.863294784726;3910.648041676263;3920.4903362562686;3942.6254505821903;7746.573938433327;7772.222777722295;7776.688932442639;7779;7822.826576013644;7387.150477695026;7644.388448924073;7652.1582625911105;7672.5012874163;7723.729669461542;7731.536107833548;7737.767866964;7744.303012728881;7750.961245193738;7776.183500732454;6089.908651370144;7368.815779605338;7395.186529481645;7402.148752893271;7476.925230747623;6846.699127165823;7047.577145371294;7244;7317.26827317264;7330.743423980135;6839.794806155624;7792.532448053135;7795.688172473037;7796.415268854745;7811.375089992901;4693.0613877224005;4693.319468677091;4693.366395536559;4704.129735998851;4709.246520556694;6519.891618424785;6876.140482439695;7141.500094993508;7159.463040271896;7256.383207427217;5742;7032.367086962198;7123.430125590044;7228.710851565878;7236.059312289369;7174.426045916419;7183.425325973805;7197.820054498679;7199.280071992759;7200.387967022652;5494.615376923577;5720.256366672306;6992.580445173306;7005.54463959841;7056.7530136444975;7230.819229519304;7236.96381518089;7248.0939882514685;7262.491625586158;7274.563526188445;6885.277045910308;7047.647617619201;7076.115485564304;7077.433805295667;7098.929010709827 04:51:47 INFO - PROCESS | 1688 | |5;yui.html;610.7160170520707;687.656171914043;720.8450183210606;745.2175216023178;746.0972223609432;14608.19654918979;14686.63283417915;14720.337584808696;14792.852071479281;14817.703645927075;13120.21278723275;13155.6711082223;13725.450981960734;15318;15357.769633455508;846.4371193156544;850.4769566716456;863.5121156546531;863.952482613456;866.7486428935632;844.2022288936957;854.7393045121236;854.8760429737684;855.1875718067829;857.1514200941054;891.6299735609714;896.1665650944619;899.2895612466144;904.1230006893336;911.2026976395654;882.3514716683264;895.5119459894373;899.2042042792143;899.4378513429107;899.7885496908222;653.1117679955257;657.063684249942;662.7282814046266;665.7969319357594;665.9800205993828;14307.998440109197;14393.640158996004;14394.640133996629;14399.992000559965;14753.967222294445;12159.209651372721;12247.938760306231;12345.38273086342;12516;12617.810732839014;10216.642417515352;10230.795384092276;10236.795264094751;10316.58733650653;10445.425501597409;3436.295559410315;3442;3493.4759786032046;3665.5601327840563;3704.6110158433517;66696;69228.30771692269;69482;77879.61060194719;79973.20026799716;9337.486438245962;9432.339736218399;9648.372855764354;9688.224942004623;10000.3499772516;19853.4043978678;20047.39857804268;20052;20112.39662810118;20151;7463.962680186564;7481.551106933602;7532.472726909174;7676.385889128856;7844.980152580242;4033.6369726724733;4071.572484889103;4103.343465045578;4240.109576988867;4245.639120674716;3435.604905435857;3473.374792537317;3490.424080026818;3494.807785571818;3499.125218695326;630.6247782569363;645.6771614192903;652.6312633362135;672.7342699633715;676.6751959059679;523.4503771040393;523.5288240583429;579.987921077722;601.5909181756448;638.396715104222;8701.956490217508;8991;9045.050269721716;9084.591193396313;9153.038930912291;534.3480953237045;590.2887021139517;591.5090474905818;618.2673531864755;633.9049142628643;3870.4581358609817;4018.4374187613757;4025.4364388985564;4032.2219513287373;4137.627613514798;85339.57330213433;85733;86747;86755.56622216974;87189.5640521806;69894.65052674703;70171;70753.64623176851;70968.58062838818;78834;72898.6355068232;73596.63201683958;74828;76742.6162869182;77078;8804.911950880409;8805.559722013746;8820.94378138383;8952.820943581222;8962.238209751984;47720;49097.50902490929;49366.50633493619;49977.250341245635;49991.75004124956;63293.68353158205;68031.65984170047;68351;68435.65782171057;68655;11082.168837337393;11285.943570282096;11346.489407976826;11700.122490813394;11821.704457388634;11497.54009839597;12309.753804923672;12382;12594.3073130975;12676.87323126757;11139.777204456028;11686.298822070703;11744.00175985051;11747.88252117502;12210.145289829627;11159.218854680095;11812;11896.583619573274;12214.877851221374;12351.38243087824;10815.459227038775;10897;11484.94257528707;11516.251443656136;12054.51781928713;9253.444793312423;9388.389754665925;9435;9507.429554226768;9782.364146330467;9381.577828997848;9561.90438095638;9913.206943444651;9959.502024898582;9966.451845148586 04:51:47 INFO - PROCESS | 1688 | __end_tp_report 04:51:47 INFO - PROCESS | 1688 | __start_cc_report 04:51:47 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,356 04:51:47 INFO - PROCESS | 1688 | __end_cc_report 04:51:47 INFO - PROCESS | 1688 | __startTimestamp1454763107261__endTimestamp 04:51:47 INFO - PROCESS | 1688 | 04:51:47 INFO - PROCESS | 1688 | ------- Summary: start ------- 04:51:47 INFO - PROCESS | 1688 | Number of tests: 6 04:51:47 INFO - PROCESS | 1688 | 04:51:47 INFO - PROCESS | 1688 | [#0] dojo.html Cycles:165 Average:5678.09 Median:5951.97 stddev:660.08 (11.1%) stddev-sans-first:622.74 04:51:47 INFO - PROCESS | 1688 | Values: 2815.7 3513.2 3514.1 3539.9 3589.8 5629.2 5684.4 5689.7 5692.9 5694.6 4822.5 5186.9 5498.5 5631.6 5645.2 5112.1 5165.5 5190.3 5213.0 5235.9 5194.4 5235.9 5246.1 5276.3 5303.3 4412.8 5226.8 5262.6 5269.9 5284.2 5026.2 5172.7 5206.8 5210.8 5211.6 5134.3 5158.0 5165.2 5172.7 5221.8 5394.2 5508.8 5537.5 5565.6 5582.1 6061.2 6095.5 6113.8 6136.4 6205.1 6234.1 6244.2 6247.7 6248.8 6269.1 5629.5 5764.1 5783.2 5784.0 5846.3 6184.5 6198.8 6238.5 6244.7 6265.2 6106.3 6134.4 6144.3 6153.1 6154.8 6077.6 6199.9 6255.1 6258.3 6284.7 5435.3 6111.8 6154.6 6167.6 6170.1 6120.6 6136.4 6209.1 6209.6 6226.1 4058.7 4748.9 4805.5 4813.5 4887.4 4382.9 4384.2 4386.4 4393.1 4419.5 5479.8 5711.9 5758.1 5782.4 5800.4 5153.9 6127.8 6172.2 6262.7 6269.6 5780.1 5790.4 5797.9 5799.7 5816.9 5341.8 5350.5 5350.7 5363.6 5366.2 6131.4 6214.3 6245.8 6286.0 6292.3 6235.6 6272.7 6273.0 6282.1 6299.0 5573.2 6027.3 6293.2 6306.4 6308.7 6104.7 6109.5 6189.1 6203.8 6212.5 6196.4 6268.9 6278.7 6295.4 6306.9 5838.5 6008.2 6079.7 6083.7 6088.7 5945.5 5983.8 6026.8 6035.7 6093.1 4500.9 5555.6 5968.1 5983.4 5988.6 5952.0 6029.0 6063.1 6126.9 6147.2 5989.3 6005.8 6012.8 6013.2 6050.8 04:51:47 INFO - PROCESS | 1688 | 04:51:47 INFO - PROCESS | 1688 | [#1] ext.html Cycles:180 Average:60703.62 Median:39113.50 stddev:123289.70 (315.2%) stddev-sans-first:123552.56 04:51:47 INFO - PROCESS | 1688 | Values: 448.6 500.5 504.4 538.8 569.1 38000.8 38551.0 38680.4 38766.0 38779.0 40899.6 41138.6 41464.6 41510.8 41742.7 9647.0 9834.8 9862.8 9879.8 9893.1 9755.3 9858.6 9897.7 9898.5 9986.7 9791.1 9856.5 9880.1 9906.7 9917.0 9771.9 9797.5 9821.2 9844.0 9851.0 9596.8 9743.8 9749.7 9761.1 9780.6 39448.0 39469.0 39658.0 39832.6 39883.6 3370.5 3374.6 3411.1 3487.4 3593.1 28408.3 28540.7 28617.6 28899.6 28937.7 2753.5 2769.3 2791.4 2809.0 2850.2 447704.0 448361.0 448501.0 448779.0 449331.0 54125.7 55211.7 62710.7 63439.7 63531.0 59977.8 60305.0 60348.7 60902.1 60968.4 15673.6 15835.0 15944.4 16041.8 16072.8 10281.7 12319.9 12413.7 12680.6 12694.9 19690.7 19779.7 20080.5 20116.5 20131.4 7527.9 8177.2 8288.5 8514.4 8518.1 922.5 936.0 971.6 1036.4 1076.0 28785.9 28963.9 29364.0 29411.6 29550.0 997.5 998.1 1026.7 1029.9 1058.5 13846.6 14068.9 14158.6 14277.6 14312.9 468303.0 473527.0 474364.0 476062.0 479467.0 55491.4 55587.4 55623.7 55780.2 55997.0 1397.5 1405.9 1418.5 1433.7 1435.4 26095.5 27059.9 27255.1 27272.7 27501.3 47747.0 47909.8 48268.8 48284.8 48442.5 467597.0 467808.0 471013.0 471962.0 473416.0 30457.5 32737.0 33581.5 33583.3 33626.3 38312.0 39970.0 39982.4 40001.8 40714.8 29788.7 33314.0 35889.5 36352.6 36397.6 35120.1 35170.6 35924.9 35967.5 36238.6 35280.8 35769.0 35925.0 35990.3 36160.1 29369.0 29381.7 31992.0 32080.0 32212.0 23940.0 24227.2 24615.1 24639.0 24656.9 04:51:47 INFO - PROCESS | 1688 | 04:51:47 INFO - PROCESS | 1688 | [#2] jquery.html Cycles:180 Average:32897.97 Median:12449.22 stddev:99168.34 (796.6%) stddev-sans-first:99416.36 04:51:47 INFO - PROCESS | 1688 | Values: 319.4 355.7 363.7 364.4 370.9 15393.3 18231.0 18609.9 19544.8 20801.6 19824.2 19859.4 20012.3 20167.0 20239.5 5446.3 5508.4 5754.0 5757.2 5769.0 4074.2 4270.6 5613.0 6038.6 6271.2 6031.3 6233.3 6255.2 6258.9 6268.2 6139.4 6202.0 6207.2 6213.7 6244.6 4660.4 4786.5 5298.5 5360.9 5380.5 22205.0 23311.2 23357.1 23373.9 24579.0 2208.6 2215.9 2284.5 2353.8 2418.6 14336.6 14481.1 14633.0 14652.6 15243.9 1676.9 1696.8 1735.0 1735.3 1737.7 88510.6 100960.5 102035.5 102525.5 105033.0 10507.5 10944.7 11088.8 11125.1 11142.8 13307.7 13341.7 13348.0 13373.4 13373.5 8157.3 8252.1 8286.3 8313.5 8405.7 8345.9 8351.5 8365.2 8389.4 8406.4 3744.3 3955.3 4284.8 4291.8 4373.5 1730.4 1766.3 1829.1 1831.6 1877.7 844.8 918.5 928.1 980.7 990.2 14632.8 18627.1 19547.5 21027.0 21193.0 848.7 878.4 948.7 971.9 972.9 10739.6 10753.7 10821.8 11184.4 11343.6 487029.0 501833.0 558536.0 700537.0 705268.0 113150.0 114610.4 115313.3 115600.0 115788.0 483.6 511.0 511.2 1162.6 1209.4 10707.4 10949.7 10968.7 11002.0 11134.6 33610.5 41874.8 46594.4 47334.0 48576.8 63570.0 66500.0 69881.0 70302.6 70961.0 7234.2 7340.6 7599.2 7613.7 7638.3 10796.2 10930.1 11215.8 11352.4 11639.4 9852.6 9903.9 10190.8 10298.0 10356.9 9862.2 10099.7 10392.2 10547.2 10640.1 10387.9 10518.1 10599.2 10664.5 10787.9 7556.3 7640.8 7641.8 7752.5 7759.1 9278.8 9383.4 10369.9 10405.3 10409.5 04:51:47 INFO - PROCESS | 1688 | 04:51:47 INFO - PROCESS | 1688 | [#3] mootools.html Cycles:180 Average:6163.62 Median:5050.13 stddev:3321.57 (65.8%) stddev-sans-first:3312.61 04:51:47 INFO - PROCESS | 1688 | Values: 1527.8 1549.7 1735.7 1831.2 1888.6 7962.5 8071.7 8826.2 8887.8 9005.5 8534.2 8695.0 8794.0 8796.8 8813.8 2443.2 2482.9 2484.4 2487.5 2489.0 2351.4 2439.3 2445.0 2447.7 2448.0 2463.2 2476.4 2487.7 2498.3 2500.3 2454.0 2480.7 2486.4 2491.6 2516.5 2151.5 2468.4 2487.8 2488.4 2493.6 8967.6 9023.3 9032.2 9057.5 9057.7 5389.5 5576.0 5580.9 5593.6 5599.2 3635.8 3760.2 3761.5 3795.3 3800.3 1053.7 1076.4 1078.9 1102.8 1111.9 12203.7 12239.1 12348.1 12414.0 12442.8 4089.3 4966.7 5001.3 5057.4 5084.5 10177.4 10458.6 10468.7 10483.0 10486.0 5548.9 5558.4 5575.5 5611.7 5613.8 4125.4 4439.2 4587.3 4976.9 5042.9 3812.2 3860.2 3873.1 3887.1 3889.1 1294.9 1307.4 1310.1 1310.4 1310.9 1066.0 1075.6 1087.8 1253.9 1358.9 7723.8 8066.3 8142.1 8157.6 8398.5 519.0 526.8 528.8 529.0 537.1 6048.2 6194.3 6214.3 6229.9 6288.0 10729.5 11096.2 11141.6 11172.8 11188.4 10726.9 10867.4 11018.6 11048.6 11084.8 7333.4 8262.5 8364.9 8415.7 8539.7 7915.6 7926.3 8047.0 8061.0 8092.6 9768.6 9944.3 10003.5 10036.2 10153.1 10108.8 10295.6 10322.4 10329.7 10366.7 7627.9 7652.7 7657.4 7743.1 7748.1 7241.9 8225.4 8300.0 8353.5 8466.7 7846.9 7945.1 8023.6 8058.3 8063.3 7690.3 7757.1 7835.6 7872.9 7879.4 7597.4 7879.1 7961.7 8001.1 8024.8 7019.1 7081.0 7094.6 7098.7 7099.8 7123.0 7174.9 7219.1 7238.6 7247.0 04:51:47 INFO - PROCESS | 1688 | 04:51:47 INFO - PROCESS | 1688 | [#4] prototype.html Cycles:180 Average:5774.13 Median:6547.30 stddev:1888.93 (28.9%) stddev-sans-first:1849.43 04:51:47 INFO - PROCESS | 1688 | Values: 325.4 328.9 335.8 340.0 340.1 6509.2 6637.7 6648.1 6659.1 6695.3 5409.3 6453.4 6574.7 6624.0 6656.4 4919.7 4931.0 4946.2 4946.5 4950.6 4934.7 4951.1 4954.8 4973.7 4979.6 4623.1 4801.2 4817.3 4820.5 4832.4 4777.9 4802.1 4806.0 4855.0 4876.5 4094.5 4118.1 4119.0 4119.8 4127.9 6180.3 6359.7 6376.6 6381.3 6389.2 5743.6 5754.1 5756.3 5764.3 5769.9 5561.6 5716.9 7135.2 7154.5 7164.8 3493.3 3811.1 4437.0 4583.9 4606.8 7295.7 7451.0 7570.2 7623.0 7634.0 3622.9 3911.9 4677.9 4679.7 4696.8 4725.0 4755.6 4772.5 4773.3 4774.2 4635.8 5581.7 5704.1 5718.4 5729.2 7176.8 7181.1 7202.9 7209.8 7219.6 1534.5 1588.0 1599.7 1647.6 1652.2 1036.4 1054.8 1058.1 1058.3 1068.1 6704.9 6740.1 6755.4 6763.0 6784.0 7375.2 7378.7 7395.9 7411.7 7429.0 6480.4 6724.8 6739.0 6751.6 6759.2 3347.8 3905.9 3910.6 3920.5 3942.6 7746.6 7772.2 7776.7 7779.0 7822.8 7387.2 7644.4 7652.2 7672.5 7723.7 7731.5 7737.8 7744.3 7751.0 7776.2 6089.9 7368.8 7395.2 7402.1 7476.9 6846.7 7047.6 7244.0 7317.3 7330.7 6839.8 7792.5 7795.7 7796.4 7811.4 4693.1 4693.3 4693.4 4704.1 4709.2 6519.9 6876.1 7141.5 7159.5 7256.4 5742.0 7032.4 7123.4 7228.7 7236.1 7174.4 7183.4 7197.8 7199.3 7200.4 5494.6 5720.3 6992.6 7005.5 7056.8 7230.8 7237.0 7248.1 7262.5 7274.6 6885.3 7047.6 7076.1 7077.4 7098.9 04:51:47 INFO - PROCESS | 1688 | 04:51:47 INFO - PROCESS | 1688 | [#5] yui.html Cycles:180 Average:17878.86 Median:31962.15 stddev:24564.17 (76.9%) stddev-sans-first:24598.86 04:51:47 INFO - PROCESS | 1688 | Values: 610.7 687.7 720.8 745.2 746.1 14608.2 14686.6 14720.3 14792.9 14817.7 13120.2 13155.7 13725.5 15318.0 15357.8 846.4 850.5 863.5 864.0 866.7 844.2 854.7 854.9 855.2 857.2 891.6 896.2 899.3 904.1 911.2 882.4 895.5 899.2 899.4 899.8 653.1 657.1 662.7 665.8 666.0 14308.0 14393.6 14394.6 14400.0 14754.0 12159.2 12247.9 12345.4 12516.0 12617.8 10216.6 10230.8 10236.8 10316.6 10445.4 3436.3 3442.0 3493.5 3665.6 3704.6 66696.0 69228.3 69482.0 77879.6 79973.2 9337.5 9432.3 9648.4 9688.2 10000.3 19853.4 20047.4 20052.0 20112.4 20151.0 7464.0 7481.6 7532.5 7676.4 7845.0 4033.6 4071.6 4103.3 4240.1 4245.6 3435.6 3473.4 3490.4 3494.8 3499.1 630.6 645.7 652.6 672.7 676.7 523.5 523.5 580.0 601.6 638.4 8702.0 8991.0 9045.1 9084.6 9153.0 534.3 590.3 591.5 618.3 633.9 3870.5 4018.4 4025.4 4032.2 4137.6 85339.6 85733.0 86747.0 86755.6 87189.6 69894.7 70171.0 70753.6 70968.6 78834.0 72898.6 73596.6 74828.0 76742.6 77078.0 8804.9 8805.6 8820.9 8952.8 8962.2 47720.0 49097.5 49366.5 49977.3 49991.8 63293.7 68031.7 68351.0 68435.7 68655.0 11082.2 11285.9 11346.5 11700.1 11821.7 11497.5 12309.8 12382.0 12594.3 12676.9 11139.8 11686.3 11744.0 11747.9 12210.1 11159.2 11812.0 11896.6 12214.9 12351.4 10815.5 10897.0 11484.9 11516.3 12054.5 9253.4 9388.4 9435.0 9507.4 9782.4 9381.6 9561.9 9913.2 9959.5 9966.5 04:51:47 INFO - PROCESS | 1688 | -------- Summary: end -------- 04:51:47 INFO - PROCESS | 1688 | 04:51:47 INFO - TEST-INFO | 1688: exit 0 04:51:47 INFO - TEST-OK | dromaeo_css | took 1110928ms 04:51:47 INFO - TEST-START | kraken 04:51:47 INFO - operating with platform_type : mac_ 04:51:47 INFO - Initialising browser for kraken test... 04:51:47 INFO - TEST-INFO | started process 1697 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpF9_b7C/profile http://localhost:49275/getInfo.html) 04:51:48 INFO - PROCESS | 1697 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 04:51:50 INFO - PROCESS | 1697 | __metrics Screen width/height:1600/1200 04:51:50 INFO - PROCESS | 1697 | colorDepth:24 04:51:50 INFO - PROCESS | 1697 | Browser inner width/height: 1024/689 04:51:50 INFO - PROCESS | 1697 | __metrics 04:51:50 ERROR - PROCESS | 1697 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2830: TypeError: this.tabs is undefined 04:51:50 INFO - PROCESS | 1697 | ************************* 04:51:50 INFO - PROCESS | 1697 | A coding exception was thrown in a Promise resolution callback. 04:51:50 INFO - PROCESS | 1697 | See https://developer.mozilla.org/Mozilla/JavaScript_code_modules/Promise.jsm/Promise 04:51:50 INFO - PROCESS | 1697 | 04:51:50 ERROR - PROCESS | 1697 | Full message: TypeError: this.tabs is undefined 04:51:50 INFO - PROCESS | 1697 | Full stack: .get@chrome://browser/content/tabbrowser.xml:2830:17 04:51:50 INFO - PROCESS | 1697 | ssi_onClose/<@resource:///modules/sessionstore/SessionStore.jsm:1323:9 04:51:50 INFO - PROCESS | 1697 | Handler.prototype.process@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:937:23 04:51:50 INFO - PROCESS | 1697 | this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:816:7 04:51:50 INFO - PROCESS | 1697 | Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:747:11 04:51:50 INFO - PROCESS | 1697 | this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:779:7 04:51:50 INFO - PROCESS | 1697 | this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:714:7 04:51:50 INFO - PROCESS | 1697 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:146:5 04:51:50 INFO - PROCESS | 1697 | resolve@resource://app/modules/sessionstore/TabStateFlusher.jsm:52:5 04:51:50 INFO - PROCESS | 1697 | receiveMessage@resource:///modules/sessionstore/SessionStore.jsm:734:11 04:51:50 INFO - PROCESS | 1697 | 04:51:50 INFO - PROCESS | 1697 | ************************* 04:51:50 INFO - PROCESS | 1697 | 04:51:50 INFO - PROCESS | 1697 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 04:51:50 INFO - PROCESS | 1697 | 04:51:51 INFO - TEST-INFO | 1697: exit 0 04:51:51 INFO - Browser initialized. 04:51:51 INFO - Running cycle 1/1 for kraken test... 04:51:51 INFO - TEST-INFO | started process 1700 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/T/tmpF9_b7C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:03 INFO - PROCESS | 1700 | RSS: Main: 256843776 04:52:03 INFO - PROCESS | 1700 | 04:52:05 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 04:52:06 INFO - PROCESS | 1700 | RSS: Main: 269721600 04:52:06 INFO - PROCESS | 1700 | 04:52:09 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 04:52:09 INFO - PROCESS | 1700 | RSS: Main: 278908928 04:52:09 INFO - PROCESS | 1700 | 04:52:13 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 04:52:13 INFO - PROCESS | 1700 | RSS: Main: 281288704 04:52:13 INFO - PROCESS | 1700 | 04:52:15 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 04:52:16 INFO - PROCESS | 1700 | RSS: Main: 283463680 04:52:16 INFO - PROCESS | 1700 | 04:52:18 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:18 INFO - PROCESS | 1700 | RSS: Main: 284164096 04:52:18 INFO - PROCESS | 1700 | 04:52:21 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:22 INFO - PROCESS | 1700 | RSS: Main: 284389376 04:52:22 INFO - PROCESS | 1700 | 04:52:25 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 04:52:25 INFO - PROCESS | 1700 | RSS: Main: 283574272 04:52:25 INFO - PROCESS | 1700 | 04:52:28 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 04:52:29 INFO - PROCESS | 1700 | RSS: Main: 284155904 04:52:29 INFO - PROCESS | 1700 | 04:52:30 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:52:31 INFO - PROCESS | 1700 | RSS: Main: 284459008 04:52:31 INFO - PROCESS | 1700 | 04:52:33 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:52:33 INFO - PROCESS | 1700 | RSS: Main: 283246592 04:52:33 INFO - PROCESS | 1700 | 04:52:35 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:52:36 INFO - PROCESS | 1700 | RSS: Main: 283938816 04:52:36 INFO - PROCESS | 1700 | 04:52:39 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:52:39 INFO - PROCESS | 1700 | RSS: Main: 285040640 04:52:39 INFO - PROCESS | 1700 | 04:52:42 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:52:42 INFO - PROCESS | 1700 | RSS: Main: 284262400 04:52:42 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 04:52:44 INFO - PROCESS | 1700 | RSS: Main: 285868032 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | __start_tp_report 04:52:44 INFO - PROCESS | 1700 | _x_x_mozilla_page_load 04:52:44 INFO - PROCESS | 1700 | _x_x_mozilla_page_load_details 04:52:44 INFO - PROCESS | 1700 | |i|pagename|runs| 04:52:44 INFO - PROCESS | 1700 | |0;ai-astar;114;111;115;115;116;126;113;114;112;115 04:52:44 INFO - PROCESS | 1700 | |1;audio-beat-detection;155;124;168;159;145;170;137;121;159;119 04:52:44 INFO - PROCESS | 1700 | |2;audio-dft;190;192;197;198;207;219;196;198;202;200 04:52:44 INFO - PROCESS | 1700 | |3;audio-fft;73;58;62;81;85;119;56;56;58;61 04:52:44 INFO - PROCESS | 1700 | |4;audio-oscillator;83;91;119;79;82;83;112;80;81;113 04:52:44 INFO - PROCESS | 1700 | |5;imaging-gaussian-blur;87;92;86;92;86;91;93;142;86;91 04:52:44 INFO - PROCESS | 1700 | |6;imaging-darkroom;95;115;137;94;113;121;96;95;96;97 04:52:44 INFO - PROCESS | 1700 | |7;imaging-desaturate;96;151;90;152;144;118;97;96;95;95 04:52:44 INFO - PROCESS | 1700 | |8;json-parse-financial;57;54;56;54;56;55;55;62;56;54 04:52:44 INFO - PROCESS | 1700 | |9;json-stringify-tinderbox;66;68;65;68;73;70;67;68;67;67 04:52:44 INFO - PROCESS | 1700 | |10;stanford-crypto-aes;86;85;84;85;82;81;85;84;95;99 04:52:44 INFO - PROCESS | 1700 | |11;stanford-crypto-ccm;123;128;140;128;153;122;115;147;145;133 04:52:44 INFO - PROCESS | 1700 | |12;stanford-crypto-pbkdf2;113;134;161;125;142;176;115;161;178;180 04:52:44 INFO - PROCESS | 1700 | |13;stanford-crypto-sha256-iterative;71;99;100;81;68;66;68;68;67;67 04:52:44 INFO - PROCESS | 1700 | __end_tp_report 04:52:44 INFO - PROCESS | 1700 | __start_cc_report 04:52:44 INFO - PROCESS | 1700 | _x_x_mozilla_cycle_collect,903 04:52:44 INFO - PROCESS | 1700 | __end_cc_report 04:52:44 INFO - PROCESS | 1700 | __startTimestamp1454763164944__endTimestamp 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | ------- Summary: start ------- 04:52:44 INFO - PROCESS | 1700 | Number of tests: 14 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.00 stddev:4.12 (3.6%) stddev-sans-first:4.35 04:52:44 INFO - PROCESS | 1700 | Values: 114.0 111.0 115.0 115.0 116.0 126.0 113.0 114.0 112.0 115.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:157.00 stddev:19.43 (12.4%) stddev-sans-first:20.32 04:52:44 INFO - PROCESS | 1700 | Values: 155.0 124.0 168.0 159.0 145.0 170.0 137.0 121.0 159.0 119.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#2] audio-dft Cycles:10 Average:199.90 Median:199.00 stddev:8.24 (4.1%) stddev-sans-first:7.92 04:52:44 INFO - PROCESS | 1700 | Values: 190.0 192.0 197.0 198.0 207.0 219.0 196.0 198.0 202.0 200.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#3] audio-fft Cycles:10 Average:70.90 Median:61.50 stddev:19.92 (32.4%) stddev-sans-first:21.12 04:52:44 INFO - PROCESS | 1700 | Values: 73.0 58.0 62.0 81.0 85.0 119.0 56.0 56.0 58.0 61.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:81.50 stddev:15.87 (19.5%) stddev-sans-first:16.47 04:52:44 INFO - PROCESS | 1700 | Values: 83.0 91.0 119.0 79.0 82.0 83.0 112.0 80.0 81.0 113.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#5] imaging-gaussian-blur Cycles:10 Average:94.60 Median:91.00 stddev:16.89 (18.6%) stddev-sans-first:17.69 04:52:44 INFO - PROCESS | 1700 | Values: 87.0 92.0 86.0 92.0 86.0 91.0 93.0 142.0 86.0 91.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#6] imaging-darkroom Cycles:10 Average:105.90 Median:95.00 stddev:14.84 (15.6%) stddev-sans-first:15.21 04:52:44 INFO - PROCESS | 1700 | Values: 95.0 115.0 137.0 94.0 113.0 121.0 96.0 95.0 96.0 97.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#7] imaging-desaturate Cycles:10 Average:113.40 Median:95.00 stddev:25.73 (27.1%) stddev-sans-first:26.51 04:52:44 INFO - PROCESS | 1700 | Values: 96.0 151.0 90.0 152.0 144.0 118.0 97.0 96.0 95.0 95.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:2.38 (4.2%) stddev-sans-first:2.49 04:52:44 INFO - PROCESS | 1700 | Values: 57.0 54.0 56.0 54.0 56.0 55.0 55.0 62.0 56.0 54.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:2.23 (3.3%) stddev-sans-first:2.26 04:52:44 INFO - PROCESS | 1700 | Values: 66.0 68.0 65.0 68.0 73.0 70.0 67.0 68.0 67.0 67.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:85.00 stddev:5.76 (6.8%) stddev-sans-first:6.10 04:52:44 INFO - PROCESS | 1700 | Values: 86.0 85.0 84.0 85.0 82.0 81.0 85.0 84.0 95.0 99.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#11] stanford-crypto-ccm Cycles:10 Average:133.40 Median:136.50 stddev:12.39 (9.1%) stddev-sans-first:12.56 04:52:44 INFO - PROCESS | 1700 | Values: 123.0 128.0 140.0 128.0 153.0 122.0 115.0 147.0 145.0 133.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.50 Median:161.00 stddev:26.07 (16.2%) stddev-sans-first:24.29 04:52:44 INFO - PROCESS | 1700 | Values: 113.0 134.0 161.0 125.0 142.0 176.0 115.0 161.0 178.0 180.0 04:52:44 INFO - PROCESS | 1700 | 04:52:44 INFO - PROCESS | 1700 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:68.00 stddev:13.36 (19.6%) stddev-sans-first:14.07 04:52:44 INFO - PROCESS | 1700 | Values: 71.0 99.0 100.0 81.0 68.0 66.0 68.0 68.0 67.0 67.0 04:52:44 INFO - PROCESS | 1700 | -------- Summary: end -------- 04:52:44 INFO - PROCESS | 1700 | 04:52:45 INFO - TEST-INFO | 1700: exit 0 04:52:45 INFO - TEST-OK | kraken | took 57939ms 04:52:45 INFO - SUITE-END | took 1168s 04:52:46 INFO - Completed test suite (00:19:29) 04:52:46 INFO - Working with test: dromaeo_css 04:52:46 INFO - Generating results file: dromaeo_css 04:52:46 INFO - Working with test: kraken 04:52:46 INFO - Generating results file: kraken 04:52:46 INFO - javascript benchmark 04:52:46 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 04:52:46 INFO - process_Request line: dromaeo_css 7428.90 graph.html#tests=[[72,64,61]] 04:52:46 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:52:46 INFO - process_Request line: kraken 1505.60 graph.html#tests=[[232,64,61]] 04:52:46 INFO - RETURN: dromaeo_css: 7428.90 04:52:46 INFO - RETURN: kraken: 1505.60 04:52:46 INFO - javascript benchmark 04:52:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2815.690274069852, 3513.1744040150543, 3514.0512061743348, 3539.893803185904, 3589.8025608591524, 5629.155626656004, 5684.374718780936, 5689.658620482764, 5692.943070569293, 5694.5729070319785, 4822.541858523435, 5186.896262074766, 5498.505134537891, 5631.63394379365, 5645.15322701595, 5112.105381558222, 5165.457626949173, 5190.299309593213, 5213.035588416155, 5235.947640523603, 5194.428612852583, 5235.947640523584, 5246.081935661263, 5276.314079169702, 5303.257543943851, 4412.75729834859, 5226.7647955841885, 5262.578993680497, 5269.947300526984, 5284.180951952453, 5026.246063090529, 5172.741362931876, 5206.76569554371, 5210.76551555181, 5211.635185537033, 5134.306868572732, 5158.0, 5165.173572228463, 5172.741362931876, 5221.765020574046, 5394.1908713692865, 5508.807191748309, 5537.473939975695, 5565.554755619541, 5582.078956972095, 6061.212042434456, 6095.481884039862, 6113.810786210604, 6136.355682653347, 6205.131281620576, 6234.0960560718895, 6244.1570387997945, 6247.687615619247, 6248.843778905563, 6269.059641053833, 5629.493345598834, 5764.135379692996, 5783.21926539916, 5783.971080144656, 5846.269216347957, 6184.474319682788, 6198.752049917953, 6238.469730072995, 6244.718987645567, 6265.216847894013, 6106.267247930188, 6134.44789968896, 6144.293406258337, 6153.107799369066, 6154.753809847645, 6077.604955677867, 6199.876002479925, 6255.12428260044, 6258.311585725566, 6284.717187726564, 5435.347758268954, 6111.804454079419, 6154.630722156685, 6167.629942203482, 6170.136180934673, 6120.60216085953, 6136.417040381246, 6209.0996805462955, 6209.627422354673, 6226.097215903668, 4058.6955978301744, 4748.881277968009, 4805.519448055236, 4813.542713442217, 4887.437944636341, 4382.8904277392685, 4384.188925048876, 4386.429764130643, 4393.055493069006, 4419.513853476115, 5479.835604931779, 5711.914321285184, 5758.078707406795, 5782.3639399666, 5800.39095894925, 5153.948460515422, 6127.785527506605, 6172.197614310201, 6262.68686565679, 6269.5611307208055, 5780.132980053026, 5790.392008839095, 5797.913031304533, 5799.652020878676, 5816.912746308809, 5341.813036543703, 5350.545203657733, 5350.678959262379, 5363.597730170253, 5366.16824392212, 6131.437835141539, 6214.285357183981, 6245.843853903689, 6286.025666021866, 6292.3078461368295, 6235.625862448268, 6272.749090036347, 6273.0, 6282.120503129474, 6299.0, 5573.164025396223, 6027.336992930686, 6293.244810622755, 6306.400891915261, 6308.684565771601, 6104.732011601694, 6109.541784366102, 6189.071639253968, 6203.844903877439, 6212.47193988516, 6196.411340922605, 6268.937310627018, 6278.6546739929745, 6295.401936815995, 6306.936930630818, 5838.474537291664, 6008.188894499362, 6079.696015199311, 6083.726232319645, 6088.695565221633, 5945.464908158287, 5983.760649574142, 6026.7946410718905, 6035.728392222449, 6093.116498107838, 4500.909981800281, 5555.638883472561, 5968.104784282393, 5983.431574000463, 5988.640681559121, 5951.970240148771, 6029.0, 6063.090536419572, 6126.938730612816, 6147.231596050494, 5989.3112292085225, 6005.819825405245, 6012.759489620366, 6013.188219590475, 6050.788222412194], "unit": "score", "name": "dojo.html", "value": 5636.843171998267}, {"lowerIsBetter": false, "replicates": [448.6164329498277, 500.54700496051066, 504.4148787406608, 538.7710223155158, 569.0809342911199, 38000.80999595002, 38551.03622409441, 38680.41979370305, 38766.0, 38779.0, 40899.59100408995, 41138.58861411385, 41464.58535414645, 41510.792446037805, 41742.74771756845, 9647.0, 9834.803303933917, 9862.753431164243, 9879.802403951917, 9893.060159284893, 9755.268354873377, 9858.605655773761, 9897.703068907907, 9898.455584942825, 9986.700398988005, 9791.06984836443, 9856.457894815781, 9880.110790028895, 9906.65326713565, 9916.950415247913, 9771.853422198672, 9797.510124493747, 9821.165200957927, 9844.0, 9850.965648606936, 9596.76008099803, 9743.805123897553, 9749.658761943298, 9761.121499065048, 9780.55987480558, 39448.0, 39469.0, 39658.0, 39832.601673983176, 39883.60116398857, 3370.4607262837826, 3374.5613070300706, 3411.113110591264, 3487.424574945131, 3593.1017245688577, 28408.289792755346, 28540.714592854012, 28617.57073643897, 28899.56650650242, 28937.710622893712, 2753.504369213541, 2769.321516228517, 2791.3719413132085, 2809.0, 2850.2304377817873, 447704.0, 448361.0, 448501.0, 448779.0, 449331.0, 54125.72937135289, 55211.723941380034, 62710.68644656747, 63439.682801585695, 63531.0, 59977.80044399088, 60305.0, 60348.69825650931, 60902.086468703004, 60968.39031609627, 15673.608159796097, 15835.0, 15944.362225511082, 16041.759373609406, 16072.75890861638, 10281.74295642615, 12319.93840030812, 12413.689657758448, 12680.556180533637, 12694.936525317315, 19690.70463943042, 19779.703304450446, 20080.497987550138, 20116.497087572927, 20131.396058117985, 7527.946087547748, 8177.182281771775, 8288.50268983863, 8514.446560973516, 8518.148185181557, 922.4603606890045, 935.9578818953163, 971.6356366362614, 1036.4247842447514, 1075.9677209683723, 28785.856070719514, 28963.85518072396, 29364.0, 29411.558826617616, 29550.0, 997.4688852611207, 998.0618218874235, 1026.6817286641165, 1029.9073083422527, 1058.4760543530847, 13846.63768014649, 14068.929655351658, 14158.64603384903, 14277.571672849832, 14312.85687143136, 468303.0, 473527.0, 474364.0, 476062.0, 479467.0, 55491.445085549436, 55587.444125559035, 55623.72188139033, 55780.16329755057, 55997.0, 1397.475946520055, 1405.894557908161, 1418.4680744720729, 1433.6702558411623, 1435.3612642374253, 26095.478090438464, 27059.91760329565, 27255.087811583675, 27272.727272727017, 27501.31246718768, 47747.0, 47909.76045119752, 48268.7586562065, 48284.75857620689, 48442.5155748438, 467597.0, 467808.0, 471013.0, 471962.0, 473416.0, 30457.54313685252, 32737.0, 33581.496277555365, 33583.328333432706, 33626.32747345088, 38312.0, 39970.00299970096, 39982.400263995485, 40001.79999099986, 40714.79642601768, 29788.659510322523, 33314.00057998264, 35889.46165807567, 36352.63647363493, 36397.634153779916, 35120.12199694926, 35170.64829351776, 35924.92225233247, 35967.460488092176, 36238.63761362458, 35280.823595881855, 35769.0, 35925.0, 35990.28019439544, 36160.09599760027, 29368.97208597689, 29381.706182937898, 31992.0, 32079.952404521533, 32212.03363898993, 23940.0, 24227.152049678883, 24615.13847015346, 24639.0, 24656.87671561631], "unit": "score", "name": "ext.html", "value": 19252.58505712791}, {"lowerIsBetter": false, "replicates": [319.4346007566607, 355.67455777963175, 363.72538733256386, 364.37873425809, 370.88131797824707, 15393.307301171446, 18231.0, 18609.906950465247, 19544.804551954476, 20801.583968320625, 19824.20703171875, 19859.404217873453, 20012.29956951507, 20166.991650417458, 20239.49401264969, 5446.319210098738, 5508.44915508448, 5754.0, 5757.193992841006, 5769.04810706233, 4074.2055299216663, 4270.587118278163, 5613.0, 6038.6074905131245, 6271.216097987752, 6031.336552979169, 6233.3143354231, 6255.218097737783, 6258.87482250357, 6268.216472940882, 6139.355367686373, 6202.038684003964, 6207.162033125515, 6213.68931553425, 6244.625322480666, 4660.3941487606735, 4786.497417771154, 5298.523132918056, 5360.892782144335, 5380.542653874425, 22205.0, 23311.18410855612, 23357.065717371286, 23373.883130584407, 24579.0, 2208.596291112317, 2215.878126703031, 2284.4745708486976, 2353.7646235376496, 2418.6372044193336, 14336.64158396038, 14481.131132132, 14633.0, 14652.560423187215, 15243.923780381027, 1676.9329226830912, 1696.8218337074677, 1734.9826501735074, 1735.3492440334874, 1737.730651748981, 88510.55744721236, 100960.49519752427, 102035.48982255116, 102525.48737256265, 105033.0, 10507.474626268657, 10944.726381840359, 11088.833667494993, 11125.054370378446, 11142.777144457066, 13307.733845323039, 13341.733165336638, 13348.0, 13373.39819708096, 13373.46506139763, 8157.265846073882, 8252.092269850311, 8286.295664868554, 8313.542755148404, 8405.747827565183, 8345.874811877828, 8351.457155284887, 8365.24712775841, 8389.412741108186, 8406.41155119148, 3744.288585168864, 3955.288048151303, 4284.828606855754, 4291.785410729451, 4373.475182978, 1730.3943619732993, 1766.2758269109604, 1829.0945981739123, 1831.6062046660031, 1877.6620208362353, 844.8225872566707, 918.4581097152712, 928.1229238369676, 980.6567701304486, 990.217727994876, 14632.780508292384, 18627.06864656789, 19547.51131221731, 21027.0, 21193.0, 848.6690190825583, 878.4114643189079, 948.7262013814877, 971.8687977122997, 972.8978457262027, 10739.570417183382, 10753.731156721145, 10821.831714281572, 11184.3646130771, 11343.602973896039, 487029.0, 501833.0, 558536.0, 700537.0, 705268.0, 113150.0, 114610.42694786473, 115313.27030094556, 115600.0, 115788.0, 483.5575448464686, 511.0468975360925, 511.16934980657174, 1162.604714397109, 1209.4194786502528, 10707.357558546511, 10949.726256843642, 10968.725781855517, 11001.954814292629, 11134.554617815196, 33610.487528061785, 41874.79062604668, 46594.36919707794, 47334.0, 48576.75711621419, 63570.046449304224, 66500.0, 69881.0, 70302.64848675724, 70961.0, 7234.16807067194, 7340.559566426032, 7599.16409194977, 7613.733519326797, 7638.312551870358, 10796.190285728444, 10930.070943969851, 11215.831762523405, 11352.432378381212, 11639.418029098342, 9852.556634951301, 9903.851442228517, 10190.847137292798, 10298.0, 10356.896431035593, 9862.211023118276, 10099.69700908974, 10392.22058345612, 10547.156227501935, 10640.148788096778, 10387.948060259952, 10518.061216334925, 10599.205059620714, 10664.466776661291, 10787.892121078688, 7556.319931206218, 7640.808979775327, 7641.847163056596, 7752.496087754504, 7759.107702614272, 9278.768030799283, 9383.436993780395, 10369.9481502592, 10405.323653962469, 10409.479526023517], "unit": "score", "name": "jquery.html", "value": 8932.167254627984}, {"lowerIsBetter": false, "replicates": [1527.8395768444313, 1549.7133030389375, 1735.713607254803, 1831.249187832988, 1888.6128343689545, 7962.52224866507, 8071.717489887855, 8826.205641492264, 8887.777805554857, 9005.50469724165, 8534.231919127278, 8694.956525217382, 8793.95603021984, 8796.824063518727, 8813.823723525526, 2443.1815341860497, 2482.8758562071916, 2484.35406794233, 2487.5398051360557, 2488.950220995579, 2351.4356554426986, 2439.280412278373, 2444.9511009779794, 2447.669564608782, 2447.963280550793, 2463.1994601754413, 2476.368526025861, 2487.7387874273213, 2498.2755001049673, 2500.2874180858457, 2453.950920981579, 2480.6651102101164, 2486.428121532049, 2491.6137998610243, 2516.4967006598754, 2151.537419454809, 2468.419921318489, 2487.81341399394, 2488.415222422729, 2493.638422428756, 8967.551622418918, 9023.323250756219, 9032.232260257886, 9057.547122643842, 9057.728268151901, 5389.51494365509, 5576.0241957657245, 5580.944190558123, 5593.580481463907, 5599.244102046212, 3635.8000309983204, 3760.172761992357, 3761.492198553215, 3795.2978698940783, 3800.258949504848, 1053.7049626104704, 1076.445630500293, 1078.8651418572679, 1102.8014957307682, 1111.9332840029624, 12203.69490762738, 12239.143259971806, 12348.073894457952, 12414.0, 12442.751144977141, 4089.345704687236, 4966.6771659842, 5001.349824522861, 5057.393112826484, 5084.51697088776, 10177.440240786827, 10458.63394781179, 10468.68593942183, 10483.0041146091, 10486.0, 5548.944510554843, 5558.44415558441, 5575.470330318694, 5611.663300202001, 5613.831585052455, 4125.401816736557, 4439.223135951195, 4587.311903214478, 4976.8755781105765, 5042.873928151826, 3812.2375524895133, 3860.208657225262, 3873.1091848874917, 3887.1059656279213, 3889.124946886984, 1294.9158304710163, 1307.3855288014618, 1310.102579732886, 1310.4037662863375, 1310.927898965566, 1065.973350666224, 1075.5805235957982, 1087.7878813631423, 1253.924764514132, 1358.8641135886332, 7723.806904827425, 8066.274035336731, 8142.063662678749, 8157.551334676531, 8398.454100483448, 518.9922151167735, 526.7866514061811, 528.8281308574728, 529.0186703664647, 537.078909669918, 6048.243969503812, 6194.34959329273, 6214.316425193225, 6229.906551401733, 6287.993920972623, 10729.463526823627, 11096.167787415814, 11141.610043648596, 11172.832407513893, 11188.440577971069, 10726.892731072745, 10867.402292873969, 11018.559257629766, 11048.558057677763, 11084.833727494093, 7333.376662983706, 8262.462939908886, 8364.874526882102, 8415.70545030921, 8539.658413663508, 7915.643796029308, 7926.326262267541, 8047.0, 8061.025048863066, 8092.635831387484, 9768.609255629695, 9944.254180936314, 10003.499825008867, 10036.19710423179, 10153.136983356497, 10108.797824043624, 10295.588176472857, 10322.380657160595, 10329.690109296433, 10366.740831479274, 7627.923720762721, 7652.693892244248, 7657.425693072931, 7743.109542402696, 7748.147703752696, 7241.927580724126, 8225.424220304521, 8300.04549476818, 8353.54055526952, 8466.74599762008, 7846.882296765667, 7945.0863150736095, 8023.6389362479995, 8058.274755272054, 8063.314618257279, 7690.2694244046725, 7757.069151701606, 7835.608219588884, 7872.921270787218, 7879.448438609243, 7597.430192735456, 7879.133295337394, 7961.681532738626, 8001.079875814356, 8024.799380015546, 7019.087518622547, 7080.964595177197, 7094.6097964612445, 7098.716051357887, 7099.787006389816, 7123.0, 7174.928250717426, 7219.133703955349, 7238.6380680966795, 7246.985422041024], "unit": "score", "name": "mootools.html", "value": 4908.690793085278}, {"lowerIsBetter": false, "replicates": [325.41425434218405, 328.8996855958932, 335.75154385754547, 339.9660033996602, 340.0987383433898, 6509.153810004693, 6637.701303441345, 6648.135742353487, 6659.13431253937, 6695.296993815652, 5409.29679141712, 6453.386928241809, 6574.704138313776, 6624.0, 6656.367645073722, 4919.655624106314, 4931.0, 4946.15915294399, 4946.480619534951, 4950.6039516838655, 4934.703917764946, 4951.133551628469, 4954.826581069663, 4973.726445045521, 4979.601631869442, 4623.121606894696, 4801.231802911535, 4817.277408388734, 4820.469748327699, 4832.444268909086, 4777.928331075037, 4802.111609352281, 4805.951940480621, 4854.951450485485, 4876.487968763265, 4094.488188976378, 4118.073433477473, 4119.011437255067, 4119.7940102994735, 4127.8968025799295, 6180.289266734293, 6359.65021923794, 6376.649284289362, 6381.298057213703, 6389.233292004989, 5743.62666426681, 5754.079347304411, 5756.280464941882, 5764.279465066867, 5769.942300577024, 5561.58288128392, 5716.914246286267, 7135.215126336099, 7154.499185057048, 7164.785056448315, 3493.283876805249, 3811.104390468238, 4436.979494716201, 4583.931241031387, 4606.815727370901, 7295.744648937261, 7450.994115794352, 7570.205128461543, 7623.0, 7634.045744281965, 3622.9456558151123, 3911.9437751806854, 4677.929831052537, 4679.719216847, 4696.7651617419, 4724.960508688083, 4755.643326750507, 4772.546608072227, 4773.284007398848, 4774.164521208844, 4635.791389387418, 5581.720913954286, 5704.0588302929555, 5718.428157184331, 5729.2265544151005, 7176.82057948545, 7181.138263408425, 7202.891956620655, 7209.783706488814, 7219.628270628564, 1534.4706076403622, 1587.9841201588067, 1599.6720672262159, 1647.6375197456541, 1652.239969613967, 1036.383351905615, 1054.8312270036756, 1058.0583280880023, 1058.30680904008, 1068.1348108032519, 6704.932950670528, 6740.123783908159, 6755.3582409671, 6762.966185169043, 6784.0, 7375.225601311892, 7378.667959941816, 7395.889061664079, 7411.740589079356, 7428.9628551856895, 6480.351964803482, 6724.798256052229, 6739.0, 6751.594904305757, 6759.188897332351, 3347.832608369572, 3905.863294784726, 3910.648041676263, 3920.4903362562686, 3942.6254505821903, 7746.573938433327, 7772.222777722295, 7776.688932442639, 7779.0, 7822.826576013644, 7387.150477695026, 7644.388448924073, 7652.1582625911105, 7672.5012874163, 7723.729669461542, 7731.536107833548, 7737.767866964, 7744.303012728881, 7750.961245193738, 7776.183500732454, 6089.908651370144, 7368.815779605338, 7395.186529481645, 7402.148752893271, 7476.925230747623, 6846.699127165823, 7047.577145371294, 7244.0, 7317.26827317264, 7330.743423980135, 6839.794806155624, 7792.532448053135, 7795.688172473037, 7796.415268854745, 7811.375089992901, 4693.0613877224005, 4693.319468677091, 4693.366395536559, 4704.129735998851, 4709.246520556694, 6519.891618424785, 6876.140482439695, 7141.500094993508, 7159.463040271896, 7256.383207427217, 5742.0, 7032.367086962198, 7123.430125590044, 7228.710851565878, 7236.059312289369, 7174.426045916419, 7183.425325973805, 7197.820054498679, 7199.280071992759, 7200.387967022652, 5494.615376923577, 5720.256366672306, 6992.580445173306, 7005.54463959841, 7056.7530136444975, 7230.819229519304, 7236.96381518089, 7248.0939882514685, 7262.491625586158, 7274.563526188445, 6885.277045910308, 7047.647617619201, 7076.115485564304, 7077.433805295667, 7098.929010709827], "unit": "score", "name": "prototype.html", "value": 5145.797733010959}, {"lowerIsBetter": false, "replicates": [610.7160170520707, 687.656171914043, 720.8450183210606, 745.2175216023178, 746.0972223609432, 14608.19654918979, 14686.63283417915, 14720.337584808696, 14792.852071479281, 14817.703645927075, 13120.21278723275, 13155.6711082223, 13725.450981960734, 15318.0, 15357.769633455508, 846.4371193156544, 850.4769566716456, 863.5121156546531, 863.952482613456, 866.7486428935632, 844.2022288936957, 854.7393045121236, 854.8760429737684, 855.1875718067829, 857.1514200941054, 891.6299735609714, 896.1665650944619, 899.2895612466144, 904.1230006893336, 911.2026976395654, 882.3514716683264, 895.5119459894373, 899.2042042792143, 899.4378513429107, 899.7885496908222, 653.1117679955257, 657.063684249942, 662.7282814046266, 665.7969319357594, 665.9800205993828, 14307.998440109197, 14393.640158996004, 14394.640133996629, 14399.992000559965, 14753.967222294445, 12159.209651372721, 12247.938760306231, 12345.38273086342, 12516.0, 12617.810732839014, 10216.642417515352, 10230.795384092276, 10236.795264094751, 10316.58733650653, 10445.425501597409, 3436.295559410315, 3442.0, 3493.4759786032046, 3665.5601327840563, 3704.6110158433517, 66696.0, 69228.30771692269, 69482.0, 77879.61060194719, 79973.20026799716, 9337.486438245962, 9432.339736218399, 9648.372855764354, 9688.224942004623, 10000.3499772516, 19853.4043978678, 20047.39857804268, 20052.0, 20112.39662810118, 20151.0, 7463.962680186564, 7481.551106933602, 7532.472726909174, 7676.385889128856, 7844.980152580242, 4033.6369726724733, 4071.572484889103, 4103.343465045578, 4240.109576988867, 4245.639120674716, 3435.604905435857, 3473.374792537317, 3490.424080026818, 3494.807785571818, 3499.125218695326, 630.6247782569363, 645.6771614192903, 652.6312633362135, 672.7342699633715, 676.6751959059679, 523.4503771040393, 523.5288240583429, 579.987921077722, 601.5909181756448, 638.396715104222, 8701.956490217508, 8991.0, 9045.050269721716, 9084.591193396313, 9153.038930912291, 534.3480953237045, 590.2887021139517, 591.5090474905818, 618.2673531864755, 633.9049142628643, 3870.4581358609817, 4018.4374187613757, 4025.4364388985564, 4032.2219513287373, 4137.627613514798, 85339.57330213433, 85733.0, 86747.0, 86755.56622216974, 87189.5640521806, 69894.65052674703, 70171.0, 70753.64623176851, 70968.58062838818, 78834.0, 72898.6355068232, 73596.63201683958, 74828.0, 76742.6162869182, 77078.0, 8804.911950880409, 8805.559722013746, 8820.94378138383, 8952.820943581222, 8962.238209751984, 47720.0, 49097.50902490929, 49366.50633493619, 49977.250341245635, 49991.75004124956, 63293.68353158205, 68031.65984170047, 68351.0, 68435.65782171057, 68655.0, 11082.168837337393, 11285.943570282096, 11346.489407976826, 11700.122490813394, 11821.704457388634, 11497.54009839597, 12309.753804923672, 12382.0, 12594.3073130975, 12676.87323126757, 11139.777204456028, 11686.298822070703, 11744.00175985051, 11747.88252117502, 12210.145289829627, 11159.218854680095, 11812.0, 11896.583619573274, 12214.877851221374, 12351.38243087824, 10815.459227038775, 10897.0, 11484.94257528707, 11516.251443656136, 12054.51781928713, 9253.444793312423, 9388.389754665925, 9435.0, 9507.429554226768, 9782.364146330467, 9381.577828997848, 9561.90438095638, 9913.206943444651, 9959.502024898582, 9966.451845148586], "unit": "score", "name": "yui.html", "value": 6864.592683237725}], "name": "dromaeo_css", "value": 7428.904361506127}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 111.0, 115.0, 115.0, 116.0, 126.0, 113.0, 114.0, 112.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.1}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 168.0, 159.0, 145.0, 170.0, 137.0, 121.0, 159.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [190.0, 192.0, 197.0, 198.0, 207.0, 219.0, 196.0, 198.0, 202.0, 200.0], "unit": "score", "name": "audio-dft", "value": 199.9}, {"lowerIsBetter": true, "replicates": [73.0, 58.0, 62.0, 81.0, 85.0, 119.0, 56.0, 56.0, 58.0, 61.0], "unit": "score", "name": "audio-fft", "value": 70.9}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 119.0, 79.0, 82.0, 83.0, 112.0, 80.0, 81.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 92.3}, {"lowerIsBetter": true, "replicates": [87.0, 92.0, 86.0, 92.0, 86.0, 91.0, 93.0, 142.0, 86.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.6}, {"lowerIsBetter": true, "replicates": [95.0, 115.0, 137.0, 94.0, 113.0, 121.0, 96.0, 95.0, 96.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 105.9}, {"lowerIsBetter": true, "replicates": [96.0, 151.0, 90.0, 152.0, 144.0, 118.0, 97.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 113.4}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 56.0, 54.0, 56.0, 55.0, 55.0, 62.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 65.0, 68.0, 73.0, 70.0, 67.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 84.0, 85.0, 82.0, 81.0, 85.0, 84.0, 95.0, 99.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.6}, {"lowerIsBetter": true, "replicates": [123.0, 128.0, 140.0, 128.0, 153.0, 122.0, 115.0, 147.0, 145.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.4}, {"lowerIsBetter": true, "replicates": [113.0, 134.0, 161.0, 125.0, 142.0, 176.0, 115.0, 161.0, 178.0, 180.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.5}, {"lowerIsBetter": true, "replicates": [71.0, 99.0, 100.0, 81.0, 68.0, 66.0, 68.0, 68.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.5}], "name": "kraken", "value": 1505.6}]} 04:52:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1505.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7428.90"}}} 04:52:46 INFO - Return code: 0 04:52:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:52:46 ERROR - # TBPL SUCCESS # 04:52:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:52:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:52:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:52:46 INFO - 2016-02-06 04:52:46.659 screenresolution[1705:11332] starting screenresolution argv=screenresolution get 04:52:46 INFO - 2016-02-06 04:52:46.662 screenresolution[1705:11332] Display 0: 1600x1200x32@60 04:52:46 INFO - 2016-02-06 04:52:46.668 screenresolution[1706:11335] starting screenresolution argv=screenresolution list 04:52:46 INFO - Available Modes on Display 0 04:52:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:52:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:52:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:52:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:52:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:52:46 INFO - Intel Iris: 04:52:46 INFO - Chipset Model: Intel Iris 04:52:46 INFO - Type: GPU 04:52:46 INFO - Bus: Built-In 04:52:46 INFO - VRAM (Dynamic, Max): 1536 MB 04:52:46 INFO - Vendor: Intel (0x8086) 04:52:46 INFO - Device ID: 0x0a2e 04:52:46 INFO - Revision ID: 0x0009 04:52:46 INFO - Displays: 04:52:46 INFO - Display: 04:52:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:52:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:52:46 INFO - Display Serial Number: 1600x1200 60 04:52:46 INFO - Main Display: Yes 04:52:46 INFO - Mirror: Off 04:52:46 INFO - Online: Yes 04:52:46 INFO - Rotation: Supported 04:52:46 INFO - Return code: 0 04:52:46 INFO - Running post-action listener: _resource_record_post_action 04:52:46 INFO - Running post-run listener: _resource_record_post_run 04:52:47 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 34151936; Write bytes: 711814144; Read time: 359; Write time: 1876 04:52:47 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 404664832; Write bytes: 406279680; Read time: 30411; Write time: 711 04:52:47 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 32349696; Write bytes: 304686592; Read time: 339; Write time: 1163 04:52:47 INFO - Running post-run listener: _upload_blobber_files 04:52:47 INFO - Blob upload gear active. 04:52:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:52:47 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 04:52:47 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'] 04:52:47 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 04:52:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:52:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:49 INFO - (blobuploader) - INFO - Done attempting. 04:52:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:52:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:52:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:50 INFO - (blobuploader) - INFO - Done attempting. 04:52:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:50 INFO - Return code: 0 04:52:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8e849e2bb31a783e69b331bce45862e07e9a3ab786cfcb34338b19ae5aaa512563ef535a42d486bd26d5a8b8cff86d215d57c2a93d28da924a9e488469d3f87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a6f7b0cf4468ac73d1ca41ffc3a2118a23700d44a6692402f40e206c95776815a9254742f564685ec727cf957d6b5973b387f26b7573e63049e3cb43f36544d"} 04:52:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:50 INFO - Contents: 04:52:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8e849e2bb31a783e69b331bce45862e07e9a3ab786cfcb34338b19ae5aaa512563ef535a42d486bd26d5a8b8cff86d215d57c2a93d28da924a9e488469d3f87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a6f7b0cf4468ac73d1ca41ffc3a2118a23700d44a6692402f40e206c95776815a9254742f564685ec727cf957d6b5973b387f26b7573e63049e3cb43f36544d"} 04:52:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:50 INFO - Copying logs to upload dir... 04:52:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.996421 ========= master_lag: 9.22 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-02-06 04:52:59.631603) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 10 secs) (at 2016-02-06 04:52:59.635276) ========= 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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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/e8e849e2bb31a783e69b331bce45862e07e9a3ab786cfcb34338b19ae5aaa512563ef535a42d486bd26d5a8b8cff86d215d57c2a93d28da924a9e488469d3f87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a6f7b0cf4468ac73d1ca41ffc3a2118a23700d44a6692402f40e206c95776815a9254742f564685ec727cf957d6b5973b387f26b7573e63049e3cb43f36544d"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010965 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-macosx64/1454515003/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e8e849e2bb31a783e69b331bce45862e07e9a3ab786cfcb34338b19ae5aaa512563ef535a42d486bd26d5a8b8cff86d215d57c2a93d28da924a9e488469d3f87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6a6f7b0cf4468ac73d1ca41ffc3a2118a23700d44a6692402f40e206c95776815a9254742f564685ec727cf957d6b5973b387f26b7573e63049e3cb43f36544d"}' ========= master_lag: 10.29 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 10 secs) (at 2016-02-06 04:53:09.934147) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-02-06 04:53:09.934498) ========= 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.6llMBBMKIy/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.BMSHkaGDXZ/Listeners TMPDIR=/var/folders/_6/4rdc3g_j72l0vnxz7yb01s0000000w/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.005131 ========= master_lag: 8.51 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 8 secs) (at 2016-02-06 04:53:18.449504) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-02-06 04:53:18.449826) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-02-06 04:53:23.001324) ========= ========= Total master_lag: 28.19 =========