builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0041 starttime: 1454085148.34 results: success (0) buildid: 20160129073442 builduid: 69be05109f7443de8fe4f5823435a69e revision: ccbe2dff012aa388153990e0a3e9c1323663270a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:28.339509) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:28.339972) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:28.340266) ========= 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.tfPmhL7p7I/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.KhQujuV5bc/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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.005982 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:28.363607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:28.363967) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:28.387462) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:28.387726) ========= 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.tfPmhL7p7I/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.KhQujuV5bc/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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.005362 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:28.476683) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:28.477007) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:28.477403) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:28.477672) ========= 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.tfPmhL7p7I/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.KhQujuV5bc/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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-01-29 08:32:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.36M=0.001s 2016-01-29 08:32:29 (8.36 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.599580 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:29.093521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:29.093809) ========= 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.tfPmhL7p7I/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.KhQujuV5bc/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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.020265 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:29.142788) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-29 08:32:29.143140) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ccbe2dff012aa388153990e0a3e9c1323663270a --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 ccbe2dff012aa388153990e0a3e9c1323663270a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tfPmhL7p7I/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.KhQujuV5bc/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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-01-29 08:32:29,223 truncating revision to first 12 chars 2016-01-29 08:32:29,223 Setting DEBUG logging. 2016-01-29 08:32:29,223 attempt 1/10 2016-01-29 08:32:29,223 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ccbe2dff012a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-29 08:32:29,825 unpacking tar archive at: fx-team-ccbe2dff012a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.015877 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-29 08:32:30.176860) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:30.177157) ========= echo ccbe2dff012aa388153990e0a3e9c1323663270a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ccbe2dff012aa388153990e0a3e9c1323663270a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tfPmhL7p7I/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.KhQujuV5bc/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 ccbe2dff012aa388153990e0a3e9c1323663270a program finished with exit code 0 elapsedTime=0.005240 script_repo_revision: 'ccbe2dff012aa388153990e0a3e9c1323663270a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:30.232006) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:30.232404) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-29 08:32:30.248159) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-29 08:32:30.248521) ========= /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.tfPmhL7p7I/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.KhQujuV5bc/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 08:32:30 INFO - MultiFileLogger online at 20160129 08:32:30 in /builds/slave/test 08:32:30 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 08:32:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:30 INFO - {'append_to_log': False, 08:32:30 INFO - 'base_work_dir': '/builds/slave/test', 08:32:30 INFO - 'blob_upload_branch': 'Fx-Team', 08:32:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:30 INFO - 'branch': 'Fx-Team', 08:32:30 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:30 INFO - 'config_files': ('talos/mac_config.py',), 08:32:30 INFO - 'default_actions': ('clobber', 08:32:30 INFO - 'read-buildbot-config', 08:32:30 INFO - 'download-and-extract', 08:32:30 INFO - 'populate-webroot', 08:32:30 INFO - 'create-virtualenv', 08:32:30 INFO - 'install', 08:32:30 INFO - 'run-tests'), 08:32:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:30 INFO - 'download_minidump_stackwalk': True, 08:32:30 INFO - 'download_symbols': 'ondemand', 08:32:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:30 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:30 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:30 INFO - 'installer_path': 'installer.exe', 08:32:30 INFO - 'log_level': 'info', 08:32:30 INFO - 'log_name': 'talos', 08:32:30 INFO - 'log_to_console': True, 08:32:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:32:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:32:30 INFO - 'opt_config_files': (), 08:32:30 INFO - 'pip_index': False, 08:32:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:32:30 INFO - 'cmd': ('bash', 08:32:30 INFO - '-c', 08:32:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:32:30 INFO - 'enabled': True, 08:32:30 INFO - 'halt_on_failure': False, 08:32:30 INFO - 'name': 'check_screen_resolution'},), 08:32:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:32:30 INFO - 'cmd': ('bash', 08:32:30 INFO - '-c', 08:32:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:32:30 INFO - 'enabled': True, 08:32:30 INFO - 'halt_on_failure': False, 08:32:30 INFO - 'name': 'check_screen_resolution'},), 08:32:30 INFO - 'run_cmd_checks_enabled': True, 08:32:30 INFO - 'sps_profile': False, 08:32:30 INFO - 'sps_profile_interval': 0, 08:32:30 INFO - 'suite': 'dromaeojs-e10s', 08:32:30 INFO - 'system_bits': '32', 08:32:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:30 INFO - 'title': 't-yosemite-r7-0041', 08:32:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:30 INFO - 'use_talos_json': True, 08:32:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:30 INFO - 'work_dir': 'build'} 08:32:30 INFO - ##### 08:32:30 INFO - ##### Running clobber step. 08:32:30 INFO - ##### 08:32:30 INFO - Running pre-action listener: _resource_record_pre_action 08:32:30 INFO - Running main action method: clobber 08:32:30 INFO - rmtree: /builds/slave/test/build 08:32:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:31 INFO - Running post-action listener: _resource_record_post_action 08:32:31 INFO - ##### 08:32:31 INFO - ##### Running read-buildbot-config step. 08:32:31 INFO - ##### 08:32:31 INFO - Running pre-action listener: _resource_record_pre_action 08:32:31 INFO - Running main action method: read_buildbot_config 08:32:31 INFO - Using buildbot properties: 08:32:31 INFO - { 08:32:31 INFO - "project": "", 08:32:31 INFO - "product": "firefox", 08:32:31 INFO - "script_repo_revision": "production", 08:32:31 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:32:31 INFO - "repository": "", 08:32:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:32:31 INFO - "buildid": "20160129073442", 08:32:31 INFO - "pgo_build": "False", 08:32:31 INFO - "basedir": "/builds/slave/test", 08:32:31 INFO - "buildnumber": 274, 08:32:31 INFO - "slavename": "t-yosemite-r7-0041", 08:32:31 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:32:31 INFO - "platform": "yosemite_r7", 08:32:31 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:32:31 INFO - "branch": "fx-team", 08:32:31 INFO - "repo_path": "integration/fx-team", 08:32:31 INFO - "revision": "ccbe2dff012aa388153990e0a3e9c1323663270a", 08:32:31 INFO - "stage_platform": "macosx64", 08:32:31 INFO - "builduid": "69be05109f7443de8fe4f5823435a69e", 08:32:31 INFO - "slavebuilddir": "test" 08:32:31 INFO - } 08:32:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 08:32:31 INFO - Running post-action listener: _resource_record_post_action 08:32:31 INFO - ##### 08:32:31 INFO - ##### Running download-and-extract step. 08:32:31 INFO - ##### 08:32:31 INFO - Running pre-action listener: _resource_record_pre_action 08:32:31 INFO - Running main action method: download_and_extract 08:32:31 INFO - mkdir: /builds/slave/test/build/tests 08:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:31 INFO - https://queue.taskcluster.net/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:32:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/test_packages.json 08:32:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/test_packages.json 08:32:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:32:52 INFO - Downloaded 1277 bytes. 08:32:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:32:52 INFO - Using the following test package requirements: 08:32:52 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:32:52 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:32:52 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 08:32:52 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:32:52 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 08:32:52 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:32:52 INFO - u'jsshell-mac.zip'], 08:32:52 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:32:52 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 08:32:52 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:32:52 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:32:52 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 08:32:52 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:32:52 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 08:32:52 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:32:52 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 08:32:52 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:32:52 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:32:52 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 08:32:52 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:32:52 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')]} 08:32:52 INFO - https://queue.taskcluster.net/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:32:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:32:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:32:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/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 08:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/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 08:32:53 INFO - Downloaded 16722317 bytes. 08:32:53 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'] 08:32:53 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 08:32:56 INFO - Return code: 0 08:32:56 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 08:32: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')]} 08:32:56 INFO - https://queue.taskcluster.net/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:32:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:32:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:32:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/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 08:32:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/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 08:32:58 INFO - Downloaded 16722317 bytes. 08:32:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:32:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:33:02 INFO - Return code: 0 08:33:02 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')]} 08:33:02 INFO - https://queue.taskcluster.net/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:33:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:33:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:33:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/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 08:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/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 08:33:03 INFO - Downloaded 10706582 bytes. 08:33:03 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'] 08:33:03 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 08:33:03 INFO - Return code: 0 08:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:03 INFO - https://queue.taskcluster.net/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:33:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:33:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:33:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 08:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SY2_ofHPT5-rOq2Y8AROkg/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 08:33:08 INFO - Downloaded 111022955 bytes. 08:33:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:33:08 INFO - mkdir: /builds/slave/test/properties 08:33:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:33:08 INFO - Writing to file /builds/slave/test/properties/build_url 08:33:08 INFO - Contents: 08:33:08 INFO - build_url:https://queue.taskcluster.net/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:33:08 INFO - Running post-action listener: _resource_record_post_action 08:33:08 INFO - Running post-action listener: set_extra_try_arguments 08:33:08 INFO - ##### 08:33:08 INFO - ##### Running populate-webroot step. 08:33:08 INFO - ##### 08:33:08 INFO - Running pre-action listener: _resource_record_pre_action 08:33:08 INFO - Running main action method: populate_webroot 08:33:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:33:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:33:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:33:08 INFO - '--tppagecycles', 08:33:08 INFO - '7'], 08:33:08 INFO - 'tests': ['tsvgm']}}, 08:33:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:33:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:33:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:33:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:33:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:33:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:33:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:33:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:08 INFO - 'talos_options': ['--e10s'], 08:33:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:33:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:08 INFO - 'tests': ['damp', 'tps']}, 08:33:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:08 INFO - 'talos_options': ['--e10s'], 08:33:08 INFO - 'tests': ['damp', 'tps']}, 08:33:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:33:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:33:08 INFO - 'other': {'tests': ['a11yr', 08:33:08 INFO - 'ts_paint', 08:33:08 INFO - 'tpaint', 08:33:08 INFO - 'sessionrestore', 08:33:08 INFO - 'sessionrestore_no_auto_restore']}, 08:33:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:33:08 INFO - 'tests': ['a11yr', 08:33:08 INFO - 'ts_paint', 08:33:08 INFO - 'tpaint', 08:33:08 INFO - 'sessionrestore', 08:33:08 INFO - 'sessionrestore_no_auto_restore']}, 08:33:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:33:08 INFO - 'tests': ['a11yr', 08:33:08 INFO - 'ts_paint', 08:33:08 INFO - 'tpaint', 08:33:08 INFO - 'sessionrestore', 08:33:08 INFO - 'sessionrestore_no_auto_restore']}, 08:33:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:33:08 INFO - 'tests': ['a11yr', 08:33:08 INFO - 'ts_paint', 08:33:08 INFO - 'tpaint', 08:33:08 INFO - 'sessionrestore', 08:33:08 INFO - 'sessionrestore_no_auto_restore']}, 08:33:08 INFO - 'other_l64': {'tests': ['a11yr', 08:33:08 INFO - 'ts_paint', 08:33:08 INFO - 'tpaint', 08:33:08 INFO - 'sessionrestore', 08:33:08 INFO - 'sessionrestore_no_auto_restore']}, 08:33:08 INFO - 'other_nol64': {'tests': ['a11yr', 08:33:08 INFO - 'ts_paint', 08:33:08 INFO - 'tpaint', 08:33:08 INFO - 'sessionrestore', 08:33:08 INFO - 'sessionrestore_no_auto_restore']}, 08:33:08 INFO - 'svgr': {'tests': ['tsvgx', 08:33:08 INFO - 'tsvgr_opacity', 08:33:08 INFO - 'tart', 08:33:08 INFO - 'tscrollx', 08:33:08 INFO - 'cart']}, 08:33:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:33:08 INFO - 'tests': ['tsvgx', 08:33:08 INFO - 'tsvgr_opacity', 08:33:08 INFO - 'tart', 08:33:08 INFO - 'tscrollx', 08:33:08 INFO - 'cart']}, 08:33:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:08 INFO - 'tests': ['tp5o']}, 08:33:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:08 INFO - 'talos_options': ['--e10s'], 08:33:08 INFO - 'tests': ['tp5o']}, 08:33:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:08 INFO - 'talos_options': ['--xperf_path', 08:33:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:33:08 INFO - 'tests': ['tp5n']}, 08:33:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:08 INFO - 'talos_options': ['--e10s', 08:33:08 INFO - '--xperf_path', 08:33:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:33:08 INFO - 'tests': ['tp5n']}}, 08:33:08 INFO - 'talos.zip': {'path': '', 08:33:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:33:08 INFO - Running post-action listener: _resource_record_post_action 08:33:08 INFO - ##### 08:33:08 INFO - ##### Running create-virtualenv step. 08:33:08 INFO - ##### 08:33:08 INFO - Running pre-action listener: _resource_record_pre_action 08:33:08 INFO - Running main action method: create_virtualenv 08:33:08 INFO - Creating virtualenv /builds/slave/test/build/venv 08:33:08 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 08:33:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:33:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:33:08 INFO - Using real prefix '/tools/python27' 08:33:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:33:09 INFO - Installing distribute.............................................................................................................................................................................................done. 08:33:12 INFO - Installing pip.................done. 08:33:12 INFO - Return code: 0 08:33:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:33:12 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')]} 08:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:12 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')]} 08:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:12 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 0x104250a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a4d6060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f5d30>, '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 0x103f58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tfPmhL7p7I/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.KhQujuV5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 08:33:12 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 08:33:12 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 08:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tfPmhL7p7I/Render', 08:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:12 INFO - 'HOME': '/Users/cltbld', 08:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:12 INFO - 'LOGNAME': 'cltbld', 08:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:12 INFO - 'MOZ_NO_REMOTE': '1', 08:33:12 INFO - 'NO_EM_RESTART': '1', 08:33:12 INFO - 'PAGER': '/bin/cat', 08:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:12 INFO - 'PWD': '/builds/slave/test', 08:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:12 INFO - 'SHELL': '/bin/bash', 08:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhQujuV5bc/Listeners', 08:33:12 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 08:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:12 INFO - 'USER': 'cltbld', 08:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:12 INFO - 'XPC_FLAGS': '0x0', 08:33:12 INFO - 'XPC_SERVICE_NAME': '0', 08:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:12 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 08:33:12 INFO - Cleaning up... 08:33:12 INFO - Return code: 0 08:33:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:33:12 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')]} 08:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:12 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')]} 08:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:12 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 0x104250a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a4d6060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f5d30>, '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 0x103f58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tfPmhL7p7I/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.KhQujuV5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 08:33:12 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 08:33:12 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 08:33:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tfPmhL7p7I/Render', 08:33:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:12 INFO - 'HOME': '/Users/cltbld', 08:33:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:12 INFO - 'LOGNAME': 'cltbld', 08:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:12 INFO - 'MOZ_NO_REMOTE': '1', 08:33:12 INFO - 'NO_EM_RESTART': '1', 08:33:12 INFO - 'PAGER': '/bin/cat', 08:33:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:12 INFO - 'PWD': '/builds/slave/test', 08:33:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:12 INFO - 'SHELL': '/bin/bash', 08:33:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhQujuV5bc/Listeners', 08:33:12 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 08:33:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:12 INFO - 'USER': 'cltbld', 08:33:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:12 INFO - 'XPC_FLAGS': '0x0', 08:33:12 INFO - 'XPC_SERVICE_NAME': '0', 08:33:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:12 INFO - Downloading/unpacking psutil>=0.7.1 08:33:12 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 08:33:12 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 08:33:12 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 08:33:12 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 08:33:12 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 08:33:12 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 08:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:33:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:15 INFO - Installing collected packages: psutil 08:33:15 INFO - Running setup.py install for psutil 08:33:15 INFO - building 'psutil._psutil_osx' extension 08:33:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:33:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:33:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:33:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:33:16 INFO - building 'psutil._psutil_posix' extension 08:33:16 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 08:33:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:33:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:33:16 INFO - ^ 08:33:16 INFO - 1 warning generated. 08:33:16 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 08:33:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:16 INFO - Successfully installed psutil 08:33:16 INFO - Cleaning up... 08:33:16 INFO - Return code: 0 08:33:16 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:33:16 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')]} 08:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:16 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')]} 08:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:16 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 0x104250a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a4d6060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f5d30>, '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 0x103f58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tfPmhL7p7I/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.KhQujuV5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 08:33:16 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 08:33:16 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 08:33:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tfPmhL7p7I/Render', 08:33:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:16 INFO - 'HOME': '/Users/cltbld', 08:33:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:16 INFO - 'LOGNAME': 'cltbld', 08:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:16 INFO - 'MOZ_NO_REMOTE': '1', 08:33:16 INFO - 'NO_EM_RESTART': '1', 08:33:16 INFO - 'PAGER': '/bin/cat', 08:33:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:16 INFO - 'PWD': '/builds/slave/test', 08:33:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:16 INFO - 'SHELL': '/bin/bash', 08:33:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhQujuV5bc/Listeners', 08:33:16 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 08:33:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:16 INFO - 'USER': 'cltbld', 08:33:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:16 INFO - 'XPC_FLAGS': '0x0', 08:33:16 INFO - 'XPC_SERVICE_NAME': '0', 08:33:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:33:16 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 08:33:16 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 08:33:16 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 08:33:16 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 08:33:16 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 08:33:16 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 08:33:18 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:33:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:33:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:33:19 INFO - Installing collected packages: mozsystemmonitor 08:33:19 INFO - Running setup.py install for mozsystemmonitor 08:33:19 INFO - Successfully installed mozsystemmonitor 08:33:19 INFO - Cleaning up... 08:33:19 INFO - Return code: 0 08:33:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:33:19 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')]} 08:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:19 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')]} 08:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:19 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 0x104250a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a4d6060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f5d30>, '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 0x103f58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tfPmhL7p7I/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.KhQujuV5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 08:33:19 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 08:33:19 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 08:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tfPmhL7p7I/Render', 08:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:19 INFO - 'HOME': '/Users/cltbld', 08:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:19 INFO - 'LOGNAME': 'cltbld', 08:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:19 INFO - 'MOZ_NO_REMOTE': '1', 08:33:19 INFO - 'NO_EM_RESTART': '1', 08:33:19 INFO - 'PAGER': '/bin/cat', 08:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:19 INFO - 'PWD': '/builds/slave/test', 08:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:19 INFO - 'SHELL': '/bin/bash', 08:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhQujuV5bc/Listeners', 08:33:19 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 08:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:19 INFO - 'USER': 'cltbld', 08:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:19 INFO - 'XPC_FLAGS': '0x0', 08:33:19 INFO - 'XPC_SERVICE_NAME': '0', 08:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:19 INFO - Downloading/unpacking blobuploader==1.2.4 08:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:21 INFO - Downloading blobuploader-1.2.4.tar.gz 08:33:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:33:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:33:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:22 INFO - Downloading docopt-0.6.1.tar.gz 08:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:33:22 INFO - Installing collected packages: blobuploader, requests, docopt 08:33:22 INFO - Running setup.py install for blobuploader 08:33:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:33:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:33:23 INFO - Running setup.py install for requests 08:33:23 INFO - Running setup.py install for docopt 08:33:23 INFO - Successfully installed blobuploader requests docopt 08:33:23 INFO - Cleaning up... 08:33:23 INFO - Return code: 0 08:33:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104250a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a4d6060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f5d30>, '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 0x103f58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tfPmhL7p7I/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.KhQujuV5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 08:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tfPmhL7p7I/Render', 08:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:23 INFO - 'HOME': '/Users/cltbld', 08:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:23 INFO - 'LOGNAME': 'cltbld', 08:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:23 INFO - 'MOZ_NO_REMOTE': '1', 08:33:23 INFO - 'NO_EM_RESTART': '1', 08:33:23 INFO - 'PAGER': '/bin/cat', 08:33:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:23 INFO - 'PWD': '/builds/slave/test', 08:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:23 INFO - 'SHELL': '/bin/bash', 08:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhQujuV5bc/Listeners', 08:33:23 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 08:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:23 INFO - 'USER': 'cltbld', 08:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:23 INFO - 'XPC_FLAGS': '0x0', 08:33:23 INFO - 'XPC_SERVICE_NAME': '0', 08:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:24 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-bmEUGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:24 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-CjbvUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:24 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-YKpsTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:24 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-oYrMxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:24 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-ob7QAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:24 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-X_0qfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:24 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-eLeGVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:24 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-A6cJ0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:24 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-HeILJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:24 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-l5zjR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:25 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-0xnzkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:25 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-434wQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:25 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-VVThJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:25 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-XREZJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:25 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-HnEk3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:25 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-cYUGVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:25 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-zP3BZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:33:25 INFO - Running setup.py install for manifestparser 08:33:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:33:25 INFO - Running setup.py install for mozcrash 08:33:26 INFO - Running setup.py install for mozdebug 08:33:26 INFO - Running setup.py install for mozdevice 08:33:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:33:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:33:26 INFO - Running setup.py install for mozfile 08:33:26 INFO - Running setup.py install for mozhttpd 08:33:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:33:26 INFO - Running setup.py install for mozinfo 08:33:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:33:26 INFO - Running setup.py install for mozInstall 08:33:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:33:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:33:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:33:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:33:26 INFO - Running setup.py install for mozleak 08:33:27 INFO - Running setup.py install for mozlog 08:33:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:33:27 INFO - Running setup.py install for moznetwork 08:33:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:33:27 INFO - Running setup.py install for mozprocess 08:33:27 INFO - Running setup.py install for mozprofile 08:33:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:33:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:33:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:33:27 INFO - Running setup.py install for mozrunner 08:33:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:33:27 INFO - Running setup.py install for mozscreenshot 08:33:28 INFO - Running setup.py install for moztest 08:33:28 INFO - Running setup.py install for mozversion 08:33:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:33:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:33:28 INFO - Cleaning up... 08:33:28 INFO - Return code: 0 08:33:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:28 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 0x104250a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a4d6060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f5d30>, '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 0x103f58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tfPmhL7p7I/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.KhQujuV5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 08:33:28 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 08:33:28 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 08:33:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tfPmhL7p7I/Render', 08:33:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:28 INFO - 'HOME': '/Users/cltbld', 08:33:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:28 INFO - 'LOGNAME': 'cltbld', 08:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:28 INFO - 'MOZ_NO_REMOTE': '1', 08:33:28 INFO - 'NO_EM_RESTART': '1', 08:33:28 INFO - 'PAGER': '/bin/cat', 08:33:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:28 INFO - 'PWD': '/builds/slave/test', 08:33:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:28 INFO - 'SHELL': '/bin/bash', 08:33:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhQujuV5bc/Listeners', 08:33:28 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 08:33:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:28 INFO - 'USER': 'cltbld', 08:33:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:28 INFO - 'XPC_FLAGS': '0x0', 08:33:28 INFO - 'XPC_SERVICE_NAME': '0', 08:33:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:33:28 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-RwP7yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:33:28 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-3MAgg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:33:28 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-JaglGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:33:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:33:28 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-J8JxP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:33:29 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)) 08:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:33:29 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-aqzoSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:33:29 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)) 08:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:33:29 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-jbVlev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:33:29 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)) 08:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:33:29 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-ejK0ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:33:29 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)) 08:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:33:29 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-FiqHOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:33:29 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)) 08:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:33:29 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-_qTIoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:33:29 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)) 08:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:33:29 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-BNORF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:33:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:33:29 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-Hmop3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:33:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:33:29 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-0AZVO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:33:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:33:29 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-3X0_rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:33:30 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)) 08:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:33:30 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-qdc4Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:33:30 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)) 08:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:30 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-w2X28s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:33:30 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)) 08:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:33:30 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-AmuZrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:33:30 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)) 08:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:33:30 INFO - Running setup.py (path:/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/pip-I_bnAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:33:30 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)) 08:33:30 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)) 08:33:30 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)) 08:33:30 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)) 08:33:30 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)) 08:33:30 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)) 08:33:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:30 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 08:33:30 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 08:33:30 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 08:33:30 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 08:33:30 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 08:33:30 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 08:33:33 INFO - Downloading blessings-1.6.tar.gz 08:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:33:33 INFO - Installing collected packages: blessings 08:33:33 INFO - Running setup.py install for blessings 08:33:33 INFO - Successfully installed blessings 08:33:33 INFO - Cleaning up... 08:33:33 INFO - Return code: 0 08:33:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:33:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:33 INFO - Reading from file tmpfile_stdout 08:33:33 INFO - Current package versions: 08:33:33 INFO - blessings == 1.6 08:33:33 INFO - blobuploader == 1.2.4 08:33:33 INFO - docopt == 0.6.1 08:33:33 INFO - manifestparser == 1.1 08:33:33 INFO - mozInstall == 1.12 08:33:33 INFO - mozcrash == 0.16 08:33:33 INFO - mozdebug == 0.1 08:33:33 INFO - mozdevice == 0.48 08:33:33 INFO - mozfile == 1.2 08:33:33 INFO - mozhttpd == 0.7 08:33:33 INFO - mozinfo == 0.9 08:33:33 INFO - mozleak == 0.1 08:33:33 INFO - mozlog == 3.1 08:33:33 INFO - moznetwork == 0.27 08:33:33 INFO - mozprocess == 0.22 08:33:33 INFO - mozprofile == 0.28 08:33:33 INFO - mozrunner == 6.11 08:33:33 INFO - mozscreenshot == 0.1 08:33:33 INFO - mozsystemmonitor == 0.0 08:33:33 INFO - moztest == 0.7 08:33:33 INFO - mozversion == 1.4 08:33:33 INFO - psutil == 3.1.1 08:33:33 INFO - requests == 1.2.3 08:33:33 INFO - wsgiref == 0.1.2 08:33:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:33:33 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')]} 08:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:34 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 0x104250a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a4d6060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f5d30>, '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 0x103f58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tfPmhL7p7I/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.KhQujuV5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 08:33:34 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 08:33:34 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 08:33:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tfPmhL7p7I/Render', 08:33:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:34 INFO - 'HOME': '/Users/cltbld', 08:33:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:34 INFO - 'LOGNAME': 'cltbld', 08:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:34 INFO - 'MOZ_NO_REMOTE': '1', 08:33:34 INFO - 'NO_EM_RESTART': '1', 08:33:34 INFO - 'PAGER': '/bin/cat', 08:33:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:34 INFO - 'PWD': '/builds/slave/test', 08:33:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:34 INFO - 'SHELL': '/bin/bash', 08:33:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhQujuV5bc/Listeners', 08:33:34 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 08:33:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:34 INFO - 'USER': 'cltbld', 08:33:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:34 INFO - 'XPC_FLAGS': '0x0', 08:33:34 INFO - 'XPC_SERVICE_NAME': '0', 08:33:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:34 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)) 08:33:34 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)) 08:33:34 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)) 08:33:34 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)) 08:33:34 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)) 08:33:34 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)) 08:33:34 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)) 08:33:34 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)) 08:33:34 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)) 08:33:34 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)) 08:33:34 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)) 08:33:34 INFO - Cleaning up... 08:33:34 INFO - Return code: 0 08:33:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:33: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')]} 08:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104250a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a4d6060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f5d30>, '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 0x103f58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tfPmhL7p7I/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.KhQujuV5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 08:33: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', 'jsonschema'] in /builds/slave/test/build 08:33: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 jsonschema 08:33:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tfPmhL7p7I/Render', 08:33:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:34 INFO - 'HOME': '/Users/cltbld', 08:33:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:34 INFO - 'LOGNAME': 'cltbld', 08:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:34 INFO - 'MOZ_NO_REMOTE': '1', 08:33:34 INFO - 'NO_EM_RESTART': '1', 08:33:34 INFO - 'PAGER': '/bin/cat', 08:33:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:34 INFO - 'PWD': '/builds/slave/test', 08:33:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:34 INFO - 'SHELL': '/bin/bash', 08:33:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhQujuV5bc/Listeners', 08:33:34 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 08:33:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:34 INFO - 'USER': 'cltbld', 08:33:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:34 INFO - 'XPC_FLAGS': '0x0', 08:33:34 INFO - 'XPC_SERVICE_NAME': '0', 08:33:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:34 INFO - Downloading/unpacking jsonschema 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:33:36 INFO - Downloading/unpacking functools32 (from jsonschema) 08:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:33:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:33:37 INFO - warning: no files found matching '*.txt' 08:33:37 INFO - no previously-included directories found matching 'build' 08:33:37 INFO - no previously-included directories found matching 'dist' 08:33:37 INFO - no previously-included directories found matching '.git*' 08:33:37 INFO - Installing collected packages: jsonschema, functools32 08:33:37 INFO - Running setup.py install for functools32 08:33:37 INFO - warning: no files found matching '*.txt' 08:33:37 INFO - no previously-included directories found matching 'build' 08:33:37 INFO - no previously-included directories found matching 'dist' 08:33:37 INFO - no previously-included directories found matching '.git*' 08:33:37 INFO - Successfully installed jsonschema functools32 08:33:37 INFO - Cleaning up... 08:33:37 INFO - Return code: 0 08:33:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:33:37 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')]} 08:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:37 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')]} 08:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:37 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 0x104250a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb54a4d6060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040f5d30>, '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 0x103f58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, '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.tfPmhL7p7I/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.KhQujuV5bc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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 08:33:37 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 08:33:37 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 08:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tfPmhL7p7I/Render', 08:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:33:37 INFO - 'HOME': '/Users/cltbld', 08:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:33:37 INFO - 'LOGNAME': 'cltbld', 08:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:37 INFO - 'MOZ_NO_REMOTE': '1', 08:33:37 INFO - 'NO_EM_RESTART': '1', 08:33:37 INFO - 'PAGER': '/bin/cat', 08:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:33:37 INFO - 'PWD': '/builds/slave/test', 08:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:33:37 INFO - 'SHELL': '/bin/bash', 08:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhQujuV5bc/Listeners', 08:33:37 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 08:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:33:37 INFO - 'USER': 'cltbld', 08:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:37 INFO - 'XPC_FLAGS': '0x0', 08:33:37 INFO - 'XPC_SERVICE_NAME': '0', 08:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:38 INFO - Downloading/unpacking flake8 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33: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 08:33:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:33:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:33:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:33:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:33:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:33:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:33:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:33:41 INFO - no previously-included directories found matching 'docs/_build' 08:33:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:33:41 INFO - Running setup.py install for pep8 08:33:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:33:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:33:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:33:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:33:41 INFO - no previously-included directories found matching 'docs/_build' 08:33:41 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:33:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:33:41 INFO - Cleaning up... 08:33:41 INFO - Return code: 0 08:33:41 INFO - Running post-action listener: _resource_record_post_action 08:33:41 INFO - Running post-action listener: _start_resource_monitoring 08:33:41 INFO - Starting resource monitoring. 08:33:41 INFO - ##### 08:33:41 INFO - ##### Running install step. 08:33:41 INFO - ##### 08:33:41 INFO - Running pre-action listener: _resource_record_pre_action 08:33:41 INFO - Running main action method: install 08:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:33:42 INFO - Reading from file tmpfile_stdout 08:33:42 INFO - Detecting whether we're running mozinstall >=1.0... 08:33:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:33:42 INFO - Reading from file tmpfile_stdout 08:33:42 INFO - Output received: 08:33:42 INFO - Usage: mozinstall [options] installer 08:33:42 INFO - Options: 08:33:42 INFO - -h, --help show this help message and exit 08:33:42 INFO - -d DEST, --destination=DEST 08:33:42 INFO - Directory to install application into. [default: 08:33:42 INFO - "/builds/slave/test"] 08:33:42 INFO - --app=APP Application being installed. [default: firefox] 08:33:42 INFO - mkdir: /builds/slave/test/build/application 08:33:42 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'] 08:33:42 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 08:34:16 INFO - Reading from file tmpfile_stdout 08:34:16 INFO - Output received: 08:34:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:34:16 INFO - Running post-action listener: _resource_record_post_action 08:34:16 INFO - ##### 08:34:16 INFO - ##### Running run-tests step. 08:34:16 INFO - ##### 08:34:16 INFO - Running pre-action listener: _resource_record_pre_action 08:34:16 INFO - Running main action method: run_tests 08:34:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:34:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:34:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:34:16 INFO - 2016-01-29 08:34:16.350 screenresolution[2358:20557] starting screenresolution argv=screenresolution get 08:34:16 INFO - 2016-01-29 08:34:16.353 screenresolution[2358:20557] Display 0: 1600x1200x32@60 08:34:16 INFO - 2016-01-29 08:34:16.359 screenresolution[2359:20559] starting screenresolution argv=screenresolution list 08:34:16 INFO - Available Modes on Display 0 08:34:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:34:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:34:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:34:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:34:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:34:16 INFO - Intel Iris: 08:34:16 INFO - Chipset Model: Intel Iris 08:34:16 INFO - Type: GPU 08:34:16 INFO - Bus: Built-In 08:34:16 INFO - VRAM (Dynamic, Max): 1536 MB 08:34:16 INFO - Vendor: Intel (0x8086) 08:34:16 INFO - Device ID: 0x0a2e 08:34:16 INFO - Revision ID: 0x0009 08:34:16 INFO - Displays: 08:34:16 INFO - Display: 08:34:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:34:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:34:16 INFO - Display Serial Number: 1600x1200 60 08:34:16 INFO - Main Display: Yes 08:34:16 INFO - Mirror: Off 08:34:16 INFO - Online: Yes 08:34:16 INFO - Rotation: Supported 08:34:16 INFO - Return code: 0 08:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:34:16 INFO - Python 2.7.3 08:34:16 INFO - Return code: 0 08:34:16 INFO - grabbing minidump binary from tooltool 08:34:16 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')]} 08:34:16 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 0x1040f5d30>, '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 0x103f58db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040ebb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:34:16 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 08:34:16 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 08:34:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:34:16 INFO - Return code: 0 08:34:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:34:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:34:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:34:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:34:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:34:17 INFO - Return code: 0 08:34:17 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/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0041', '--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 08:34:17 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/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0041 --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 08:34:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tfPmhL7p7I/Render', 08:34:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:34:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:34:17 INFO - 'HOME': '/Users/cltbld', 08:34:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:34:17 INFO - 'LOGNAME': 'cltbld', 08:34:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:34:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:34:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:34:17 INFO - 'MOZ_NO_REMOTE': '1', 08:34:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:34:17 INFO - 'NO_EM_RESTART': '1', 08:34:17 INFO - 'PAGER': '/bin/cat', 08:34:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:34:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:34:17 INFO - 'PWD': '/builds/slave/test', 08:34:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:34:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:34:17 INFO - 'SHELL': '/bin/bash', 08:34:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KhQujuV5bc/Listeners', 08:34:17 INFO - 'TMPDIR': '/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/', 08:34:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:34:17 INFO - 'USER': 'cltbld', 08:34:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:34:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:34:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:34:17 INFO - 'XPC_FLAGS': '0x0', 08:34:17 INFO - 'XPC_SERVICE_NAME': '0', 08:34:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:34:17 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/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0041', '--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 08:34:18 INFO - mozversion application_buildid: 20160129073442 08:34:18 INFO - mozversion application_changeset: ccbe2dff012aa388153990e0a3e9c1323663270a 08:34:18 INFO - mozversion application_display_name: Nightly 08:34:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:34:18 INFO - mozversion application_name: Firefox 08:34:18 INFO - mozversion application_remotingname: firefox 08:34:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:34:18 INFO - mozversion application_vendor: Mozilla 08:34:18 INFO - mozversion application_version: 47.0a1 08:34:18 INFO - mozversion platform_buildid: 20160129073442 08:34:18 INFO - mozversion platform_changeset: ccbe2dff012aa388153990e0a3e9c1323663270a 08:34:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:34:18 INFO - mozversion platform_version: 47.0a1 08:34:18 INFO - using testdate: 1454085258 08:34:18 INFO - actual date: 1454085258 08:34:18 INFO - starting webserver on 'localhost:49685' 08:34:18 INFO - SUITE-START | Running 2 tests 08:34:18 INFO - TEST-START | dromaeo_css 08:34:18 INFO - operating with platform_type : mac_ 08:34:18 INFO - Initialising browser for dromaeo_css test... 08:34:18 INFO - TEST-INFO | started process 2377 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmpX4xDSq/profile http://localhost:49685/getInfo.html) 08:34:21 INFO - PROCESS | 2377 | __metrics Screen width/height:1600/1200 08:34:21 INFO - PROCESS | 2377 | colorDepth:24 08:34:21 INFO - PROCESS | 2377 | Browser inner width/height: 1024/689 08:34:21 INFO - PROCESS | 2377 | __metrics 08:34:21 INFO - PROCESS | 2377 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:34:21 INFO - TEST-INFO | 2377: exit 0 08:34:21 INFO - Browser initialized. 08:34:21 INFO - Running cycle 1/1 for dromaeo_css test... 08:34:21 INFO - TEST-INFO | started process 2381 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmpX4xDSq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:33 INFO - PROCESS | 2381 | RSS: Main: 256290816 08:34:33 INFO - PROCESS | 2381 | 08:35:23 INFO - PROCESS | 2381 | 1454085323571 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] 08:37:34 INFO - PROCESS | 2381 | Cycle 1(1): loaded http://localhost:49685/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49685/tests/dromaeo/cssquery-ext.html) 08:37:35 INFO - PROCESS | 2381 | RSS: Main: 270594048 08:37:35 INFO - PROCESS | 2381 | 08:40:37 INFO - PROCESS | 2381 | Cycle 1(1): loaded http://localhost:49685/tests/dromaeo/cssquery-ext.html (next: http://localhost:49685/tests/dromaeo/cssquery-jquery.html) 08:40:38 INFO - PROCESS | 2381 | RSS: Main: 282226688 08:40:38 INFO - PROCESS | 2381 | 08:43:40 INFO - PROCESS | 2381 | Cycle 1(1): loaded http://localhost:49685/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49685/tests/dromaeo/cssquery-mootools.html) 08:43:40 INFO - PROCESS | 2381 | RSS: Main: 283586560 08:43:40 INFO - PROCESS | 2381 | 08:46:42 INFO - PROCESS | 2381 | Cycle 1(1): loaded http://localhost:49685/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49685/tests/dromaeo/cssquery-prototype.html) 08:46:43 INFO - PROCESS | 2381 | RSS: Main: 284884992 08:46:43 INFO - PROCESS | 2381 | 08:49:45 INFO - PROCESS | 2381 | Cycle 1(1): loaded http://localhost:49685/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49685/tests/dromaeo/cssquery-yui.html) 08:49:46 INFO - PROCESS | 2381 | RSS: Main: 288657408 08:49:46 INFO - PROCESS | 2381 | 08:52:48 INFO - PROCESS | 2381 | Cycle 1(1): loaded http://localhost:49685/tests/dromaeo/cssquery-yui.html (next: http://localhost:49685/tests/dromaeo/cssquery-dojo.html) 08:52:48 INFO - PROCESS | 2381 | RSS: Main: 290435072 08:52:48 INFO - PROCESS | 2381 | 08:52:48 INFO - PROCESS | 2381 | __start_tp_report 08:52:48 INFO - PROCESS | 2381 | _x_x_mozilla_page_load 08:52:48 INFO - PROCESS | 2381 | _x_x_mozilla_page_load_details 08:52:48 INFO - PROCESS | 2381 | |i|pagename|runs| 08:52:48 INFO - PROCESS | 2381 | |0;dojo.html;3426.657334266574;3547.7161827053837;3566.1084728817796;3589.030961640357;3590.6947909427704;4930.827421040264;5581.358143813468;5835.124731290309;5902.911456328158;5922.466977971982;5647.689377084259;5804.535637149029;5806.216160818299;5822.82531524055;5876.76492940283;5143.562797162227;5176.50823171799;5218.42597314297;5256.185291279858;5299.496547827969;4792.952070479286;5315.946840531603;5329.360476742796;5342.626016178869;5410.404855465896;5141;5160.690358578498;5242.056429842627;5253.50091741284;5276.12943864262;5200.401953775327;5211.973940130313;5218.843434696965;5225.111731005738;5228.529432351107;5174.948250517522;5214.661047031968;5243.187305967581;5244.65909715871;5263.605229607757;5435.728213589305;5649.378568357477;5744.540436765049;5777;5839.182514447981;5243.659162154448;5751.309842818847;5774.105013722879;6227.501799856046;6292.433680968735;6243.250809902841;6251.093591429218;6264.185655864754;6267.091271765568;6274.309825919146;5803.129530570406;5817.854553636193;5911.704414779287;5971.671558064261;5996.2504686914135;6280.407340089155;6306.873862522724;6332.240131184288;6338.8415289617205;6393.424591786761;5218.9739051304505;6000.579959402888;6208.379162083756;6250;6289.245290565162;6184.041473571604;6236.906446403307;6248.31268560458;6268.404501572343;6270.49836013127;6182.6599537024995;6231.626102433868;6251.4061164189325;6273.529485288622;6285.9057114143325;6139.768135342631;6232.407921247474;6247.250329960343;6247.375262473716;6267.843303917439;4860.927086093711;4949.579285760678;4952.455229924777;4956.504349565014;4994.076095922266;4470;4472.8210871565425;4473;4488.596026357578;4515.645306408064;5666.575006874501;5789.768409263666;5804.593678442553;5883.3234178069215;5902.2327097477055;6162.876742465126;6227.221597300338;6250;6261.405166509175;6286.842828929313;5871.853203669943;5874.324452687995;5887.1463637772285;5904.1734157218025;5929.970350148222;5277.8416647500635;5332.066888294533;5440.836774896759;5461.15352120422;5461.508464238238;6193.597416167935;6217.347178546278;6242.375762423721;6252.187215662026;6330.050492426173;6213.96893015532;6228.065790131516;6236.220472440945;6240.563160578716;6252.218472690914;6228.5951413158;6383.202099737533;6385.361463853577;6389.9680501597195;6396.104545363746;6145.4161854623735;6157.6613286269685;6234.189555357774;6235.189425374672;6248.718807653576;6266.091416744455;6268.247810262797;6269.811905642838;6271.404216599416;6286.497080233662;6057.818265452043;6250.562460627712;6253.593516421418;6256.937430625636;6317.936820631735;5571.220029195997;5711.286089238845;6114.785982490592;6125.47964319526;6138.600990935575;5125.897482050413;5961.314448838266;6027.517798576016;6082.118092876596;6101.420365065312;6101.633901965896;6137.65279220269;6223.595466294676;6237.095621135;6258.874822503433;6126.387361264016;6169.784057557964;6176.938230617816;6177.938220617736;6194.225721784777 08:52:48 INFO - PROCESS | 2381 | |1;ext.html;454.911292298002;496.6424174594291;508.40770502364745;514.6320380927637;564.0298686259633;31776.68223317766;37538.624613753855;38069.42895856561;38087;38225;34980.475292870564;40133.59866401342;41277.17445651085;41304.17391652173;41352.37971430431;9513.1913787328;9658.372205806636;9756.41461512308;9764.755881102958;9800.607975681;9574.186194173504;9707.514624268793;9736.26977976651;9752.756181095458;9754.853677194847;9711.368761030546;9726.416415015086;9770.951145244264;9779.266555008368;9796.26528010402;9591.760205994837;9673.22614190863;9685.903140968605;9701;9732.07545283197;9576.377535460173;9666.178374838148;9715.854262186072;9728.075832795874;9799.657012004545;38670.80664596659;39116.60883391158;39123.41314880279;39196.80401598002;41381;3152;3174.492081266986;3200.4079245339685;3204.871805127792;3571.3035957988204;28078.859605702044;28175.15474535767;28306;28817.423651526853;29476;2766.101017169428;2834.6881842997254;2861.585070164835;2874.2095923620964;2958.40831833632;481407.3014888959;482399;482778;483582;485499;52424.68938276573;53228.733856331244;60188.39811601828;60477.69761151166;60517.09224361638;57361.852762945346;57566.560835979435;57581.71209143927;57631.71184144136;57734.42265577374;16188;16494.505164845075;16511;16529.917350413172;16545.338186472647;12681.49274029047;12698;12729.427175777113;12733.872661273268;12756.872431275568;15743.842561574467;18793.81206187948;18811.81188188128;18918.81081189198;19092.71360929587;7797.181295963956;7898.486598371088;7931.2068793120225;7962.800929976797;7975.282224599698;925.3430064654036;955.2405837359316;1003.1723827841913;1011.5346940407347;1050.8423736439595;29226.97705580337;29537.556936645968;29554.375202613573;29749.256268593457;30037.098887033422;1015.192921627308;1091.9344839309667;1125.1617544929081;1212.5994476379794;1215.471269997554;14262.144271343544;15231.695366092616;15331.846681533265;15430.074195548303;15654.452094176877;536460;540040;541722;545006;548406;57224.141637875466;57521.71239143861;57523.712381438665;57734.42265577374;57783.71108144432;1316.3352506983913;1358.3479929633831;1421.3390773290469;1430.342042660367;1433.6559225785736;29659.258518537208;29789.851050745474;29825.403491930472;31224.53163202599;31470.685293146777;52306.47693523016;52561.68595784983;52850.207246892096;52957.47042529525;52968.20547691865;438363;438692;441098;441997;443125;30859.84570077135;32262.838685806422;32809.01572952815;32818.83590582127;32829;40535.797321013204;42558.787206063775;43749.34375984299;43779.562204378824;44707.32939005853;33307.83346083254;34121.82939085289;34748.47877281893;34826.78106266269;35672.821635892695;35526;35836.64163358333;36810.63189368072;36832.63167368292;37214.255714886094;33975.830120849234;34275.31449371049;34320.48519272263;34373;34424;29481.410371792874;30445;30548.541771873883;30755;32096.518552222202;24027.639585405883;24423.02307907735;24433;24437.633435498126;24439 08:52:48 INFO - PROCESS | 2381 | |2;jquery.html;358.84210947183254;359.8146954318525;361.82270687363194;368.80637665225754;369.1951545630524;14304.642383940394;15329.616759581017;17865.19606617702;18947.71578426323;20094.39716808496;11680.357580333079;12471.625851224455;19055.42833714987;19097.52256193596;19174.80825191751;3896.688264938798;4777.641676874231;5057.772400241998;5312.203169524583;5349.491798279158;3976.383660532622;5710.685912274823;6008.909866351986;6018.819435416923;6025.276966763972;5661.8584535386735;5963.9403605964035;5990.400959904018;6003.429674180968;6028.125921741344;5824.359320474744;5871.735771890275;5909.7340619672;5978;6449.193850768654;5655.773769049233;5688.203651488795;5697.886042279172;5704.600677952545;5709.314882214161;23635;24092.518149636908;24134.517309653886;24429.877850610632;24731.90851143607;2220.8667479951255;2299.4136495193784;2394.5809483340345;2602.9067791527414;2619.6594442722517;9209.263258939269;9490.193333566654;9709.854352184722;9720.562574684085;9875;1684.45588887173;1761.6652835961254;1772.769539959797;1780.830821072009;1797.1373740604583;94352.056479435;97040;97071.51464242634;98927.0214595704;99811.50282745765;10995.450227488753;11095.223334366518;11138.27601205919;11232.98903098725;11292.661220163409;13536.390862411215;13559.45762169502;13611.591652250449;13633.25017124048;13716.862831371758;8558.229759321692;8568.143185681507;8600.784980375416;8625.439346442461;8674.436161649473;8628.26659733917;8686.782830429163;8690.218505206418;8756.299496040428;8776.692815751545;3254.5280934264397;3580.803055831954;3707.0917625181464;3803.353429916921;4137.213929353413;1747.8726221587006;1813.03002893454;1825.3611236067536;1867.9533011674816;1888.4145914766466;918.903515130915;964.7877466957399;985.2512090810892;1009.2934945538005;1051.02254902941;18748.906255468635;19276;19317.61364772697;19463.12415941258;19591.412257632295;948.8766460360109;958.324381311174;965.0976337124811;967.849983252597;1016.1413605503337;10335.069843714102;10537.262391632665;10557.313774604627;10644.893551064544;10854.403007834644;676027;756690;757761;784830;789029;73213.90179147317;104580;117932.82067179219;120539.39730301467;121995;1122.4275619433984;1163.4124766992784;1179.3159967219165;1206.0532482001586;1219.9695007624703;17801;18095;18188.181531830836;18330.17514211837;18488.445346639623;40146;42689.7193084208;47761.32835350746;47995;50393.74803125961;65078;65377.69244615176;65753.34246657472;65830.67084664738;66588.6670566644;7330.120385553768;7602.8099297518;7665.540067595962;7745.22547745221;7751.3411360035025;4378.956210437855;9332.486713230837;9397.859032114387;9809.166220871306;12036.939815300868;10047.145992590711;10400.427976461368;10517.842232366675;10676;10826.404547749635;10159.644412445528;10280.023397777199;10291.43397113136;10475.738106547396;10628.202884783517;10300.072993430627;10308.433036183082;10575.418351990715;10605.681829545127;10845.457727113771;7331.706731730671;7531.510451820614;7605.619719013916;7620.8475830484185;7689.192634773268;9295.814083718153;10573.312734672221;10645.912685321171;10765.623203187852;10826.188035897181 08:52:48 INFO - PROCESS | 2381 | |3;mootools.html;1521.954341369759;1546.4046342158265;1562.671838913828;1787.5352408373826;1929.913153908075;7795.610219489031;7908.051033875943;8687.08785577514;8899.510526921025;8913.910860891398;7184.712611495534;8537.018242902068;8630.352723545728;8637.654493820255;8695.782605434868;2444.3033735385375;2473.950520989579;2489.6638953741285;2496.5381404440145;2497.862617556034;2430.769076937697;2474.2453551666736;2479.6776419065495;2488.2410864686262;2493.9002439902383;2447.0945750072497;2461.6430617560445;2496.662950501677;2497.612870005143;2502.949941001179;2446.4740080882607;2476.839005464648;2480.8263421560496;2483.838550494212;2485.3413845331;2440.365504968721;2466.691663542057;2468.7531246875346;2479.454520005596;2501.0996041425074;8761.693340733043;8807.823843523094;8808.823823523493;8828.779280517974;8872.245859101984;4721.905561888777;5379.596530260246;5463.31708536433;5530.391656917735;5531.9723401383135;3647.908802279964;3684.244729830378;3744.307303148926;3769.491118698968;3774.1508160663907;1038.646860067573;1071.2233630617818;1075.3225467955217;1086.8913108689069;1103.1615971861443;11981.94009029958;11995.880041199563;12128.45421956014;12137;12166;4860.635452341018;4888.755562221874;4931.408231012229;4963.305137280783;4965.379327584052;8551.358648101417;10120.190384769201;10120.34217775857;10145.28982971185;10156.39061656303;5453.072977593819;5473;5476.644018138808;5502.202180683858;5524.4199359067525;4421.071574969293;4527.026689261825;4889.242167464049;4982.10322142018;5039.614106120773;3470.6182319944787;3950.308695978192;3954.189391174802;4005.97847548879;4015.6988225883174;1158.3802665573878;1323.1796286302554;1325.5029363988504;1336.051403503504;1352.4184600621827;1125.3979121170298;1127.4644543841773;1138.135017386792;1253.6301790971502;1344.4286178374152;7904.1700621435075;8059.435839491297;8111.269985701315;8332.250097491255;8359.665613375397;501.20308709152624;501.801788293622;503.22252120473956;506.8150125204274;518.3235877180241;6212.968935155295;6222.502199824004;6232;6279.686015699197;6296.370362963667;10503.579856805642;10883.727906802234;10928.672139835817;10932.781344373068;10939.726506837234;10386.532606032746;10614.469276536296;10619.469026548642;10723.624673136403;10812.891871081189;7133.822919218374;8286.958565207135;8373.41386102979;8465.407421480437;8492.702755403654;7830.334421574002;7832.21677832235;7848;7899.09160446533;7918.960405197937;9488.715338539854;9520.61917523319;9657.5856035991;9663.275254356093;9736.805263894825;9796.412215267106;9891.258155638212;9977.850332245167;10112.089911907964;10133.695989120339;6748.493862960396;6887.380135787603;7380.852382952418;7544.698212071456;7631.54210747357;6691.364320389555;7566.638005158904;7897.68409263623;7908.130105688255;7916.960415197887;6708.597484150967;7600.733974311093;7609.201033891583;7709.807254818675;7769.145394006542;7375.55746655181;7391;7413.814654633462;7486.850262994819;7565.394768418403;7629.809254768676;7656.042994625672;7670.041244844395;7675.654595543326;7695.384369250334;6165.938340616536;7013.193482749345;7057.929420705727;7091;7125.5368401053765;6127.754889804358;6878.312168783082;7149.642517874189;7199.748008819666;7209.341851374108 08:52:48 INFO - PROCESS | 2381 | |4;prototype.html;325.89734233716376;329.3084522502743;330.3805364940736;337.39269315232593;338.6004514672686;5764.5100166485845;6677.899831502531;6844.555103918255;6847.760328388507;6922.065521154649;6643.734250629969;6792.524523283372;6806.863862722743;6837.726490940357;6842.04211410403;5004.724740139291;5009.599232061444;5011.42368627607;5026.472220416858;5048.1670524363435;4787.8324258650955;5028.170351891933;5042.722650254234;5048.747562621873;5055.115354812911;4861.392325959255;4866.051120031595;4877.365942427479;4886.193778026622;4898.951010489903;4853.95146048542;4873.731944743037;4876.073546026261;4878.292647566119;4889.682170658932;3426.8629254829775;4086.8773936781945;4089.325261331877;4136.090060186754;4182.079942412694;6552.6068435894;6553.836154096138;6604.900926486107;6610.9669451652435;6669.933300667029;5900.085486749518;5906.586538942276;5916.852078698024;5920.407959204045;5927.703614819242;7107.502474826764;7286.089238845145;7340.669669864869;7380.0405947227055;7407.925850751665;4746.83386081489;4748.145333839908;4763.737994410306;4783.091212669582;4787.066522028206;6435.967820160869;7743.612819359009;7795.103563090261;7809.062912450486;7814;4604.8388306409115;4802.759862006886;4810.086083644096;4822.445418776815;4833.540813622701;4851.223804191312;4861.465238823726;4869.902601947942;4879.56083952446;4882.926756098661;4993.475685053089;5870.442307980735;5902.822915312548;5908.143319218775;5910.083936989773;7228.63856807168;7428.702851885972;7431.405487560982;7435.293647103516;7451.403887688972;1690.467502736634;1709.8803083784264;1711.8972861628342;1715.2452920714845;1717.4418314047734;1080.8702955645374;1082.7076689294004;1095.6932059023486;1100.4937728644913;1101.6970333158445;6858.039874417585;6869.278725733826;6907.792766217021;6927.861442771116;6937.826554336081;6689.130413046273;7683.270089341504;7700.768976930701;7702.653380597774;7705.614719264015;6527.412532872065;6688.297728738413;6880.071190389233;6886.10480637514;6960.37356637905;3488.5116083748294;3633.672969432711;3934.7605504266066;4007.338789099824;4065.8576949807207;6500.447461965691;7970.974657797775;8014.719484818003;8047.919520804834;8107.324582887633;7992.720254791055;8001.239882211181;8005.639746211435;8014.278714915686;8018;6442.61344319333;6520.804375868732;7741.806454838562;7991.960040199761;8082.555459449787;7746.961265193638;7752.65113069902;7760.611969401394;7767.961160194162;7790.065192176975;6339.334369891095;7345.6694448751;7563.470557060953;7573.129090154703;7577.924220757722;7988.960055199919;8007.719729809429;8020.318272946864;8051.154628763896;8071.031476222656;4811.903761924812;4856.562909338177;4869.805207791649;4872.464028956882;4881.658283920092;6370.490360771035;7674.155842857393;7686.3466605336935;7710;7717.344025757873;7398.11222653285;7501.62491875415;7527.322540971339;7527.924720752722;7541.057367829021;7222.133343998544;7441.665125069277;7451.2921272479025;7455.813604659927;7477.401807855467;7297.306755858185;7302.34278914879;7312.597807120659;7324.304191101837;7329.267073292842;7497.737579184703;7502.137254215617;7523.3229009389415;7530.736424225345;7557;7063.5055546113335;7299.124105107421;7309.451791115581;7309.561426314438;7345.192028876926 08:52:48 INFO - PROCESS | 2381 | |5;yui.html;622.37140488107;653.9308231042247;673.579013116802;698.9475789315801;728.0135416510628;14785.408583656654;15052.397904083837;15121.31954062067;15189.936704430695;17175.57061073474;15589.532314030568;15599;15660.138692371915;15675.529734107995;15694.686106277868;696.4219697650938;709.5317090720126;857.3355649371756;871.904090550039;875.1904488348284;848.3552500099937;864.7708357285293;875.6366108065146;877.7717793373737;879.4855009819263;890.3945317184312;913.8949020862619;914.2000749344323;914.3919293669702;915.8763566918448;887.9289656827439;893.0890491698464;897.349421669291;905.311962908188;911.9179273865318;647.5596594315863;661.2362721057186;663.3797399431547;666.9499787515956;675.1796567170862;13305.534306299232;14806.629834254121;14971.850281497154;15016.549503514912;15016.774748378783;12436.378181091;12537.122401431903;12673.683157921034;12677.936610316981;13077.21536707791;10244.231682623833;10365;11552.3646199459;11597.014253788439;11624;3125.749940004794;3464.082018265162;3529.5764508258917;3659.158393569494;3696.796676182809;79687;79985.60007199986;80093;80178.39643207162;82499.5875020621;9339.439633622005;9344.626214951326;9376.156145946761;9575.856362154573;9647.517624118906;20242.898785506273;20619.793802062086;20694.586108277752;20736.274230401865;20756;7483.139438964588;7586.696532138763;7628.0464941882265;7781.299683028441;8023.679052837938;4117.505899292104;4149.398337241083;4150.481189851269;4154.729942553724;4168.854090106832;3585.964140358615;3607.9278414432088;3610.458431235336;3631.946735446691;3632.56409230894;697.553565717941;701.8876979683226;704.915410150775;705.0750507703685;725.4450345485708;553.7231384307846;617.3178637605381;620.1163342237294;634.5811764235582;641.8780431717959;8258.339332853357;8667.349948753868;8679.826403472021;8729.650813967497;8770.079141690157;477.5701868318472;531.2695044314069;538.727942389091;544.6432586655668;546.8386825886373;3886.4947556817433;3926.7447615904875;4037.1723796621623;4117;4163.417121602978;65699.6860062796;90247.54876225708;91244;91649.62525562121;93521;75255;75293;75690.62154689191;76268;76719.61640191764;67669.66165169142;68226;68299.29251768647;68473.63052738918;68961.2759681012;8408.87386689188;8729.956350218463;8901.629750131391;8918.37571369998;9186.678466253648;48018.5198148028;49360.25959610681;50446.73883152804;51033.489665102876;51459.48540514547;54548.72725636346;65361;65616;65842.67078664576;66072.66963665151;10961.61634342826;11002.119830413387;11186.888131118585;11288.94355528217;11654.592089276835;11725.76548469043;12058.879411205775;12109.636710898687;12139.150259481752;12401.379931003594;10353.896461035594;10934.343939363664;11573.826392603949;11888.34614096233;12376.195547289397;11429.314241145557;11454.083673306282;11507;11792.056635469313;11874.871887170704;11332.150088743212;11446.713832154262;11724.531018759155;12032.217905836093;12287;9437.292203084658;9486.667966621135;9506.572204250688;9768.36505627132;10541.4729263535;8280.875786863322;8813;8924.419912705653;9059.139381758723;9602.423854568748 08:52:48 INFO - PROCESS | 2381 | __end_tp_report 08:52:48 INFO - PROCESS | 2381 | __start_cc_report 08:52:48 INFO - PROCESS | 2381 | _x_x_mozilla_cycle_collect,361 08:52:48 INFO - PROCESS | 2381 | __end_cc_report 08:52:48 INFO - PROCESS | 2381 | __startTimestamp1454086368795__endTimestamp 08:52:48 INFO - PROCESS | 2381 | 08:52:48 INFO - PROCESS | 2381 | ------- Summary: start ------- 08:52:48 INFO - PROCESS | 2381 | Number of tests: 6 08:52:48 INFO - PROCESS | 2381 | 08:52:48 INFO - PROCESS | 2381 | [#0] dojo.html Cycles:165 Average:5766.31 Median:5996.25 stddev:630.96 (10.5%) stddev-sans-first:605.61 08:52:48 INFO - PROCESS | 2381 | Values: 3426.7 3547.7 3566.1 3589.0 3590.7 4930.8 5581.4 5835.1 5902.9 5922.5 5647.7 5804.5 5806.2 5822.8 5876.8 5143.6 5176.5 5218.4 5256.2 5299.5 4793.0 5315.9 5329.4 5342.6 5410.4 5141.0 5160.7 5242.1 5253.5 5276.1 5200.4 5212.0 5218.8 5225.1 5228.5 5174.9 5214.7 5243.2 5244.7 5263.6 5435.7 5649.4 5744.5 5777.0 5839.2 5243.7 5751.3 5774.1 6227.5 6292.4 6243.3 6251.1 6264.2 6267.1 6274.3 5803.1 5817.9 5911.7 5971.7 5996.3 6280.4 6306.9 6332.2 6338.8 6393.4 5219.0 6000.6 6208.4 6250.0 6289.2 6184.0 6236.9 6248.3 6268.4 6270.5 6182.7 6231.6 6251.4 6273.5 6285.9 6139.8 6232.4 6247.3 6247.4 6267.8 4860.9 4949.6 4952.5 4956.5 4994.1 4470.0 4472.8 4473.0 4488.6 4515.6 5666.6 5789.8 5804.6 5883.3 5902.2 6162.9 6227.2 6250.0 6261.4 6286.8 5871.9 5874.3 5887.1 5904.2 5930.0 5277.8 5332.1 5440.8 5461.2 5461.5 6193.6 6217.3 6242.4 6252.2 6330.1 6214.0 6228.1 6236.2 6240.6 6252.2 6228.6 6383.2 6385.4 6390.0 6396.1 6145.4 6157.7 6234.2 6235.2 6248.7 6266.1 6268.2 6269.8 6271.4 6286.5 6057.8 6250.6 6253.6 6256.9 6317.9 5571.2 5711.3 6114.8 6125.5 6138.6 5125.9 5961.3 6027.5 6082.1 6101.4 6101.6 6137.7 6223.6 6237.1 6258.9 6126.4 6169.8 6176.9 6177.9 6194.2 08:52:48 INFO - PROCESS | 2381 | 08:52:48 INFO - PROCESS | 2381 | [#1] ext.html Cycles:180 Average:62801.25 Median:37804.03 stddev:130456.71 (345.1%) stddev-sans-first:130738.69 08:52:48 INFO - PROCESS | 2381 | Values: 454.9 496.6 508.4 514.6 564.0 31776.7 37538.6 38069.4 38087.0 38225.0 34980.5 40133.6 41277.2 41304.2 41352.4 9513.2 9658.4 9756.4 9764.8 9800.6 9574.2 9707.5 9736.3 9752.8 9754.9 9711.4 9726.4 9771.0 9779.3 9796.3 9591.8 9673.2 9685.9 9701.0 9732.1 9576.4 9666.2 9715.9 9728.1 9799.7 38670.8 39116.6 39123.4 39196.8 41381.0 3152.0 3174.5 3200.4 3204.9 3571.3 28078.9 28175.2 28306.0 28817.4 29476.0 2766.1 2834.7 2861.6 2874.2 2958.4 481407.3 482399.0 482778.0 483582.0 485499.0 52424.7 53228.7 60188.4 60477.7 60517.1 57361.9 57566.6 57581.7 57631.7 57734.4 16188.0 16494.5 16511.0 16529.9 16545.3 12681.5 12698.0 12729.4 12733.9 12756.9 15743.8 18793.8 18811.8 18918.8 19092.7 7797.2 7898.5 7931.2 7962.8 7975.3 925.3 955.2 1003.2 1011.5 1050.8 29227.0 29537.6 29554.4 29749.3 30037.1 1015.2 1091.9 1125.2 1212.6 1215.5 14262.1 15231.7 15331.8 15430.1 15654.5 536460.0 540040.0 541722.0 545006.0 548406.0 57224.1 57521.7 57523.7 57734.4 57783.7 1316.3 1358.3 1421.3 1430.3 1433.7 29659.3 29789.9 29825.4 31224.5 31470.7 52306.5 52561.7 52850.2 52957.5 52968.2 438363.0 438692.0 441098.0 441997.0 443125.0 30859.8 32262.8 32809.0 32818.8 32829.0 40535.8 42558.8 43749.3 43779.6 44707.3 33307.8 34121.8 34748.5 34826.8 35672.8 35526.0 35836.6 36810.6 36832.6 37214.3 33975.8 34275.3 34320.5 34373.0 34424.0 29481.4 30445.0 30548.5 30755.0 32096.5 24027.6 24423.0 24433.0 24437.6 24439.0 08:52:48 INFO - PROCESS | 2381 | 08:52:48 INFO - PROCESS | 2381 | [#2] jquery.html Cycles:180 Average:37062.61 Median:360.82 stddev:123973.88 (34359.1%) stddev-sans-first:124291.02 08:52:48 INFO - PROCESS | 2381 | Values: 358.8 359.8 361.8 368.8 369.2 14304.6 15329.6 17865.2 18947.7 20094.4 11680.4 12471.6 19055.4 19097.5 19174.8 3896.7 4777.6 5057.8 5312.2 5349.5 3976.4 5710.7 6008.9 6018.8 6025.3 5661.9 5963.9 5990.4 6003.4 6028.1 5824.4 5871.7 5909.7 5978.0 6449.2 5655.8 5688.2 5697.9 5704.6 5709.3 23635.0 24092.5 24134.5 24429.9 24731.9 2220.9 2299.4 2394.6 2602.9 2619.7 9209.3 9490.2 9709.9 9720.6 9875.0 1684.5 1761.7 1772.8 1780.8 1797.1 94352.1 97040.0 97071.5 98927.0 99811.5 10995.5 11095.2 11138.3 11233.0 11292.7 13536.4 13559.5 13611.6 13633.3 13716.9 8558.2 8568.1 8600.8 8625.4 8674.4 8628.3 8686.8 8690.2 8756.3 8776.7 3254.5 3580.8 3707.1 3803.4 4137.2 1747.9 1813.0 1825.4 1868.0 1888.4 918.9 964.8 985.3 1009.3 1051.0 18748.9 19276.0 19317.6 19463.1 19591.4 948.9 958.3 965.1 967.8 1016.1 10335.1 10537.3 10557.3 10644.9 10854.4 676027.0 756690.0 757761.0 784830.0 789029.0 73213.9 104580.0 117932.8 120539.4 121995.0 1122.4 1163.4 1179.3 1206.1 1220.0 17801.0 18095.0 18188.2 18330.2 18488.4 40146.0 42689.7 47761.3 47995.0 50393.7 65078.0 65377.7 65753.3 65830.7 66588.7 7330.1 7602.8 7665.5 7745.2 7751.3 4379.0 9332.5 9397.9 9809.2 12036.9 10047.1 10400.4 10517.8 10676.0 10826.4 10159.6 10280.0 10291.4 10475.7 10628.2 10300.1 10308.4 10575.4 10605.7 10845.5 7331.7 7531.5 7605.6 7620.8 7689.2 9295.8 10573.3 10645.9 10765.6 10826.2 08:52:48 INFO - PROCESS | 2381 | 08:52:48 INFO - PROCESS | 2381 | [#3] mootools.html Cycles:180 Average:6012.35 Median:512.57 stddev:3198.10 (623.9%) stddev-sans-first:3189.26 08:52:48 INFO - PROCESS | 2381 | Values: 1522.0 1546.4 1562.7 1787.5 1929.9 7795.6 7908.1 8687.1 8899.5 8913.9 7184.7 8537.0 8630.4 8637.7 8695.8 2444.3 2474.0 2489.7 2496.5 2497.9 2430.8 2474.2 2479.7 2488.2 2493.9 2447.1 2461.6 2496.7 2497.6 2502.9 2446.5 2476.8 2480.8 2483.8 2485.3 2440.4 2466.7 2468.8 2479.5 2501.1 8761.7 8807.8 8808.8 8828.8 8872.2 4721.9 5379.6 5463.3 5530.4 5532.0 3647.9 3684.2 3744.3 3769.5 3774.2 1038.6 1071.2 1075.3 1086.9 1103.2 11981.9 11995.9 12128.5 12137.0 12166.0 4860.6 4888.8 4931.4 4963.3 4965.4 8551.4 10120.2 10120.3 10145.3 10156.4 5453.1 5473.0 5476.6 5502.2 5524.4 4421.1 4527.0 4889.2 4982.1 5039.6 3470.6 3950.3 3954.2 4006.0 4015.7 1158.4 1323.2 1325.5 1336.1 1352.4 1125.4 1127.5 1138.1 1253.6 1344.4 7904.2 8059.4 8111.3 8332.3 8359.7 501.2 501.8 503.2 506.8 518.3 6213.0 6222.5 6232.0 6279.7 6296.4 10503.6 10883.7 10928.7 10932.8 10939.7 10386.5 10614.5 10619.5 10723.6 10812.9 7133.8 8287.0 8373.4 8465.4 8492.7 7830.3 7832.2 7848.0 7899.1 7919.0 9488.7 9520.6 9657.6 9663.3 9736.8 9796.4 9891.3 9977.9 10112.1 10133.7 6748.5 6887.4 7380.9 7544.7 7631.5 6691.4 7566.6 7897.7 7908.1 7917.0 6708.6 7600.7 7609.2 7709.8 7769.1 7375.6 7391.0 7413.8 7486.9 7565.4 7629.8 7656.0 7670.0 7675.7 7695.4 6165.9 7013.2 7057.9 7091.0 7125.5 6127.8 6878.3 7149.6 7199.7 7209.3 08:52:48 INFO - PROCESS | 2381 | 08:52:48 INFO - PROCESS | 2381 | [#4] prototype.html Cycles:180 Average:5989.16 Median:6688.71 stddev:1953.56 (29.2%) stddev-sans-first:1912.23 08:52:48 INFO - PROCESS | 2381 | Values: 325.9 329.3 330.4 337.4 338.6 5764.5 6677.9 6844.6 6847.8 6922.1 6643.7 6792.5 6806.9 6837.7 6842.0 5004.7 5009.6 5011.4 5026.5 5048.2 4787.8 5028.2 5042.7 5048.7 5055.1 4861.4 4866.1 4877.4 4886.2 4899.0 4854.0 4873.7 4876.1 4878.3 4889.7 3426.9 4086.9 4089.3 4136.1 4182.1 6552.6 6553.8 6604.9 6611.0 6669.9 5900.1 5906.6 5916.9 5920.4 5927.7 7107.5 7286.1 7340.7 7380.0 7407.9 4746.8 4748.1 4763.7 4783.1 4787.1 6436.0 7743.6 7795.1 7809.1 7814.0 4604.8 4802.8 4810.1 4822.4 4833.5 4851.2 4861.5 4869.9 4879.6 4882.9 4993.5 5870.4 5902.8 5908.1 5910.1 7228.6 7428.7 7431.4 7435.3 7451.4 1690.5 1709.9 1711.9 1715.2 1717.4 1080.9 1082.7 1095.7 1100.5 1101.7 6858.0 6869.3 6907.8 6927.9 6937.8 6689.1 7683.3 7700.8 7702.7 7705.6 6527.4 6688.3 6880.1 6886.1 6960.4 3488.5 3633.7 3934.8 4007.3 4065.9 6500.4 7971.0 8014.7 8047.9 8107.3 7992.7 8001.2 8005.6 8014.3 8018.0 6442.6 6520.8 7741.8 7992.0 8082.6 7747.0 7752.7 7760.6 7768.0 7790.1 6339.3 7345.7 7563.5 7573.1 7577.9 7989.0 8007.7 8020.3 8051.2 8071.0 4811.9 4856.6 4869.8 4872.5 4881.7 6370.5 7674.2 7686.3 7710.0 7717.3 7398.1 7501.6 7527.3 7527.9 7541.1 7222.1 7441.7 7451.3 7455.8 7477.4 7297.3 7302.3 7312.6 7324.3 7329.3 7497.7 7502.1 7523.3 7530.7 7557.0 7063.5 7299.1 7309.5 7309.6 7345.2 08:52:48 INFO - PROCESS | 2381 | 08:52:48 INFO - PROCESS | 2381 | [#5] yui.html Cycles:180 Average:18003.66 Median:628.48 stddev:24790.59 (3944.6%) stddev-sans-first:24825.78 08:52:48 INFO - PROCESS | 2381 | Values: 622.4 653.9 673.6 698.9 728.0 14785.4 15052.4 15121.3 15189.9 17175.6 15589.5 15599.0 15660.1 15675.5 15694.7 696.4 709.5 857.3 871.9 875.2 848.4 864.8 875.6 877.8 879.5 890.4 913.9 914.2 914.4 915.9 887.9 893.1 897.3 905.3 911.9 647.6 661.2 663.4 666.9 675.2 13305.5 14806.6 14971.9 15016.5 15016.8 12436.4 12537.1 12673.7 12677.9 13077.2 10244.2 10365.0 11552.4 11597.0 11624.0 3125.7 3464.1 3529.6 3659.2 3696.8 79687.0 79985.6 80093.0 80178.4 82499.6 9339.4 9344.6 9376.2 9575.9 9647.5 20242.9 20619.8 20694.6 20736.3 20756.0 7483.1 7586.7 7628.0 7781.3 8023.7 4117.5 4149.4 4150.5 4154.7 4168.9 3586.0 3607.9 3610.5 3631.9 3632.6 697.6 701.9 704.9 705.1 725.4 553.7 617.3 620.1 634.6 641.9 8258.3 8667.3 8679.8 8729.7 8770.1 477.6 531.3 538.7 544.6 546.8 3886.5 3926.7 4037.2 4117.0 4163.4 65699.7 90247.5 91244.0 91649.6 93521.0 75255.0 75293.0 75690.6 76268.0 76719.6 67669.7 68226.0 68299.3 68473.6 68961.3 8408.9 8730.0 8901.6 8918.4 9186.7 48018.5 49360.3 50446.7 51033.5 51459.5 54548.7 65361.0 65616.0 65842.7 66072.7 10961.6 11002.1 11186.9 11288.9 11654.6 11725.8 12058.9 12109.6 12139.2 12401.4 10353.9 10934.3 11573.8 11888.3 12376.2 11429.3 11454.1 11507.0 11792.1 11874.9 11332.2 11446.7 11724.5 12032.2 12287.0 9437.3 9486.7 9506.6 9768.4 10541.5 8280.9 8813.0 8924.4 9059.1 9602.4 08:52:48 INFO - PROCESS | 2381 | -------- Summary: end -------- 08:52:48 INFO - PROCESS | 2381 | 08:52:49 INFO - TEST-INFO | 2381: exit 0 08:52:49 INFO - TEST-OK | dromaeo_css | took 1111188ms 08:52:49 INFO - TEST-START | kraken 08:52:49 INFO - operating with platform_type : mac_ 08:52:49 INFO - Initialising browser for kraken test... 08:52:49 INFO - TEST-INFO | started process 2386 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmpDj3bYq/profile http://localhost:49685/getInfo.html) 08:52:52 INFO - PROCESS | 2386 | __metrics Screen width/height:1600/1200 08:52:52 INFO - PROCESS | 2386 | colorDepth:24 08:52:52 INFO - PROCESS | 2386 | Browser inner width/height: 1024/689 08:52:52 INFO - PROCESS | 2386 | __metrics 08:52:52 INFO - PROCESS | 2386 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:52:52 INFO - PROCESS | 2386 | 08:52:52 INFO - PROCESS | 2386 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 08:52:52 INFO - PROCESS | 2386 | 08:52:53 INFO - TEST-INFO | 2386: exit 0 08:52:53 INFO - Browser initialized. 08:52:53 INFO - Running cycle 1/1 for kraken test... 08:52:53 INFO - TEST-INFO | started process 2389 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/T/tmpDj3bYq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:53:05 INFO - PROCESS | 2389 | RSS: Main: 255176704 08:53:05 INFO - PROCESS | 2389 | 08:53:07 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49685/tests/kraken/driver.html?testName=audio-beat-detection) 08:53:08 INFO - PROCESS | 2389 | RSS: Main: 269783040 08:53:08 INFO - PROCESS | 2389 | 08:53:11 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49685/tests/kraken/driver.html?testName=audio-dft) 08:53:11 INFO - PROCESS | 2389 | RSS: Main: 277442560 08:53:11 INFO - PROCESS | 2389 | 08:53:14 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49685/tests/kraken/driver.html?testName=audio-fft) 08:53:15 INFO - PROCESS | 2389 | RSS: Main: 282243072 08:53:15 INFO - PROCESS | 2389 | 08:53:17 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49685/tests/kraken/driver.html?testName=audio-oscillator) 08:53:17 INFO - PROCESS | 2389 | RSS: Main: 283721728 08:53:17 INFO - PROCESS | 2389 | 08:53:19 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49685/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:53:20 INFO - PROCESS | 2389 | RSS: Main: 285454336 08:53:20 INFO - PROCESS | 2389 | 08:53:23 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49685/tests/kraken/driver.html?testName=imaging-darkroom) 08:53:24 INFO - PROCESS | 2389 | RSS: Main: 284381184 08:53:24 INFO - PROCESS | 2389 | 08:53:26 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49685/tests/kraken/driver.html?testName=imaging-desaturate) 08:53:27 INFO - PROCESS | 2389 | RSS: Main: 284299264 08:53:27 INFO - PROCESS | 2389 | 08:53:30 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49685/tests/kraken/driver.html?testName=json-parse-financial) 08:53:30 INFO - PROCESS | 2389 | RSS: Main: 284786688 08:53:30 INFO - PROCESS | 2389 | 08:53:32 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49685/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:53:33 INFO - PROCESS | 2389 | RSS: Main: 284594176 08:53:33 INFO - PROCESS | 2389 | 08:53:34 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:53:35 INFO - PROCESS | 2389 | RSS: Main: 285380608 08:53:35 INFO - PROCESS | 2389 | 08:53:37 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:53:38 INFO - PROCESS | 2389 | RSS: Main: 285573120 08:53:38 INFO - PROCESS | 2389 | 08:53:40 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:53:41 INFO - PROCESS | 2389 | RSS: Main: 285618176 08:53:41 INFO - PROCESS | 2389 | 08:53:43 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:44 INFO - PROCESS | 2389 | RSS: Main: 284786688 08:53:44 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | Cycle 1(1): loaded http://localhost:49685/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49685/tests/kraken/driver.html?testName=ai-astar) 08:53:46 INFO - PROCESS | 2389 | RSS: Main: 286224384 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | __start_tp_report 08:53:46 INFO - PROCESS | 2389 | _x_x_mozilla_page_load 08:53:46 INFO - PROCESS | 2389 | _x_x_mozilla_page_load_details 08:53:46 INFO - PROCESS | 2389 | |i|pagename|runs| 08:53:46 INFO - PROCESS | 2389 | |0;ai-astar;114;109;114;116;117;124;116;141;96;118 08:53:46 INFO - PROCESS | 2389 | |1;audio-beat-detection;172;128;150;173;118;169;167;150;153;142 08:53:46 INFO - PROCESS | 2389 | |2;audio-dft;198;196;196;208;211;212;192;196;200;197 08:53:46 INFO - PROCESS | 2389 | |3;audio-fft;67;66;73;70;128;57;57;59;58;102 08:53:46 INFO - PROCESS | 2389 | |4;audio-oscillator;82;82;134;78;82;82;118;80;82;116 08:53:46 INFO - PROCESS | 2389 | |5;imaging-gaussian-blur;85;92;89;133;127;92;90;124;86;91 08:53:46 INFO - PROCESS | 2389 | |6;imaging-darkroom;95;95;94;96;95;94;95;95;95;96 08:53:46 INFO - PROCESS | 2389 | |7;imaging-desaturate;85;80;139;148;100;91;96;90;92;91 08:53:46 INFO - PROCESS | 2389 | |8;json-parse-financial;57;54;56;53;55;54;57;61;53;54 08:53:46 INFO - PROCESS | 2389 | |9;json-stringify-tinderbox;66;65;71;74;79;75;70;68;67;67 08:53:46 INFO - PROCESS | 2389 | |10;stanford-crypto-aes;84;85;84;85;84;85;85;85;83;84 08:53:46 INFO - PROCESS | 2389 | |11;stanford-crypto-ccm;149;150;130;136;129;126;115;139;135;131 08:53:46 INFO - PROCESS | 2389 | |12;stanford-crypto-pbkdf2;141;141;140;137;141;142;141;140;135;142 08:53:46 INFO - PROCESS | 2389 | |13;stanford-crypto-sha256-iterative;65;69;69;65;70;65;68;67;67;65 08:53:46 INFO - PROCESS | 2389 | __end_tp_report 08:53:46 INFO - PROCESS | 2389 | __start_cc_report 08:53:46 INFO - PROCESS | 2389 | _x_x_mozilla_cycle_collect,872 08:53:46 INFO - PROCESS | 2389 | __end_cc_report 08:53:46 INFO - PROCESS | 2389 | __startTimestamp1454086426365__endTimestamp 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | ------- Summary: start ------- 08:53:46 INFO - PROCESS | 2389 | Number of tests: 14 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#0] ai-astar Cycles:10 Average:116.50 Median:117.50 stddev:11.30 (9.6%) stddev-sans-first:11.95 08:53:46 INFO - PROCESS | 2389 | Values: 114.0 109.0 114.0 116.0 117.0 124.0 116.0 141.0 96.0 118.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:160.00 stddev:18.84 (11.8%) stddev-sans-first:18.57 08:53:46 INFO - PROCESS | 2389 | Values: 172.0 128.0 150.0 173.0 118.0 169.0 167.0 150.0 153.0 142.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#2] audio-dft Cycles:10 Average:200.60 Median:199.00 stddev:7.07 (3.6%) stddev-sans-first:7.44 08:53:46 INFO - PROCESS | 2389 | Values: 198.0 196.0 196.0 208.0 211.0 212.0 192.0 196.0 200.0 197.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#3] audio-fft Cycles:10 Average:73.70 Median:62.50 stddev:23.30 (37.3%) stddev-sans-first:24.59 08:53:46 INFO - PROCESS | 2389 | Values: 67.0 66.0 73.0 70.0 128.0 57.0 57.0 59.0 58.0 102.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:82.00 stddev:20.63 (25.2%) stddev-sans-first:21.45 08:53:46 INFO - PROCESS | 2389 | Values: 82.0 82.0 134.0 78.0 82.0 82.0 118.0 80.0 82.0 116.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#5] imaging-gaussian-blur Cycles:10 Average:100.90 Median:89.50 stddev:18.96 (21.2%) stddev-sans-first:19.22 08:53:46 INFO - PROCESS | 2389 | Values: 85.0 92.0 89.0 133.0 127.0 92.0 90.0 124.0 86.0 91.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:53:46 INFO - PROCESS | 2389 | Values: 95.0 95.0 94.0 96.0 95.0 94.0 95.0 95.0 95.0 96.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#7] imaging-desaturate Cycles:10 Average:101.20 Median:90.50 stddev:23.04 (25.5%) stddev-sans-first:23.68 08:53:46 INFO - PROCESS | 2389 | Values: 85.0 80.0 139.0 148.0 100.0 91.0 96.0 90.0 92.0 91.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:2.46 (4.4%) stddev-sans-first:2.54 08:53:46 INFO - PROCESS | 2389 | Values: 57.0 54.0 56.0 53.0 55.0 54.0 57.0 61.0 53.0 54.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:70.50 stddev:4.54 (6.4%) stddev-sans-first:4.56 08:53:46 INFO - PROCESS | 2389 | Values: 66.0 65.0 71.0 74.0 79.0 75.0 70.0 68.0 67.0 67.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 08:53:46 INFO - PROCESS | 2389 | Values: 84.0 85.0 84.0 85.0 84.0 85.0 85.0 85.0 83.0 84.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:135.50 stddev:10.47 (7.7%) stddev-sans-first:9.59 08:53:46 INFO - PROCESS | 2389 | Values: 149.0 150.0 130.0 136.0 129.0 126.0 115.0 139.0 135.0 131.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.00 Median:141.00 stddev:2.26 (1.6%) stddev-sans-first:2.37 08:53:46 INFO - PROCESS | 2389 | Values: 141.0 141.0 140.0 137.0 141.0 142.0 141.0 140.0 135.0 142.0 08:53:46 INFO - PROCESS | 2389 | 08:53:46 INFO - PROCESS | 2389 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.94 (2.9%) stddev-sans-first:1.92 08:53:46 INFO - PROCESS | 2389 | Values: 65.0 69.0 69.0 65.0 70.0 65.0 68.0 67.0 67.0 65.0 08:53:46 INFO - PROCESS | 2389 | -------- Summary: end -------- 08:53:46 INFO - PROCESS | 2389 | 08:53:47 INFO - TEST-INFO | 2389: exit 0 08:53:47 INFO - TEST-OK | kraken | took 57714ms 08:53:47 INFO - SUITE-END | took 1168s 08:53:47 INFO - Completed test suite (00:19:29) 08:53:47 INFO - Working with test: dromaeo_css 08:53:47 INFO - Generating results file: dromaeo_css 08:53:47 INFO - Working with test: kraken 08:53:47 INFO - Generating results file: kraken 08:53:47 INFO - javascript benchmark 08:53:47 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 08:53:47 INFO - process_Request line: dromaeo_css 7499.33 graph.html#tests=[[72,64,61]] 08:53:47 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:47 INFO - process_Request line: kraken 1484.70 graph.html#tests=[[232,64,61]] 08:53:47 INFO - RETURN: dromaeo_css: 7499.33 08:53:47 INFO - RETURN: kraken: 1484.70 08:53:47 INFO - javascript benchmark 08:53:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3426.657334266574, 3547.7161827053837, 3566.1084728817796, 3589.030961640357, 3590.6947909427704, 4930.827421040264, 5581.358143813468, 5835.124731290309, 5902.911456328158, 5922.466977971982, 5647.689377084259, 5804.535637149029, 5806.216160818299, 5822.82531524055, 5876.76492940283, 5143.562797162227, 5176.50823171799, 5218.42597314297, 5256.185291279858, 5299.496547827969, 4792.952070479286, 5315.946840531603, 5329.360476742796, 5342.626016178869, 5410.404855465896, 5141.0, 5160.690358578498, 5242.056429842627, 5253.50091741284, 5276.12943864262, 5200.401953775327, 5211.973940130313, 5218.843434696965, 5225.111731005738, 5228.529432351107, 5174.948250517522, 5214.661047031968, 5243.187305967581, 5244.65909715871, 5263.605229607757, 5435.728213589305, 5649.378568357477, 5744.540436765049, 5777.0, 5839.182514447981, 5243.659162154448, 5751.309842818847, 5774.105013722879, 6227.501799856046, 6292.433680968735, 6243.250809902841, 6251.093591429218, 6264.185655864754, 6267.091271765568, 6274.309825919146, 5803.129530570406, 5817.854553636193, 5911.704414779287, 5971.671558064261, 5996.2504686914135, 6280.407340089155, 6306.873862522724, 6332.240131184288, 6338.8415289617205, 6393.424591786761, 5218.9739051304505, 6000.579959402888, 6208.379162083756, 6250.0, 6289.245290565162, 6184.041473571604, 6236.906446403307, 6248.31268560458, 6268.404501572343, 6270.49836013127, 6182.6599537024995, 6231.626102433868, 6251.4061164189325, 6273.529485288622, 6285.9057114143325, 6139.768135342631, 6232.407921247474, 6247.250329960343, 6247.375262473716, 6267.843303917439, 4860.927086093711, 4949.579285760678, 4952.455229924777, 4956.504349565014, 4994.076095922266, 4470.0, 4472.8210871565425, 4473.0, 4488.596026357578, 4515.645306408064, 5666.575006874501, 5789.768409263666, 5804.593678442553, 5883.3234178069215, 5902.2327097477055, 6162.876742465126, 6227.221597300338, 6250.0, 6261.405166509175, 6286.842828929313, 5871.853203669943, 5874.324452687995, 5887.1463637772285, 5904.1734157218025, 5929.970350148222, 5277.8416647500635, 5332.066888294533, 5440.836774896759, 5461.15352120422, 5461.508464238238, 6193.597416167935, 6217.347178546278, 6242.375762423721, 6252.187215662026, 6330.050492426173, 6213.96893015532, 6228.065790131516, 6236.220472440945, 6240.563160578716, 6252.218472690914, 6228.5951413158, 6383.202099737533, 6385.361463853577, 6389.9680501597195, 6396.104545363746, 6145.4161854623735, 6157.6613286269685, 6234.189555357774, 6235.189425374672, 6248.718807653576, 6266.091416744455, 6268.247810262797, 6269.811905642838, 6271.404216599416, 6286.497080233662, 6057.818265452043, 6250.562460627712, 6253.593516421418, 6256.937430625636, 6317.936820631735, 5571.220029195997, 5711.286089238845, 6114.785982490592, 6125.47964319526, 6138.600990935575, 5125.897482050413, 5961.314448838266, 6027.517798576016, 6082.118092876596, 6101.420365065312, 6101.633901965896, 6137.65279220269, 6223.595466294676, 6237.095621135, 6258.874822503433, 6126.387361264016, 6169.784057557964, 6176.938230617816, 6177.938220617736, 6194.225721784777], "unit": "score", "name": "dojo.html", "value": 5728.648733169325}, {"lowerIsBetter": false, "replicates": [454.911292298002, 496.6424174594291, 508.40770502364745, 514.6320380927637, 564.0298686259633, 31776.68223317766, 37538.624613753855, 38069.42895856561, 38087.0, 38225.0, 34980.475292870564, 40133.59866401342, 41277.17445651085, 41304.17391652173, 41352.37971430431, 9513.1913787328, 9658.372205806636, 9756.41461512308, 9764.755881102958, 9800.607975681, 9574.186194173504, 9707.514624268793, 9736.26977976651, 9752.756181095458, 9754.853677194847, 9711.368761030546, 9726.416415015086, 9770.951145244264, 9779.266555008368, 9796.26528010402, 9591.760205994837, 9673.22614190863, 9685.903140968605, 9701.0, 9732.07545283197, 9576.377535460173, 9666.178374838148, 9715.854262186072, 9728.075832795874, 9799.657012004545, 38670.80664596659, 39116.60883391158, 39123.41314880279, 39196.80401598002, 41381.0, 3152.0, 3174.492081266986, 3200.4079245339685, 3204.871805127792, 3571.3035957988204, 28078.859605702044, 28175.15474535767, 28306.0, 28817.423651526853, 29476.0, 2766.101017169428, 2834.6881842997254, 2861.585070164835, 2874.2095923620964, 2958.40831833632, 481407.3014888959, 482399.0, 482778.0, 483582.0, 485499.0, 52424.68938276573, 53228.733856331244, 60188.39811601828, 60477.69761151166, 60517.09224361638, 57361.852762945346, 57566.560835979435, 57581.71209143927, 57631.71184144136, 57734.42265577374, 16188.0, 16494.505164845075, 16511.0, 16529.917350413172, 16545.338186472647, 12681.49274029047, 12698.0, 12729.427175777113, 12733.872661273268, 12756.872431275568, 15743.842561574467, 18793.81206187948, 18811.81188188128, 18918.81081189198, 19092.71360929587, 7797.181295963956, 7898.486598371088, 7931.2068793120225, 7962.800929976797, 7975.282224599698, 925.3430064654036, 955.2405837359316, 1003.1723827841913, 1011.5346940407347, 1050.8423736439595, 29226.97705580337, 29537.556936645968, 29554.375202613573, 29749.256268593457, 30037.098887033422, 1015.192921627308, 1091.9344839309667, 1125.1617544929081, 1212.5994476379794, 1215.471269997554, 14262.144271343544, 15231.695366092616, 15331.846681533265, 15430.074195548303, 15654.452094176877, 536460.0, 540040.0, 541722.0, 545006.0, 548406.0, 57224.141637875466, 57521.71239143861, 57523.712381438665, 57734.42265577374, 57783.71108144432, 1316.3352506983913, 1358.3479929633831, 1421.3390773290469, 1430.342042660367, 1433.6559225785736, 29659.258518537208, 29789.851050745474, 29825.403491930472, 31224.53163202599, 31470.685293146777, 52306.47693523016, 52561.68595784983, 52850.207246892096, 52957.47042529525, 52968.20547691865, 438363.0, 438692.0, 441098.0, 441997.0, 443125.0, 30859.84570077135, 32262.838685806422, 32809.01572952815, 32818.83590582127, 32829.0, 40535.797321013204, 42558.787206063775, 43749.34375984299, 43779.562204378824, 44707.32939005853, 33307.83346083254, 34121.82939085289, 34748.47877281893, 34826.78106266269, 35672.821635892695, 35526.0, 35836.64163358333, 36810.63189368072, 36832.63167368292, 37214.255714886094, 33975.830120849234, 34275.31449371049, 34320.48519272263, 34373.0, 34424.0, 29481.410371792874, 30445.0, 30548.541771873883, 30755.0, 32096.518552222202, 24027.639585405883, 24423.02307907735, 24433.0, 24437.633435498126, 24439.0], "unit": "score", "name": "ext.html", "value": 19392.347903100163}, {"lowerIsBetter": false, "replicates": [358.84210947183254, 359.8146954318525, 361.82270687363194, 368.80637665225754, 369.1951545630524, 14304.642383940394, 15329.616759581017, 17865.19606617702, 18947.71578426323, 20094.39716808496, 11680.357580333079, 12471.625851224455, 19055.42833714987, 19097.52256193596, 19174.80825191751, 3896.688264938798, 4777.641676874231, 5057.772400241998, 5312.203169524583, 5349.491798279158, 3976.383660532622, 5710.685912274823, 6008.909866351986, 6018.819435416923, 6025.276966763972, 5661.8584535386735, 5963.9403605964035, 5990.400959904018, 6003.429674180968, 6028.125921741344, 5824.359320474744, 5871.735771890275, 5909.7340619672, 5978.0, 6449.193850768654, 5655.773769049233, 5688.203651488795, 5697.886042279172, 5704.600677952545, 5709.314882214161, 23635.0, 24092.518149636908, 24134.517309653886, 24429.877850610632, 24731.90851143607, 2220.8667479951255, 2299.4136495193784, 2394.5809483340345, 2602.9067791527414, 2619.6594442722517, 9209.263258939269, 9490.193333566654, 9709.854352184722, 9720.562574684085, 9875.0, 1684.45588887173, 1761.6652835961254, 1772.769539959797, 1780.830821072009, 1797.1373740604583, 94352.056479435, 97040.0, 97071.51464242634, 98927.0214595704, 99811.50282745765, 10995.450227488753, 11095.223334366518, 11138.27601205919, 11232.98903098725, 11292.661220163409, 13536.390862411215, 13559.45762169502, 13611.591652250449, 13633.25017124048, 13716.862831371758, 8558.229759321692, 8568.143185681507, 8600.784980375416, 8625.439346442461, 8674.436161649473, 8628.26659733917, 8686.782830429163, 8690.218505206418, 8756.299496040428, 8776.692815751545, 3254.5280934264397, 3580.803055831954, 3707.0917625181464, 3803.353429916921, 4137.213929353413, 1747.8726221587006, 1813.03002893454, 1825.3611236067536, 1867.9533011674816, 1888.4145914766466, 918.903515130915, 964.7877466957399, 985.2512090810892, 1009.2934945538005, 1051.02254902941, 18748.906255468635, 19276.0, 19317.61364772697, 19463.12415941258, 19591.412257632295, 948.8766460360109, 958.324381311174, 965.0976337124811, 967.849983252597, 1016.1413605503337, 10335.069843714102, 10537.262391632665, 10557.313774604627, 10644.893551064544, 10854.403007834644, 676027.0, 756690.0, 757761.0, 784830.0, 789029.0, 73213.90179147317, 104580.0, 117932.82067179219, 120539.39730301467, 121995.0, 1122.4275619433984, 1163.4124766992784, 1179.3159967219165, 1206.0532482001586, 1219.9695007624703, 17801.0, 18095.0, 18188.181531830836, 18330.17514211837, 18488.445346639623, 40146.0, 42689.7193084208, 47761.32835350746, 47995.0, 50393.74803125961, 65078.0, 65377.69244615176, 65753.34246657472, 65830.67084664738, 66588.6670566644, 7330.120385553768, 7602.8099297518, 7665.540067595962, 7745.22547745221, 7751.3411360035025, 4378.956210437855, 9332.486713230837, 9397.859032114387, 9809.166220871306, 12036.939815300868, 10047.145992590711, 10400.427976461368, 10517.842232366675, 10676.0, 10826.404547749635, 10159.644412445528, 10280.023397777199, 10291.43397113136, 10475.738106547396, 10628.202884783517, 10300.072993430627, 10308.433036183082, 10575.418351990715, 10605.681829545127, 10845.457727113771, 7331.706731730671, 7531.510451820614, 7605.619719013916, 7620.8475830484185, 7689.192634773268, 9295.814083718153, 10573.312734672221, 10645.912685321171, 10765.623203187852, 10826.188035897181], "unit": "score", "name": "jquery.html", "value": 9041.214587482962}, {"lowerIsBetter": false, "replicates": [1521.954341369759, 1546.4046342158265, 1562.671838913828, 1787.5352408373826, 1929.913153908075, 7795.610219489031, 7908.051033875943, 8687.08785577514, 8899.510526921025, 8913.910860891398, 7184.712611495534, 8537.018242902068, 8630.352723545728, 8637.654493820255, 8695.782605434868, 2444.3033735385375, 2473.950520989579, 2489.6638953741285, 2496.5381404440145, 2497.862617556034, 2430.769076937697, 2474.2453551666736, 2479.6776419065495, 2488.2410864686262, 2493.9002439902383, 2447.0945750072497, 2461.6430617560445, 2496.662950501677, 2497.612870005143, 2502.949941001179, 2446.4740080882607, 2476.839005464648, 2480.8263421560496, 2483.838550494212, 2485.3413845331, 2440.365504968721, 2466.691663542057, 2468.7531246875346, 2479.454520005596, 2501.0996041425074, 8761.693340733043, 8807.823843523094, 8808.823823523493, 8828.779280517974, 8872.245859101984, 4721.905561888777, 5379.596530260246, 5463.31708536433, 5530.391656917735, 5531.9723401383135, 3647.908802279964, 3684.244729830378, 3744.307303148926, 3769.491118698968, 3774.1508160663907, 1038.646860067573, 1071.2233630617818, 1075.3225467955217, 1086.8913108689069, 1103.1615971861443, 11981.94009029958, 11995.880041199563, 12128.45421956014, 12137.0, 12166.0, 4860.635452341018, 4888.755562221874, 4931.408231012229, 4963.305137280783, 4965.379327584052, 8551.358648101417, 10120.190384769201, 10120.34217775857, 10145.28982971185, 10156.39061656303, 5453.072977593819, 5473.0, 5476.644018138808, 5502.202180683858, 5524.4199359067525, 4421.071574969293, 4527.026689261825, 4889.242167464049, 4982.10322142018, 5039.614106120773, 3470.6182319944787, 3950.308695978192, 3954.189391174802, 4005.97847548879, 4015.6988225883174, 1158.3802665573878, 1323.1796286302554, 1325.5029363988504, 1336.051403503504, 1352.4184600621827, 1125.3979121170298, 1127.4644543841773, 1138.135017386792, 1253.6301790971502, 1344.4286178374152, 7904.1700621435075, 8059.435839491297, 8111.269985701315, 8332.250097491255, 8359.665613375397, 501.20308709152624, 501.801788293622, 503.22252120473956, 506.8150125204274, 518.3235877180241, 6212.968935155295, 6222.502199824004, 6232.0, 6279.686015699197, 6296.370362963667, 10503.579856805642, 10883.727906802234, 10928.672139835817, 10932.781344373068, 10939.726506837234, 10386.532606032746, 10614.469276536296, 10619.469026548642, 10723.624673136403, 10812.891871081189, 7133.822919218374, 8286.958565207135, 8373.41386102979, 8465.407421480437, 8492.702755403654, 7830.334421574002, 7832.21677832235, 7848.0, 7899.09160446533, 7918.960405197937, 9488.715338539854, 9520.61917523319, 9657.5856035991, 9663.275254356093, 9736.805263894825, 9796.412215267106, 9891.258155638212, 9977.850332245167, 10112.089911907964, 10133.695989120339, 6748.493862960396, 6887.380135787603, 7380.852382952418, 7544.698212071456, 7631.54210747357, 6691.364320389555, 7566.638005158904, 7897.68409263623, 7908.130105688255, 7916.960415197887, 6708.597484150967, 7600.733974311093, 7609.201033891583, 7709.807254818675, 7769.145394006542, 7375.55746655181, 7391.0, 7413.814654633462, 7486.850262994819, 7565.394768418403, 7629.809254768676, 7656.042994625672, 7670.041244844395, 7675.654595543326, 7695.384369250334, 6165.938340616536, 7013.193482749345, 7057.929420705727, 7091.0, 7125.5368401053765, 6127.754889804358, 6878.312168783082, 7149.642517874189, 7199.748008819666, 7209.341851374108], "unit": "score", "name": "mootools.html", "value": 4820.1350909463445}, {"lowerIsBetter": false, "replicates": [325.89734233716376, 329.3084522502743, 330.3805364940736, 337.39269315232593, 338.6004514672686, 5764.5100166485845, 6677.899831502531, 6844.555103918255, 6847.760328388507, 6922.065521154649, 6643.734250629969, 6792.524523283372, 6806.863862722743, 6837.726490940357, 6842.04211410403, 5004.724740139291, 5009.599232061444, 5011.42368627607, 5026.472220416858, 5048.1670524363435, 4787.8324258650955, 5028.170351891933, 5042.722650254234, 5048.747562621873, 5055.115354812911, 4861.392325959255, 4866.051120031595, 4877.365942427479, 4886.193778026622, 4898.951010489903, 4853.95146048542, 4873.731944743037, 4876.073546026261, 4878.292647566119, 4889.682170658932, 3426.8629254829775, 4086.8773936781945, 4089.325261331877, 4136.090060186754, 4182.079942412694, 6552.6068435894, 6553.836154096138, 6604.900926486107, 6610.9669451652435, 6669.933300667029, 5900.085486749518, 5906.586538942276, 5916.852078698024, 5920.407959204045, 5927.703614819242, 7107.502474826764, 7286.089238845145, 7340.669669864869, 7380.0405947227055, 7407.925850751665, 4746.83386081489, 4748.145333839908, 4763.737994410306, 4783.091212669582, 4787.066522028206, 6435.967820160869, 7743.612819359009, 7795.103563090261, 7809.062912450486, 7814.0, 4604.8388306409115, 4802.759862006886, 4810.086083644096, 4822.445418776815, 4833.540813622701, 4851.223804191312, 4861.465238823726, 4869.902601947942, 4879.56083952446, 4882.926756098661, 4993.475685053089, 5870.442307980735, 5902.822915312548, 5908.143319218775, 5910.083936989773, 7228.63856807168, 7428.702851885972, 7431.405487560982, 7435.293647103516, 7451.403887688972, 1690.467502736634, 1709.8803083784264, 1711.8972861628342, 1715.2452920714845, 1717.4418314047734, 1080.8702955645374, 1082.7076689294004, 1095.6932059023486, 1100.4937728644913, 1101.6970333158445, 6858.039874417585, 6869.278725733826, 6907.792766217021, 6927.861442771116, 6937.826554336081, 6689.130413046273, 7683.270089341504, 7700.768976930701, 7702.653380597774, 7705.614719264015, 6527.412532872065, 6688.297728738413, 6880.071190389233, 6886.10480637514, 6960.37356637905, 3488.5116083748294, 3633.672969432711, 3934.7605504266066, 4007.338789099824, 4065.8576949807207, 6500.447461965691, 7970.974657797775, 8014.719484818003, 8047.919520804834, 8107.324582887633, 7992.720254791055, 8001.239882211181, 8005.639746211435, 8014.278714915686, 8018.0, 6442.61344319333, 6520.804375868732, 7741.806454838562, 7991.960040199761, 8082.555459449787, 7746.961265193638, 7752.65113069902, 7760.611969401394, 7767.961160194162, 7790.065192176975, 6339.334369891095, 7345.6694448751, 7563.470557060953, 7573.129090154703, 7577.924220757722, 7988.960055199919, 8007.719729809429, 8020.318272946864, 8051.154628763896, 8071.031476222656, 4811.903761924812, 4856.562909338177, 4869.805207791649, 4872.464028956882, 4881.658283920092, 6370.490360771035, 7674.155842857393, 7686.3466605336935, 7710.0, 7717.344025757873, 7398.11222653285, 7501.62491875415, 7527.322540971339, 7527.924720752722, 7541.057367829021, 7222.133343998544, 7441.665125069277, 7451.2921272479025, 7455.813604659927, 7477.401807855467, 7297.306755858185, 7302.34278914879, 7312.597807120659, 7324.304191101837, 7329.267073292842, 7497.737579184703, 7502.137254215617, 7523.3229009389415, 7530.736424225345, 7557.0, 7063.5055546113335, 7299.124105107421, 7309.451791115581, 7309.561426314438, 7345.192028876926], "unit": "score", "name": "prototype.html", "value": 5332.7938138402815}, {"lowerIsBetter": false, "replicates": [622.37140488107, 653.9308231042247, 673.579013116802, 698.9475789315801, 728.0135416510628, 14785.408583656654, 15052.397904083837, 15121.31954062067, 15189.936704430695, 17175.57061073474, 15589.532314030568, 15599.0, 15660.138692371915, 15675.529734107995, 15694.686106277868, 696.4219697650938, 709.5317090720126, 857.3355649371756, 871.904090550039, 875.1904488348284, 848.3552500099937, 864.7708357285293, 875.6366108065146, 877.7717793373737, 879.4855009819263, 890.3945317184312, 913.8949020862619, 914.2000749344323, 914.3919293669702, 915.8763566918448, 887.9289656827439, 893.0890491698464, 897.349421669291, 905.311962908188, 911.9179273865318, 647.5596594315863, 661.2362721057186, 663.3797399431547, 666.9499787515956, 675.1796567170862, 13305.534306299232, 14806.629834254121, 14971.850281497154, 15016.549503514912, 15016.774748378783, 12436.378181091, 12537.122401431903, 12673.683157921034, 12677.936610316981, 13077.21536707791, 10244.231682623833, 10365.0, 11552.3646199459, 11597.014253788439, 11624.0, 3125.749940004794, 3464.082018265162, 3529.5764508258917, 3659.158393569494, 3696.796676182809, 79687.0, 79985.60007199986, 80093.0, 80178.39643207162, 82499.5875020621, 9339.439633622005, 9344.626214951326, 9376.156145946761, 9575.856362154573, 9647.517624118906, 20242.898785506273, 20619.793802062086, 20694.586108277752, 20736.274230401865, 20756.0, 7483.139438964588, 7586.696532138763, 7628.0464941882265, 7781.299683028441, 8023.679052837938, 4117.505899292104, 4149.398337241083, 4150.481189851269, 4154.729942553724, 4168.854090106832, 3585.964140358615, 3607.9278414432088, 3610.458431235336, 3631.946735446691, 3632.56409230894, 697.553565717941, 701.8876979683226, 704.915410150775, 705.0750507703685, 725.4450345485708, 553.7231384307846, 617.3178637605381, 620.1163342237294, 634.5811764235582, 641.8780431717959, 8258.339332853357, 8667.349948753868, 8679.826403472021, 8729.650813967497, 8770.079141690157, 477.5701868318472, 531.2695044314069, 538.727942389091, 544.6432586655668, 546.8386825886373, 3886.4947556817433, 3926.7447615904875, 4037.1723796621623, 4117.0, 4163.417121602978, 65699.6860062796, 90247.54876225708, 91244.0, 91649.62525562121, 93521.0, 75255.0, 75293.0, 75690.62154689191, 76268.0, 76719.61640191764, 67669.66165169142, 68226.0, 68299.29251768647, 68473.63052738918, 68961.2759681012, 8408.87386689188, 8729.956350218463, 8901.629750131391, 8918.37571369998, 9186.678466253648, 48018.5198148028, 49360.25959610681, 50446.73883152804, 51033.489665102876, 51459.48540514547, 54548.72725636346, 65361.0, 65616.0, 65842.67078664576, 66072.66963665151, 10961.61634342826, 11002.119830413387, 11186.888131118585, 11288.94355528217, 11654.592089276835, 11725.76548469043, 12058.879411205775, 12109.636710898687, 12139.150259481752, 12401.379931003594, 10353.896461035594, 10934.343939363664, 11573.826392603949, 11888.34614096233, 12376.195547289397, 11429.314241145557, 11454.083673306282, 11507.0, 11792.056635469313, 11874.871887170704, 11332.150088743212, 11446.713832154262, 11724.531018759155, 12032.217905836093, 12287.0, 9437.292203084658, 9486.667966621135, 9506.572204250688, 9768.36505627132, 10541.4729263535, 8280.875786863322, 8813.0, 8924.419912705653, 9059.139381758723, 9602.423854568748], "unit": "score", "name": "yui.html", "value": 6889.317388858578}], "name": "dromaeo_css", "value": 7499.324575131615}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 114.0, 116.0, 117.0, 124.0, 116.0, 141.0, 96.0, 118.0], "unit": "score", "name": "ai-astar", "value": 116.5}, {"lowerIsBetter": true, "replicates": [172.0, 128.0, 150.0, 173.0, 118.0, 169.0, 167.0, 150.0, 153.0, 142.0], "unit": "score", "name": "audio-beat-detection", "value": 152.2}, {"lowerIsBetter": true, "replicates": [198.0, 196.0, 196.0, 208.0, 211.0, 212.0, 192.0, 196.0, 200.0, 197.0], "unit": "score", "name": "audio-dft", "value": 200.6}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 73.0, 70.0, 128.0, 57.0, 57.0, 59.0, 58.0, 102.0], "unit": "score", "name": "audio-fft", "value": 73.7}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 134.0, 78.0, 82.0, 82.0, 118.0, 80.0, 82.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 93.6}, {"lowerIsBetter": true, "replicates": [85.0, 92.0, 89.0, 133.0, 127.0, 92.0, 90.0, 124.0, 86.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 100.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 95.0}, {"lowerIsBetter": true, "replicates": [85.0, 80.0, 139.0, 148.0, 100.0, 91.0, 96.0, 90.0, 92.0, 91.0], "unit": "score", "name": "imaging-desaturate", "value": 101.2}, {"lowerIsBetter": true, "replicates": [57.0, 54.0, 56.0, 53.0, 55.0, 54.0, 57.0, 61.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 71.0, 74.0, 79.0, 75.0, 70.0, 68.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.2}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [149.0, 150.0, 130.0, 136.0, 129.0, 126.0, 115.0, 139.0, 135.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 134.0}, {"lowerIsBetter": true, "replicates": [141.0, 141.0, 140.0, 137.0, 141.0, 142.0, 141.0, 140.0, 135.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.0}, {"lowerIsBetter": true, "replicates": [65.0, 69.0, 69.0, 65.0, 70.0, 65.0, 68.0, 67.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1484.7}]} 08:53:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1484.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7499.33"}}} 08:53:47 INFO - Return code: 0 08:53:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:53:47 INFO - # TBPL SUCCESS # 08:53:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:53:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:53:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:53:47 INFO - 2016-01-29 08:53:47.768 screenresolution[2394:23276] starting screenresolution argv=screenresolution get 08:53:47 INFO - 2016-01-29 08:53:47.771 screenresolution[2394:23276] Display 0: 1600x1200x32@60 08:53:47 INFO - 2016-01-29 08:53:47.777 screenresolution[2395:23279] starting screenresolution argv=screenresolution list 08:53:47 INFO - Available Modes on Display 0 08:53:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:53:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:53:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:53:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:53:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:53:48 INFO - Intel Iris: 08:53:48 INFO - Chipset Model: Intel Iris 08:53:48 INFO - Type: GPU 08:53:48 INFO - Bus: Built-In 08:53:48 INFO - VRAM (Dynamic, Max): 1536 MB 08:53:48 INFO - Vendor: Intel (0x8086) 08:53:48 INFO - Device ID: 0x0a2e 08:53:48 INFO - Revision ID: 0x0009 08:53:48 INFO - Displays: 08:53:48 INFO - Display: 08:53:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:53:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:53:48 INFO - Display Serial Number: 1600x1200 60 08:53:48 INFO - Main Display: Yes 08:53:48 INFO - Mirror: Off 08:53:48 INFO - Online: Yes 08:53:48 INFO - Rotation: Supported 08:53:48 INFO - Return code: 0 08:53:48 INFO - Running post-action listener: _resource_record_post_action 08:53:48 INFO - Running post-run listener: _resource_record_post_run 08:53:49 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 98304; Write bytes: 711570944; Read time: 1; Write time: 2057 08:53:49 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 395061760; Write bytes: 390043136; Read time: 30159; Write time: 845 08:53:49 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 98304; Write bytes: 303935488; Read time: 1; Write time: 1169 08:53:49 INFO - Running post-run listener: _upload_blobber_files 08:53:49 INFO - Blob upload gear active. 08:53:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:53:49 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 08:53:49 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'] 08:53:49 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 08:53:49 INFO - (blobuploader) - INFO - Open directory for files ... 08:53:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:53:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:53:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:50 INFO - (blobuploader) - INFO - Done attempting. 08:53:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:53:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:53:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:53:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:53:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:53:51 INFO - (blobuploader) - INFO - Done attempting. 08:53:51 INFO - (blobuploader) - INFO - Iteration through files over. 08:53:51 INFO - Return code: 0 08:53:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:53:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:53:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34c1cabda4bab9aeda58a51ae0d9d47fbb441c834863901984a42ea04e198fa84a09be984c12235fe779fc4e61c3049c7429fcf15db5ba9048445fe351ec1b5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cecd34e2b37645f851710d88343f22958431c9ec294471ebae9c3847bad31968f4c53ed1f5d6e829f667140a7f5f041880943c2abf5c2e60a23d063311cc50cc"} 08:53:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:53:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:53:51 INFO - Contents: 08:53:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34c1cabda4bab9aeda58a51ae0d9d47fbb441c834863901984a42ea04e198fa84a09be984c12235fe779fc4e61c3049c7429fcf15db5ba9048445fe351ec1b5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cecd34e2b37645f851710d88343f22958431c9ec294471ebae9c3847bad31968f4c53ed1f5d6e829f667140a7f5f041880943c2abf5c2e60a23d063311cc50cc"} 08:53:51 INFO - Running post-run listener: copy_logs_to_upload_dir 08:53:51 INFO - Copying logs to upload dir... 08:53:51 INFO - mkdir: /builds/slave/test/build/upload/logs 08:53:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.618886 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2016-01-29 08:53:51.901873) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 08:53:51.905208) ========= 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.tfPmhL7p7I/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.KhQujuV5bc/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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/34c1cabda4bab9aeda58a51ae0d9d47fbb441c834863901984a42ea04e198fa84a09be984c12235fe779fc4e61c3049c7429fcf15db5ba9048445fe351ec1b5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cecd34e2b37645f851710d88343f22958431c9ec294471ebae9c3847bad31968f4c53ed1f5d6e829f667140a7f5f041880943c2abf5c2e60a23d063311cc50cc"} build_url:https://queue.taskcluster.net/v1/task/SY2_ofHPT5-rOq2Y8AROkg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://queue.taskcluster.net/v1/task/SY2_ofHPT5-rOq2Y8AROkg/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/34c1cabda4bab9aeda58a51ae0d9d47fbb441c834863901984a42ea04e198fa84a09be984c12235fe779fc4e61c3049c7429fcf15db5ba9048445fe351ec1b5c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cecd34e2b37645f851710d88343f22958431c9ec294471ebae9c3847bad31968f4c53ed1f5d6e829f667140a7f5f041880943c2abf5c2e60a23d063311cc50cc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-29 08:53:51.933858) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 08:53:51.934186) ========= 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.tfPmhL7p7I/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.KhQujuV5bc/Listeners TMPDIR=/var/folders/m2/20p1rw6x5r77sn7qtvvpy75800000w/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.005547 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-29 08:53:51.987068) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 08:53:51.987740) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-29 08:53:51.988533) ========= ========= Total master_lag: 0.31 =========