builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0010 starttime: 1454466047.96 results: success (0) buildid: 20160202164942 builduid: b554462887c948dcb38729db7766c1d8 revision: 95fdfaf5e766ad6e0ef134fe0fd4408ff918127c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:47.961423) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:47.962031) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:47.962319) ========= 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.U0obbBpey9/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.9m7vSSvF5s/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.005503 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:48.013684) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:48.013996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:48.078304) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:48.078608) ========= 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.U0obbBpey9/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.9m7vSSvF5s/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.005229 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:48.119101) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:48.119397) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:48.119742) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:48.120025) ========= 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.U0obbBpey9/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.9m7vSSvF5s/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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-02 18:20:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2016-02-02 18:20:48 (147 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190264 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:48.351311) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:48.351612) ========= 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.U0obbBpey9/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.9m7vSSvF5s/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.019544 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:48.434961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-02 18:20:48.435364) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 95fdfaf5e766ad6e0ef134fe0fd4408ff918127c --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 95fdfaf5e766ad6e0ef134fe0fd4408ff918127c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.U0obbBpey9/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.9m7vSSvF5s/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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-02 18:20:48,509 truncating revision to first 12 chars 2016-02-02 18:20:48,509 Setting DEBUG logging. 2016-02-02 18:20:48,509 attempt 1/10 2016-02-02 18:20:48,510 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/95fdfaf5e766?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-02 18:20:49,647 unpacking tar archive at: fx-team-95fdfaf5e766/testing/mozharness/ program finished with exit code 0 elapsedTime=1.376638 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-02 18:20:49.830263) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:49.830591) ========= echo 95fdfaf5e766ad6e0ef134fe0fd4408ff918127c in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'95fdfaf5e766ad6e0ef134fe0fd4408ff918127c'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.U0obbBpey9/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.9m7vSSvF5s/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 95fdfaf5e766ad6e0ef134fe0fd4408ff918127c program finished with exit code 0 elapsedTime=0.004910 script_repo_revision: '95fdfaf5e766ad6e0ef134fe0fd4408ff918127c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:49.881534) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:49.881816) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-02 18:20:49.894339) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-02-02 18:20:49.894606) ========= /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.U0obbBpey9/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.9m7vSSvF5s/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 18:20:50 INFO - MultiFileLogger online at 20160202 18:20:50 in /builds/slave/test 18:20:50 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 18:20:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:20:50 INFO - {'append_to_log': False, 18:20:50 INFO - 'base_work_dir': '/builds/slave/test', 18:20:50 INFO - 'blob_upload_branch': 'Fx-Team', 18:20:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:20:50 INFO - 'branch': 'Fx-Team', 18:20:50 INFO - 'buildbot_json_path': 'buildprops.json', 18:20:50 INFO - 'config_files': ('talos/mac_config.py',), 18:20:50 INFO - 'default_actions': ('clobber', 18:20:50 INFO - 'read-buildbot-config', 18:20:50 INFO - 'download-and-extract', 18:20:50 INFO - 'populate-webroot', 18:20:50 INFO - 'create-virtualenv', 18:20:50 INFO - 'install', 18:20:50 INFO - 'run-tests'), 18:20:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:20:50 INFO - 'download_minidump_stackwalk': True, 18:20:50 INFO - 'download_symbols': 'ondemand', 18:20:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:20:50 INFO - 'tooltool.py': '/tools/tooltool.py', 18:20:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:20:50 INFO - '/tools/misc-python/virtualenv.py')}, 18:20:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:20:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:20:50 INFO - 'installer_path': 'installer.exe', 18:20:50 INFO - 'log_level': 'info', 18:20:50 INFO - 'log_name': 'talos', 18:20:50 INFO - 'log_to_console': True, 18:20:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:20:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:20:50 INFO - 'opt_config_files': (), 18:20:50 INFO - 'pip_index': False, 18:20:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:20:50 INFO - 'cmd': ('bash', 18:20:50 INFO - '-c', 18:20:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:20:50 INFO - 'enabled': True, 18:20:50 INFO - 'halt_on_failure': False, 18:20:50 INFO - 'name': 'check_screen_resolution'},), 18:20:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:20:50 INFO - 'cmd': ('bash', 18:20:50 INFO - '-c', 18:20:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:20:50 INFO - 'enabled': True, 18:20:50 INFO - 'halt_on_failure': False, 18:20:50 INFO - 'name': 'check_screen_resolution'},), 18:20:50 INFO - 'run_cmd_checks_enabled': True, 18:20:50 INFO - 'sps_profile': False, 18:20:50 INFO - 'sps_profile_interval': 0, 18:20:50 INFO - 'suite': 'dromaeojs-e10s', 18:20:50 INFO - 'system_bits': '32', 18:20:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:20:50 INFO - 'title': 't-yosemite-r7-0010', 18:20:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:20:50 INFO - 'use_talos_json': True, 18:20:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:20:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:20:50 INFO - 'work_dir': 'build'} 18:20:50 INFO - ##### 18:20:50 INFO - ##### Running clobber step. 18:20:50 INFO - ##### 18:20:50 INFO - Running pre-action listener: _resource_record_pre_action 18:20:50 INFO - Running main action method: clobber 18:20:50 INFO - rmtree: /builds/slave/test/build 18:20:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:20:51 INFO - Running post-action listener: _resource_record_post_action 18:20:51 INFO - ##### 18:20:51 INFO - ##### Running read-buildbot-config step. 18:20:51 INFO - ##### 18:20:51 INFO - Running pre-action listener: _resource_record_pre_action 18:20:51 INFO - Running main action method: read_buildbot_config 18:20:51 INFO - Using buildbot properties: 18:20:51 INFO - { 18:20:51 INFO - "project": "", 18:20:51 INFO - "product": "firefox", 18:20:51 INFO - "script_repo_revision": "production", 18:20:51 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 18:20:51 INFO - "repository": "", 18:20:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 18:20:51 INFO - "buildid": "20160202164942", 18:20:51 INFO - "pgo_build": "False", 18:20:51 INFO - "basedir": "/builds/slave/test", 18:20:51 INFO - "buildnumber": 305, 18:20:51 INFO - "slavename": "t-yosemite-r7-0010", 18:20:51 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 18:20:51 INFO - "platform": "yosemite_r7", 18:20:51 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:20:51 INFO - "branch": "fx-team", 18:20:51 INFO - "repo_path": "integration/fx-team", 18:20:51 INFO - "revision": "95fdfaf5e766ad6e0ef134fe0fd4408ff918127c", 18:20:51 INFO - "stage_platform": "macosx64", 18:20:51 INFO - "builduid": "b554462887c948dcb38729db7766c1d8", 18:20:51 INFO - "slavebuilddir": "test" 18:20:51 INFO - } 18:20:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 18:20:51 INFO - Running post-action listener: _resource_record_post_action 18:20:51 INFO - ##### 18:20:51 INFO - ##### Running download-and-extract step. 18:20:51 INFO - ##### 18:20:51 INFO - Running pre-action listener: _resource_record_pre_action 18:20:51 INFO - Running main action method: download_and_extract 18:20:51 INFO - mkdir: /builds/slave/test/build/tests 18:20:51 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')]} 18:20:51 INFO - https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:20:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/test_packages.json 18:20:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/test_packages.json 18:20:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:21:09 INFO - Downloaded 1277 bytes. 18:21:09 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:21:09 INFO - Using the following test package requirements: 18:21:09 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:21:09 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:21:09 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 18:21:09 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:21:09 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 18:21:09 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:21:09 INFO - u'jsshell-mac.zip'], 18:21:09 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:21:09 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 18:21:09 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:21:09 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:21:09 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 18:21:09 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:21:09 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 18:21:09 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:21:09 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 18:21:09 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 18:21:09 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 18:21:09 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 18:21:09 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:09 INFO - https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:21:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:21:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:21:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:21:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/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 18:21:17 INFO - Downloaded 17114416 bytes. 18:21:17 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'] 18:21:17 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 18:21:20 INFO - Return code: 0 18:21:20 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 18:21:20 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')]} 18:21:20 INFO - https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:21:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:21:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:21:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 18:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/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 18:21:21 INFO - Downloaded 17114416 bytes. 18:21:21 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'] 18:21:21 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 18:21:25 INFO - Return code: 0 18:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:25 INFO - https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 18:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/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 18:21:25 INFO - Downloaded 10706582 bytes. 18:21:25 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'] 18:21:25 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 18:21:26 INFO - Return code: 0 18:21:26 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')]} 18:21:26 INFO - https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:21:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:21:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:21:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 18:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 18:21:30 INFO - Downloaded 111058799 bytes. 18:21:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:21:30 INFO - mkdir: /builds/slave/test/properties 18:21:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:21:30 INFO - Writing to file /builds/slave/test/properties/build_url 18:21:30 INFO - Contents: 18:21:30 INFO - build_url:https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 18:21:30 INFO - Running post-action listener: _resource_record_post_action 18:21:30 INFO - Running post-action listener: set_extra_try_arguments 18:21:30 INFO - ##### 18:21:30 INFO - ##### Running populate-webroot step. 18:21:30 INFO - ##### 18:21:30 INFO - Running pre-action listener: _resource_record_pre_action 18:21:30 INFO - Running main action method: populate_webroot 18:21:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:21:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:21:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:21:30 INFO - '--tppagecycles', 18:21:30 INFO - '7'], 18:21:30 INFO - 'tests': ['tsvgm']}}, 18:21:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:21:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:21:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:21:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:21:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:21:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:21:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:21:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:30 INFO - 'talos_options': ['--e10s'], 18:21:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:21:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:30 INFO - 'tests': ['damp', 'tps']}, 18:21:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:30 INFO - 'talos_options': ['--e10s'], 18:21:30 INFO - 'tests': ['damp', 'tps']}, 18:21:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:21:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:21:30 INFO - 'other': {'tests': ['a11yr', 18:21:30 INFO - 'ts_paint', 18:21:30 INFO - 'tpaint', 18:21:30 INFO - 'sessionrestore', 18:21:30 INFO - 'sessionrestore_no_auto_restore']}, 18:21:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:21:30 INFO - 'tests': ['a11yr', 18:21:30 INFO - 'ts_paint', 18:21:30 INFO - 'tpaint', 18:21:30 INFO - 'sessionrestore', 18:21:30 INFO - 'sessionrestore_no_auto_restore']}, 18:21:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:21:30 INFO - 'tests': ['a11yr', 18:21:30 INFO - 'ts_paint', 18:21:30 INFO - 'tpaint', 18:21:30 INFO - 'sessionrestore', 18:21:30 INFO - 'sessionrestore_no_auto_restore']}, 18:21:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:21:30 INFO - 'tests': ['a11yr', 18:21:30 INFO - 'ts_paint', 18:21:30 INFO - 'tpaint', 18:21:30 INFO - 'sessionrestore', 18:21:30 INFO - 'sessionrestore_no_auto_restore']}, 18:21:30 INFO - 'other_l64': {'tests': ['a11yr', 18:21:30 INFO - 'ts_paint', 18:21:30 INFO - 'tpaint', 18:21:30 INFO - 'sessionrestore', 18:21:30 INFO - 'sessionrestore_no_auto_restore']}, 18:21:30 INFO - 'other_nol64': {'tests': ['a11yr', 18:21:30 INFO - 'ts_paint', 18:21:30 INFO - 'tpaint', 18:21:30 INFO - 'sessionrestore', 18:21:30 INFO - 'sessionrestore_no_auto_restore']}, 18:21:30 INFO - 'svgr': {'tests': ['tsvgx', 18:21:30 INFO - 'tsvgr_opacity', 18:21:30 INFO - 'tart', 18:21:30 INFO - 'tscrollx', 18:21:30 INFO - 'cart']}, 18:21:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:21:30 INFO - 'tests': ['tsvgx', 18:21:30 INFO - 'tsvgr_opacity', 18:21:30 INFO - 'tart', 18:21:30 INFO - 'tscrollx', 18:21:30 INFO - 'cart']}, 18:21:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:30 INFO - 'tests': ['tp5o']}, 18:21:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:30 INFO - 'talos_options': ['--e10s'], 18:21:30 INFO - 'tests': ['tp5o']}, 18:21:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:30 INFO - 'talos_options': ['--xperf_path', 18:21:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:21:30 INFO - 'tests': ['tp5n']}, 18:21:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:21:30 INFO - 'talos_options': ['--e10s', 18:21:30 INFO - '--xperf_path', 18:21:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:21:30 INFO - 'tests': ['tp5n']}}, 18:21:30 INFO - 'talos.zip': {'path': '', 18:21:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:21:30 INFO - Running post-action listener: _resource_record_post_action 18:21:30 INFO - ##### 18:21:30 INFO - ##### Running create-virtualenv step. 18:21:30 INFO - ##### 18:21:30 INFO - Running pre-action listener: _resource_record_pre_action 18:21:30 INFO - Running main action method: create_virtualenv 18:21:30 INFO - Creating virtualenv /builds/slave/test/build/venv 18:21:30 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 18:21:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:21:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:21:30 INFO - Using real prefix '/tools/python27' 18:21:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:21:31 INFO - Installing distribute.............................................................................................................................................................................................done. 18:21:34 INFO - Installing pip.................done. 18:21:34 INFO - Return code: 0 18:21:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:34 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 0x105325a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10532c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac15e6cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051cad30>, '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 0x10502ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051c0b20>, '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.U0obbBpey9/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.9m7vSSvF5s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 18:21:34 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 18:21:34 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 18:21:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U0obbBpey9/Render', 18:21:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:34 INFO - 'HOME': '/Users/cltbld', 18:21:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:34 INFO - 'LOGNAME': 'cltbld', 18:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:34 INFO - 'MOZ_NO_REMOTE': '1', 18:21:34 INFO - 'NO_EM_RESTART': '1', 18:21:34 INFO - 'PAGER': '/bin/cat', 18:21:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:34 INFO - 'PWD': '/builds/slave/test', 18:21:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:34 INFO - 'SHELL': '/bin/bash', 18:21:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9m7vSSvF5s/Listeners', 18:21:34 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 18:21:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:34 INFO - 'USER': 'cltbld', 18:21:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:34 INFO - 'XPC_FLAGS': '0x0', 18:21:34 INFO - 'XPC_SERVICE_NAME': '0', 18:21:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:34 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 18:21:34 INFO - Cleaning up... 18:21:34 INFO - Return code: 0 18:21:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:34 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 0x105325a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10532c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac15e6cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051cad30>, '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 0x10502ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051c0b20>, '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.U0obbBpey9/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.9m7vSSvF5s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 18:21:34 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 18:21:34 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 18:21:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U0obbBpey9/Render', 18:21:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:34 INFO - 'HOME': '/Users/cltbld', 18:21:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:34 INFO - 'LOGNAME': 'cltbld', 18:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:34 INFO - 'MOZ_NO_REMOTE': '1', 18:21:34 INFO - 'NO_EM_RESTART': '1', 18:21:34 INFO - 'PAGER': '/bin/cat', 18:21:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:34 INFO - 'PWD': '/builds/slave/test', 18:21:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:34 INFO - 'SHELL': '/bin/bash', 18:21:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9m7vSSvF5s/Listeners', 18:21:34 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 18:21:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:34 INFO - 'USER': 'cltbld', 18:21:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:34 INFO - 'XPC_FLAGS': '0x0', 18:21:34 INFO - 'XPC_SERVICE_NAME': '0', 18:21:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:34 INFO - Downloading/unpacking psutil>=0.7.1 18:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:21:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:37 INFO - Installing collected packages: psutil 18:21:37 INFO - Running setup.py install for psutil 18:21:37 INFO - building 'psutil._psutil_osx' extension 18:21:37 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 18:21:38 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 18:21:38 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 18:21:38 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 18:21:38 INFO - building 'psutil._psutil_posix' extension 18:21:38 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 18:21:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:21:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:21:38 INFO - ^ 18:21:38 INFO - 1 warning generated. 18:21:38 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 18:21:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:21:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:21:38 INFO - Successfully installed psutil 18:21:38 INFO - Cleaning up... 18:21:38 INFO - Return code: 0 18:21:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:21:38 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')]} 18:21:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:38 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')]} 18:21:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:38 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 0x105325a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10532c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac15e6cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051cad30>, '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 0x10502ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051c0b20>, '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.U0obbBpey9/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.9m7vSSvF5s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 18:21:38 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 18:21:38 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 18:21:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U0obbBpey9/Render', 18:21:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:38 INFO - 'HOME': '/Users/cltbld', 18:21:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:38 INFO - 'LOGNAME': 'cltbld', 18:21:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:38 INFO - 'MOZ_NO_REMOTE': '1', 18:21:38 INFO - 'NO_EM_RESTART': '1', 18:21:38 INFO - 'PAGER': '/bin/cat', 18:21:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:38 INFO - 'PWD': '/builds/slave/test', 18:21:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:38 INFO - 'SHELL': '/bin/bash', 18:21:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9m7vSSvF5s/Listeners', 18:21:38 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 18:21:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:38 INFO - 'USER': 'cltbld', 18:21:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:38 INFO - 'XPC_FLAGS': '0x0', 18:21:38 INFO - 'XPC_SERVICE_NAME': '0', 18:21:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:38 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21: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 18:21:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:21:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:21:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:21:41 INFO - Installing collected packages: mozsystemmonitor 18:21:41 INFO - Running setup.py install for mozsystemmonitor 18:21:41 INFO - Successfully installed mozsystemmonitor 18:21:41 INFO - Cleaning up... 18:21:41 INFO - Return code: 0 18:21:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:21:41 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')]} 18:21:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:41 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')]} 18:21:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:41 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 0x105325a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10532c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac15e6cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051cad30>, '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 0x10502ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051c0b20>, '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.U0obbBpey9/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.9m7vSSvF5s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 18:21:41 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 18:21:41 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 18:21:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U0obbBpey9/Render', 18:21:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:41 INFO - 'HOME': '/Users/cltbld', 18:21:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:41 INFO - 'LOGNAME': 'cltbld', 18:21:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:41 INFO - 'MOZ_NO_REMOTE': '1', 18:21:41 INFO - 'NO_EM_RESTART': '1', 18:21:41 INFO - 'PAGER': '/bin/cat', 18:21:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:41 INFO - 'PWD': '/builds/slave/test', 18:21:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:41 INFO - 'SHELL': '/bin/bash', 18:21:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9m7vSSvF5s/Listeners', 18:21:41 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 18:21:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:41 INFO - 'USER': 'cltbld', 18:21:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:41 INFO - 'XPC_FLAGS': '0x0', 18:21:41 INFO - 'XPC_SERVICE_NAME': '0', 18:21:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:41 INFO - Downloading/unpacking blobuploader==1.2.4 18:21:41 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 18:21:41 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 18:21:41 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 18:21:41 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 18:21:41 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 18:21:41 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 18:21:43 INFO - Downloading blobuploader-1.2.4.tar.gz 18:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:21:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:21:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:44 INFO - Downloading docopt-0.6.1.tar.gz 18:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:21:45 INFO - Installing collected packages: blobuploader, requests, docopt 18:21:45 INFO - Running setup.py install for blobuploader 18:21:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:21:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:21:45 INFO - Running setup.py install for requests 18:21:45 INFO - Running setup.py install for docopt 18:21:45 INFO - Successfully installed blobuploader requests docopt 18:21:45 INFO - Cleaning up... 18:21:45 INFO - Return code: 0 18:21:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:45 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 0x105325a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10532c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac15e6cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051cad30>, '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 0x10502ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051c0b20>, '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.U0obbBpey9/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.9m7vSSvF5s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 18:21:45 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 18:21:45 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 18:21:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U0obbBpey9/Render', 18:21:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:45 INFO - 'HOME': '/Users/cltbld', 18:21:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:45 INFO - 'LOGNAME': 'cltbld', 18:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:45 INFO - 'MOZ_NO_REMOTE': '1', 18:21:45 INFO - 'NO_EM_RESTART': '1', 18:21:45 INFO - 'PAGER': '/bin/cat', 18:21:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:45 INFO - 'PWD': '/builds/slave/test', 18:21:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:45 INFO - 'SHELL': '/bin/bash', 18:21:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9m7vSSvF5s/Listeners', 18:21:45 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 18:21:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:45 INFO - 'USER': 'cltbld', 18:21:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:45 INFO - 'XPC_FLAGS': '0x0', 18:21:45 INFO - 'XPC_SERVICE_NAME': '0', 18:21:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:46 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-LmTgXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:46 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-FRSowf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:46 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-TGXb78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:46 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-UKrSKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:46 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-wpKtU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:46 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-hSNqqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:46 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-RT6NoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:46 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-fsaa1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:47 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-nTJ4AT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:47 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-lvxrog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:47 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-9qiwMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:47 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-PxwnBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:47 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-TbkXp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:47 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-AmR8PQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:47 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-xv_wZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:47 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-WNhfSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:47 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Tm9R5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:21:48 INFO - Running setup.py install for manifestparser 18:21:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:21:48 INFO - Running setup.py install for mozcrash 18:21:48 INFO - Running setup.py install for mozdebug 18:21:48 INFO - Running setup.py install for mozdevice 18:21:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:21:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:21:48 INFO - Running setup.py install for mozfile 18:21:48 INFO - Running setup.py install for mozhttpd 18:21:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:21:48 INFO - Running setup.py install for mozinfo 18:21:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:21:49 INFO - Running setup.py install for mozInstall 18:21:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:21:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:21:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:21:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:21:49 INFO - Running setup.py install for mozleak 18:21:49 INFO - Running setup.py install for mozlog 18:21:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:21:49 INFO - Running setup.py install for moznetwork 18:21:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:21:49 INFO - Running setup.py install for mozprocess 18:21:49 INFO - Running setup.py install for mozprofile 18:21:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:21:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:21:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:21:49 INFO - Running setup.py install for mozrunner 18:21:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:21:50 INFO - Running setup.py install for mozscreenshot 18:21:50 INFO - Running setup.py install for moztest 18:21:50 INFO - Running setup.py install for mozversion 18:21:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:21:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:21:50 INFO - Cleaning up... 18:21:50 INFO - Return code: 0 18:21:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:50 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 0x105325a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10532c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac15e6cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051cad30>, '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 0x10502ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051c0b20>, '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.U0obbBpey9/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.9m7vSSvF5s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 18:21:50 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 18:21:50 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 18:21:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U0obbBpey9/Render', 18:21:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:50 INFO - 'HOME': '/Users/cltbld', 18:21:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:50 INFO - 'LOGNAME': 'cltbld', 18:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:50 INFO - 'MOZ_NO_REMOTE': '1', 18:21:50 INFO - 'NO_EM_RESTART': '1', 18:21:50 INFO - 'PAGER': '/bin/cat', 18:21:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:50 INFO - 'PWD': '/builds/slave/test', 18:21:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:50 INFO - 'SHELL': '/bin/bash', 18:21:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9m7vSSvF5s/Listeners', 18:21:50 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 18:21:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:50 INFO - 'USER': 'cltbld', 18:21:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:50 INFO - 'XPC_FLAGS': '0x0', 18:21:50 INFO - 'XPC_SERVICE_NAME': '0', 18:21:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:50 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-D9VyJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:50 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)) 18:21:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:50 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-F5_GPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:51 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)) 18:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:51 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-2FWXVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:51 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)) 18:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:51 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-5w8mFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:51 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)) 18:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:51 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-hqReCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:51 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)) 18:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:51 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-iO6H0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:51 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)) 18:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:51 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-TdzIOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:51 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)) 18:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:51 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-xW7x_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:51 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)) 18:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:51 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-vsZxX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:51 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)) 18:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:51 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-8qJtXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:51 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)) 18:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:51 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-VpUVXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:51 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)) 18:21:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:51 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-j5ROdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:52 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)) 18:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:52 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Vv7QSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:52 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)) 18:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:52 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-JEJibl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21:52 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)) 18:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:52 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-tCjfJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:52 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)) 18:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:52 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ALwd22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21:52 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)) 18:21:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:52 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-rv9FUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:52 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)) 18:21:52 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)) 18:21:52 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)) 18:21:52 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)) 18:21:52 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)) 18:21:52 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)) 18:21:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:54 INFO - Downloading blessings-1.6.tar.gz 18:21:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:21:55 INFO - Installing collected packages: blessings 18:21:55 INFO - Running setup.py install for blessings 18:21:55 INFO - Successfully installed blessings 18:21:55 INFO - Cleaning up... 18:21:55 INFO - Return code: 0 18:21:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:21:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:55 INFO - Reading from file tmpfile_stdout 18:21:55 INFO - Current package versions: 18:21:55 INFO - blessings == 1.6 18:21:55 INFO - blobuploader == 1.2.4 18:21:55 INFO - docopt == 0.6.1 18:21:55 INFO - manifestparser == 1.1 18:21:55 INFO - mozInstall == 1.12 18:21:55 INFO - mozcrash == 0.16 18:21:55 INFO - mozdebug == 0.1 18:21:55 INFO - mozdevice == 0.48 18:21:55 INFO - mozfile == 1.2 18:21:55 INFO - mozhttpd == 0.7 18:21:55 INFO - mozinfo == 0.9 18:21:55 INFO - mozleak == 0.1 18:21:55 INFO - mozlog == 3.1 18:21:55 INFO - moznetwork == 0.27 18:21:55 INFO - mozprocess == 0.22 18:21:55 INFO - mozprofile == 0.28 18:21:55 INFO - mozrunner == 6.11 18:21:55 INFO - mozscreenshot == 0.1 18:21:55 INFO - mozsystemmonitor == 0.0 18:21:55 INFO - moztest == 0.7 18:21:55 INFO - mozversion == 1.4 18:21:55 INFO - psutil == 3.1.1 18:21:55 INFO - requests == 1.2.3 18:21:55 INFO - wsgiref == 0.1.2 18:21:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:56 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 0x105325a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10532c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac15e6cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051cad30>, '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 0x10502ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051c0b20>, '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.U0obbBpey9/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.9m7vSSvF5s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 18:21:56 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 18:21:56 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 18:21:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U0obbBpey9/Render', 18:21:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:56 INFO - 'HOME': '/Users/cltbld', 18:21:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:56 INFO - 'LOGNAME': 'cltbld', 18:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:56 INFO - 'MOZ_NO_REMOTE': '1', 18:21:56 INFO - 'NO_EM_RESTART': '1', 18:21:56 INFO - 'PAGER': '/bin/cat', 18:21:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:56 INFO - 'PWD': '/builds/slave/test', 18:21:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:56 INFO - 'SHELL': '/bin/bash', 18:21:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9m7vSSvF5s/Listeners', 18:21:56 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 18:21:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:56 INFO - 'USER': 'cltbld', 18:21:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:56 INFO - 'XPC_FLAGS': '0x0', 18:21:56 INFO - 'XPC_SERVICE_NAME': '0', 18:21:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:56 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)) 18:21:56 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)) 18:21:56 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)) 18:21:56 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)) 18:21:56 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)) 18:21:56 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)) 18:21:56 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)) 18:21:56 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)) 18:21:56 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)) 18:21:56 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)) 18:21:56 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)) 18:21:56 INFO - Cleaning up... 18:21:56 INFO - Return code: 0 18:21:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:56 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 0x105325a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10532c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac15e6cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051cad30>, '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 0x10502ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051c0b20>, '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.U0obbBpey9/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.9m7vSSvF5s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 18:21:56 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 18:21:56 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 18:21:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U0obbBpey9/Render', 18:21:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:56 INFO - 'HOME': '/Users/cltbld', 18:21:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:56 INFO - 'LOGNAME': 'cltbld', 18:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:56 INFO - 'MOZ_NO_REMOTE': '1', 18:21:56 INFO - 'NO_EM_RESTART': '1', 18:21:56 INFO - 'PAGER': '/bin/cat', 18:21:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:56 INFO - 'PWD': '/builds/slave/test', 18:21:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:56 INFO - 'SHELL': '/bin/bash', 18:21:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9m7vSSvF5s/Listeners', 18:21:56 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 18:21:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:56 INFO - 'USER': 'cltbld', 18:21:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:56 INFO - 'XPC_FLAGS': '0x0', 18:21:56 INFO - 'XPC_SERVICE_NAME': '0', 18:21:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:56 INFO - Downloading/unpacking jsonschema 18:21:56 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 18:21:56 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 18:21:56 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 18:21:56 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 18:21:56 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 18:21:56 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 18:21:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:21:58 INFO - Downloading/unpacking functools32 (from jsonschema) 18:21:58 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 18:21:58 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 18:21:58 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 18:21:58 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 18:21:58 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 18:21:58 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 18:21:59 INFO - Downloading functools32-3.2.3-2.tar.gz 18:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:21:59 INFO - warning: no files found matching '*.txt' 18:21:59 INFO - no previously-included directories found matching 'build' 18:21:59 INFO - no previously-included directories found matching 'dist' 18:21:59 INFO - no previously-included directories found matching '.git*' 18:21:59 INFO - Installing collected packages: jsonschema, functools32 18:21:59 INFO - Running setup.py install for functools32 18:21:59 INFO - warning: no files found matching '*.txt' 18:21:59 INFO - no previously-included directories found matching 'build' 18:21:59 INFO - no previously-included directories found matching 'dist' 18:21:59 INFO - no previously-included directories found matching '.git*' 18:21:59 INFO - Successfully installed jsonschema functools32 18:21:59 INFO - Cleaning up... 18:21:59 INFO - Return code: 0 18:21:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:21:59 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 0x105325a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10532c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac15e6cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1051cad30>, '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 0x10502ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051c0b20>, '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.U0obbBpey9/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.9m7vSSvF5s/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 18:21:59 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 18:21:59 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 18:21:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U0obbBpey9/Render', 18:21:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:21:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:21:59 INFO - 'HOME': '/Users/cltbld', 18:21:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:21:59 INFO - 'LOGNAME': 'cltbld', 18:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:59 INFO - 'MOZ_NO_REMOTE': '1', 18:21:59 INFO - 'NO_EM_RESTART': '1', 18:21:59 INFO - 'PAGER': '/bin/cat', 18:21:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:59 INFO - 'PWD': '/builds/slave/test', 18:21:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:21:59 INFO - 'SHELL': '/bin/bash', 18:21:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9m7vSSvF5s/Listeners', 18:21:59 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 18:21:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:21:59 INFO - 'USER': 'cltbld', 18:21:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:21:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:59 INFO - 'XPC_FLAGS': '0x0', 18:21:59 INFO - 'XPC_SERVICE_NAME': '0', 18:21:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:59 INFO - Downloading/unpacking flake8 18:21:59 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 18:21:59 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 18:21:59 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 18:21:59 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 18:21:59 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 18:21:59 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 18:22:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:22:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:22:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 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 18:22:02 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 18:22:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:22:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:22:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:22:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:22:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:22:03 INFO - no previously-included directories found matching 'docs/_build' 18:22:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:22:03 INFO - Running setup.py install for pep8 18:22:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:22:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:22:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:22:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:22:03 INFO - no previously-included directories found matching 'docs/_build' 18:22:03 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:22:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:22:03 INFO - Cleaning up... 18:22:03 INFO - Return code: 0 18:22:03 INFO - Running post-action listener: _resource_record_post_action 18:22:03 INFO - Running post-action listener: _start_resource_monitoring 18:22:03 INFO - Starting resource monitoring. 18:22:03 INFO - ##### 18:22:03 INFO - ##### Running install step. 18:22:03 INFO - ##### 18:22:03 INFO - Running pre-action listener: _resource_record_pre_action 18:22:03 INFO - Running main action method: install 18:22:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:22:03 INFO - Reading from file tmpfile_stdout 18:22:03 INFO - Detecting whether we're running mozinstall >=1.0... 18:22:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:22:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:22:03 INFO - Reading from file tmpfile_stdout 18:22:03 INFO - Output received: 18:22:03 INFO - Usage: mozinstall [options] installer 18:22:03 INFO - Options: 18:22:03 INFO - -h, --help show this help message and exit 18:22:03 INFO - -d DEST, --destination=DEST 18:22:03 INFO - Directory to install application into. [default: 18:22:03 INFO - "/builds/slave/test"] 18:22:03 INFO - --app=APP Application being installed. [default: firefox] 18:22:03 INFO - mkdir: /builds/slave/test/build/application 18:22:03 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'] 18:22:03 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 18:22:37 INFO - Reading from file tmpfile_stdout 18:22:37 INFO - Output received: 18:22:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:22:37 INFO - Running post-action listener: _resource_record_post_action 18:22:37 INFO - ##### 18:22:37 INFO - ##### Running run-tests step. 18:22:37 INFO - ##### 18:22:37 INFO - Running pre-action listener: _resource_record_pre_action 18:22:37 INFO - Running main action method: run_tests 18:22:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:22:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:22:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:22:37 INFO - 2016-02-02 18:22:37.894 screenresolution[1967:16267] starting screenresolution argv=screenresolution get 18:22:37 INFO - 2016-02-02 18:22:37.897 screenresolution[1967:16267] Display 0: 1600x1200x32@60 18:22:37 INFO - 2016-02-02 18:22:37.903 screenresolution[1968:16269] starting screenresolution argv=screenresolution list 18:22:37 INFO - Available Modes on Display 0 18:22:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:22:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:22:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:22:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:22:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:22:38 INFO - Intel Iris: 18:22:38 INFO - Chipset Model: Intel Iris 18:22:38 INFO - Type: GPU 18:22:38 INFO - Bus: Built-In 18:22:38 INFO - VRAM (Dynamic, Max): 1536 MB 18:22:38 INFO - Vendor: Intel (0x8086) 18:22:38 INFO - Device ID: 0x0a2e 18:22:38 INFO - Revision ID: 0x0009 18:22:38 INFO - Displays: 18:22:38 INFO - Display: 18:22:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:22:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:22:38 INFO - Display Serial Number: 1600x1200 60 18:22:38 INFO - Main Display: Yes 18:22:38 INFO - Mirror: Off 18:22:38 INFO - Online: Yes 18:22:38 INFO - Rotation: Supported 18:22:38 INFO - Return code: 0 18:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:22:38 INFO - Python 2.7.3 18:22:38 INFO - Return code: 0 18:22:38 INFO - grabbing minidump binary from tooltool 18:22:38 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')]} 18:22:38 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 0x1051cad30>, '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 0x10502ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1051c0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:22:38 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 18:22:38 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 18:22:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:22:38 INFO - Return code: 0 18:22:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:22:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:22:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:22:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:22:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:22:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:22:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:22:39 INFO - Return code: 0 18:22:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 18:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0010 --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 18:22:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U0obbBpey9/Render', 18:22:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:22:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:22:39 INFO - 'HOME': '/Users/cltbld', 18:22:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:22:39 INFO - 'LOGNAME': 'cltbld', 18:22:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:22:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:22:39 INFO - 'MOZ_NO_REMOTE': '1', 18:22:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:22:39 INFO - 'NO_EM_RESTART': '1', 18:22:39 INFO - 'PAGER': '/bin/cat', 18:22:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:22:39 INFO - 'PWD': '/builds/slave/test', 18:22:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:22:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:22:39 INFO - 'SHELL': '/bin/bash', 18:22:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9m7vSSvF5s/Listeners', 18:22:39 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 18:22:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:22:39 INFO - 'USER': 'cltbld', 18:22:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:22:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:22:39 INFO - 'XPC_FLAGS': '0x0', 18:22:39 INFO - 'XPC_SERVICE_NAME': '0', 18:22:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:22:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 18:22:39 INFO - mozversion application_buildid: 20160202164942 18:22:39 INFO - mozversion application_changeset: 95fdfaf5e766ad6e0ef134fe0fd4408ff918127c 18:22:39 INFO - mozversion application_display_name: Nightly 18:22:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:22:39 INFO - mozversion application_name: Firefox 18:22:39 INFO - mozversion application_remotingname: firefox 18:22:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:22:39 INFO - mozversion application_vendor: Mozilla 18:22:39 INFO - mozversion application_version: 47.0a1 18:22:39 INFO - mozversion platform_buildid: 20160202164942 18:22:39 INFO - mozversion platform_changeset: 95fdfaf5e766ad6e0ef134fe0fd4408ff918127c 18:22:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:22:39 INFO - mozversion platform_version: 47.0a1 18:22:39 INFO - using testdate: 1454466159 18:22:39 INFO - actual date: 1454466159 18:22:40 INFO - starting webserver on 'localhost:49733' 18:22:40 INFO - SUITE-START | Running 2 tests 18:22:40 INFO - TEST-START | dromaeo_css 18:22:40 INFO - operating with platform_type : mac_ 18:22:40 INFO - Initialising browser for dromaeo_css test... 18:22:40 INFO - TEST-INFO | started process 1986 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmp537o2m/profile http://localhost:49733/getInfo.html) 18:22:40 INFO - PROCESS | 1986 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 18:22:42 INFO - PROCESS | 1986 | __metrics Screen width/height:1600/1200 18:22:42 INFO - PROCESS | 1986 | colorDepth:24 18:22:42 INFO - PROCESS | 1986 | Browser inner width/height: 1024/689 18:22:42 INFO - PROCESS | 1986 | __metrics 18:22:42 INFO - PROCESS | 1986 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:22:43 INFO - TEST-INFO | 1986: exit 0 18:22:43 INFO - Browser initialized. 18:22:43 INFO - Running cycle 1/1 for dromaeo_css test... 18:22:43 INFO - TEST-INFO | started process 1990 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmp537o2m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:22:55 INFO - PROCESS | 1990 | RSS: Main: 255750144 18:22:55 INFO - PROCESS | 1990 | 18:23:45 INFO - PROCESS | 1990 | 1454466225396 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] 18:25:55 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:49733/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49733/tests/dromaeo/cssquery-ext.html) 18:25:57 INFO - PROCESS | 1990 | RSS: Main: 269492224 18:25:57 INFO - PROCESS | 1990 | 18:28:59 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:49733/tests/dromaeo/cssquery-ext.html (next: http://localhost:49733/tests/dromaeo/cssquery-jquery.html) 18:28:59 INFO - PROCESS | 1990 | RSS: Main: 282128384 18:28:59 INFO - PROCESS | 1990 | 18:32:01 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:49733/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49733/tests/dromaeo/cssquery-mootools.html) 18:32:01 INFO - PROCESS | 1990 | RSS: Main: 283156480 18:32:01 INFO - PROCESS | 1990 | 18:35:03 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:49733/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49733/tests/dromaeo/cssquery-prototype.html) 18:35:04 INFO - PROCESS | 1990 | RSS: Main: 285937664 18:35:04 INFO - PROCESS | 1990 | 18:38:06 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:49733/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49733/tests/dromaeo/cssquery-yui.html) 18:38:07 INFO - PROCESS | 1990 | RSS: Main: 287354880 18:38:07 INFO - PROCESS | 1990 | 18:41:09 INFO - PROCESS | 1990 | Cycle 1(1): loaded http://localhost:49733/tests/dromaeo/cssquery-yui.html (next: http://localhost:49733/tests/dromaeo/cssquery-dojo.html) 18:41:10 INFO - PROCESS | 1990 | RSS: Main: 289337344 18:41:10 INFO - PROCESS | 1990 | 18:41:10 INFO - PROCESS | 1990 | __start_tp_report 18:41:10 INFO - PROCESS | 1990 | _x_x_mozilla_page_load 18:41:10 INFO - PROCESS | 1990 | _x_x_mozilla_page_load_details 18:41:10 INFO - PROCESS | 1990 | |i|pagename|runs| 18:41:10 INFO - PROCESS | 1990 | |0;dojo.html;2927.502324604817;3477.965220347797;3503.211777350098;3545.929081418372;3551.7336199785013;5593.133064375023;5713.085906255;5721.227634269383;5742.54059675226;5747.885042299152;5502.58730595206;5593.3847276799515;5626.2967129108865;5628.549716022719;5655;5103.362079740024;5140.794368225266;5142.228665700138;5195.922061169066;5199.766010529535;5211.609129315298;5229.163333866582;5239.345081864767;5249.527542521172;5279.683219006872;5213.556847667953;5222.32109825724;5234.293370394986;5268.341457317835;5320.866978325535;4971.0803501352;5121.718305493197;5167.560757335631;5228.92156617651;5257.579393648499;5096.159133742928;5157.71632560209;5172.663776854492;5195.012947539955;5197.376314842205;5483.095289277265;5564.137558678412;5612.017896868032;5642.971785141089;5747.770089196427;5111.872203194913;6164.383561643845;6178.660173690445;6227.3772622737815;6318.968405157991;6239.844003899893;6270.09083682868;6280.497560195174;6295.811125666191;6300.117983482316;5825.796097136665;5834.883302333972;5867.354590994987;5905.143754155709;5937.257842769697;5488.847342058132;5746.9425305747245;6128.319797384489;6193.907091393633;6250.624962502265;4341.435613370241;6145.723442445101;6146.877062458726;6166.969165154235;6173.47525460332;6106.938930610637;6138.846528836725;6210.31686514483;6232.283287422005;6298;5332.466753324714;5984.982552965919;6160.414760597736;6215.844603884939;6278.905816412666;6174.351693072253;6242.750289988349;6257.030160325156;6269;6283.842903927439;4801.18379875422;4825.927611085836;4837.879053023703;4878.146324393217;4917.164082106051;3769.7361184717356;4361.258586040381;4372.453443319585;4385.429894113809;4395.582419670126;5637.351704554028;5641.52047075995;5706.28671416073;5707.200991861143;5755.568332375088;6129.970128114947;6145.432914606747;6224.004159334485;6234.407731265523;6239.96880015597;5670.121131224667;5695.658260504383;5716.914246286309;5727.570432217517;5752.597318187687;5150.4334523202415;5353.678779273256;5356.544693701079;5357.812476563302;5377.4084850666395;6203.410675985774;6207.255129384503;6315.305316415191;6320.051992201298;6327.936720632735;6203.844903877439;6220;6246.718897649525;6289.559730818799;6320.968395158179;6159.938400615936;6239.844003899939;6245.406686364788;6256.436920677161;6273.686315684289;6152.446279834837;6237.96881015592;6241.157443745036;6241.625502469867;6242.438180563771;6166.938330616636;6170.629762214281;6259.3427690091885;6266.467350275278;6283.5287353449585;4428.380026796315;5875.823725288248;5984.9401505986125;6136.723847426787;6139.754409823557;6017.518598512021;6094.51243900478;6095.664738439428;6121.3572574879;6126.908096378469;5820.941790582209;5890.764369425347;5912.142739302863;5927.377625349449;5976.491998180029;4481.103779244229;5857.00430926752;6022.698865056817;6100.702285529835;6121.571489995657;5963.52291816645;5995.520358371233;6001;6019.398060193946;6032.487238584769 18:41:10 INFO - PROCESS | 1990 | |1;ext.html;438.1696684782337;465.4205514134903;486.4964761471877;492.662526169574;576.8010036537396;38137.61862381375;38471.61528384715;38646.613533864656;38738.41892371617;38792.61207387925;33716.66283337166;41334.58665413353;41542.961425964364;41705.16589668205;41912;9467.195288400495;9575.712728618153;9582.664606738765;9618.855717164248;9668.758281042996;9574.47340396278;9708.126268635822;9718.222542196607;9724.513774311255;9738.902610973906;9783.95108024459;9818.803623927517;9880.456574888378;9899;9958.900410995906;9503.28725345595;9783;9836.409815411098;9857.852132218022;9882.11061004513;9656.130948214695;9719.222462203006;9805.31362804604;9808.31341806074;9821.410715357102;40379.1924161518;40433;40440.797796011124;40591.1881762366;40611.18777624431;3263.853126609308;3265.7713960022807;3383.3571621392102;3450;3595.8022308773006;28613.570796437863;28782;28832;29102.854485727436;29109.41781164386;2779.9557350854043;2833.5183018886837;2854.82871027739;2879.1794338613395;2990.850457477139;425566;428606;429399;430741;431498.99999999686;56158.15762763562;57140.14289785657;65592;68180;69031;65555.67222163954;66017;66247.33752662412;66265.66867165633;66442.33557664361;15819.762703559456;16034.797390195781;16212.35150593963;16340.85614007008;16588.50234492967;12420.130590858553;12543.811842822182;12626;12816.743665126645;12863.614091577268;21019.78980210209;21094.367168984954;21116.47208819761;21384.679229811565;21426.892865535883;8750.431221970552;8959.1936725695;8990.280777537911;8994.145556172152;9038.231750301167;905.343625871238;1006.5520843224841;1044.9268551201344;1093.3439936038314;1139.273999890167;25533.106341277966;29971.700282997328;30107.096787096423;30554.847225764173;30640.54039189414;927.2674587076134;1034.4155552113032;1084.9240553161203;1086.1419478611965;1089.2865173311493;14480.565583032527;14616.634584135481;14692.853071469148;14716.484923027643;14773.26133693311;688987;693910;696960.5151974207;707962;711640;59287.11069333964;59703.70148149318;60233;60294;60499.69750151221;1398.9650258743613;1399.5451478269604;1418.829740431155;1434.0965191929017;1437.2238990944982;28608.284792880346;28650.85674571697;28877.278068047628;29366.41267174687;29409.38248396359;43979.34030989602;48999;49217.75391123021;50007.49992500174;50050.24924626061;522005;527587;530027;532138;532474;33617.32765344728;43409.3488597665;44464.777676111415;45028;45116.32325515185;43052;43118.78440607777;43372.56627433812;43632;44096.338554922346;34840;35625.82187089048;36130.27739445249;36237;36629.90110296696;36511;36921;37514.87455376343;37697.62302376941;37851.62148378591;37055;37893.86318410452;38773.612263877;39134.6086539131;39168;29767.404651907273;31895.68104318927;32001.199970000936;32136;32218.35563288768;19601.509962251057;24740.876295619128;24764.628530572416;24825.379365516008;24916.501669966136 18:41:10 INFO - PROCESS | 1990 | |2;jquery.html;318.8373929296058;366.4283717400855;368.60006892521614;376.2362404319233;377.71671246565074;15398.153101579408;18552.721709174373;18755.687101902873;19330.51673708156;20168.495787605298;18960.905195474003;19288.807111928876;19510.31713890014;19659.508512287164;19776.703349449734;5053.51991560803;5609.663420194791;5819.970900145493;5908.320543137551;5949.464548190662;4157.314043182886;4363.650907927358;5565.693886836222;6209.316975132731;6480;6202.534809889254;6352.269489008754;6396.808095757112;6419.614823110628;6430.7749228777;6244.094606282109;6297.559170858041;6303.9684801575695;6345.524085693568;6361.045843123522;5134.794608215667;5247.39654939683;5317.361916569997;5345.919811202835;5374.570034397278;11958.342291173982;13015.934920325337;13042.608721738363;13063.673408164872;13125.606231812966;2145.495808485005;2189.4964158243693;2210.5799898019486;2232.3749350181974;2285.2915596165076;9956.651517196864;11518.481668324945;12230.877691223062;12839.871601284054;14702.529747025319;1686.4097565851976;1746.7991181014092;1768.5224989252958;1776.4493007167819;1805.5576383785926;95759.08481830393;100844.49577752137;102657.48671256671;107520.99999999921;111088.4445577775;11015;11370.488328025092;11453.083753299716;11461.656150315504;11503.252288601214;13362.933185334012;13600.727985440433;13648.976326775333;13659.385327660279;13679.521216757366;8585.828283434297;8623.439476434012;8631.180037896514;8686.609102590399;8720.8691869622;8650.95674521636;8706.738797836075;8746.34402419821;8792.34057445694;8853.29173666105;3681.0245284999496;4402.163588918095;4469.776511174428;4483.708558943724;4497.190505708938;1497.2438918346165;1818.2908665620419;1858.6375656747075;1868.2433614386196;1899.1833511589873;806.9354451643854;895.5611750242334;919.9264058875274;938.1228551304553;993.4287784523927;18339.724904126448;19230;19246.903765481362;19406.320778772675;19702.21191152338;934.8036912248504;972.4505654305295;1000.7948370584013;1004.42747633848;1058.6559368205365;10556.472176391304;10687;10849.891501085045;10879.347239165676;10923.289986150874;710913;749315.2534237294;750123;766832;767828;111982.44008779904;115404.42297788458;115451.42274288574;119217;120091;1118.6308518188978;1185.0993245133761;1197.26368283505;1197.808350663907;1203.6088271311858;17766.733498997266;17786.37747678825;17840.46478605644;18163.818361816742;18436.26254949787;48362.5163748358;51148.232776509125;52360.214596780315;52956;53067.46932530625;54753.726231368586;60553;75575.86636200572;75909.62045189738;76477.17614119161;7482.588457634883;7598;7658.885116723365;7705.6147192641265;7735.071791385069;10582.788344232918;11289.661310160709;11466.426678666201;11788.23376480526;12296.50813967467;8567.329370772888;9364.859527106963;9965.701028969142;10159.492025398848;10261.486925653837;9979.45113018762;10243;10270.33242839213;10748.83876741865;10862.782744344911;10315.793684126125;10675.412852292888;10871.40207288575;10898.583184186005;11012.449377531251;7542.321191092828;7696.653650585849;7729.07251129868;7734.574598397142;7742.341900938483;8247.670093196204;10450.477476126316;10554.894451055698;10587.841182382117;10769.407682577534 18:41:10 INFO - PROCESS | 1990 | |3;mootools.html;1357.8506364299928;1548.2800497768535;1748.8950662960224;1889.93385231517;1910.2550005497849;7912.248336408046;8011.9599402002905;8646.17861303176;8721.694740684085;8887.244584210343;7292.234315396887;8468.915310846889;8510.27662648674;8673;8697.347698922591;2067.7208576842086;2406.362313986795;2426.4540478392396;2465.642481840141;2472.0606169655593;2099.433153048676;2445.963310550343;2489.477209785938;2490;2492.67595212623;2108.5677436125634;2442.1330427698176;2461.655368248447;2466.1738317663517;2524.1039431002005;2469.8518088914543;2487.6019836826113;2502.6120951252583;2515.157422263544;2520.3825062859532;2533.7972962162985;2543.9618405723927;2545.185540627;2553.3616595851036;2555.6805399325085;8869.866951995726;8900.109989001048;8916.910830891738;8918.777030574223;8926.553672316422;4304.483461984551;5532.861678458031;5552.86117847053;5554.1391084381985;5568.331800184003;3547.379208638478;3627.7460577759566;3682.3371793077235;3687.967369136646;3696.77819330841;1006.5923301063082;1043.2697112021615;1096.2545469081022;1097.2703152403722;1104.1222228328497;11680.591179308769;11829.99445047172;11842.526298948032;11870.584529541424;11891.940540297242;4940.209566469348;4941;5025.14572522672;5035.874103147451;5063.06333328328;8650.95674521636;10024.448655324028;10258.897411025944;10267.691969240936;10288.588456461808;5001.7499125043605;5319.414864364917;5459.208414779914;5529;5574.9721251393485;4353.869383918487;4505.36924830524;4858.076965376567;4973.975130124326;5060.734816295926;3951.5455722591696;3980.1641655252142;3989.3617021276455;4025.939610905839;4034.455348527911;1309.109805332383;1314.4216544720293;1327.0909427042507;1328.4885319152197;1329.5014369611395;969.8399764038854;1158.8030034894089;1327.561904571489;1363.9113457625222;1376.8623137686152;8005.759827205193;8033.3974951878845;8050.476719013245;8127.309178719756;8128.105908350077;426.97224680396295;429.38812192626006;459.010831657778;503.7632611937684;514.1773162939342;6218.253809542884;6255.530835187379;6294.150289710922;6295.024271237966;6305.96847015762;10361.533730982124;10716.249862509705;10742.838857417146;10792;10805.243632945618;10460.372377657213;10614;10621.097206737513;10674.519646615921;10678.786424271471;7147.678354474165;7474.393005503843;7884.093329267208;8296.294814940798;8304.335653147733;6796.218434879855;7510.286522780327;7882.448228624171;7901.920980790348;7952.721654742057;8363.289120424588;9351;9474.478903660365;9516.19112375456;9531.142197202285;9703.320767546204;9808.65669701557;9878.357906736039;9944.602215911573;9970.501474926079;6607.735690572324;6797.354251346114;7233.746818861315;7600.429967752551;7650.273224043707;8095.150009248944;8110.5944702763445;8151.225633564802;8169.142240064708;8183.95908020456;7453.850922981618;7586.051743532059;7643.5716379863925;7737.535747855147;7816.179301173295;6535.57518761279;7597.544147351176;7616.543007419573;7671.846563068596;7769.92230077692;7719.652615632423;7767.300942915164;7777.261160189773;7778.49439786412;7787.649555769891;6954.478414119062;6968.198657154492;6986.720531178696;7044.436445084279;7108.07595012645;7062.788116356517;7087.468439866928;7130.893036604559;7158.570485770871;7195.064641596559 18:41:10 INFO - PROCESS | 1990 | |4;prototype.html;331.2497193855916;333.849767604578;337.2799073977058;339.96090449598296;345.6957877068181;6673.165854268216;6902.378785909267;6970.581765094098;6970.790876273713;7061.364477197051;6402.359764023596;6678.26539080702;6874.553154044984;6904.447644188465;6922.134733158356;4697.412823397075;5014.373203349582;5029.647924645276;5044;5048.444671086178;4785.21044027735;5029.748512574375;5045.722485263309;5051.3938327400765;5051.444341122474;4855.198892182786;4859.902801943959;4883.389576302962;4890.388701412324;4893.119238537062;4793.856184314476;4860.756962151896;4866.6106711463;4899.069176856386;4917.754112294407;3471.8784842530645;3973.98013009936;4047.6964227683043;4119.8970025749595;4179.477565304337;6164.506839452833;6447;6543.247526534462;6572.474202063823;6602.2737498875085;5823.912641310384;5886.558508111909;5911.113333000085;5911.29064512257;5926.496247818941;7056.400205982498;7328.303811137934;7331.936869153996;7360;7393.889091663629;3700.5744339400776;4700;4730.266808644666;4731.739754313511;4732.787024583902;6209.968950155266;6466.708998095097;7676.616169191574;7772.455928085036;7784.766457006299;4045.19096180765;4578.175928332932;4759.309900064541;4781.737004464719;4809.350737650372;4896.11869863428;4899.1426500362295;4901.803927842918;4904.926426103611;4906.533879281463;5828.688545077323;5834.183214349994;5856.648601083949;5869.7945571904775;5878.764849406061;7366.77899663011;7369.963150184215;7387.630618469055;7405.8889116663295;7406.666699998513;1641.983580164183;1707.4792188382662;1708.9145542723063;1715.2367196597643;1719.9140042997801;1074.3768614203743;1090.9509072091776;1092.3282181458505;1094.8631421072366;1101.9283746556448;5632;6851.520393572502;6885;6923.515353925278;6944.652767361612;7607.885881711779;7615.390768738488;7666.808329791688;7678.117016543058;7699.960505331821;6646.335366463315;6861.656917154122;6878.65606719672;6884.345987131214;6957.199922009034;3488.354654388946;3773.7735735855936;4003.459532963071;4029.3351596986167;4071.531773845986;7936;8007.279344858991;8021.679132834738;8075.192480751878;8097.514149151069;6781.287964763727;7737.226277372218;7979.3616510679;7991.760247192477;8058.35533157346;7771.533707977539;8087.353011759045;8088.393370497119;8095.150009249061;8146.877796833052;7695.345895598713;7709.383249340151;7713.1129920057665;7736.535807851547;7748.651310691145;7337.559746415232;7638.8090297743;7654.272844079804;7657.425693072931;7673.6546855390525;6518.57629254097;8032.196780321921;8059;8078.555679437687;8091.1504292048485;4782.450018247946;4837.718004728679;4846.588040016638;4857.489963553918;4864.148773964472;7538.585377804054;7702.229777022253;7749.41879359039;7754.573498457639;7768.417368697257;7392.112946446461;7417.777466676009;7420.851582968418;7434.182239953709;7434.962825185839;6027.30685971119;7181.964090179725;7410.999515065613;7425.405967522694;7501.699932002877;7224.602646854263;7234.204237533761;7241.4206863451855;7249.456290778318;7273.3453989141235;6729.226138993882;7435.776926692208;7455.7017719290625;7456.067991501062;7482.027336446227;5939.584229103922;6366.363363663597;6881.554873476626;7028.789136325919;7266.781996540112 18:41:10 INFO - PROCESS | 1990 | |5;yui.html;658.3087757854249;690.9965450172748;703.5989485992986;740.2708332292692;747.0885519666009;14307.856921430783;14318.355673994669;14400.991930564865;14402;14447.566573002814;12955.676108097303;13013.284269365182;13041;13078.542251021216;13126;703.0824773670358;716.1477841368754;841.7979684875647;863.7883718488963;870.1559487297311;850.9234168924795;857.2884505860152;868.5700578213794;872.1191596487562;872.1235158665532;896.708569714842;916.9954150229273;923.8244733500647;928.5960607135884;930.1675000874213;891.6210610490548;906.8186362727448;907.2515174980667;918.9908100919006;921.391881358307;669.9095622091004;673.2325149329768;688.3907741648627;690.3648643248174;693.3482526425195;13674.247916364597;13825.51610693631;13903.652408689763;13967.720645587031;14000.859991400159;12392.256464612063;12415.130940834146;12438.502459901683;12531.06017048725;12581.874181258161;9911;10393.116585090276;10570.577176912915;10798.514066866932;11233.775324493465;3554.9822250888838;3556.1287484566446;3574.571051473814;3582.946255806165;3652.3243200008083;78805.60597196977;79181;79444;79537.20462795356;82300.58849705773;9327.720168394959;9558.091981261909;9560.28297877662;9591.472469014272;10174.8473772892;19919.60160796805;19961.401157965283;20225.49436264076;20287.391378258675;20351.4912127198;7434.479586428898;7581.393488521016;7743.806404839924;7798.25916537928;7897.526148431112;4132.710710250314;4158.4178215049915;4186.748795072305;4196.160767846443;4342.370356298319;3305.25631732863;3429.725621950238;3482.8432720527635;3495.318412909509;3501.2122272488486;651.5113664751436;661.9536632435684;666.2737615998585;669.6450881033061;670.045185610503;570.5179123640518;571.1432850723914;585.6164212440858;595.2172892646156;598.8413070536311;7930.801729956682;7975.441719079608;8145.42981991255;8219.95890020546;8303.097202765963;517.3429744224813;519.6206769058608;547.8356493052069;583.3087790967717;593.2317648645015;3969.8809035728973;4028.194361127786;4078.2047500737663;4286.164197981426;4379.956200438019;74071;98061;100355.99644003467;100380.49809750904;100587.99412005933;80165.19834801694;83818;85429;86624;87270.56364718136;72035.63982180055;72939.63530182421;73864.26135738574;74058.5188296231;76235.61882190553;6467;8971.775705607151;8985.505797181218;8992.325575581726;9127.452352858849;44852.98161582671;50081;51865.22202167046;53184.468155317954;55339.16991245215;66393;68318.65840670765;71279;71660;72207;11604;11607.535698572301;11769.117316201491;11819.468123934272;12313.753724925631;10421.583136674448;11950;11982.820257696316;12184.878151218374;12569.811452828031;9773.267004974798;11051.447427628747;11065.557377704801;11419.714507137056;11957.880421196025;11350.489227984595;11848.348340841336;11854.407279636156;11900.345480998629;12317.572958427738;9065.54675244732;9617.903820961701;11092.168087393638;11612.88387116118;11962.521499140285;9065.32010099232;9138.63445462174;9147.817043659223;9181.995812282188;9499.287553433382;8035.67857285702;9962.103410693073;10160.441175735405;10189.898101018895;10202.38785672862 18:41:10 INFO - PROCESS | 1990 | __end_tp_report 18:41:10 INFO - PROCESS | 1990 | __start_cc_report 18:41:10 INFO - PROCESS | 1990 | _x_x_mozilla_cycle_collect,358 18:41:10 INFO - PROCESS | 1990 | __end_cc_report 18:41:10 INFO - PROCESS | 1990 | __startTimestamp1454467270210__endTimestamp 18:41:10 INFO - PROCESS | 1990 | 18:41:10 INFO - PROCESS | 1990 | ------- Summary: start ------- 18:41:10 INFO - PROCESS | 1990 | Number of tests: 6 18:41:10 INFO - PROCESS | 1990 | 18:41:10 INFO - PROCESS | 1990 | [#0] dojo.html Cycles:165 Average:5675.67 Median:5875.82 stddev:667.87 (11.4%) stddev-sans-first:634.17 18:41:10 INFO - PROCESS | 1990 | Values: 2927.5 3478.0 3503.2 3545.9 3551.7 5593.1 5713.1 5721.2 5742.5 5747.9 5502.6 5593.4 5626.3 5628.5 5655.0 5103.4 5140.8 5142.2 5195.9 5199.8 5211.6 5229.2 5239.3 5249.5 5279.7 5213.6 5222.3 5234.3 5268.3 5320.9 4971.1 5121.7 5167.6 5228.9 5257.6 5096.2 5157.7 5172.7 5195.0 5197.4 5483.1 5564.1 5612.0 5643.0 5747.8 5111.9 6164.4 6178.7 6227.4 6319.0 6239.8 6270.1 6280.5 6295.8 6300.1 5825.8 5834.9 5867.4 5905.1 5937.3 5488.8 5746.9 6128.3 6193.9 6250.6 4341.4 6145.7 6146.9 6167.0 6173.5 6106.9 6138.8 6210.3 6232.3 6298.0 5332.5 5985.0 6160.4 6215.8 6278.9 6174.4 6242.8 6257.0 6269.0 6283.8 4801.2 4825.9 4837.9 4878.1 4917.2 3769.7 4361.3 4372.5 4385.4 4395.6 5637.4 5641.5 5706.3 5707.2 5755.6 6130.0 6145.4 6224.0 6234.4 6240.0 5670.1 5695.7 5716.9 5727.6 5752.6 5150.4 5353.7 5356.5 5357.8 5377.4 6203.4 6207.3 6315.3 6320.1 6327.9 6203.8 6220.0 6246.7 6289.6 6321.0 6159.9 6239.8 6245.4 6256.4 6273.7 6152.4 6238.0 6241.2 6241.6 6242.4 6166.9 6170.6 6259.3 6266.5 6283.5 4428.4 5875.8 5984.9 6136.7 6139.8 6017.5 6094.5 6095.7 6121.4 6126.9 5820.9 5890.8 5912.1 5927.4 5976.5 4481.1 5857.0 6022.7 6100.7 6121.6 5963.5 5995.5 6001.0 6019.4 6032.5 18:41:10 INFO - PROCESS | 1990 | 18:41:10 INFO - PROCESS | 1990 | [#1] ext.html Cycles:180 Average:69093.02 Median:40406.10 stddev:150850.57 (373.3%) stddev-sans-first:151185.68 18:41:10 INFO - PROCESS | 1990 | Values: 438.2 465.4 486.5 492.7 576.8 38137.6 38471.6 38646.6 38738.4 38792.6 33716.7 41334.6 41543.0 41705.2 41912.0 9467.2 9575.7 9582.7 9618.9 9668.8 9574.5 9708.1 9718.2 9724.5 9738.9 9784.0 9818.8 9880.5 9899.0 9958.9 9503.3 9783.0 9836.4 9857.9 9882.1 9656.1 9719.2 9805.3 9808.3 9821.4 40379.2 40433.0 40440.8 40591.2 40611.2 3263.9 3265.8 3383.4 3450.0 3595.8 28613.6 28782.0 28832.0 29102.9 29109.4 2780.0 2833.5 2854.8 2879.2 2990.9 425566.0 428606.0 429399.0 430741.0 431499.0 56158.2 57140.1 65592.0 68180.0 69031.0 65555.7 66017.0 66247.3 66265.7 66442.3 15819.8 16034.8 16212.4 16340.9 16588.5 12420.1 12543.8 12626.0 12816.7 12863.6 21019.8 21094.4 21116.5 21384.7 21426.9 8750.4 8959.2 8990.3 8994.1 9038.2 905.3 1006.6 1044.9 1093.3 1139.3 25533.1 29971.7 30107.1 30554.8 30640.5 927.3 1034.4 1084.9 1086.1 1089.3 14480.6 14616.6 14692.9 14716.5 14773.3 688987.0 693910.0 696960.5 707962.0 711640.0 59287.1 59703.7 60233.0 60294.0 60499.7 1399.0 1399.5 1418.8 1434.1 1437.2 28608.3 28650.9 28877.3 29366.4 29409.4 43979.3 48999.0 49217.8 50007.5 50050.2 522005.0 527587.0 530027.0 532138.0 532474.0 33617.3 43409.3 44464.8 45028.0 45116.3 43052.0 43118.8 43372.6 43632.0 44096.3 34840.0 35625.8 36130.3 36237.0 36629.9 36511.0 36921.0 37514.9 37697.6 37851.6 37055.0 37893.9 38773.6 39134.6 39168.0 29767.4 31895.7 32001.2 32136.0 32218.4 19601.5 24740.9 24764.6 24825.4 24916.5 18:41:10 INFO - PROCESS | 1990 | 18:41:10 INFO - PROCESS | 1990 | [#2] jquery.html Cycles:180 Average:37577.34 Median:11157.00 stddev:123447.09 (1106.5%) stddev-sans-first:123761.69 18:41:10 INFO - PROCESS | 1990 | Values: 318.8 366.4 368.6 376.2 377.7 15398.2 18552.7 18755.7 19330.5 20168.5 18960.9 19288.8 19510.3 19659.5 19776.7 5053.5 5609.7 5820.0 5908.3 5949.5 4157.3 4363.7 5565.7 6209.3 6480.0 6202.5 6352.3 6396.8 6419.6 6430.8 6244.1 6297.6 6304.0 6345.5 6361.0 5134.8 5247.4 5317.4 5345.9 5374.6 11958.3 13015.9 13042.6 13063.7 13125.6 2145.5 2189.5 2210.6 2232.4 2285.3 9956.7 11518.5 12230.9 12839.9 14702.5 1686.4 1746.8 1768.5 1776.4 1805.6 95759.1 100844.5 102657.5 107521.0 111088.4 11015.0 11370.5 11453.1 11461.7 11503.3 13362.9 13600.7 13649.0 13659.4 13679.5 8585.8 8623.4 8631.2 8686.6 8720.9 8651.0 8706.7 8746.3 8792.3 8853.3 3681.0 4402.2 4469.8 4483.7 4497.2 1497.2 1818.3 1858.6 1868.2 1899.2 806.9 895.6 919.9 938.1 993.4 18339.7 19230.0 19246.9 19406.3 19702.2 934.8 972.5 1000.8 1004.4 1058.7 10556.5 10687.0 10849.9 10879.3 10923.3 710913.0 749315.3 750123.0 766832.0 767828.0 111982.4 115404.4 115451.4 119217.0 120091.0 1118.6 1185.1 1197.3 1197.8 1203.6 17766.7 17786.4 17840.5 18163.8 18436.3 48362.5 51148.2 52360.2 52956.0 53067.5 54753.7 60553.0 75575.9 75909.6 76477.2 7482.6 7598.0 7658.9 7705.6 7735.1 10582.8 11289.7 11466.4 11788.2 12296.5 8567.3 9364.9 9965.7 10159.5 10261.5 9979.5 10243.0 10270.3 10748.8 10862.8 10315.8 10675.4 10871.4 10898.6 11012.4 7542.3 7696.7 7729.1 7734.6 7742.3 8247.7 10450.5 10554.9 10587.8 10769.4 18:41:10 INFO - PROCESS | 1990 | 18:41:10 INFO - PROCESS | 1990 | [#3] mootools.html Cycles:180 Average:5998.85 Median:5389.31 stddev:3174.04 (58.9%) stddev-sans-first:3163.77 18:41:10 INFO - PROCESS | 1990 | Values: 1357.9 1548.3 1748.9 1889.9 1910.3 7912.2 8012.0 8646.2 8721.7 8887.2 7292.2 8468.9 8510.3 8673.0 8697.3 2067.7 2406.4 2426.5 2465.6 2472.1 2099.4 2446.0 2489.5 2490.0 2492.7 2108.6 2442.1 2461.7 2466.2 2524.1 2469.9 2487.6 2502.6 2515.2 2520.4 2533.8 2544.0 2545.2 2553.4 2555.7 8869.9 8900.1 8916.9 8918.8 8926.6 4304.5 5532.9 5552.9 5554.1 5568.3 3547.4 3627.7 3682.3 3688.0 3696.8 1006.6 1043.3 1096.3 1097.3 1104.1 11680.6 11830.0 11842.5 11870.6 11891.9 4940.2 4941.0 5025.1 5035.9 5063.1 8651.0 10024.4 10258.9 10267.7 10288.6 5001.7 5319.4 5459.2 5529.0 5575.0 4353.9 4505.4 4858.1 4974.0 5060.7 3951.5 3980.2 3989.4 4025.9 4034.5 1309.1 1314.4 1327.1 1328.5 1329.5 969.8 1158.8 1327.6 1363.9 1376.9 8005.8 8033.4 8050.5 8127.3 8128.1 427.0 429.4 459.0 503.8 514.2 6218.3 6255.5 6294.2 6295.0 6306.0 10361.5 10716.2 10742.8 10792.0 10805.2 10460.4 10614.0 10621.1 10674.5 10678.8 7147.7 7474.4 7884.1 8296.3 8304.3 6796.2 7510.3 7882.4 7901.9 7952.7 8363.3 9351.0 9474.5 9516.2 9531.1 9703.3 9808.7 9878.4 9944.6 9970.5 6607.7 6797.4 7233.7 7600.4 7650.3 8095.2 8110.6 8151.2 8169.1 8184.0 7453.9 7586.1 7643.6 7737.5 7816.2 6535.6 7597.5 7616.5 7671.8 7769.9 7719.7 7767.3 7777.3 7778.5 7787.6 6954.5 6968.2 6986.7 7044.4 7108.1 7062.8 7087.5 7130.9 7158.6 7195.1 18:41:10 INFO - PROCESS | 1990 | 18:41:10 INFO - PROCESS | 1990 | [#4] prototype.html Cycles:180 Average:5964.95 Median:6703.75 stddev:1958.91 (29.2%) stddev-sans-first:1918.23 18:41:10 INFO - PROCESS | 1990 | Values: 331.2 333.8 337.3 340.0 345.7 6673.2 6902.4 6970.6 6970.8 7061.4 6402.4 6678.3 6874.6 6904.4 6922.1 4697.4 5014.4 5029.6 5044.0 5048.4 4785.2 5029.7 5045.7 5051.4 5051.4 4855.2 4859.9 4883.4 4890.4 4893.1 4793.9 4860.8 4866.6 4899.1 4917.8 3471.9 3974.0 4047.7 4119.9 4179.5 6164.5 6447.0 6543.2 6572.5 6602.3 5823.9 5886.6 5911.1 5911.3 5926.5 7056.4 7328.3 7331.9 7360.0 7393.9 3700.6 4700.0 4730.3 4731.7 4732.8 6210.0 6466.7 7676.6 7772.5 7784.8 4045.2 4578.2 4759.3 4781.7 4809.4 4896.1 4899.1 4901.8 4904.9 4906.5 5828.7 5834.2 5856.6 5869.8 5878.8 7366.8 7370.0 7387.6 7405.9 7406.7 1642.0 1707.5 1708.9 1715.2 1719.9 1074.4 1091.0 1092.3 1094.9 1101.9 5632.0 6851.5 6885.0 6923.5 6944.7 7607.9 7615.4 7666.8 7678.1 7700.0 6646.3 6861.7 6878.7 6884.3 6957.2 3488.4 3773.8 4003.5 4029.3 4071.5 7936.0 8007.3 8021.7 8075.2 8097.5 6781.3 7737.2 7979.4 7991.8 8058.4 7771.5 8087.4 8088.4 8095.2 8146.9 7695.3 7709.4 7713.1 7736.5 7748.7 7337.6 7638.8 7654.3 7657.4 7673.7 6518.6 8032.2 8059.0 8078.6 8091.2 4782.5 4837.7 4846.6 4857.5 4864.1 7538.6 7702.2 7749.4 7754.6 7768.4 7392.1 7417.8 7420.9 7434.2 7435.0 6027.3 7182.0 7411.0 7425.4 7501.7 7224.6 7234.2 7241.4 7249.5 7273.3 6729.2 7435.8 7455.7 7456.1 7482.0 5939.6 6366.4 6881.6 7028.8 7266.8 18:41:10 INFO - PROCESS | 1990 | 18:41:10 INFO - PROCESS | 1990 | [#5] yui.html Cycles:180 Average:18631.19 Median:594.22 stddev:26710.03 (4494.9%) stddev-sans-first:26750.86 18:41:10 INFO - PROCESS | 1990 | Values: 658.3 691.0 703.6 740.3 747.1 14307.9 14318.4 14401.0 14402.0 14447.6 12955.7 13013.3 13041.0 13078.5 13126.0 703.1 716.1 841.8 863.8 870.2 850.9 857.3 868.6 872.1 872.1 896.7 917.0 923.8 928.6 930.2 891.6 906.8 907.3 919.0 921.4 669.9 673.2 688.4 690.4 693.3 13674.2 13825.5 13903.7 13967.7 14000.9 12392.3 12415.1 12438.5 12531.1 12581.9 9911.0 10393.1 10570.6 10798.5 11233.8 3555.0 3556.1 3574.6 3582.9 3652.3 78805.6 79181.0 79444.0 79537.2 82300.6 9327.7 9558.1 9560.3 9591.5 10174.8 19919.6 19961.4 20225.5 20287.4 20351.5 7434.5 7581.4 7743.8 7798.3 7897.5 4132.7 4158.4 4186.7 4196.2 4342.4 3305.3 3429.7 3482.8 3495.3 3501.2 651.5 662.0 666.3 669.6 670.0 570.5 571.1 585.6 595.2 598.8 7930.8 7975.4 8145.4 8220.0 8303.1 517.3 519.6 547.8 583.3 593.2 3969.9 4028.2 4078.2 4286.2 4380.0 74071.0 98061.0 100356.0 100380.5 100588.0 80165.2 83818.0 85429.0 86624.0 87270.6 72035.6 72939.6 73864.3 74058.5 76235.6 6467.0 8971.8 8985.5 8992.3 9127.5 44853.0 50081.0 51865.2 53184.5 55339.2 66393.0 68318.7 71279.0 71660.0 72207.0 11604.0 11607.5 11769.1 11819.5 12313.8 10421.6 11950.0 11982.8 12184.9 12569.8 9773.3 11051.4 11065.6 11419.7 11957.9 11350.5 11848.3 11854.4 11900.3 12317.6 9065.5 9617.9 11092.2 11612.9 11962.5 9065.3 9138.6 9147.8 9182.0 9499.3 8035.7 9962.1 10160.4 10189.9 10202.4 18:41:10 INFO - PROCESS | 1990 | -------- Summary: end -------- 18:41:10 INFO - PROCESS | 1990 | 18:41:10 INFO - TEST-INFO | 1990: exit 0 18:41:10 INFO - TEST-OK | dromaeo_css | took 1110713ms 18:41:10 INFO - TEST-START | kraken 18:41:10 INFO - operating with platform_type : mac_ 18:41:10 INFO - Initialising browser for kraken test... 18:41:10 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpWdIoP1/profile http://localhost:49733/getInfo.html) 18:41:10 INFO - PROCESS | 1997 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 18:41:13 INFO - PROCESS | 1997 | __metrics Screen width/height:1600/1200 18:41:13 INFO - PROCESS | 1997 | colorDepth:24 18:41:13 INFO - PROCESS | 1997 | Browser inner width/height: 1024/689 18:41:13 INFO - PROCESS | 1997 | __metrics 18:41:13 INFO - PROCESS | 1997 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:41:13 INFO - PROCESS | 1997 | 18:41:13 INFO - PROCESS | 1997 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 18:41:13 INFO - PROCESS | 1997 | 18:41:14 INFO - TEST-INFO | 1997: exit 0 18:41:14 INFO - Browser initialized. 18:41:14 INFO - Running cycle 1/1 for kraken test... 18:41:14 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpWdIoP1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:26 INFO - PROCESS | 2000 | RSS: Main: 254402560 18:41:26 INFO - PROCESS | 2000 | 18:41:28 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49733/tests/kraken/driver.html?testName=audio-beat-detection) 18:41:29 INFO - PROCESS | 2000 | RSS: Main: 268660736 18:41:29 INFO - PROCESS | 2000 | 18:41:32 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49733/tests/kraken/driver.html?testName=audio-dft) 18:41:32 INFO - PROCESS | 2000 | RSS: Main: 278368256 18:41:32 INFO - PROCESS | 2000 | 18:41:36 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49733/tests/kraken/driver.html?testName=audio-fft) 18:41:36 INFO - PROCESS | 2000 | RSS: Main: 281731072 18:41:36 INFO - PROCESS | 2000 | 18:41:38 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49733/tests/kraken/driver.html?testName=audio-oscillator) 18:41:39 INFO - PROCESS | 2000 | RSS: Main: 283742208 18:41:39 INFO - PROCESS | 2000 | 18:41:41 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49733/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:41:41 INFO - PROCESS | 2000 | RSS: Main: 283906048 18:41:41 INFO - PROCESS | 2000 | 18:41:44 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49733/tests/kraken/driver.html?testName=imaging-darkroom) 18:41:45 INFO - PROCESS | 2000 | RSS: Main: 284123136 18:41:45 INFO - PROCESS | 2000 | 18:41:47 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49733/tests/kraken/driver.html?testName=imaging-desaturate) 18:41:48 INFO - PROCESS | 2000 | RSS: Main: 283676672 18:41:48 INFO - PROCESS | 2000 | 18:41:51 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49733/tests/kraken/driver.html?testName=json-parse-financial) 18:41:51 INFO - PROCESS | 2000 | RSS: Main: 284012544 18:41:51 INFO - PROCESS | 2000 | 18:41:53 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49733/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:41:53 INFO - PROCESS | 2000 | RSS: Main: 284385280 18:41:53 INFO - PROCESS | 2000 | 18:41:55 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49733/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:41:56 INFO - PROCESS | 2000 | RSS: Main: 284807168 18:41:56 INFO - PROCESS | 2000 | 18:41:58 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49733/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:41:59 INFO - PROCESS | 2000 | RSS: Main: 284897280 18:41:59 INFO - PROCESS | 2000 | 18:42:01 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:42:02 INFO - PROCESS | 2000 | RSS: Main: 284561408 18:42:02 INFO - PROCESS | 2000 | 18:42:04 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:42:05 INFO - PROCESS | 2000 | RSS: Main: 283389952 18:42:05 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | Cycle 1(1): loaded http://localhost:49733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49733/tests/kraken/driver.html?testName=ai-astar) 18:42:07 INFO - PROCESS | 2000 | RSS: Main: 286130176 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | __start_tp_report 18:42:07 INFO - PROCESS | 2000 | _x_x_mozilla_page_load 18:42:07 INFO - PROCESS | 2000 | _x_x_mozilla_page_load_details 18:42:07 INFO - PROCESS | 2000 | |i|pagename|runs| 18:42:07 INFO - PROCESS | 2000 | |0;ai-astar;115;108;115;116;158;125;113;113;116;114 18:42:07 INFO - PROCESS | 2000 | |1;audio-beat-detection;147;119;143;151;121;160;167;149;159;119 18:42:07 INFO - PROCESS | 2000 | |2;audio-dft;188;200;198;278;272;199;194;198;198;195 18:42:07 INFO - PROCESS | 2000 | |3;audio-fft;60;69;63;72;109;52;56;83;86;136 18:42:07 INFO - PROCESS | 2000 | |4;audio-oscillator;82;86;116;78;83;84;116;76;82;124 18:42:07 INFO - PROCESS | 2000 | |5;imaging-gaussian-blur;86;91;85;92;85;92;86;91;88;92 18:42:07 INFO - PROCESS | 2000 | |6;imaging-darkroom;95;95;103;95;95;94;105;95;95;100 18:42:07 INFO - PROCESS | 2000 | |7;imaging-desaturate;95;93;90;91;92;93;93;93;91;92 18:42:07 INFO - PROCESS | 2000 | |8;json-parse-financial;56;57;57;54;57;56;56;61;56;54 18:42:07 INFO - PROCESS | 2000 | |9;json-stringify-tinderbox;66;66;90;100;110;70;71;66;70;68 18:42:07 INFO - PROCESS | 2000 | |10;stanford-crypto-aes;84;86;87;81;84;83;87;86;85;82 18:42:07 INFO - PROCESS | 2000 | |11;stanford-crypto-ccm;145;145;115;133;125;125;124;124;135;129 18:42:07 INFO - PROCESS | 2000 | |12;stanford-crypto-pbkdf2;138;140;151;173;149;142;140;139;142;139 18:42:07 INFO - PROCESS | 2000 | |13;stanford-crypto-sha256-iterative;67;68;69;68;64;67;69;70;69;69 18:42:07 INFO - PROCESS | 2000 | __end_tp_report 18:42:07 INFO - PROCESS | 2000 | __start_cc_report 18:42:07 INFO - PROCESS | 2000 | _x_x_mozilla_cycle_collect,862 18:42:07 INFO - PROCESS | 2000 | __end_cc_report 18:42:07 INFO - PROCESS | 2000 | __startTimestamp1454467327358__endTimestamp 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | ------- Summary: start ------- 18:42:07 INFO - PROCESS | 2000 | Number of tests: 14 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#0] ai-astar Cycles:10 Average:119.30 Median:115.50 stddev:14.24 (12.3%) stddev-sans-first:15.01 18:42:07 INFO - PROCESS | 2000 | Values: 115.0 108.0 115.0 116.0 158.0 125.0 113.0 113.0 116.0 114.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:150.00 stddev:17.86 (11.9%) stddev-sans-first:18.90 18:42:07 INFO - PROCESS | 2000 | Values: 147.0 119.0 143.0 151.0 121.0 160.0 167.0 149.0 159.0 119.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#2] audio-dft Cycles:10 Average:212.00 Median:198.50 stddev:33.41 (16.8%) stddev-sans-first:34.29 18:42:07 INFO - PROCESS | 2000 | Values: 188.0 200.0 198.0 278.0 272.0 199.0 194.0 198.0 198.0 195.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#3] audio-fft Cycles:10 Average:78.60 Median:66.00 stddev:26.32 (39.9%) stddev-sans-first:27.05 18:42:07 INFO - PROCESS | 2000 | Values: 60.0 69.0 63.0 72.0 109.0 52.0 56.0 83.0 86.0 136.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:82.00 stddev:18.27 (22.3%) stddev-sans-first:18.96 18:42:07 INFO - PROCESS | 2000 | Values: 82.0 86.0 116.0 78.0 83.0 84.0 116.0 76.0 82.0 124.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:91.00 stddev:3.08 (3.4%) stddev-sans-first:3.10 18:42:07 INFO - PROCESS | 2000 | Values: 86.0 91.0 85.0 92.0 85.0 92.0 86.0 91.0 88.0 92.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#6] imaging-darkroom Cycles:10 Average:97.20 Median:95.00 stddev:3.97 (4.2%) stddev-sans-first:4.13 18:42:07 INFO - PROCESS | 2000 | Values: 95.0 95.0 103.0 95.0 95.0 94.0 105.0 95.0 95.0 100.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#7] imaging-desaturate Cycles:10 Average:92.30 Median:93.00 stddev:1.42 (1.5%) stddev-sans-first:1.12 18:42:07 INFO - PROCESS | 2000 | Values: 95.0 93.0 90.0 91.0 92.0 93.0 93.0 93.0 91.0 92.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.96 (3.5%) stddev-sans-first:2.07 18:42:07 INFO - PROCESS | 2000 | Values: 56.0 57.0 57.0 54.0 57.0 56.0 56.0 61.0 56.0 54.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#9] json-stringify-tinderbox Cycles:10 Average:77.70 Median:69.00 stddev:16.19 (23.5%) stddev-sans-first:16.61 18:42:07 INFO - PROCESS | 2000 | Values: 66.0 66.0 90.0 100.0 110.0 70.0 71.0 66.0 70.0 68.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.50 stddev:2.07 (2.4%) stddev-sans-first:2.19 18:42:07 INFO - PROCESS | 2000 | Values: 84.0 86.0 87.0 81.0 84.0 83.0 87.0 86.0 85.0 82.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:131.00 stddev:9.61 (7.3%) stddev-sans-first:8.53 18:42:07 INFO - PROCESS | 2000 | Values: 145.0 145.0 115.0 133.0 125.0 125.0 124.0 124.0 135.0 129.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:142.00 stddev:10.67 (7.5%) stddev-sans-first:10.98 18:42:07 INFO - PROCESS | 2000 | Values: 138.0 140.0 151.0 173.0 149.0 142.0 140.0 139.0 142.0 139.0 18:42:07 INFO - PROCESS | 2000 | 18:42:07 INFO - PROCESS | 2000 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:69.00 stddev:1.70 (2.5%) stddev-sans-first:1.76 18:42:07 INFO - PROCESS | 2000 | Values: 67.0 68.0 69.0 68.0 64.0 67.0 69.0 70.0 69.0 69.0 18:42:07 INFO - PROCESS | 2000 | -------- Summary: end -------- 18:42:07 INFO - PROCESS | 2000 | 18:42:08 INFO - TEST-INFO | 2000: exit 0 18:42:08 INFO - TEST-OK | kraken | took 57379ms 18:42:08 INFO - SUITE-END | took 1168s 18:42:08 INFO - Completed test suite (00:19:28) 18:42:08 INFO - Working with test: dromaeo_css 18:42:08 INFO - Generating results file: dromaeo_css 18:42:08 INFO - Working with test: kraken 18:42:08 INFO - Generating results file: kraken 18:42:08 INFO - javascript benchmark 18:42:08 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:42:08 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 18:42:08 INFO - process_Request line: dromaeo_css 7526.70 graph.html#tests=[[72,64,61]] 18:42:08 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:42:08 INFO - process_Request line: kraken 1486.30 graph.html#tests=[[232,64,61]] 18:42:08 INFO - RETURN: dromaeo_css: 7526.70 18:42:08 INFO - RETURN: kraken: 1486.30 18:42:08 INFO - javascript benchmark 18:42:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2927.502324604817, 3477.965220347797, 3503.211777350098, 3545.929081418372, 3551.7336199785013, 5593.133064375023, 5713.085906255, 5721.227634269383, 5742.54059675226, 5747.885042299152, 5502.58730595206, 5593.3847276799515, 5626.2967129108865, 5628.549716022719, 5655.0, 5103.362079740024, 5140.794368225266, 5142.228665700138, 5195.922061169066, 5199.766010529535, 5211.609129315298, 5229.163333866582, 5239.345081864767, 5249.527542521172, 5279.683219006872, 5213.556847667953, 5222.32109825724, 5234.293370394986, 5268.341457317835, 5320.866978325535, 4971.0803501352, 5121.718305493197, 5167.560757335631, 5228.92156617651, 5257.579393648499, 5096.159133742928, 5157.71632560209, 5172.663776854492, 5195.012947539955, 5197.376314842205, 5483.095289277265, 5564.137558678412, 5612.017896868032, 5642.971785141089, 5747.770089196427, 5111.872203194913, 6164.383561643845, 6178.660173690445, 6227.3772622737815, 6318.968405157991, 6239.844003899893, 6270.09083682868, 6280.497560195174, 6295.811125666191, 6300.117983482316, 5825.796097136665, 5834.883302333972, 5867.354590994987, 5905.143754155709, 5937.257842769697, 5488.847342058132, 5746.9425305747245, 6128.319797384489, 6193.907091393633, 6250.624962502265, 4341.435613370241, 6145.723442445101, 6146.877062458726, 6166.969165154235, 6173.47525460332, 6106.938930610637, 6138.846528836725, 6210.31686514483, 6232.283287422005, 6298.0, 5332.466753324714, 5984.982552965919, 6160.414760597736, 6215.844603884939, 6278.905816412666, 6174.351693072253, 6242.750289988349, 6257.030160325156, 6269.0, 6283.842903927439, 4801.18379875422, 4825.927611085836, 4837.879053023703, 4878.146324393217, 4917.164082106051, 3769.7361184717356, 4361.258586040381, 4372.453443319585, 4385.429894113809, 4395.582419670126, 5637.351704554028, 5641.52047075995, 5706.28671416073, 5707.200991861143, 5755.568332375088, 6129.970128114947, 6145.432914606747, 6224.004159334485, 6234.407731265523, 6239.96880015597, 5670.121131224667, 5695.658260504383, 5716.914246286309, 5727.570432217517, 5752.597318187687, 5150.4334523202415, 5353.678779273256, 5356.544693701079, 5357.812476563302, 5377.4084850666395, 6203.410675985774, 6207.255129384503, 6315.305316415191, 6320.051992201298, 6327.936720632735, 6203.844903877439, 6220.0, 6246.718897649525, 6289.559730818799, 6320.968395158179, 6159.938400615936, 6239.844003899939, 6245.406686364788, 6256.436920677161, 6273.686315684289, 6152.446279834837, 6237.96881015592, 6241.157443745036, 6241.625502469867, 6242.438180563771, 6166.938330616636, 6170.629762214281, 6259.3427690091885, 6266.467350275278, 6283.5287353449585, 4428.380026796315, 5875.823725288248, 5984.9401505986125, 6136.723847426787, 6139.754409823557, 6017.518598512021, 6094.51243900478, 6095.664738439428, 6121.3572574879, 6126.908096378469, 5820.941790582209, 5890.764369425347, 5912.142739302863, 5927.377625349449, 5976.491998180029, 4481.103779244229, 5857.00430926752, 6022.698865056817, 6100.702285529835, 6121.571489995657, 5963.52291816645, 5995.520358371233, 6001.0, 6019.398060193946, 6032.487238584769], "unit": "score", "name": "dojo.html", "value": 5635.605754440347}, {"lowerIsBetter": false, "replicates": [438.1696684782337, 465.4205514134903, 486.4964761471877, 492.662526169574, 576.8010036537396, 38137.61862381375, 38471.61528384715, 38646.613533864656, 38738.41892371617, 38792.61207387925, 33716.66283337166, 41334.58665413353, 41542.961425964364, 41705.16589668205, 41912.0, 9467.195288400495, 9575.712728618153, 9582.664606738765, 9618.855717164248, 9668.758281042996, 9574.47340396278, 9708.126268635822, 9718.222542196607, 9724.513774311255, 9738.902610973906, 9783.95108024459, 9818.803623927517, 9880.456574888378, 9899.0, 9958.900410995906, 9503.28725345595, 9783.0, 9836.409815411098, 9857.852132218022, 9882.11061004513, 9656.130948214695, 9719.222462203006, 9805.31362804604, 9808.31341806074, 9821.410715357102, 40379.1924161518, 40433.0, 40440.797796011124, 40591.1881762366, 40611.18777624431, 3263.853126609308, 3265.7713960022807, 3383.3571621392102, 3450.0, 3595.8022308773006, 28613.570796437863, 28782.0, 28832.0, 29102.854485727436, 29109.41781164386, 2779.9557350854043, 2833.5183018886837, 2854.82871027739, 2879.1794338613395, 2990.850457477139, 425566.0, 428606.0, 429399.0, 430741.0, 431498.99999999686, 56158.15762763562, 57140.14289785657, 65592.0, 68180.0, 69031.0, 65555.67222163954, 66017.0, 66247.33752662412, 66265.66867165633, 66442.33557664361, 15819.762703559456, 16034.797390195781, 16212.35150593963, 16340.85614007008, 16588.50234492967, 12420.130590858553, 12543.811842822182, 12626.0, 12816.743665126645, 12863.614091577268, 21019.78980210209, 21094.367168984954, 21116.47208819761, 21384.679229811565, 21426.892865535883, 8750.431221970552, 8959.1936725695, 8990.280777537911, 8994.145556172152, 9038.231750301167, 905.343625871238, 1006.5520843224841, 1044.9268551201344, 1093.3439936038314, 1139.273999890167, 25533.106341277966, 29971.700282997328, 30107.096787096423, 30554.847225764173, 30640.54039189414, 927.2674587076134, 1034.4155552113032, 1084.9240553161203, 1086.1419478611965, 1089.2865173311493, 14480.565583032527, 14616.634584135481, 14692.853071469148, 14716.484923027643, 14773.26133693311, 688987.0, 693910.0, 696960.5151974207, 707962.0, 711640.0, 59287.11069333964, 59703.70148149318, 60233.0, 60294.0, 60499.69750151221, 1398.9650258743613, 1399.5451478269604, 1418.829740431155, 1434.0965191929017, 1437.2238990944982, 28608.284792880346, 28650.85674571697, 28877.278068047628, 29366.41267174687, 29409.38248396359, 43979.34030989602, 48999.0, 49217.75391123021, 50007.49992500174, 50050.24924626061, 522005.0, 527587.0, 530027.0, 532138.0, 532474.0, 33617.32765344728, 43409.3488597665, 44464.777676111415, 45028.0, 45116.32325515185, 43052.0, 43118.78440607777, 43372.56627433812, 43632.0, 44096.338554922346, 34840.0, 35625.82187089048, 36130.27739445249, 36237.0, 36629.90110296696, 36511.0, 36921.0, 37514.87455376343, 37697.62302376941, 37851.62148378591, 37055.0, 37893.86318410452, 38773.612263877, 39134.6086539131, 39168.0, 29767.404651907273, 31895.68104318927, 32001.199970000936, 32136.0, 32218.35563288768, 19601.509962251057, 24740.876295619128, 24764.628530572416, 24825.379365516008, 24916.501669966136], "unit": "score", "name": "ext.html", "value": 20067.626980616453}, {"lowerIsBetter": false, "replicates": [318.8373929296058, 366.4283717400855, 368.60006892521614, 376.2362404319233, 377.71671246565074, 15398.153101579408, 18552.721709174373, 18755.687101902873, 19330.51673708156, 20168.495787605298, 18960.905195474003, 19288.807111928876, 19510.31713890014, 19659.508512287164, 19776.703349449734, 5053.51991560803, 5609.663420194791, 5819.970900145493, 5908.320543137551, 5949.464548190662, 4157.314043182886, 4363.650907927358, 5565.693886836222, 6209.316975132731, 6480.0, 6202.534809889254, 6352.269489008754, 6396.808095757112, 6419.614823110628, 6430.7749228777, 6244.094606282109, 6297.559170858041, 6303.9684801575695, 6345.524085693568, 6361.045843123522, 5134.794608215667, 5247.39654939683, 5317.361916569997, 5345.919811202835, 5374.570034397278, 11958.342291173982, 13015.934920325337, 13042.608721738363, 13063.673408164872, 13125.606231812966, 2145.495808485005, 2189.4964158243693, 2210.5799898019486, 2232.3749350181974, 2285.2915596165076, 9956.651517196864, 11518.481668324945, 12230.877691223062, 12839.871601284054, 14702.529747025319, 1686.4097565851976, 1746.7991181014092, 1768.5224989252958, 1776.4493007167819, 1805.5576383785926, 95759.08481830393, 100844.49577752137, 102657.48671256671, 107520.99999999921, 111088.4445577775, 11015.0, 11370.488328025092, 11453.083753299716, 11461.656150315504, 11503.252288601214, 13362.933185334012, 13600.727985440433, 13648.976326775333, 13659.385327660279, 13679.521216757366, 8585.828283434297, 8623.439476434012, 8631.180037896514, 8686.609102590399, 8720.8691869622, 8650.95674521636, 8706.738797836075, 8746.34402419821, 8792.34057445694, 8853.29173666105, 3681.0245284999496, 4402.163588918095, 4469.776511174428, 4483.708558943724, 4497.190505708938, 1497.2438918346165, 1818.2908665620419, 1858.6375656747075, 1868.2433614386196, 1899.1833511589873, 806.9354451643854, 895.5611750242334, 919.9264058875274, 938.1228551304553, 993.4287784523927, 18339.724904126448, 19230.0, 19246.903765481362, 19406.320778772675, 19702.21191152338, 934.8036912248504, 972.4505654305295, 1000.7948370584013, 1004.42747633848, 1058.6559368205365, 10556.472176391304, 10687.0, 10849.891501085045, 10879.347239165676, 10923.289986150874, 710913.0, 749315.2534237294, 750123.0, 766832.0, 767828.0, 111982.44008779904, 115404.42297788458, 115451.42274288574, 119217.0, 120091.0, 1118.6308518188978, 1185.0993245133761, 1197.26368283505, 1197.808350663907, 1203.6088271311858, 17766.733498997266, 17786.37747678825, 17840.46478605644, 18163.818361816742, 18436.26254949787, 48362.5163748358, 51148.232776509125, 52360.214596780315, 52956.0, 53067.46932530625, 54753.726231368586, 60553.0, 75575.86636200572, 75909.62045189738, 76477.17614119161, 7482.588457634883, 7598.0, 7658.885116723365, 7705.6147192641265, 7735.071791385069, 10582.788344232918, 11289.661310160709, 11466.426678666201, 11788.23376480526, 12296.50813967467, 8567.329370772888, 9364.859527106963, 9965.701028969142, 10159.492025398848, 10261.486925653837, 9979.45113018762, 10243.0, 10270.33242839213, 10748.83876741865, 10862.782744344911, 10315.793684126125, 10675.412852292888, 10871.40207288575, 10898.583184186005, 11012.449377531251, 7542.321191092828, 7696.653650585849, 7729.07251129868, 7734.574598397142, 7742.341900938483, 8247.670093196204, 10450.477476126316, 10554.894451055698, 10587.841182382117, 10769.407682577534], "unit": "score", "name": "jquery.html", "value": 9165.771856523248}, {"lowerIsBetter": false, "replicates": [1357.8506364299928, 1548.2800497768535, 1748.8950662960224, 1889.93385231517, 1910.2550005497849, 7912.248336408046, 8011.9599402002905, 8646.17861303176, 8721.694740684085, 8887.244584210343, 7292.234315396887, 8468.915310846889, 8510.27662648674, 8673.0, 8697.347698922591, 2067.7208576842086, 2406.362313986795, 2426.4540478392396, 2465.642481840141, 2472.0606169655593, 2099.433153048676, 2445.963310550343, 2489.477209785938, 2490.0, 2492.67595212623, 2108.5677436125634, 2442.1330427698176, 2461.655368248447, 2466.1738317663517, 2524.1039431002005, 2469.8518088914543, 2487.6019836826113, 2502.6120951252583, 2515.157422263544, 2520.3825062859532, 2533.7972962162985, 2543.9618405723927, 2545.185540627, 2553.3616595851036, 2555.6805399325085, 8869.866951995726, 8900.109989001048, 8916.910830891738, 8918.777030574223, 8926.553672316422, 4304.483461984551, 5532.861678458031, 5552.86117847053, 5554.1391084381985, 5568.331800184003, 3547.379208638478, 3627.7460577759566, 3682.3371793077235, 3687.967369136646, 3696.77819330841, 1006.5923301063082, 1043.2697112021615, 1096.2545469081022, 1097.2703152403722, 1104.1222228328497, 11680.591179308769, 11829.99445047172, 11842.526298948032, 11870.584529541424, 11891.940540297242, 4940.209566469348, 4941.0, 5025.14572522672, 5035.874103147451, 5063.06333328328, 8650.95674521636, 10024.448655324028, 10258.897411025944, 10267.691969240936, 10288.588456461808, 5001.7499125043605, 5319.414864364917, 5459.208414779914, 5529.0, 5574.9721251393485, 4353.869383918487, 4505.36924830524, 4858.076965376567, 4973.975130124326, 5060.734816295926, 3951.5455722591696, 3980.1641655252142, 3989.3617021276455, 4025.939610905839, 4034.455348527911, 1309.109805332383, 1314.4216544720293, 1327.0909427042507, 1328.4885319152197, 1329.5014369611395, 969.8399764038854, 1158.8030034894089, 1327.561904571489, 1363.9113457625222, 1376.8623137686152, 8005.759827205193, 8033.3974951878845, 8050.476719013245, 8127.309178719756, 8128.105908350077, 426.97224680396295, 429.38812192626006, 459.010831657778, 503.7632611937684, 514.1773162939342, 6218.253809542884, 6255.530835187379, 6294.150289710922, 6295.024271237966, 6305.96847015762, 10361.533730982124, 10716.249862509705, 10742.838857417146, 10792.0, 10805.243632945618, 10460.372377657213, 10614.0, 10621.097206737513, 10674.519646615921, 10678.786424271471, 7147.678354474165, 7474.393005503843, 7884.093329267208, 8296.294814940798, 8304.335653147733, 6796.218434879855, 7510.286522780327, 7882.448228624171, 7901.920980790348, 7952.721654742057, 8363.289120424588, 9351.0, 9474.478903660365, 9516.19112375456, 9531.142197202285, 9703.320767546204, 9808.65669701557, 9878.357906736039, 9944.602215911573, 9970.501474926079, 6607.735690572324, 6797.354251346114, 7233.746818861315, 7600.429967752551, 7650.273224043707, 8095.150009248944, 8110.5944702763445, 8151.225633564802, 8169.142240064708, 8183.95908020456, 7453.850922981618, 7586.051743532059, 7643.5716379863925, 7737.535747855147, 7816.179301173295, 6535.57518761279, 7597.544147351176, 7616.543007419573, 7671.846563068596, 7769.92230077692, 7719.652615632423, 7767.300942915164, 7777.261160189773, 7778.49439786412, 7787.649555769891, 6954.478414119062, 6968.198657154492, 6986.720531178696, 7044.436445084279, 7108.07595012645, 7062.788116356517, 7087.468439866928, 7130.893036604559, 7158.570485770871, 7195.064641596559], "unit": "score", "name": "mootools.html", "value": 4806.129582707711}, {"lowerIsBetter": false, "replicates": [331.2497193855916, 333.849767604578, 337.2799073977058, 339.96090449598296, 345.6957877068181, 6673.165854268216, 6902.378785909267, 6970.581765094098, 6970.790876273713, 7061.364477197051, 6402.359764023596, 6678.26539080702, 6874.553154044984, 6904.447644188465, 6922.134733158356, 4697.412823397075, 5014.373203349582, 5029.647924645276, 5044.0, 5048.444671086178, 4785.21044027735, 5029.748512574375, 5045.722485263309, 5051.3938327400765, 5051.444341122474, 4855.198892182786, 4859.902801943959, 4883.389576302962, 4890.388701412324, 4893.119238537062, 4793.856184314476, 4860.756962151896, 4866.6106711463, 4899.069176856386, 4917.754112294407, 3471.8784842530645, 3973.98013009936, 4047.6964227683043, 4119.8970025749595, 4179.477565304337, 6164.506839452833, 6447.0, 6543.247526534462, 6572.474202063823, 6602.2737498875085, 5823.912641310384, 5886.558508111909, 5911.113333000085, 5911.29064512257, 5926.496247818941, 7056.400205982498, 7328.303811137934, 7331.936869153996, 7360.0, 7393.889091663629, 3700.5744339400776, 4700.0, 4730.266808644666, 4731.739754313511, 4732.787024583902, 6209.968950155266, 6466.708998095097, 7676.616169191574, 7772.455928085036, 7784.766457006299, 4045.19096180765, 4578.175928332932, 4759.309900064541, 4781.737004464719, 4809.350737650372, 4896.11869863428, 4899.1426500362295, 4901.803927842918, 4904.926426103611, 4906.533879281463, 5828.688545077323, 5834.183214349994, 5856.648601083949, 5869.7945571904775, 5878.764849406061, 7366.77899663011, 7369.963150184215, 7387.630618469055, 7405.8889116663295, 7406.666699998513, 1641.983580164183, 1707.4792188382662, 1708.9145542723063, 1715.2367196597643, 1719.9140042997801, 1074.3768614203743, 1090.9509072091776, 1092.3282181458505, 1094.8631421072366, 1101.9283746556448, 5632.0, 6851.520393572502, 6885.0, 6923.515353925278, 6944.652767361612, 7607.885881711779, 7615.390768738488, 7666.808329791688, 7678.117016543058, 7699.960505331821, 6646.335366463315, 6861.656917154122, 6878.65606719672, 6884.345987131214, 6957.199922009034, 3488.354654388946, 3773.7735735855936, 4003.459532963071, 4029.3351596986167, 4071.531773845986, 7936.0, 8007.279344858991, 8021.679132834738, 8075.192480751878, 8097.514149151069, 6781.287964763727, 7737.226277372218, 7979.3616510679, 7991.760247192477, 8058.35533157346, 7771.533707977539, 8087.353011759045, 8088.393370497119, 8095.150009249061, 8146.877796833052, 7695.345895598713, 7709.383249340151, 7713.1129920057665, 7736.535807851547, 7748.651310691145, 7337.559746415232, 7638.8090297743, 7654.272844079804, 7657.425693072931, 7673.6546855390525, 6518.57629254097, 8032.196780321921, 8059.0, 8078.555679437687, 8091.1504292048485, 4782.450018247946, 4837.718004728679, 4846.588040016638, 4857.489963553918, 4864.148773964472, 7538.585377804054, 7702.229777022253, 7749.41879359039, 7754.573498457639, 7768.417368697257, 7392.112946446461, 7417.777466676009, 7420.851582968418, 7434.182239953709, 7434.962825185839, 6027.30685971119, 7181.964090179725, 7410.999515065613, 7425.405967522694, 7501.699932002877, 7224.602646854263, 7234.204237533761, 7241.4206863451855, 7249.456290778318, 7273.3453989141235, 6729.226138993882, 7435.776926692208, 7455.7017719290625, 7456.067991501062, 7482.027336446227, 5939.584229103922, 6366.363363663597, 6881.554873476626, 7028.789136325919, 7266.781996540112], "unit": "score", "name": "prototype.html", "value": 5310.906694430042}, {"lowerIsBetter": false, "replicates": [658.3087757854249, 690.9965450172748, 703.5989485992986, 740.2708332292692, 747.0885519666009, 14307.856921430783, 14318.355673994669, 14400.991930564865, 14402.0, 14447.566573002814, 12955.676108097303, 13013.284269365182, 13041.0, 13078.542251021216, 13126.0, 703.0824773670358, 716.1477841368754, 841.7979684875647, 863.7883718488963, 870.1559487297311, 850.9234168924795, 857.2884505860152, 868.5700578213794, 872.1191596487562, 872.1235158665532, 896.708569714842, 916.9954150229273, 923.8244733500647, 928.5960607135884, 930.1675000874213, 891.6210610490548, 906.8186362727448, 907.2515174980667, 918.9908100919006, 921.391881358307, 669.9095622091004, 673.2325149329768, 688.3907741648627, 690.3648643248174, 693.3482526425195, 13674.247916364597, 13825.51610693631, 13903.652408689763, 13967.720645587031, 14000.859991400159, 12392.256464612063, 12415.130940834146, 12438.502459901683, 12531.06017048725, 12581.874181258161, 9911.0, 10393.116585090276, 10570.577176912915, 10798.514066866932, 11233.775324493465, 3554.9822250888838, 3556.1287484566446, 3574.571051473814, 3582.946255806165, 3652.3243200008083, 78805.60597196977, 79181.0, 79444.0, 79537.20462795356, 82300.58849705773, 9327.720168394959, 9558.091981261909, 9560.28297877662, 9591.472469014272, 10174.8473772892, 19919.60160796805, 19961.401157965283, 20225.49436264076, 20287.391378258675, 20351.4912127198, 7434.479586428898, 7581.393488521016, 7743.806404839924, 7798.25916537928, 7897.526148431112, 4132.710710250314, 4158.4178215049915, 4186.748795072305, 4196.160767846443, 4342.370356298319, 3305.25631732863, 3429.725621950238, 3482.8432720527635, 3495.318412909509, 3501.2122272488486, 651.5113664751436, 661.9536632435684, 666.2737615998585, 669.6450881033061, 670.045185610503, 570.5179123640518, 571.1432850723914, 585.6164212440858, 595.2172892646156, 598.8413070536311, 7930.801729956682, 7975.441719079608, 8145.42981991255, 8219.95890020546, 8303.097202765963, 517.3429744224813, 519.6206769058608, 547.8356493052069, 583.3087790967717, 593.2317648645015, 3969.8809035728973, 4028.194361127786, 4078.2047500737663, 4286.164197981426, 4379.956200438019, 74071.0, 98061.0, 100355.99644003467, 100380.49809750904, 100587.99412005933, 80165.19834801694, 83818.0, 85429.0, 86624.0, 87270.56364718136, 72035.63982180055, 72939.63530182421, 73864.26135738574, 74058.5188296231, 76235.61882190553, 6467.0, 8971.775705607151, 8985.505797181218, 8992.325575581726, 9127.452352858849, 44852.98161582671, 50081.0, 51865.22202167046, 53184.468155317954, 55339.16991245215, 66393.0, 68318.65840670765, 71279.0, 71660.0, 72207.0, 11604.0, 11607.535698572301, 11769.117316201491, 11819.468123934272, 12313.753724925631, 10421.583136674448, 11950.0, 11982.820257696316, 12184.878151218374, 12569.811452828031, 9773.267004974798, 11051.447427628747, 11065.557377704801, 11419.714507137056, 11957.880421196025, 11350.489227984595, 11848.348340841336, 11854.407279636156, 11900.345480998629, 12317.572958427738, 9065.54675244732, 9617.903820961701, 11092.168087393638, 11612.88387116118, 11962.521499140285, 9065.32010099232, 9138.63445462174, 9147.817043659223, 9181.995812282188, 9499.287553433382, 8035.67857285702, 9962.103410693073, 10160.441175735405, 10189.898101018895, 10202.38785672862], "unit": "score", "name": "yui.html", "value": 6871.050597246651}], "name": "dromaeo_css", "value": 7526.701563699977}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 115.0, 116.0, 158.0, 125.0, 113.0, 113.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 119.3}, {"lowerIsBetter": true, "replicates": [147.0, 119.0, 143.0, 151.0, 121.0, 160.0, 167.0, 149.0, 159.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [188.0, 200.0, 198.0, 278.0, 272.0, 199.0, 194.0, 198.0, 198.0, 195.0], "unit": "score", "name": "audio-dft", "value": 212.0}, {"lowerIsBetter": true, "replicates": [60.0, 69.0, 63.0, 72.0, 109.0, 52.0, 56.0, 83.0, 86.0, 136.0], "unit": "score", "name": "audio-fft", "value": 78.6}, {"lowerIsBetter": true, "replicates": [82.0, 86.0, 116.0, 78.0, 83.0, 84.0, 116.0, 76.0, 82.0, 124.0], "unit": "score", "name": "audio-oscillator", "value": 92.7}, {"lowerIsBetter": true, "replicates": [86.0, 91.0, 85.0, 92.0, 85.0, 92.0, 86.0, 91.0, 88.0, 92.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 103.0, 95.0, 95.0, 94.0, 105.0, 95.0, 95.0, 100.0], "unit": "score", "name": "imaging-darkroom", "value": 97.2}, {"lowerIsBetter": true, "replicates": [95.0, 93.0, 90.0, 91.0, 92.0, 93.0, 93.0, 93.0, 91.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 92.3}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 57.0, 54.0, 57.0, 56.0, 56.0, 61.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 90.0, 100.0, 110.0, 70.0, 71.0, 66.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.7}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 87.0, 81.0, 84.0, 83.0, 87.0, 86.0, 85.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 115.0, 133.0, 125.0, 125.0, 124.0, 124.0, 135.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 130.0}, {"lowerIsBetter": true, "replicates": [138.0, 140.0, 151.0, 173.0, 149.0, 142.0, 140.0, 139.0, 142.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 68.0, 64.0, 67.0, 69.0, 70.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.0}], "name": "kraken", "value": 1486.3}]} 18:42:09 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1486.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7526.70"}}} 18:42:09 INFO - Return code: 0 18:42:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:42:09 INFO - # TBPL SUCCESS # 18:42:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:42:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:42:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:42:09 INFO - 2016-02-02 18:42:09.140 screenresolution[2005:18838] starting screenresolution argv=screenresolution get 18:42:09 INFO - 2016-02-02 18:42:09.143 screenresolution[2005:18838] Display 0: 1600x1200x32@60 18:42:09 INFO - 2016-02-02 18:42:09.149 screenresolution[2006:18841] starting screenresolution argv=screenresolution list 18:42:09 INFO - Available Modes on Display 0 18:42:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:42:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:42:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:42:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:42:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:42:09 INFO - Intel Iris: 18:42:09 INFO - Chipset Model: Intel Iris 18:42:09 INFO - Type: GPU 18:42:09 INFO - Bus: Built-In 18:42:09 INFO - VRAM (Dynamic, Max): 1536 MB 18:42:09 INFO - Vendor: Intel (0x8086) 18:42:09 INFO - Device ID: 0x0a2e 18:42:09 INFO - Revision ID: 0x0009 18:42:09 INFO - Displays: 18:42:09 INFO - Display: 18:42:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:42:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:42:09 INFO - Display Serial Number: 1600x1200 60 18:42:09 INFO - Main Display: Yes 18:42:09 INFO - Mirror: Off 18:42:09 INFO - Online: Yes 18:42:09 INFO - Rotation: Supported 18:42:09 INFO - Return code: 0 18:42:09 INFO - Running post-action listener: _resource_record_post_action 18:42:09 INFO - Running post-run listener: _resource_record_post_run 18:42:10 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 2383872; Write bytes: 711389696; Read time: 89; Write time: 2177 18:42:10 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 403606016; Write bytes: 406638080; Read time: 30258; Write time: 802 18:42:10 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 2383872; Write bytes: 303125504; Read time: 89; Write time: 1302 18:42:10 INFO - Running post-run listener: _upload_blobber_files 18:42:10 INFO - Blob upload gear active. 18:42:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:42:10 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 18:42:10 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'] 18:42:10 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 18:42:10 INFO - (blobuploader) - INFO - Open directory for files ... 18:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:11 INFO - (blobuploader) - INFO - Done attempting. 18:42:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:42:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:42:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:42:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:42:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:42:12 INFO - (blobuploader) - INFO - Done attempting. 18:42:12 INFO - (blobuploader) - INFO - Iteration through files over. 18:42:12 INFO - Return code: 0 18:42:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:42:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:42:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65080adc02f2940123d940cbbd7a877d7121a51bb47d91236854119b227363b94572003b5a962991612be53f8558ffa5b6828ba18e9201d97a9023537dbc1bc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a9af8511cfc0b689547fbc84c416865aec87cda7c2669ac02111a6ddbe4a681e822d4e404cd0189c295084f1194053fc5b58a3e00a4a838db0089ff92705f8f"} 18:42:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:42:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:42:12 INFO - Contents: 18:42:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65080adc02f2940123d940cbbd7a877d7121a51bb47d91236854119b227363b94572003b5a962991612be53f8558ffa5b6828ba18e9201d97a9023537dbc1bc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a9af8511cfc0b689547fbc84c416865aec87cda7c2669ac02111a6ddbe4a681e822d4e404cd0189c295084f1194053fc5b58a3e00a4a838db0089ff92705f8f"} 18:42:12 INFO - Running post-run listener: copy_logs_to_upload_dir 18:42:12 INFO - Copying logs to upload dir... 18:42:12 INFO - mkdir: /builds/slave/test/build/upload/logs 18:42:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.765218 ========= master_lag: 2.52 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2016-02-02 18:42:15.176207) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 18:42:15.180220) ========= 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.U0obbBpey9/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.9m7vSSvF5s/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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/65080adc02f2940123d940cbbd7a877d7121a51bb47d91236854119b227363b94572003b5a962991612be53f8558ffa5b6828ba18e9201d97a9023537dbc1bc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a9af8511cfc0b689547fbc84c416865aec87cda7c2669ac02111a6ddbe4a681e822d4e404cd0189c295084f1194053fc5b58a3e00a4a838db0089ff92705f8f"} build_url:https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/WBoKRG69TeKfv02_c9IBng/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/65080adc02f2940123d940cbbd7a877d7121a51bb47d91236854119b227363b94572003b5a962991612be53f8558ffa5b6828ba18e9201d97a9023537dbc1bc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a9af8511cfc0b689547fbc84c416865aec87cda7c2669ac02111a6ddbe4a681e822d4e404cd0189c295084f1194053fc5b58a3e00a4a838db0089ff92705f8f"}' ========= master_lag: 0.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-02 18:42:15.469209) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 18:42:15.469540) ========= 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.U0obbBpey9/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.9m7vSSvF5s/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.005170 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-02 18:42:15.491993) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 18:42:15.492384) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-02 18:42:15.493091) ========= ========= Total master_lag: 3.06 =========