builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0059 starttime: 1456330155.15 results: success (0) buildid: 20160224064045 builduid: f6470c0d048041499c2870cd3223df22 revision: e8a80985911bcf2921223e0a2365a9e591e18d97 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.153684) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.154112) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.154394) ========= 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.lkEySxx1SU/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.kew7k8r0FL/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005745 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.184536) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.184842) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.204411) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.204667) ========= 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.lkEySxx1SU/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.kew7k8r0FL/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.005598 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.253085) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.253380) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.253727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.254008) ========= 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.lkEySxx1SU/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.kew7k8r0FL/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-24 08:09:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 163M=0s 2016-02-24 08:09:15 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134956 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.407733) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.408077) ========= 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.lkEySxx1SU/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.kew7k8r0FL/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.025929 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:15.458390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 08:09:15.458732) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e8a80985911bcf2921223e0a2365a9e591e18d97 --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 e8a80985911bcf2921223e0a2365a9e591e18d97 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lkEySxx1SU/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.kew7k8r0FL/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-24 08:09:15,540 truncating revision to first 12 chars 2016-02-24 08:09:15,540 Setting DEBUG logging. 2016-02-24 08:09:15,540 attempt 1/10 2016-02-24 08:09:15,540 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e8a80985911b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 08:09:17,101 unpacking tar archive at: fx-team-e8a80985911b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.808364 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 08:09:17.282532) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:17.282843) ========= echo e8a80985911bcf2921223e0a2365a9e591e18d97 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e8a80985911bcf2921223e0a2365a9e591e18d97'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lkEySxx1SU/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.kew7k8r0FL/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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 e8a80985911bcf2921223e0a2365a9e591e18d97 program finished with exit code 0 elapsedTime=0.005028 script_repo_revision: 'e8a80985911bcf2921223e0a2365a9e591e18d97' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:17.332622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:17.332913) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 08:09:17.345556) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-24 08:09:17.345834) ========= /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.lkEySxx1SU/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.kew7k8r0FL/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:09:17 INFO - MultiFileLogger online at 20160224 08:09:17 in /builds/slave/test 08:09:17 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:09:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:09:17 INFO - {'append_to_log': False, 08:09:17 INFO - 'base_work_dir': '/builds/slave/test', 08:09:17 INFO - 'blob_upload_branch': 'Fx-Team', 08:09:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:09:17 INFO - 'branch': 'Fx-Team', 08:09:17 INFO - 'buildbot_json_path': 'buildprops.json', 08:09:17 INFO - 'config_files': ('talos/mac_config.py',), 08:09:17 INFO - 'default_actions': ('clobber', 08:09:17 INFO - 'read-buildbot-config', 08:09:17 INFO - 'download-and-extract', 08:09:17 INFO - 'populate-webroot', 08:09:17 INFO - 'create-virtualenv', 08:09:17 INFO - 'install', 08:09:17 INFO - 'run-tests'), 08:09:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:09:17 INFO - 'download_minidump_stackwalk': True, 08:09:17 INFO - 'download_symbols': 'ondemand', 08:09:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:09:17 INFO - 'tooltool.py': '/tools/tooltool.py', 08:09:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:09:17 INFO - '/tools/misc-python/virtualenv.py')}, 08:09:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:09:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:09:17 INFO - 'installer_path': 'installer.exe', 08:09:17 INFO - 'log_level': 'info', 08:09:17 INFO - 'log_name': 'talos', 08:09:17 INFO - 'log_to_console': True, 08:09:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:09:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:09:17 INFO - 'opt_config_files': (), 08:09:17 INFO - 'pip_index': False, 08:09:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:09:17 INFO - 'cmd': ('bash', 08:09:17 INFO - '-c', 08:09:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:09:17 INFO - 'enabled': True, 08:09:17 INFO - 'halt_on_failure': False, 08:09:17 INFO - 'name': 'check_screen_resolution'},), 08:09:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:09:17 INFO - 'cmd': ('bash', 08:09:17 INFO - '-c', 08:09:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:09:17 INFO - 'enabled': True, 08:09:17 INFO - 'halt_on_failure': False, 08:09:17 INFO - 'name': 'check_screen_resolution'},), 08:09:17 INFO - 'run_cmd_checks_enabled': True, 08:09:17 INFO - 'sps_profile': False, 08:09:17 INFO - 'sps_profile_interval': 0, 08:09:17 INFO - 'suite': 'dromaeojs-e10s', 08:09:17 INFO - 'system_bits': '32', 08:09:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:09:17 INFO - 'title': 't-yosemite-r7-0059', 08:09:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:09:17 INFO - 'use_talos_json': True, 08:09:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:09:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:09:17 INFO - 'work_dir': 'build'} 08:09:17 INFO - ##### 08:09:17 INFO - ##### Running clobber step. 08:09:17 INFO - ##### 08:09:17 INFO - Running pre-action listener: _resource_record_pre_action 08:09:17 INFO - Running main action method: clobber 08:09:17 INFO - rmtree: /builds/slave/test/build 08:09:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:09:19 INFO - Running post-action listener: _resource_record_post_action 08:09:19 INFO - ##### 08:09:19 INFO - ##### Running read-buildbot-config step. 08:09:19 INFO - ##### 08:09:19 INFO - Running pre-action listener: _resource_record_pre_action 08:09:19 INFO - Running main action method: read_buildbot_config 08:09:19 INFO - Using buildbot properties: 08:09:19 INFO - { 08:09:19 INFO - "project": "", 08:09:19 INFO - "product": "firefox", 08:09:19 INFO - "script_repo_revision": "production", 08:09:19 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:09:19 INFO - "repository": "", 08:09:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:09:19 INFO - "buildid": "20160224064045", 08:09:19 INFO - "pgo_build": "False", 08:09:19 INFO - "basedir": "/builds/slave/test", 08:09:19 INFO - "buildnumber": 411, 08:09:19 INFO - "slavename": "t-yosemite-r7-0059", 08:09:19 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:09:19 INFO - "platform": "yosemite_r7", 08:09:19 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:09:19 INFO - "branch": "fx-team", 08:09:19 INFO - "repo_path": "integration/fx-team", 08:09:19 INFO - "revision": "e8a80985911bcf2921223e0a2365a9e591e18d97", 08:09:19 INFO - "stage_platform": "macosx64", 08:09:19 INFO - "builduid": "f6470c0d048041499c2870cd3223df22", 08:09:19 INFO - "slavebuilddir": "test" 08:09:19 INFO - } 08:09:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 08:09:19 INFO - Running post-action listener: _resource_record_post_action 08:09:19 INFO - ##### 08:09:19 INFO - ##### Running download-and-extract step. 08:09:19 INFO - ##### 08:09:19 INFO - Running pre-action listener: _resource_record_pre_action 08:09:19 INFO - Running main action method: download_and_extract 08:09:19 INFO - mkdir: /builds/slave/test/build/tests 08:09: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:09:19 INFO - https://queue.taskcluster.net/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:09:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/test_packages.json 08:09:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/test_packages.json 08:09:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:09:20 INFO - Downloaded 1277 bytes. 08:09:20 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:09:20 INFO - Using the following test package requirements: 08:09:20 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:09:20 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:09:20 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 08:09:20 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:09:20 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 08:09:20 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:09:20 INFO - u'jsshell-mac.zip'], 08:09:20 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:09:20 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 08:09:20 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:09:20 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:09:20 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 08:09:20 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:09:20 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 08:09:20 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:09:20 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 08:09:20 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:09:20 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:09:20 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 08:09:20 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:20 INFO - https://queue.taskcluster.net/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/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:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/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:09:21 INFO - Downloaded 17827693 bytes. 08:09:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:09:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:09:24 INFO - Return code: 0 08:09:24 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:09:24 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:09:24 INFO - https://queue.taskcluster.net/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:09:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:09:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:09:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/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:09:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/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:09:25 INFO - Downloaded 17827693 bytes. 08:09:25 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:09:25 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:09:29 INFO - Return code: 0 08:09:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:29 INFO - https://queue.taskcluster.net/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:09:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:09:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:09:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/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:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/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:09:30 INFO - Downloaded 10707015 bytes. 08:09:30 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:09:30 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:09:30 INFO - Return code: 0 08:09:30 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:09:30 INFO - https://queue.taskcluster.net/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:09:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:09:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:09:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 08:09:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/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:09:34 INFO - Downloaded 111448122 bytes. 08:09:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:09:34 INFO - mkdir: /builds/slave/test/properties 08:09:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:34 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:34 INFO - Contents: 08:09:34 INFO - build_url:https://queue.taskcluster.net/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:09:35 INFO - Running post-action listener: _resource_record_post_action 08:09:35 INFO - Running post-action listener: set_extra_try_arguments 08:09:35 INFO - ##### 08:09:35 INFO - ##### Running populate-webroot step. 08:09:35 INFO - ##### 08:09:35 INFO - Running pre-action listener: _resource_record_pre_action 08:09:35 INFO - Running main action method: populate_webroot 08:09:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:35 INFO - '--tppagecycles', 08:09:35 INFO - '7'], 08:09:35 INFO - 'tests': ['tsvgm']}}, 08:09:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:09:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:09:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:09:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:09:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:35 INFO - 'talos_options': ['--e10s'], 08:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:35 INFO - 'tests': ['damp', 'tps']}, 08:09:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:35 INFO - 'talos_options': ['--e10s'], 08:09:35 INFO - 'tests': ['damp', 'tps']}, 08:09:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:09:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:35 INFO - 'other': {'tests': ['a11yr', 08:09:35 INFO - 'ts_paint', 08:09:35 INFO - 'tpaint', 08:09:35 INFO - 'sessionrestore', 08:09:35 INFO - 'sessionrestore_no_auto_restore']}, 08:09:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:09:35 INFO - 'tests': ['a11yr', 08:09:35 INFO - 'ts_paint', 08:09:35 INFO - 'tpaint', 08:09:35 INFO - 'sessionrestore', 08:09:35 INFO - 'sessionrestore_no_auto_restore']}, 08:09:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:09:35 INFO - 'tests': ['a11yr', 08:09:35 INFO - 'ts_paint', 08:09:35 INFO - 'tpaint', 08:09:35 INFO - 'sessionrestore', 08:09:35 INFO - 'sessionrestore_no_auto_restore']}, 08:09:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:09:35 INFO - 'tests': ['a11yr', 08:09:35 INFO - 'ts_paint', 08:09:35 INFO - 'tpaint', 08:09:35 INFO - 'sessionrestore', 08:09:35 INFO - 'sessionrestore_no_auto_restore']}, 08:09:35 INFO - 'other_l64': {'tests': ['a11yr', 08:09:35 INFO - 'ts_paint', 08:09:35 INFO - 'tpaint', 08:09:35 INFO - 'sessionrestore', 08:09:35 INFO - 'sessionrestore_no_auto_restore']}, 08:09:35 INFO - 'other_nol64': {'tests': ['a11yr', 08:09:35 INFO - 'ts_paint', 08:09:35 INFO - 'tpaint', 08:09:35 INFO - 'sessionrestore', 08:09:35 INFO - 'sessionrestore_no_auto_restore']}, 08:09:35 INFO - 'svgr': {'tests': ['tsvgx', 08:09:35 INFO - 'tsvgr_opacity', 08:09:35 INFO - 'tart', 08:09:35 INFO - 'tscrollx', 08:09:35 INFO - 'cart']}, 08:09:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:09:35 INFO - 'tests': ['tsvgx', 08:09:35 INFO - 'tsvgr_opacity', 08:09:35 INFO - 'tart', 08:09:35 INFO - 'tscrollx', 08:09:35 INFO - 'cart']}, 08:09:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:35 INFO - 'tests': ['tp5o']}, 08:09:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:35 INFO - 'talos_options': ['--e10s'], 08:09:35 INFO - 'tests': ['tp5o']}, 08:09:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:35 INFO - 'talos_options': ['--xperf_path', 08:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:35 INFO - 'tests': ['tp5n']}, 08:09:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:35 INFO - 'talos_options': ['--e10s', 08:09:35 INFO - '--xperf_path', 08:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:35 INFO - 'tests': ['tp5n']}}, 08:09:35 INFO - 'talos.zip': {'path': '', 08:09:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:35 INFO - Running post-action listener: _resource_record_post_action 08:09:35 INFO - ##### 08:09:35 INFO - ##### Running create-virtualenv step. 08:09:35 INFO - ##### 08:09:35 INFO - Running pre-action listener: _resource_record_pre_action 08:09:35 INFO - Running main action method: create_virtualenv 08:09:35 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:35 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:09:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:35 INFO - Using real prefix '/tools/python27' 08:09:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:36 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:38 INFO - Installing pip.................done. 08:09:38 INFO - Return code: 0 08:09:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ba1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca994d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a45d30>, '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 0x105869db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3cb20>, '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.lkEySxx1SU/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.kew7k8r0FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkEySxx1SU/Render', 08:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:38 INFO - 'HOME': '/Users/cltbld', 08:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:38 INFO - 'LOGNAME': 'cltbld', 08:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:38 INFO - 'MOZ_NO_REMOTE': '1', 08:09:38 INFO - 'NO_EM_RESTART': '1', 08:09:38 INFO - 'PAGER': '/bin/cat', 08:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:38 INFO - 'PWD': '/builds/slave/test', 08:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:38 INFO - 'SHELL': '/bin/bash', 08:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kew7k8r0FL/Listeners', 08:09:38 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 08:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:38 INFO - 'USER': 'cltbld', 08:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:38 INFO - 'XPC_FLAGS': '0x0', 08:09:38 INFO - 'XPC_SERVICE_NAME': '0', 08:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:39 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:09:39 INFO - Cleaning up... 08:09:39 INFO - Return code: 0 08:09:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:09:39 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:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:39 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:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:39 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 0x105ba1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca994d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a45d30>, '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 0x105869db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3cb20>, '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.lkEySxx1SU/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.kew7k8r0FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:09:39 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:09:39 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:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkEySxx1SU/Render', 08:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:39 INFO - 'HOME': '/Users/cltbld', 08:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:39 INFO - 'LOGNAME': 'cltbld', 08:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:39 INFO - 'MOZ_NO_REMOTE': '1', 08:09:39 INFO - 'NO_EM_RESTART': '1', 08:09:39 INFO - 'PAGER': '/bin/cat', 08:09:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:39 INFO - 'PWD': '/builds/slave/test', 08:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:39 INFO - 'SHELL': '/bin/bash', 08:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kew7k8r0FL/Listeners', 08:09:39 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 08:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:39 INFO - 'USER': 'cltbld', 08:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:39 INFO - 'XPC_FLAGS': '0x0', 08:09:39 INFO - 'XPC_SERVICE_NAME': '0', 08:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:39 INFO - Downloading/unpacking psutil>=0.7.1 08:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:42 INFO - Installing collected packages: psutil 08:09:42 INFO - Running setup.py install for psutil 08:09:42 INFO - building 'psutil._psutil_osx' extension 08:09:42 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:09:42 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:09:42 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:09:43 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:09:43 INFO - building 'psutil._psutil_posix' extension 08:09:43 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:09:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:09:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:09:43 INFO - ^ 08:09:43 INFO - 1 warning generated. 08:09:43 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:09:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:43 INFO - Successfully installed psutil 08:09:43 INFO - Cleaning up... 08:09:43 INFO - Return code: 0 08:09:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:09:43 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:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:43 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:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:43 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 0x105ba1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca994d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a45d30>, '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 0x105869db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3cb20>, '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.lkEySxx1SU/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.kew7k8r0FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:09:43 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:09:43 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:09:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkEySxx1SU/Render', 08:09:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:43 INFO - 'HOME': '/Users/cltbld', 08:09:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:43 INFO - 'LOGNAME': 'cltbld', 08:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:43 INFO - 'MOZ_NO_REMOTE': '1', 08:09:43 INFO - 'NO_EM_RESTART': '1', 08:09:43 INFO - 'PAGER': '/bin/cat', 08:09:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:43 INFO - 'PWD': '/builds/slave/test', 08:09:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:43 INFO - 'SHELL': '/bin/bash', 08:09:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kew7k8r0FL/Listeners', 08:09:43 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 08:09:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:43 INFO - 'USER': 'cltbld', 08:09:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:43 INFO - 'XPC_FLAGS': '0x0', 08:09:43 INFO - 'XPC_SERVICE_NAME': '0', 08:09:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:46 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:09:46 INFO - Installing collected packages: mozsystemmonitor 08:09:46 INFO - Running setup.py install for mozsystemmonitor 08:09:46 INFO - Successfully installed mozsystemmonitor 08:09:46 INFO - Cleaning up... 08:09:46 INFO - Return code: 0 08:09:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ba1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca994d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a45d30>, '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 0x105869db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3cb20>, '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.lkEySxx1SU/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.kew7k8r0FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:09:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:09:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkEySxx1SU/Render', 08:09:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:46 INFO - 'HOME': '/Users/cltbld', 08:09:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:46 INFO - 'LOGNAME': 'cltbld', 08:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:46 INFO - 'MOZ_NO_REMOTE': '1', 08:09:46 INFO - 'NO_EM_RESTART': '1', 08:09:46 INFO - 'PAGER': '/bin/cat', 08:09:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:46 INFO - 'PWD': '/builds/slave/test', 08:09:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:46 INFO - 'SHELL': '/bin/bash', 08:09:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kew7k8r0FL/Listeners', 08:09:46 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 08:09:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:46 INFO - 'USER': 'cltbld', 08:09:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:46 INFO - 'XPC_FLAGS': '0x0', 08:09:46 INFO - 'XPC_SERVICE_NAME': '0', 08:09:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:46 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:49 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:49 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:09:49 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:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:49 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:09:49 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:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:50 INFO - Downloading docopt-0.6.1.tar.gz 08:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:50 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:50 INFO - Running setup.py install for blobuploader 08:09:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:50 INFO - Running setup.py install for requests 08:09:51 INFO - Running setup.py install for docopt 08:09:51 INFO - Successfully installed blobuploader requests docopt 08:09:51 INFO - Cleaning up... 08:09:51 INFO - Return code: 0 08:09:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:51 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 0x105ba1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca994d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a45d30>, '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 0x105869db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3cb20>, '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.lkEySxx1SU/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.kew7k8r0FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:09:51 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:09:51 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:09:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkEySxx1SU/Render', 08:09:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:51 INFO - 'HOME': '/Users/cltbld', 08:09:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:51 INFO - 'LOGNAME': 'cltbld', 08:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:51 INFO - 'MOZ_NO_REMOTE': '1', 08:09:51 INFO - 'NO_EM_RESTART': '1', 08:09:51 INFO - 'PAGER': '/bin/cat', 08:09:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:51 INFO - 'PWD': '/builds/slave/test', 08:09:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:51 INFO - 'SHELL': '/bin/bash', 08:09:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kew7k8r0FL/Listeners', 08:09:51 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 08:09:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:51 INFO - 'USER': 'cltbld', 08:09:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:51 INFO - 'XPC_FLAGS': '0x0', 08:09:51 INFO - 'XPC_SERVICE_NAME': '0', 08:09:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:51 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-bCbIqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:51 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-IpiZUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:51 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-uHYs20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:51 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-WkLzKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:52 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-iRPVW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:52 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-Lxv0yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:52 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-a81OT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:52 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-0RmZ_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:52 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-EJs1hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:52 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-VVFtAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:52 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-_RI_iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:52 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-qDxo7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:52 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-CwP_b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:52 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-WRRaun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:53 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-z4cQUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:53 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-F7QJQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:53 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-BLW2qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:53 INFO - Running setup.py install for manifestparser 08:09:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:53 INFO - Running setup.py install for mozcrash 08:09:53 INFO - Running setup.py install for mozdebug 08:09:53 INFO - Running setup.py install for mozdevice 08:09:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:53 INFO - Running setup.py install for mozfile 08:09:54 INFO - Running setup.py install for mozhttpd 08:09:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:54 INFO - Running setup.py install for mozinfo 08:09:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:54 INFO - Running setup.py install for mozInstall 08:09:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:54 INFO - Running setup.py install for mozleak 08:09:54 INFO - Running setup.py install for mozlog 08:09:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:54 INFO - Running setup.py install for moznetwork 08:09:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:55 INFO - Running setup.py install for mozprocess 08:09:55 INFO - Running setup.py install for mozprofile 08:09:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:55 INFO - Running setup.py install for mozrunner 08:09:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:55 INFO - Running setup.py install for mozscreenshot 08:09:55 INFO - Running setup.py install for moztest 08:09:55 INFO - Running setup.py install for mozversion 08:09:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:55 INFO - Cleaning up... 08:09:55 INFO - Return code: 0 08:09:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:09:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:55 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 0x105ba1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca994d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a45d30>, '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 0x105869db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3cb20>, '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.lkEySxx1SU/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.kew7k8r0FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:09:55 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:09:55 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:09:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkEySxx1SU/Render', 08:09:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:09:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:09:55 INFO - 'HOME': '/Users/cltbld', 08:09:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:09:55 INFO - 'LOGNAME': 'cltbld', 08:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:55 INFO - 'MOZ_NO_REMOTE': '1', 08:09:55 INFO - 'NO_EM_RESTART': '1', 08:09:55 INFO - 'PAGER': '/bin/cat', 08:09:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:55 INFO - 'PWD': '/builds/slave/test', 08:09:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:09:55 INFO - 'SHELL': '/bin/bash', 08:09:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kew7k8r0FL/Listeners', 08:09:55 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 08:09:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:09:55 INFO - 'USER': 'cltbld', 08:09:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:09:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:55 INFO - 'XPC_FLAGS': '0x0', 08:09:55 INFO - 'XPC_SERVICE_NAME': '0', 08:09:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:56 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-idM7w2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:56 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:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:56 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-ZQBZkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:56 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:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:56 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-J_FGfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:56 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:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:56 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-vI2XdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:56 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:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:56 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-TF29qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:56 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:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:56 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-TsLIpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:56 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:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:56 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-1fwqUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:56 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:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:56 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-u6bpkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:57 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:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:57 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-PzmXt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:57 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:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:57 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-qMyQyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:57 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:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:57 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-Z998HB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:57 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:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:57 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-cPplUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:57 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:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:57 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-9qL5ry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:57 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:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:57 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-kgtDlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:57 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:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:57 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-VJkpAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:57 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:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:57 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-gobLd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:57 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:09:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:57 INFO - Running setup.py (path:/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/pip-ali2do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:58 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:09:58 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:09:58 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:09:58 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:09:58 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:09:58 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:09:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:00 INFO - Downloading blessings-1.6.tar.gz 08:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:10:00 INFO - Installing collected packages: blessings 08:10:00 INFO - Running setup.py install for blessings 08:10:00 INFO - Successfully installed blessings 08:10:00 INFO - Cleaning up... 08:10:00 INFO - Return code: 0 08:10:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:10:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:00 INFO - Reading from file tmpfile_stdout 08:10:01 INFO - Current package versions: 08:10:01 INFO - blessings == 1.6 08:10:01 INFO - blobuploader == 1.2.4 08:10:01 INFO - docopt == 0.6.1 08:10:01 INFO - manifestparser == 1.1 08:10:01 INFO - mozInstall == 1.12 08:10:01 INFO - mozcrash == 0.16 08:10:01 INFO - mozdebug == 0.1 08:10:01 INFO - mozdevice == 0.48 08:10:01 INFO - mozfile == 1.2 08:10:01 INFO - mozhttpd == 0.7 08:10:01 INFO - mozinfo == 0.9 08:10:01 INFO - mozleak == 0.1 08:10:01 INFO - mozlog == 3.1 08:10:01 INFO - moznetwork == 0.27 08:10:01 INFO - mozprocess == 0.22 08:10:01 INFO - mozprofile == 0.28 08:10:01 INFO - mozrunner == 6.11 08:10:01 INFO - mozscreenshot == 0.1 08:10:01 INFO - mozsystemmonitor == 0.0 08:10:01 INFO - moztest == 0.7 08:10:01 INFO - mozversion == 1.4 08:10:01 INFO - psutil == 3.1.1 08:10:01 INFO - requests == 1.2.3 08:10:01 INFO - wsgiref == 0.1.2 08:10:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:01 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 0x105ba1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca994d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a45d30>, '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 0x105869db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3cb20>, '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.lkEySxx1SU/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.kew7k8r0FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:10:01 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:10:01 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:10:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkEySxx1SU/Render', 08:10:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:01 INFO - 'HOME': '/Users/cltbld', 08:10:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:01 INFO - 'LOGNAME': 'cltbld', 08:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:01 INFO - 'MOZ_NO_REMOTE': '1', 08:10:01 INFO - 'NO_EM_RESTART': '1', 08:10:01 INFO - 'PAGER': '/bin/cat', 08:10:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:01 INFO - 'PWD': '/builds/slave/test', 08:10:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:01 INFO - 'SHELL': '/bin/bash', 08:10:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kew7k8r0FL/Listeners', 08:10:01 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 08:10:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:01 INFO - 'USER': 'cltbld', 08:10:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:01 INFO - 'XPC_FLAGS': '0x0', 08:10:01 INFO - 'XPC_SERVICE_NAME': '0', 08:10:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:01 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:10:01 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:10:01 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:10:01 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:10:01 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:10:01 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:10:01 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:10:01 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:10:01 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:10:01 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:10:01 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:10:01 INFO - Cleaning up... 08:10:01 INFO - Return code: 0 08:10:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:01 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 0x105ba1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca994d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a45d30>, '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 0x105869db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3cb20>, '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.lkEySxx1SU/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.kew7k8r0FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:10:01 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:10:01 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:10:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkEySxx1SU/Render', 08:10:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:01 INFO - 'HOME': '/Users/cltbld', 08:10:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:01 INFO - 'LOGNAME': 'cltbld', 08:10:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:01 INFO - 'MOZ_NO_REMOTE': '1', 08:10:01 INFO - 'NO_EM_RESTART': '1', 08:10:01 INFO - 'PAGER': '/bin/cat', 08:10:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:01 INFO - 'PWD': '/builds/slave/test', 08:10:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:01 INFO - 'SHELL': '/bin/bash', 08:10:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kew7k8r0FL/Listeners', 08:10:01 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 08:10:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:01 INFO - 'USER': 'cltbld', 08:10:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:01 INFO - 'XPC_FLAGS': '0x0', 08:10:01 INFO - 'XPC_SERVICE_NAME': '0', 08:10:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:01 INFO - Downloading/unpacking jsonschema 08:10:01 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:10:01 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:10:01 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:10:01 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:10:01 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:10:01 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:10:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:10:03 INFO - Downloading/unpacking functools32 (from jsonschema) 08:10:03 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:10:03 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:10:03 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:10:03 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:10:03 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:10:03 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:10:04 INFO - Downloading functools32-3.2.3-2.tar.gz 08:10:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:10:04 INFO - warning: no files found matching '*.txt' 08:10:04 INFO - no previously-included directories found matching 'build' 08:10:04 INFO - no previously-included directories found matching 'dist' 08:10:04 INFO - no previously-included directories found matching '.git*' 08:10:04 INFO - Installing collected packages: jsonschema, functools32 08:10:04 INFO - Running setup.py install for functools32 08:10:04 INFO - warning: no files found matching '*.txt' 08:10:04 INFO - no previously-included directories found matching 'build' 08:10:04 INFO - no previously-included directories found matching 'dist' 08:10:04 INFO - no previously-included directories found matching '.git*' 08:10:04 INFO - Successfully installed jsonschema functools32 08:10:04 INFO - Cleaning up... 08:10:04 INFO - Return code: 0 08:10:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:04 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 0x105ba1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ba84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca994d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a45d30>, '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 0x105869db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3cb20>, '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.lkEySxx1SU/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.kew7k8r0FL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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:10:04 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:10:04 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:10:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkEySxx1SU/Render', 08:10:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:04 INFO - 'HOME': '/Users/cltbld', 08:10:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:04 INFO - 'LOGNAME': 'cltbld', 08:10:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:04 INFO - 'MOZ_NO_REMOTE': '1', 08:10:04 INFO - 'NO_EM_RESTART': '1', 08:10:04 INFO - 'PAGER': '/bin/cat', 08:10:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:04 INFO - 'PWD': '/builds/slave/test', 08:10:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:04 INFO - 'SHELL': '/bin/bash', 08:10:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kew7k8r0FL/Listeners', 08:10:04 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 08:10:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:04 INFO - 'USER': 'cltbld', 08:10:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:04 INFO - 'XPC_FLAGS': '0x0', 08:10:04 INFO - 'XPC_SERVICE_NAME': '0', 08:10:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:04 INFO - Downloading/unpacking flake8 08:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:10:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:10:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:10:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:10:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:10:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:10:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:10:08 INFO - no previously-included directories found matching 'docs/_build' 08:10:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:10:08 INFO - Running setup.py install for pep8 08:10:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:10:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:10:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:10:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:10:08 INFO - no previously-included directories found matching 'docs/_build' 08:10:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:10:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:10:08 INFO - Cleaning up... 08:10:08 INFO - Return code: 0 08:10:08 INFO - Running post-action listener: _resource_record_post_action 08:10:08 INFO - Running post-action listener: _start_resource_monitoring 08:10:08 INFO - Starting resource monitoring. 08:10:08 INFO - ##### 08:10:08 INFO - ##### Running install step. 08:10:08 INFO - ##### 08:10:08 INFO - Running pre-action listener: _resource_record_pre_action 08:10:08 INFO - Running main action method: install 08:10:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:09 INFO - Reading from file tmpfile_stdout 08:10:09 INFO - Detecting whether we're running mozinstall >=1.0... 08:10:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:10:09 INFO - Reading from file tmpfile_stdout 08:10:09 INFO - Output received: 08:10:09 INFO - Usage: mozinstall [options] installer 08:10:09 INFO - Options: 08:10:09 INFO - -h, --help show this help message and exit 08:10:09 INFO - -d DEST, --destination=DEST 08:10:09 INFO - Directory to install application into. [default: 08:10:09 INFO - "/builds/slave/test"] 08:10:09 INFO - --app=APP Application being installed. [default: firefox] 08:10:09 INFO - mkdir: /builds/slave/test/build/application 08:10:09 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:10:09 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:10:43 INFO - Reading from file tmpfile_stdout 08:10:43 INFO - Output received: 08:10:43 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:10:43 INFO - Running post-action listener: _resource_record_post_action 08:10:43 INFO - ##### 08:10:43 INFO - ##### Running run-tests step. 08:10:43 INFO - ##### 08:10:43 INFO - Running pre-action listener: _resource_record_pre_action 08:10:43 INFO - Running main action method: run_tests 08:10:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:10:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:10:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:10:43 INFO - 2016-02-24 08:10:43.632 screenresolution[1661:7811] starting screenresolution argv=screenresolution get 08:10:43 INFO - 2016-02-24 08:10:43.635 screenresolution[1661:7811] Display 0: 1600x1200x32@60 08:10:43 INFO - 2016-02-24 08:10:43.641 screenresolution[1662:7813] starting screenresolution argv=screenresolution list 08:10:43 INFO - Available Modes on Display 0 08:10:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:10:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:10:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:10:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:10:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:10:43 INFO - Intel Iris: 08:10:43 INFO - Chipset Model: Intel Iris 08:10:43 INFO - Type: GPU 08:10:43 INFO - Bus: Built-In 08:10:43 INFO - VRAM (Dynamic, Max): 1536 MB 08:10:43 INFO - Vendor: Intel (0x8086) 08:10:43 INFO - Device ID: 0x0a2e 08:10:43 INFO - Revision ID: 0x0009 08:10:43 INFO - Displays: 08:10:43 INFO - Display: 08:10:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:10:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:10:43 INFO - Display Serial Number: 1600x1200 60 08:10:43 INFO - Main Display: Yes 08:10:43 INFO - Mirror: Off 08:10:43 INFO - Online: Yes 08:10:43 INFO - Rotation: Supported 08:10:43 INFO - Return code: 0 08:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:10:43 INFO - Python 2.7.3 08:10:43 INFO - Return code: 0 08:10:43 INFO - grabbing minidump binary from tooltool 08:10:43 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:10:43 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 0x105a45d30>, '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 0x105869db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a3cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:10:43 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:10:43 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:10:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:10:43 INFO - Return code: 0 08:10:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:10:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:10:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:10:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:10:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:10:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:10:45 INFO - Return code: 0 08:10:45 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/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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:10:45 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/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0059 --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:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lkEySxx1SU/Render', 08:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:10:45 INFO - 'HOME': '/Users/cltbld', 08:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:10:45 INFO - 'LOGNAME': 'cltbld', 08:10:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:45 INFO - 'MOZ_NO_REMOTE': '1', 08:10:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:45 INFO - 'NO_EM_RESTART': '1', 08:10:45 INFO - 'PAGER': '/bin/cat', 08:10:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:45 INFO - 'PWD': '/builds/slave/test', 08:10:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:10:45 INFO - 'SHELL': '/bin/bash', 08:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kew7k8r0FL/Listeners', 08:10:45 INFO - 'TMPDIR': '/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/', 08:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:10:45 INFO - 'USER': 'cltbld', 08:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:45 INFO - 'XPC_FLAGS': '0x0', 08:10:45 INFO - 'XPC_SERVICE_NAME': '0', 08:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:10:45 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/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0059', '--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:10:45 INFO - mozversion application_buildid: 20160224064045 08:10:45 INFO - mozversion application_changeset: e8a80985911bcf2921223e0a2365a9e591e18d97 08:10:45 INFO - mozversion application_display_name: Nightly 08:10:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:10:45 INFO - mozversion application_name: Firefox 08:10:45 INFO - mozversion application_remotingname: firefox 08:10:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:10:45 INFO - mozversion application_vendor: Mozilla 08:10:45 INFO - mozversion application_version: 47.0a1 08:10:45 INFO - mozversion platform_buildid: 20160224064045 08:10:45 INFO - mozversion platform_changeset: e8a80985911bcf2921223e0a2365a9e591e18d97 08:10:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:10:45 INFO - mozversion platform_version: 47.0a1 08:10:45 INFO - using testdate: 1456330245 08:10:45 INFO - actual date: 1456330245 08:10:45 INFO - starting webserver on 'localhost:49280' 08:10:45 INFO - SUITE-START | Running 2 tests 08:10:45 INFO - TEST-START | dromaeo_css 08:10:45 INFO - operating with platform_type : mac_ 08:10:45 INFO - Initialising browser for dromaeo_css test... 08:10:45 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpeckAjn/profile http://localhost:49280/getInfo.html) 08:10:48 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 08:10:48 INFO - PROCESS | 1680 | colorDepth:24 08:10:48 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 08:10:48 INFO - PROCESS | 1680 | __metrics 08:10:48 ERROR - PROCESS | 1680 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:10:49 INFO - TEST-INFO | 1680: exit 0 08:10:49 INFO - Browser initialized. 08:10:49 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:49 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmpeckAjn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:01 INFO - PROCESS | 1684 | RSS: Main: 255688704 08:11:01 INFO - PROCESS | 1684 | 08:11:51 INFO - PROCESS | 1684 | 1456330311270 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:14:01 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 08:14:03 INFO - PROCESS | 1684 | RSS: Main: 273989632 08:14:03 INFO - PROCESS | 1684 | 08:17:05 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 08:17:05 INFO - PROCESS | 1684 | RSS: Main: 284909568 08:17:05 INFO - PROCESS | 1684 | 08:20:07 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 08:20:08 INFO - PROCESS | 1684 | RSS: Main: 286068736 08:20:08 INFO - PROCESS | 1684 | 08:23:10 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 08:23:10 INFO - PROCESS | 1684 | RSS: Main: 286527488 08:23:10 INFO - PROCESS | 1684 | 08:26:13 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 08:26:13 INFO - PROCESS | 1684 | RSS: Main: 291278848 08:26:13 INFO - PROCESS | 1684 | 08:29:16 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 08:29:16 INFO - PROCESS | 1684 | RSS: Main: 291946496 08:29:16 INFO - PROCESS | 1684 | 08:29:16 INFO - PROCESS | 1684 | __start_tp_report 08:29:16 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 08:29:16 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 08:29:16 INFO - PROCESS | 1684 | |i|pagename|runs| 08:29:16 INFO - PROCESS | 1684 | |0;dojo.html;3251.2359595495054;3493.87771428;3517.78893266404;3550.3076900004507;3569.1790888095748;5670.206171136039;5708.372079071304;5732.254806875106;5746.597738158331;5762.423757624236;5612.270404847364;5662.518685911702;5724.599278050528;5734.082546792514;5832.154337621042;5173.3533308336455;5211.765470553815;5217.087009773274;5220.895582088356;5289.761960711758;5228.73856307185;5264.499872512105;5268;5288.947110528903;5293.206019097147;5060.822871199509;5089.974550127263;5244.501772331622;5253.080710875582;5288.603354748409;5174.8097937474595;5202.92195617066;5230.084735171368;5233.712145831978;5288.629795914288;3908.530976282836;5091.821786237464;5168.5606723428555;5223.817166399158;5273.182656688219;4352.086061926999;4691.437027556715;5601.103823388279;5605.383407825136;5612.635178713371;6188.257409110935;6215.378462153793;6219.751209951596;6231.719572619243;6232.688365581703;5309.283246761676;6039.728212230416;6182.721777520022;6188.978818494943;6284.497240220771;5905.4685078343155;5908.261467316585;5909;5910.674912879746;5916.112583112525;6147.016477363601;6276.309605943343;6278.6546739929745;6282.748690052438;6304.148939893147;4899.608031357483;4961.900761984813;5140.922886156711;6096.405739310651;6104.3590423005835;5230.869228269324;6122.00175312775;6161.322254551996;6291.182146320949;6348.682565871688;5961.642301461926;6128.264608247039;6193.597416167935;6215.34738852423;6226.62640241587;6103.671041328402;6151.108089327112;6170.784022559189;6198.690065496708;6200.224971878515;4879.634027447955;4900.191468407673;4931.988942266827;4941.357623508993;4941.925871111936;4304.655627549789;4316.525182229952;4324.308110702273;4435.911281774346;4452.977735111369;5659.43405659439;5691.430856914276;5719.256496655491;5730.140478928194;5741.88516229673;6278.905816412757;6282.18331616896;6282.685865706788;6283.183186185766;6300.960341543686;5622.522085622686;5792.189093526909;5823.679697616587;5856.267966504187;5908.172855800191;5365.248865158881;5396.568274538027;5399.70301633414;5401.405845357008;5421.5933804964;6191.288001879841;6246.750129994749;6343.175387199634;6351.333110023474;6352.841178970562;6251.062340648939;6260.217472815898;6272.153259309935;6301.527385446018;6326.905096423649;6334;6337.271213810286;6338.397852204033;6343.333949935375;6361.045843123384;6080.969595151996;6125.510168486406;6222;6228.501719862491;6232.8130156095385;6113.3546859767275;6181.196444462191;6249.500039996698;6275.937240627718;6280.937190628035;6145.463634091477;6170.907436388368;6177.505799536116;6191.504679625709;6204.162438070803;5836.474717275466;6090.269167699905;6123.693815309306;6143.788236235041;6163.106349579376;5851.61964472308;5946.464818166212;6019.578629495893;6023.5181185505935;6025;5997.31030931431;6174.104754810617;6176.8764624706355;6198.256209254918;6232.501399888089;5939.910901336397;5979.701014949323;6017.097435384728;6036;6063.181470501426 08:29:16 INFO - PROCESS | 1684 | |1;ext.html;500.74211780932825;514.5369167749026;530.7081105392036;546.7785546853523;601.7262145723696;37060.25879482412;37075.814620926925;37522.62477375226;37607;37714.8114259429;38273;38473.61526384735;38546.03634909121;38598.80700596493;38706.41940370897;9455.952720236406;9693.660721874736;9706.126448619623;9712.611495540204;9768.462734549597;8421.70524031659;9520.952395238015;9685.467299298536;9795.363301385423;9799.755006124868;8851.95574022129;9376.062393760603;9717.708468745948;9779.755506112333;9856;9706.223502119848;9791.363561368487;9827;9831.606735730562;9837.262205334628;8252.752417427488;9565.569549370295;9610.135087842127;9660.565274562661;9694.36986595876;37556.497740090366;37665.623343766485;37901.62098379008;38014.619853801385;38056.23887522234;2696.492262196157;3081.876724931;3334.799912005263;3634.8909532713797;3707.2029513654693;26687;26856.59715104275;26867.596986045224;27342.179734607995;27575;2745.9725402746117;2774.4728501584636;2850.757685596727;2855.457463082008;2952.2766922104006;427500;480715;517777;525069;528365;53362.466375336524;53641.731791341575;54032.45967540353;54119.64700882509;54158.72920635372;56225;56657;57163.714181428826;57395;57450;15478.303476343592;15601.141937193337;15657.37370505167;15839.52481425559;15863.127527986071;12248.693782655504;12469.376531173404;12494.81257781134;12604.369781510888;12608.991280697523;17495.512881404968;17585.03282319459;17661.205245763973;17687.734683979492;17702.557436064202;8686.131386861263;8876.556172191365;8915.509646969349;8920.509371984603;8943.508107054175;806.8139834443359;925.9768505787409;988.7132731507926;997.4065431068502;1024.283001898674;27372.726272737018;29300.120996370144;29402.264943376158;29589.408211835642;29883.70116298809;1040.245821779204;1088.7495875948418;1097.1896370987774;1160.3502038858267;1165.8659254185707;12944.805827912589;14155.929220353832;14271.072380295247;14353.856461435253;14433.278336083154;427675;526285;529081.709182911;531589;533814;54508.637284068216;54844.45155548473;54875.902481950136;54912.45087549074;54928.72535637296;1428.7999680044802;1432.2767002663588;1433.3621538415305;1448.6885319656114;1597.9932642435424;27877;28170.446557216335;28193.577096343983;28474.288142795765;28519.144425667262;47226.76386618182;48811.53565393044;49025.754871225414;49091.50908490869;49270;504838;507094;507686;508355;509549;31324.530132048494;31787.728490860107;33039.33921321512;33136.668633313355;33155;41651.58055980955;42645.78677106595;43005.35491967561;43668.344974824766;44407.77796110999;34637.82681086579;35611.10972225715;36023.819880900424;36194.095147620465;36343;34568.96293111211;35318.82340588281;35589.644103559665;35684.46473302851;35767.64232357747;35974.280514389044;36087.27825443529;36149.09627259339;36365.0908727284;37095.62904370922;29122.417551648425;30129.548056779604;30156;30492.542611860397;30495.237619059702;23500.529989399773;23657.29028129159;24010.639840402757;24036.87981560081;24054.15810446626 08:29:16 INFO - PROCESS | 1684 | |2;jquery.html;314.7088942727976;332.9184349834291;357.62806681051705;363.2444515407952;369.796611863475;15371.308291126898;18906.149223284952;18942.431727048195;19493;20133.899330503344;14428.92785536071;18736.344227952024;18995.05024748764;19005.334813281537;19044.238230470764;5567.4432556744205;5591.524720398761;5843.883122337551;5884;5951.434613711691;5797.217375654296;5897.882042359151;5924.763009479616;5950.404959504037;5955.404459554054;5511.476409741068;5705.115707065412;5785.421457854223;5908.497777688902;5913.349531551547;4531.886702832456;5732.856678583027;5761.991651460978;5772.971135144318;5789.4500022498005;5481.725913704338;5503.174523821459;5505.697186654733;5524.06090964537;5528.170774383834;12766.106372553924;12944.417501212469;13243.47026118954;13322.933385333108;13371.665708357272;1978.9307374241832;2020.1818263603118;2103.28488313974;2174.1629472653144;2185.093186327688;9706.90293097074;9904.504774761304;9930.602775888956;10713.303635263683;14823.851761482463;1673.2637639438608;1711.6918954588293;1744.2151032035636;1755.587436952315;1778.8754787164903;104474.47762761214;108425.45787271092;108709;108996;112053.43973280163;11031.448427578589;11312.490937907814;11447.828282575769;11468.770624587629;11525.193236473366;12026.398680065962;12852.48590056406;13339.799903001463;13586.320683965761;13642.2496762679;6707.966460167668;8120.025596928406;8221.876671849926;8394.412391132562;8410.369222308229;8224.38317126218;8361.163883611713;8458.87311690325;8471.279941204943;8595.097514760984;4360.454943132108;4429.534898835575;4468.374427580141;4472.351509031172;4490.483594386687;1902.2105826082297;1912.368918256972;1941.26232031827;1946.2312386607211;1966.056292979378;865.0743704236532;891.8394688955921;948.061419194992;1009.4649835587151;1086.21792309537;18753.6568192862;19187.136578853984;19843.801561984194;20015.699764503544;20270.59458810845;896.9864053619499;968.8837339519303;987.151050096916;989.2827699917646;1039.0648416425126;10446.738831529121;10646.520906559223;10649.89350106489;10653.041226289672;10701.250912436055;603251;611562;613396;616191;619177;68170.29574260683;72403;74532;110755.44622276837;117040;850.9021462531764;983.2429029647275;1000.2348203624233;1007.969760907174;1008.0826447932346;17378.044207568706;17611.119444027492;17752.2011509485;17938.19278132513;17960.730589040915;33115;48083.75958120187;48436.54690359295;49791.25313120378;50174.99650007053;62795.6860215696;63550;68095.65952170208;74695.62652186705;74986;7100.467464940047;8102.79743006406;8181.959090204511;8224.835503289782;8245.093039765501;11696.298222106701;12455;13101.213927164401;13497.932510337385;13541.93229033888;4683.695559788603;5242.082635538842;11127.609048868891;11410.543578256777;11654.242474239147;10948.233623646587;11319.133202424237;11509.482073306888;11697.532098715956;11823.231489953125;11740.823887641864;11858.466369013242;11923.880761192277;11928;11962.760744784882;7992.120866704541;8016.639251233825;8140.430169888051;8145.755627331189;8178.468399554248;11746.941265293619;11883.82174267404;11886.28682279066;11899.405029748652;11918.165728398928 08:29:16 INFO - PROCESS | 1684 | |3;mootools.html;1439.2875526614328;1553.74363230067;1777.511184424283;1909.4748944040396;1926.9807301926976;7740.303372696456;8285.295749861269;8517.957410212948;8689.52207628581;8716.520591367473;8488.78778030548;8492;8629.395942284043;8631.956840215806;8658.393912426132;2435.0868424340874;2445.608702607583;2456.091246238894;2462.729099799021;2468.8518688878726;2415.915442959497;2465.9260222193275;2470.6170543565777;2479.5412848622973;2482.7765501104896;2125.224293133003;2409.33743220614;2436;2450.840695354805;2467.6915385576804;2414.5291668124723;2435.2085572189108;2440.45089854783;2471.542764588548;2473.3692908308444;2428.9271321860374;2433.6106223004413;2448.20433359159;2450.1791899713617;2455.472073504205;8584.399092063559;8617.224449799549;8619.913800861974;8647.567621618893;8659.090795466449;5273.34083239595;5444.428335024844;5480.424555421663;5482.506574408282;5488.890222195534;3137.8587963541695;3550.91122721934;3599.1002249437643;3714.1457464783252;3726.329260733067;1060.8355704865758;1062.6333914799459;1065.2702898514542;1080.8540846985713;1084.4035780320871;9716.562754676057;11391;11472.369019703912;11542.134339924456;11565.190436669436;4054.7567145970747;4373.431453911035;4813.109574728616;4942.777575009133;4981.526754958273;10018.74953126163;10023.799524009624;10033.849492257623;10048.899511004942;10065.798684026426;5460.672359658433;5470.835874923759;5490.423505531861;5513.5037846594;5517.4482551745305;4913.582345500601;4955.529224723646;4981.950180498148;5016.924746128811;5025.020121076428;3704.870329538453;3755.7746535207975;3756.2111956489443;3788.791616461066;3799.639034291738;1132.5243397772956;1158.976820463586;1167.9416029198505;1179.8584169899666;1195.6413076077142;1125.358545629;1131.660501849442;1193.8209268609605;1307.5619667411333;1368.3500337339883;7791.0650721913735;7829.3736501079775;7858.371330293563;7984.760457186294;7995;1197.7245233596323;1207.927524348542;1209.4255228766265;1231.6428235811513;1235.5737270641614;5219.347581552306;6037.909431358533;6118.541109416722;6126.23422072241;6220.440160385587;9450.243980481546;9516.38143520669;10326.432046237529;10335.22485813552;10453;9965.252606054575;10237.027482389161;10277.280590358752;10338.37969721804;10407.635732749317;6760;7933.246341597539;8027.8359637853355;8073.798155046054;8117.959410202911;7877.960610196912;7897.644605992859;7920.801979950547;7942.880856787037;8125.146859579659;9092.545372731205;9495.66765163216;9513.762155946157;9529.714108576754;9558.28312876551;8604.61279242423;9619.807603848023;9670.56482458277;9710.465924373944;9860.71810664609;7955.801104972422;8067.112617611941;8167.183281671785;8196.54918979462;8224.054233762954;8070.596470176585;8071.394645401736;8101.918980810116;8146;8157.428979971345;6298.433141017331;6431.421172094534;7251.093613298338;7478.307809188579;7494.6252687366505;7018.473614478832;7116.252793456612;7165.104361954755;7183.066201393785;7191.42468602521;7473.813154671177;7502.924970750222;7548;7552.735654252075;7556.546607203585;6835.624040677611;6866.588004719732;6875.656217189021;6877.965610171917;6879.793606191823;6770.729170833111;6962.408195303456;6989.091418115612;7012.228654848064;7016.228214896255 08:29:16 INFO - PROCESS | 1684 | |4;prototype.html;295.51387966794624;327.7541843617287;328.6713286713287;332.1778597970024;336.71042903103313;6578.144841170653;6760.729570817161;6807.7957661270175;6849.178098628166;6856.52004359695;6717;6754.594724316532;6794.592324460536;6806.727730890759;6835.829104272383;4992.550670439659;5014.448410674814;5016.072026675059;5018.7992480300745;5024.221245706921;3887.319719049169;4041.6160464755803;5022.698638081727;5039.949600504003;5062.9240561391425;4101.487314085739;4893.975530122344;4965.503449655023;4969.2049272116465;4981.352424184869;4707.152712511746;4917.336159618477;4989.3513843200335;4993.226049962243;5001.624878134118;3365.4951757236367;4098;4102.979485102585;4113.095119073799;4133.607307305801;6379.075034120073;6401.455876250524;6427.132337134473;6448.45188159007;6485.092087107809;5579.302587176603;5667.688277144755;5711.657300561979;5717.48542631161;5724.513416359614;7089.5037347385705;7092.645367731593;7102.92897071033;7112.431005519546;7118.07465029548;4559.110973360196;4595.218812801798;4609.354690343354;4611.723296602181;4617.030423611046;7586.544807311579;7611;7613.0483689538805;7627.199144089846;7690.538567685957;4476.955230447654;4628.352030715702;4634.976825115853;4650.4186976627925;4653.813847446132;3936.193080418507;4692.718436893797;4728.219843725816;4741.336212930192;4742.478327383985;5630.5495560355075;5636.802711905064;5641.858953526113;5647.322321321386;5673.461021202979;7230.746923857745;7234.927650723425;7237.674304656303;7263.382612477999;7291.927080729125;1622.7890374251272;1647.5139833749072;1650.5048485454315;1651.5953591370192;1652.2977734463045;992.2211064314479;1023.8924912884189;1043.7860238651058;1056.3133962924007;1072.828347464402;5338.546223570962;6786.4910131739325;6811.863762724718;6843.555168914005;6851.177858656993;6051.062085376686;6105.877882442415;7505.6997720090585;7515.962420187864;7522.924770752223;6808.4212841908;6824.18109826824;6827.702736480053;6832.59004459734;6842.281560436182;3870.1666376933854;3955.0705584187695;3982.900427489336;3992.640662340403;3996.320625493615;5397;7640.541567505968;7769.689212431553;7831.725889593951;7858.803529911684;7635.465517413728;7664.846703065908;7673.271039251262;7677.808054798563;7701.537907725555;7793.220677932161;7817.218278172251;7825.726099586487;7843.803904902309;7849.686012559548;7188.964055179691;7394.482386232912;7465.253474652492;7479.962600187182;7505.624718764149;7271.41828653717;7315.6342182889575;7321.63391830417;7339.9633001834645;7342;6310.968445157745;7782.455228133977;7802.648880800264;7813.179616140451;7852.764417067498;4662.184117779443;4674.135284972155;4677.766111694334;4679.485256621837;4704.129735998851;6550.967245163743;7014.859702806018;7230.602316872622;7428.9628551856895;7451.913464230024;6197.597156184834;7335.8532829344185;7366.594837284001;7373.193567575764;7374.225706300761;7323.963380183065;7356.4114870809135;7372.926270737438;7376.7049318026675;7379.557226566423;7144.642767861482;7157.141143062866;7157.534760240567;7173.1392232932385;7184.353408193288;7066.681999310146;7266.273372662691;7282.162551306667;7350.301721336465;7350.77947661571;6191.133241346125;6721.899171512529;7063.223045464892;7072.858542829217;7147.748459235324 08:29:16 INFO - PROCESS | 1684 | |5;yui.html;622.8723111762089;659.518551457436;665.0888283052219;671.4963777167123;737.3363972424813;14645.487407940738;14678.192699401528;14787.704245915089;17074.487765367026;17334;15740.212989350515;15837;15930.920345398257;15971.92014039931;15976.680466390666;705.3546005405049;856.5931182688236;861.9224269815732;866.077627326898;879.7360791762478;868.5223127280002;874.6501399440211;875.8948926128874;876.2289185516736;877.55244825139;905.2441211588332;916.7708072981754;919.7240827751681;920.4109370003204;923.6628630549868;877.9517126558037;898.1691934960136;917.4357769971419;917.6467060181844;922.3866129024191;669.0432681265788;682.8907374820005;682.9180498340181;684.0696652552524;684.3737979748524;15139.015963962418;15172.620684482867;15197.088174709554;15199.468018619295;15199.772003419957;11897.643070707893;12327.753444931051;12482.126251162423;12506.437210325466;12539.93730031344;10108.241881858816;10171.288009839314;10238.385696858213;10250.17998560121;10251.89748102517;3416.538767266412;3468.930621387558;3469.063352894704;3472.149323415754;3479.425894727367;85448.59135564858;85967.28065438718;86109;87425;87626;9169.08309169091;9211.380864322971;9242.399244049115;9298.814023719488;9493.19307858826;20376.796232037785;20420.285290014777;20429.591408171753;20477.38567842967;20505.17979280812;7230.927690723131;7237.565746055254;7386.409087273005;7392.593407362539;7578.810529736801;3558.484019817112;4040.9797951010055;4083.5099788025627;4085.162541678949;4088.652464540488;3456.1359660084977;3491.4064609016527;3506.1234691327168;3508.8421021053605;3525.3654342218133;541.3936391241756;549.4148731600833;640.2509064394669;648.597869321024;660.7423104989058;571.5199232644599;581.5725441800273;592;618.4804763998263;622.9974198596555;6836;7787.221277872168;8267.462614930011;8337.458065225741;8380.120087390858;464.30818081058976;507.57363814396086;582.3586019425175;585.233344318935;631.2771876201723;4018.1561872007205;4065.2072845794787;4074.490688663917;4126.628603425706;4147.668186545069;84471;85313;86182.13817861867;86411;86821.56589217014;71896;72543;74181.62909185527;74902.62548687222;76859.46281074347;66634.33365666281;68940.27649308708;69164.6541767298;69588.30411695919;70042;8015.7595272141925;8034;8160;8249.670013199644;8343.582820859054;47312;47541.28688069613;47841.76079119582;48198.51801482081;48443;59723.027697231664;64671.70656586748;70049;70821;73901;9593.520323983634;11310.095192384753;11453.19827612059;11663.008644264994;12104.676670614152;11836.70408239801;11840.289582624726;11870.525178992744;12280.017598591912;12589.24464532131;11094.445277736242;11603.419829008348;11634.534618615498;11929.224600400947;12130.818037729265;11183;11400.372979486208;11503.252288601214;11659.88340116588;12345.321007344683;11100.333979961228;11362;11461.885381146416;11592.004550580217;12233.816492752438;9251.259899208182;9498.525073746423;9503.904960950302;9735;9920;8879.289656827568;9186.954065229631;9493.95253023758;9804.509774511389;9836.409815411098 08:29:16 INFO - PROCESS | 1684 | __end_tp_report 08:29:16 INFO - PROCESS | 1684 | __start_cc_report 08:29:16 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,348 08:29:16 INFO - PROCESS | 1684 | __end_cc_report 08:29:16 INFO - PROCESS | 1684 | __startTimestamp1456331356350__endTimestamp 08:29:16 INFO - PROCESS | 1684 | 08:29:16 INFO - PROCESS | 1684 | ------- Summary: start ------- 08:29:16 INFO - PROCESS | 1684 | Number of tests: 6 08:29:16 INFO - PROCESS | 1684 | 08:29:16 INFO - PROCESS | 1684 | [#0] dojo.html Cycles:165 Average:5705.31 Median:5939.91 stddev:663.76 (11.2%) stddev-sans-first:637.27 08:29:16 INFO - PROCESS | 1684 | Values: 3251.2 3493.9 3517.8 3550.3 3569.2 5670.2 5708.4 5732.3 5746.6 5762.4 5612.3 5662.5 5724.6 5734.1 5832.2 5173.4 5211.8 5217.1 5220.9 5289.8 5228.7 5264.5 5268.0 5288.9 5293.2 5060.8 5090.0 5244.5 5253.1 5288.6 5174.8 5202.9 5230.1 5233.7 5288.6 3908.5 5091.8 5168.6 5223.8 5273.2 4352.1 4691.4 5601.1 5605.4 5612.6 6188.3 6215.4 6219.8 6231.7 6232.7 5309.3 6039.7 6182.7 6189.0 6284.5 5905.5 5908.3 5909.0 5910.7 5916.1 6147.0 6276.3 6278.7 6282.7 6304.1 4899.6 4961.9 5140.9 6096.4 6104.4 5230.9 6122.0 6161.3 6291.2 6348.7 5961.6 6128.3 6193.6 6215.3 6226.6 6103.7 6151.1 6170.8 6198.7 6200.2 4879.6 4900.2 4932.0 4941.4 4941.9 4304.7 4316.5 4324.3 4435.9 4453.0 5659.4 5691.4 5719.3 5730.1 5741.9 6278.9 6282.2 6282.7 6283.2 6301.0 5622.5 5792.2 5823.7 5856.3 5908.2 5365.2 5396.6 5399.7 5401.4 5421.6 6191.3 6246.8 6343.2 6351.3 6352.8 6251.1 6260.2 6272.2 6301.5 6326.9 6334.0 6337.3 6338.4 6343.3 6361.0 6081.0 6125.5 6222.0 6228.5 6232.8 6113.4 6181.2 6249.5 6275.9 6280.9 6145.5 6170.9 6177.5 6191.5 6204.2 5836.5 6090.3 6123.7 6143.8 6163.1 5851.6 5946.5 6019.6 6023.5 6025.0 5997.3 6174.1 6176.9 6198.3 6232.5 5939.9 5979.7 6017.1 6036.0 6063.2 08:29:16 INFO - PROCESS | 1684 | 08:29:16 INFO - PROCESS | 1684 | [#1] ext.html Cycles:180 Average:63590.27 Median:37636.31 stddev:134615.63 (357.7%) stddev-sans-first:134909.93 08:29:16 INFO - PROCESS | 1684 | Values: 500.7 514.5 530.7 546.8 601.7 37060.3 37075.8 37522.6 37607.0 37714.8 38273.0 38473.6 38546.0 38598.8 38706.4 9456.0 9693.7 9706.1 9712.6 9768.5 8421.7 9521.0 9685.5 9795.4 9799.8 8852.0 9376.1 9717.7 9779.8 9856.0 9706.2 9791.4 9827.0 9831.6 9837.3 8252.8 9565.6 9610.1 9660.6 9694.4 37556.5 37665.6 37901.6 38014.6 38056.2 2696.5 3081.9 3334.8 3634.9 3707.2 26687.0 26856.6 26867.6 27342.2 27575.0 2746.0 2774.5 2850.8 2855.5 2952.3 427500.0 480715.0 517777.0 525069.0 528365.0 53362.5 53641.7 54032.5 54119.6 54158.7 56225.0 56657.0 57163.7 57395.0 57450.0 15478.3 15601.1 15657.4 15839.5 15863.1 12248.7 12469.4 12494.8 12604.4 12609.0 17495.5 17585.0 17661.2 17687.7 17702.6 8686.1 8876.6 8915.5 8920.5 8943.5 806.8 926.0 988.7 997.4 1024.3 27372.7 29300.1 29402.3 29589.4 29883.7 1040.2 1088.7 1097.2 1160.4 1165.9 12944.8 14155.9 14271.1 14353.9 14433.3 427675.0 526285.0 529081.7 531589.0 533814.0 54508.6 54844.5 54875.9 54912.5 54928.7 1428.8 1432.3 1433.4 1448.7 1598.0 27877.0 28170.4 28193.6 28474.3 28519.1 47226.8 48811.5 49025.8 49091.5 49270.0 504838.0 507094.0 507686.0 508355.0 509549.0 31324.5 31787.7 33039.3 33136.7 33155.0 41651.6 42645.8 43005.4 43668.3 44407.8 34637.8 35611.1 36023.8 36194.1 36343.0 34569.0 35318.8 35589.6 35684.5 35767.6 35974.3 36087.3 36149.1 36365.1 37095.6 29122.4 30129.5 30156.0 30492.5 30495.2 23500.5 23657.3 24010.6 24036.9 24054.2 08:29:16 INFO - PROCESS | 1684 | 08:29:16 INFO - PROCESS | 1684 | [#2] jquery.html Cycles:180 Average:33028.01 Median:2138.72 stddev:101162.84 (4730.1%) stddev-sans-first:101416.80 08:29:16 INFO - PROCESS | 1684 | Values: 314.7 332.9 357.6 363.2 369.8 15371.3 18906.1 18942.4 19493.0 20133.9 14428.9 18736.3 18995.1 19005.3 19044.2 5567.4 5591.5 5843.9 5884.0 5951.4 5797.2 5897.9 5924.8 5950.4 5955.4 5511.5 5705.1 5785.4 5908.5 5913.3 4531.9 5732.9 5762.0 5773.0 5789.5 5481.7 5503.2 5505.7 5524.1 5528.2 12766.1 12944.4 13243.5 13322.9 13371.7 1978.9 2020.2 2103.3 2174.2 2185.1 9706.9 9904.5 9930.6 10713.3 14823.9 1673.3 1711.7 1744.2 1755.6 1778.9 104474.5 108425.5 108709.0 108996.0 112053.4 11031.4 11312.5 11447.8 11468.8 11525.2 12026.4 12852.5 13339.8 13586.3 13642.2 6708.0 8120.0 8221.9 8394.4 8410.4 8224.4 8361.2 8458.9 8471.3 8595.1 4360.5 4429.5 4468.4 4472.4 4490.5 1902.2 1912.4 1941.3 1946.2 1966.1 865.1 891.8 948.1 1009.5 1086.2 18753.7 19187.1 19843.8 20015.7 20270.6 897.0 968.9 987.2 989.3 1039.1 10446.7 10646.5 10649.9 10653.0 10701.3 603251.0 611562.0 613396.0 616191.0 619177.0 68170.3 72403.0 74532.0 110755.4 117040.0 850.9 983.2 1000.2 1008.0 1008.1 17378.0 17611.1 17752.2 17938.2 17960.7 33115.0 48083.8 48436.5 49791.3 50175.0 62795.7 63550.0 68095.7 74695.6 74986.0 7100.5 8102.8 8182.0 8224.8 8245.1 11696.3 12455.0 13101.2 13497.9 13541.9 4683.7 5242.1 11127.6 11410.5 11654.2 10948.2 11319.1 11509.5 11697.5 11823.2 11740.8 11858.5 11923.9 11928.0 11962.8 7992.1 8016.6 8140.4 8145.8 8178.5 11746.9 11883.8 11886.3 11899.4 11918.2 08:29:16 INFO - PROCESS | 1684 | 08:29:16 INFO - PROCESS | 1684 | [#3] mootools.html Cycles:180 Average:5935.16 Median:5475.63 stddev:3070.28 (56.1%) stddev-sans-first:3060.29 08:29:16 INFO - PROCESS | 1684 | Values: 1439.3 1553.7 1777.5 1909.5 1927.0 7740.3 8285.3 8518.0 8689.5 8716.5 8488.8 8492.0 8629.4 8632.0 8658.4 2435.1 2445.6 2456.1 2462.7 2468.9 2415.9 2465.9 2470.6 2479.5 2482.8 2125.2 2409.3 2436.0 2450.8 2467.7 2414.5 2435.2 2440.5 2471.5 2473.4 2428.9 2433.6 2448.2 2450.2 2455.5 8584.4 8617.2 8619.9 8647.6 8659.1 5273.3 5444.4 5480.4 5482.5 5488.9 3137.9 3550.9 3599.1 3714.1 3726.3 1060.8 1062.6 1065.3 1080.9 1084.4 9716.6 11391.0 11472.4 11542.1 11565.2 4054.8 4373.4 4813.1 4942.8 4981.5 10018.7 10023.8 10033.8 10048.9 10065.8 5460.7 5470.8 5490.4 5513.5 5517.4 4913.6 4955.5 4982.0 5016.9 5025.0 3704.9 3755.8 3756.2 3788.8 3799.6 1132.5 1159.0 1167.9 1179.9 1195.6 1125.4 1131.7 1193.8 1307.6 1368.4 7791.1 7829.4 7858.4 7984.8 7995.0 1197.7 1207.9 1209.4 1231.6 1235.6 5219.3 6037.9 6118.5 6126.2 6220.4 9450.2 9516.4 10326.4 10335.2 10453.0 9965.3 10237.0 10277.3 10338.4 10407.6 6760.0 7933.2 8027.8 8073.8 8118.0 7878.0 7897.6 7920.8 7942.9 8125.1 9092.5 9495.7 9513.8 9529.7 9558.3 8604.6 9619.8 9670.6 9710.5 9860.7 7955.8 8067.1 8167.2 8196.5 8224.1 8070.6 8071.4 8101.9 8146.0 8157.4 6298.4 6431.4 7251.1 7478.3 7494.6 7018.5 7116.3 7165.1 7183.1 7191.4 7473.8 7502.9 7548.0 7552.7 7556.5 6835.6 6866.6 6875.7 6878.0 6879.8 6770.7 6962.4 6989.1 7012.2 7016.2 08:29:16 INFO - PROCESS | 1684 | 08:29:16 INFO - PROCESS | 1684 | [#4] prototype.html Cycles:180 Average:5839.43 Median:6757.66 stddev:1908.82 (28.2%) stddev-sans-first:1868.27 08:29:16 INFO - PROCESS | 1684 | Values: 295.5 327.8 328.7 332.2 336.7 6578.1 6760.7 6807.8 6849.2 6856.5 6717.0 6754.6 6794.6 6806.7 6835.8 4992.6 5014.4 5016.1 5018.8 5024.2 3887.3 4041.6 5022.7 5039.9 5062.9 4101.5 4894.0 4965.5 4969.2 4981.4 4707.2 4917.3 4989.4 4993.2 5001.6 3365.5 4098.0 4103.0 4113.1 4133.6 6379.1 6401.5 6427.1 6448.5 6485.1 5579.3 5667.7 5711.7 5717.5 5724.5 7089.5 7092.6 7102.9 7112.4 7118.1 4559.1 4595.2 4609.4 4611.7 4617.0 7586.5 7611.0 7613.0 7627.2 7690.5 4477.0 4628.4 4635.0 4650.4 4653.8 3936.2 4692.7 4728.2 4741.3 4742.5 5630.5 5636.8 5641.9 5647.3 5673.5 7230.7 7234.9 7237.7 7263.4 7291.9 1622.8 1647.5 1650.5 1651.6 1652.3 992.2 1023.9 1043.8 1056.3 1072.8 5338.5 6786.5 6811.9 6843.6 6851.2 6051.1 6105.9 7505.7 7516.0 7522.9 6808.4 6824.2 6827.7 6832.6 6842.3 3870.2 3955.1 3982.9 3992.6 3996.3 5397.0 7640.5 7769.7 7831.7 7858.8 7635.5 7664.8 7673.3 7677.8 7701.5 7793.2 7817.2 7825.7 7843.8 7849.7 7189.0 7394.5 7465.3 7480.0 7505.6 7271.4 7315.6 7321.6 7340.0 7342.0 6311.0 7782.5 7802.6 7813.2 7852.8 4662.2 4674.1 4677.8 4679.5 4704.1 6551.0 7014.9 7230.6 7429.0 7451.9 6197.6 7335.9 7366.6 7373.2 7374.2 7324.0 7356.4 7372.9 7376.7 7379.6 7144.6 7157.1 7157.5 7173.1 7184.4 7066.7 7266.3 7282.2 7350.3 7350.8 6191.1 6721.9 7063.2 7072.9 7147.7 08:29:16 INFO - PROCESS | 1684 | 08:29:16 INFO - PROCESS | 1684 | [#5] yui.html Cycles:180 Average:18120.76 Median:622.93 stddev:25227.53 (4049.8%) stddev-sans-first:25264.09 08:29:16 INFO - PROCESS | 1684 | Values: 622.9 659.5 665.1 671.5 737.3 14645.5 14678.2 14787.7 17074.5 17334.0 15740.2 15837.0 15930.9 15971.9 15976.7 705.4 856.6 861.9 866.1 879.7 868.5 874.7 875.9 876.2 877.6 905.2 916.8 919.7 920.4 923.7 878.0 898.2 917.4 917.6 922.4 669.0 682.9 682.9 684.1 684.4 15139.0 15172.6 15197.1 15199.5 15199.8 11897.6 12327.8 12482.1 12506.4 12539.9 10108.2 10171.3 10238.4 10250.2 10251.9 3416.5 3468.9 3469.1 3472.1 3479.4 85448.6 85967.3 86109.0 87425.0 87626.0 9169.1 9211.4 9242.4 9298.8 9493.2 20376.8 20420.3 20429.6 20477.4 20505.2 7230.9 7237.6 7386.4 7392.6 7578.8 3558.5 4041.0 4083.5 4085.2 4088.7 3456.1 3491.4 3506.1 3508.8 3525.4 541.4 549.4 640.3 648.6 660.7 571.5 581.6 592.0 618.5 623.0 6836.0 7787.2 8267.5 8337.5 8380.1 464.3 507.6 582.4 585.2 631.3 4018.2 4065.2 4074.5 4126.6 4147.7 84471.0 85313.0 86182.1 86411.0 86821.6 71896.0 72543.0 74181.6 74902.6 76859.5 66634.3 68940.3 69164.7 69588.3 70042.0 8015.8 8034.0 8160.0 8249.7 8343.6 47312.0 47541.3 47841.8 48198.5 48443.0 59723.0 64671.7 70049.0 70821.0 73901.0 9593.5 11310.1 11453.2 11663.0 12104.7 11836.7 11840.3 11870.5 12280.0 12589.2 11094.4 11603.4 11634.5 11929.2 12130.8 11183.0 11400.4 11503.3 11659.9 12345.3 11100.3 11362.0 11461.9 11592.0 12233.8 9251.3 9498.5 9503.9 9735.0 9920.0 8879.3 9187.0 9494.0 9804.5 9836.4 08:29:16 INFO - PROCESS | 1684 | -------- Summary: end -------- 08:29:16 INFO - PROCESS | 1684 | 08:29:16 INFO - TEST-INFO | 1684: exit 0 08:29:16 INFO - TEST-OK | dromaeo_css | took 1111050ms 08:29:16 INFO - TEST-START | kraken 08:29:16 INFO - operating with platform_type : mac_ 08:29:16 INFO - Initialising browser for kraken test... 08:29:16 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmprt79BW/profile http://localhost:49280/getInfo.html) 08:29:19 INFO - PROCESS | 1692 | __metrics Screen width/height:1600/1200 08:29:19 INFO - PROCESS | 1692 | colorDepth:24 08:29:19 INFO - PROCESS | 1692 | Browser inner width/height: 1024/689 08:29:19 INFO - PROCESS | 1692 | __metrics 08:29:19 ERROR - PROCESS | 1692 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 08:29:20 INFO - TEST-INFO | 1692: exit 0 08:29:20 INFO - Browser initialized. 08:29:20 INFO - Running cycle 1/1 for kraken test... 08:29:20 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/T/tmprt79BW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:32 INFO - PROCESS | 1695 | RSS: Main: 255471616 08:29:32 INFO - PROCESS | 1695 | 08:29:35 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 08:29:35 INFO - PROCESS | 1695 | RSS: Main: 268472320 08:29:35 INFO - PROCESS | 1695 | 08:29:38 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 08:29:38 INFO - PROCESS | 1695 | RSS: Main: 276324352 08:29:38 INFO - PROCESS | 1695 | 08:29:42 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 08:29:42 INFO - PROCESS | 1695 | RSS: Main: 281378816 08:29:42 INFO - PROCESS | 1695 | 08:29:44 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 08:29:45 INFO - PROCESS | 1695 | RSS: Main: 282800128 08:29:45 INFO - PROCESS | 1695 | 08:29:47 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:48 INFO - PROCESS | 1695 | RSS: Main: 283389952 08:29:48 INFO - PROCESS | 1695 | 08:29:50 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:51 INFO - PROCESS | 1695 | RSS: Main: 283537408 08:29:51 INFO - PROCESS | 1695 | 08:29:54 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:54 INFO - PROCESS | 1695 | RSS: Main: 283267072 08:29:54 INFO - PROCESS | 1695 | 08:29:57 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 08:29:58 INFO - PROCESS | 1695 | RSS: Main: 283815936 08:29:58 INFO - PROCESS | 1695 | 08:29:59 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:30:00 INFO - PROCESS | 1695 | RSS: Main: 283799552 08:30:00 INFO - PROCESS | 1695 | 08:30:02 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:30:03 INFO - PROCESS | 1695 | RSS: Main: 282255360 08:30:03 INFO - PROCESS | 1695 | 08:30:05 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:30:05 INFO - PROCESS | 1695 | RSS: Main: 283164672 08:30:05 INFO - PROCESS | 1695 | 08:30:08 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:30:09 INFO - PROCESS | 1695 | RSS: Main: 282374144 08:30:09 INFO - PROCESS | 1695 | 08:30:11 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:30:12 INFO - PROCESS | 1695 | RSS: Main: 282542080 08:30:12 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 08:30:14 INFO - PROCESS | 1695 | RSS: Main: 285884416 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | __start_tp_report 08:30:14 INFO - PROCESS | 1695 | _x_x_mozilla_page_load 08:30:14 INFO - PROCESS | 1695 | _x_x_mozilla_page_load_details 08:30:14 INFO - PROCESS | 1695 | |i|pagename|runs| 08:30:14 INFO - PROCESS | 1695 | |0;ai-astar;113;109;97;162;174;130;114;115;115;115 08:30:14 INFO - PROCESS | 1695 | |1;audio-beat-detection;154;124;149;152;125;138;141;130;161;127 08:30:14 INFO - PROCESS | 1695 | |2;audio-dft;192;197;203;214;213;204;195;202;204;203 08:30:14 INFO - PROCESS | 1695 | |3;audio-fft;60;67;66;72;105;62;86;87;94;128 08:30:14 INFO - PROCESS | 1695 | |4;audio-oscillator;83;81;116;80;78;83;129;116;119;127 08:30:14 INFO - PROCESS | 1695 | |5;imaging-gaussian-blur;87;96;129;94;87;131;87;93;88;93 08:30:14 INFO - PROCESS | 1695 | |6;imaging-darkroom;95;96;95;96;98;96;96;98;97;96 08:30:14 INFO - PROCESS | 1695 | |7;imaging-desaturate;91;91;89;94;94;125;90;144;149;94 08:30:14 INFO - PROCESS | 1695 | |8;json-parse-financial;55;58;54;57;57;58;57;65;55;55 08:30:14 INFO - PROCESS | 1695 | |9;json-stringify-tinderbox;70;92;91;70;80;72;59;78;96;93 08:30:14 INFO - PROCESS | 1695 | |10;stanford-crypto-aes;87;87;87;83;87;87;83;91;84;84 08:30:14 INFO - PROCESS | 1695 | |11;stanford-crypto-ccm;126;133;132;135;135;134;129;134;134;133 08:30:14 INFO - PROCESS | 1695 | |12;stanford-crypto-pbkdf2;173;175;132;186;187;169;178;154;141;152 08:30:14 INFO - PROCESS | 1695 | |13;stanford-crypto-sha256-iterative;68;69;72;70;77;98;94;95;94;69 08:30:14 INFO - PROCESS | 1695 | __end_tp_report 08:30:14 INFO - PROCESS | 1695 | __start_cc_report 08:30:14 INFO - PROCESS | 1695 | _x_x_mozilla_cycle_collect,905 08:30:14 INFO - PROCESS | 1695 | __end_cc_report 08:30:14 INFO - PROCESS | 1695 | __startTimestamp1456331414482__endTimestamp 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | ------- Summary: start ------- 08:30:14 INFO - PROCESS | 1695 | Number of tests: 14 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#0] ai-astar Cycles:10 Average:124.40 Median:122.50 stddev:24.49 (20.0%) stddev-sans-first:25.62 08:30:14 INFO - PROCESS | 1695 | Values: 113.0 109.0 97.0 162.0 174.0 130.0 114.0 115.0 115.0 115.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:145.00 stddev:13.40 (9.2%) stddev-sans-first:13.24 08:30:14 INFO - PROCESS | 1695 | Values: 154.0 124.0 149.0 152.0 125.0 138.0 141.0 130.0 161.0 127.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#2] audio-dft Cycles:10 Average:202.70 Median:203.50 stddev:7.02 (3.5%) stddev-sans-first:6.29 08:30:14 INFO - PROCESS | 1695 | Values: 192.0 197.0 203.0 214.0 213.0 204.0 195.0 202.0 204.0 203.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#3] audio-fft Cycles:10 Average:82.70 Median:69.50 stddev:21.83 (31.4%) stddev-sans-first:21.56 08:30:14 INFO - PROCESS | 1695 | Values: 60.0 67.0 66.0 72.0 105.0 62.0 86.0 87.0 94.0 128.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:79.00 stddev:21.73 (27.5%) stddev-sans-first:22.03 08:30:14 INFO - PROCESS | 1695 | Values: 83.0 81.0 116.0 80.0 78.0 83.0 129.0 116.0 119.0 127.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:90.50 stddev:16.93 (18.7%) stddev-sans-first:17.44 08:30:14 INFO - PROCESS | 1695 | Values: 87.0 96.0 129.0 94.0 87.0 131.0 87.0 93.0 88.0 93.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.00 stddev:1.06 (1.1%) stddev-sans-first:1.01 08:30:14 INFO - PROCESS | 1695 | Values: 95.0 96.0 95.0 96.0 98.0 96.0 96.0 98.0 97.0 96.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#7] imaging-desaturate Cycles:10 Average:106.10 Median:91.00 stddev:23.76 (26.1%) stddev-sans-first:24.57 08:30:14 INFO - PROCESS | 1695 | Values: 91.0 91.0 89.0 94.0 94.0 125.0 90.0 144.0 149.0 94.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:3.11 (5.5%) stddev-sans-first:3.20 08:30:14 INFO - PROCESS | 1695 | Values: 55.0 58.0 54.0 57.0 57.0 58.0 57.0 65.0 55.0 55.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#9] json-stringify-tinderbox Cycles:10 Average:80.10 Median:85.50 stddev:12.47 (14.6%) stddev-sans-first:12.68 08:30:14 INFO - PROCESS | 1695 | Values: 70.0 92.0 91.0 70.0 80.0 72.0 59.0 78.0 96.0 93.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:87.00 stddev:2.49 (2.9%) stddev-sans-first:2.62 08:30:14 INFO - PROCESS | 1695 | Values: 87.0 87.0 87.0 83.0 87.0 87.0 83.0 91.0 84.0 84.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:134.00 stddev:2.88 (2.1%) stddev-sans-first:1.86 08:30:14 INFO - PROCESS | 1695 | Values: 126.0 133.0 132.0 135.0 135.0 134.0 129.0 134.0 134.0 133.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.70 Median:174.00 stddev:18.94 (10.9%) stddev-sans-first:19.85 08:30:14 INFO - PROCESS | 1695 | Values: 173.0 175.0 132.0 186.0 187.0 169.0 178.0 154.0 141.0 152.0 08:30:14 INFO - PROCESS | 1695 | 08:30:14 INFO - PROCESS | 1695 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.60 Median:85.50 stddev:12.89 (15.1%) stddev-sans-first:12.85 08:30:14 INFO - PROCESS | 1695 | Values: 68.0 69.0 72.0 70.0 77.0 98.0 94.0 95.0 94.0 69.0 08:30:14 INFO - PROCESS | 1695 | -------- Summary: end -------- 08:30:14 INFO - PROCESS | 1695 | 08:30:15 INFO - TEST-INFO | 1695: exit 0 08:30:15 INFO - TEST-OK | kraken | took 58378ms 08:30:15 INFO - SUITE-END | took 1169s 08:30:15 INFO - Completed test suite (00:19:29) 08:30:15 INFO - Working with test: dromaeo_css 08:30:15 INFO - Generating results file: dromaeo_css 08:30:15 INFO - Working with test: kraken 08:30:15 INFO - Generating results file: kraken 08:30:15 INFO - javascript benchmark 08:30:15 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:30:15 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 08:30:15 INFO - process_Request line: dromaeo_css 7438.76 graph.html#tests=[[72,64,61]] 08:30:15 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:30:15 INFO - process_Request line: kraken 1553.00 graph.html#tests=[[232,64,61]] 08:30:15 INFO - RETURN: dromaeo_css: 7438.76 08:30:15 INFO - RETURN: kraken: 1553.00 08:30:15 INFO - javascript benchmark 08:30:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3251.2359595495054, 3493.87771428, 3517.78893266404, 3550.3076900004507, 3569.1790888095748, 5670.206171136039, 5708.372079071304, 5732.254806875106, 5746.597738158331, 5762.423757624236, 5612.270404847364, 5662.518685911702, 5724.599278050528, 5734.082546792514, 5832.154337621042, 5173.3533308336455, 5211.765470553815, 5217.087009773274, 5220.895582088356, 5289.761960711758, 5228.73856307185, 5264.499872512105, 5268.0, 5288.947110528903, 5293.206019097147, 5060.822871199509, 5089.974550127263, 5244.501772331622, 5253.080710875582, 5288.603354748409, 5174.8097937474595, 5202.92195617066, 5230.084735171368, 5233.712145831978, 5288.629795914288, 3908.530976282836, 5091.821786237464, 5168.5606723428555, 5223.817166399158, 5273.182656688219, 4352.086061926999, 4691.437027556715, 5601.103823388279, 5605.383407825136, 5612.635178713371, 6188.257409110935, 6215.378462153793, 6219.751209951596, 6231.719572619243, 6232.688365581703, 5309.283246761676, 6039.728212230416, 6182.721777520022, 6188.978818494943, 6284.497240220771, 5905.4685078343155, 5908.261467316585, 5909.0, 5910.674912879746, 5916.112583112525, 6147.016477363601, 6276.309605943343, 6278.6546739929745, 6282.748690052438, 6304.148939893147, 4899.608031357483, 4961.900761984813, 5140.922886156711, 6096.405739310651, 6104.3590423005835, 5230.869228269324, 6122.00175312775, 6161.322254551996, 6291.182146320949, 6348.682565871688, 5961.642301461926, 6128.264608247039, 6193.597416167935, 6215.34738852423, 6226.62640241587, 6103.671041328402, 6151.108089327112, 6170.784022559189, 6198.690065496708, 6200.224971878515, 4879.634027447955, 4900.191468407673, 4931.988942266827, 4941.357623508993, 4941.925871111936, 4304.655627549789, 4316.525182229952, 4324.308110702273, 4435.911281774346, 4452.977735111369, 5659.43405659439, 5691.430856914276, 5719.256496655491, 5730.140478928194, 5741.88516229673, 6278.905816412757, 6282.18331616896, 6282.685865706788, 6283.183186185766, 6300.960341543686, 5622.522085622686, 5792.189093526909, 5823.679697616587, 5856.267966504187, 5908.172855800191, 5365.248865158881, 5396.568274538027, 5399.70301633414, 5401.405845357008, 5421.5933804964, 6191.288001879841, 6246.750129994749, 6343.175387199634, 6351.333110023474, 6352.841178970562, 6251.062340648939, 6260.217472815898, 6272.153259309935, 6301.527385446018, 6326.905096423649, 6334.0, 6337.271213810286, 6338.397852204033, 6343.333949935375, 6361.045843123384, 6080.969595151996, 6125.510168486406, 6222.0, 6228.501719862491, 6232.8130156095385, 6113.3546859767275, 6181.196444462191, 6249.500039996698, 6275.937240627718, 6280.937190628035, 6145.463634091477, 6170.907436388368, 6177.505799536116, 6191.504679625709, 6204.162438070803, 5836.474717275466, 6090.269167699905, 6123.693815309306, 6143.788236235041, 6163.106349579376, 5851.61964472308, 5946.464818166212, 6019.578629495893, 6023.5181185505935, 6025.0, 5997.31030931431, 6174.104754810617, 6176.8764624706355, 6198.256209254918, 6232.501399888089, 5939.910901336397, 5979.701014949323, 6017.097435384728, 6036.0, 6063.181470501426], "unit": "score", "name": "dojo.html", "value": 5664.612564253658}, {"lowerIsBetter": false, "replicates": [500.74211780932825, 514.5369167749026, 530.7081105392036, 546.7785546853523, 601.7262145723696, 37060.25879482412, 37075.814620926925, 37522.62477375226, 37607.0, 37714.8114259429, 38273.0, 38473.61526384735, 38546.03634909121, 38598.80700596493, 38706.41940370897, 9455.952720236406, 9693.660721874736, 9706.126448619623, 9712.611495540204, 9768.462734549597, 8421.70524031659, 9520.952395238015, 9685.467299298536, 9795.363301385423, 9799.755006124868, 8851.95574022129, 9376.062393760603, 9717.708468745948, 9779.755506112333, 9856.0, 9706.223502119848, 9791.363561368487, 9827.0, 9831.606735730562, 9837.262205334628, 8252.752417427488, 9565.569549370295, 9610.135087842127, 9660.565274562661, 9694.36986595876, 37556.497740090366, 37665.623343766485, 37901.62098379008, 38014.619853801385, 38056.23887522234, 2696.492262196157, 3081.876724931, 3334.799912005263, 3634.8909532713797, 3707.2029513654693, 26687.0, 26856.59715104275, 26867.596986045224, 27342.179734607995, 27575.0, 2745.9725402746117, 2774.4728501584636, 2850.757685596727, 2855.457463082008, 2952.2766922104006, 427500.0, 480715.0, 517777.0, 525069.0, 528365.0, 53362.466375336524, 53641.731791341575, 54032.45967540353, 54119.64700882509, 54158.72920635372, 56225.0, 56657.0, 57163.714181428826, 57395.0, 57450.0, 15478.303476343592, 15601.141937193337, 15657.37370505167, 15839.52481425559, 15863.127527986071, 12248.693782655504, 12469.376531173404, 12494.81257781134, 12604.369781510888, 12608.991280697523, 17495.512881404968, 17585.03282319459, 17661.205245763973, 17687.734683979492, 17702.557436064202, 8686.131386861263, 8876.556172191365, 8915.509646969349, 8920.509371984603, 8943.508107054175, 806.8139834443359, 925.9768505787409, 988.7132731507926, 997.4065431068502, 1024.283001898674, 27372.726272737018, 29300.120996370144, 29402.264943376158, 29589.408211835642, 29883.70116298809, 1040.245821779204, 1088.7495875948418, 1097.1896370987774, 1160.3502038858267, 1165.8659254185707, 12944.805827912589, 14155.929220353832, 14271.072380295247, 14353.856461435253, 14433.278336083154, 427675.0, 526285.0, 529081.709182911, 531589.0, 533814.0, 54508.637284068216, 54844.45155548473, 54875.902481950136, 54912.45087549074, 54928.72535637296, 1428.7999680044802, 1432.2767002663588, 1433.3621538415305, 1448.6885319656114, 1597.9932642435424, 27877.0, 28170.446557216335, 28193.577096343983, 28474.288142795765, 28519.144425667262, 47226.76386618182, 48811.53565393044, 49025.754871225414, 49091.50908490869, 49270.0, 504838.0, 507094.0, 507686.0, 508355.0, 509549.0, 31324.530132048494, 31787.728490860107, 33039.33921321512, 33136.668633313355, 33155.0, 41651.58055980955, 42645.78677106595, 43005.35491967561, 43668.344974824766, 44407.77796110999, 34637.82681086579, 35611.10972225715, 36023.819880900424, 36194.095147620465, 36343.0, 34568.96293111211, 35318.82340588281, 35589.644103559665, 35684.46473302851, 35767.64232357747, 35974.280514389044, 36087.27825443529, 36149.09627259339, 36365.0908727284, 37095.62904370922, 29122.417551648425, 30129.548056779604, 30156.0, 30492.542611860397, 30495.237619059702, 23500.529989399773, 23657.29028129159, 24010.639840402757, 24036.87981560081, 24054.15810446626], "unit": "score", "name": "ext.html", "value": 19197.596771306668}, {"lowerIsBetter": false, "replicates": [314.7088942727976, 332.9184349834291, 357.62806681051705, 363.2444515407952, 369.796611863475, 15371.308291126898, 18906.149223284952, 18942.431727048195, 19493.0, 20133.899330503344, 14428.92785536071, 18736.344227952024, 18995.05024748764, 19005.334813281537, 19044.238230470764, 5567.4432556744205, 5591.524720398761, 5843.883122337551, 5884.0, 5951.434613711691, 5797.217375654296, 5897.882042359151, 5924.763009479616, 5950.404959504037, 5955.404459554054, 5511.476409741068, 5705.115707065412, 5785.421457854223, 5908.497777688902, 5913.349531551547, 4531.886702832456, 5732.856678583027, 5761.991651460978, 5772.971135144318, 5789.4500022498005, 5481.725913704338, 5503.174523821459, 5505.697186654733, 5524.06090964537, 5528.170774383834, 12766.106372553924, 12944.417501212469, 13243.47026118954, 13322.933385333108, 13371.665708357272, 1978.9307374241832, 2020.1818263603118, 2103.28488313974, 2174.1629472653144, 2185.093186327688, 9706.90293097074, 9904.504774761304, 9930.602775888956, 10713.303635263683, 14823.851761482463, 1673.2637639438608, 1711.6918954588293, 1744.2151032035636, 1755.587436952315, 1778.8754787164903, 104474.47762761214, 108425.45787271092, 108709.0, 108996.0, 112053.43973280163, 11031.448427578589, 11312.490937907814, 11447.828282575769, 11468.770624587629, 11525.193236473366, 12026.398680065962, 12852.48590056406, 13339.799903001463, 13586.320683965761, 13642.2496762679, 6707.966460167668, 8120.025596928406, 8221.876671849926, 8394.412391132562, 8410.369222308229, 8224.38317126218, 8361.163883611713, 8458.87311690325, 8471.279941204943, 8595.097514760984, 4360.454943132108, 4429.534898835575, 4468.374427580141, 4472.351509031172, 4490.483594386687, 1902.2105826082297, 1912.368918256972, 1941.26232031827, 1946.2312386607211, 1966.056292979378, 865.0743704236532, 891.8394688955921, 948.061419194992, 1009.4649835587151, 1086.21792309537, 18753.6568192862, 19187.136578853984, 19843.801561984194, 20015.699764503544, 20270.59458810845, 896.9864053619499, 968.8837339519303, 987.151050096916, 989.2827699917646, 1039.0648416425126, 10446.738831529121, 10646.520906559223, 10649.89350106489, 10653.041226289672, 10701.250912436055, 603251.0, 611562.0, 613396.0, 616191.0, 619177.0, 68170.29574260683, 72403.0, 74532.0, 110755.44622276837, 117040.0, 850.9021462531764, 983.2429029647275, 1000.2348203624233, 1007.969760907174, 1008.0826447932346, 17378.044207568706, 17611.119444027492, 17752.2011509485, 17938.19278132513, 17960.730589040915, 33115.0, 48083.75958120187, 48436.54690359295, 49791.25313120378, 50174.99650007053, 62795.6860215696, 63550.0, 68095.65952170208, 74695.62652186705, 74986.0, 7100.467464940047, 8102.79743006406, 8181.959090204511, 8224.835503289782, 8245.093039765501, 11696.298222106701, 12455.0, 13101.213927164401, 13497.932510337385, 13541.93229033888, 4683.695559788603, 5242.082635538842, 11127.609048868891, 11410.543578256777, 11654.242474239147, 10948.233623646587, 11319.133202424237, 11509.482073306888, 11697.532098715956, 11823.231489953125, 11740.823887641864, 11858.466369013242, 11923.880761192277, 11928.0, 11962.760744784882, 7992.120866704541, 8016.639251233825, 8140.430169888051, 8145.755627331189, 8178.468399554248, 11746.941265293619, 11883.82174267404, 11886.28682279066, 11899.405029748652, 11918.165728398928], "unit": "score", "name": "jquery.html", "value": 9008.006114631633}, {"lowerIsBetter": false, "replicates": [1439.2875526614328, 1553.74363230067, 1777.511184424283, 1909.4748944040396, 1926.9807301926976, 7740.303372696456, 8285.295749861269, 8517.957410212948, 8689.52207628581, 8716.520591367473, 8488.78778030548, 8492.0, 8629.395942284043, 8631.956840215806, 8658.393912426132, 2435.0868424340874, 2445.608702607583, 2456.091246238894, 2462.729099799021, 2468.8518688878726, 2415.915442959497, 2465.9260222193275, 2470.6170543565777, 2479.5412848622973, 2482.7765501104896, 2125.224293133003, 2409.33743220614, 2436.0, 2450.840695354805, 2467.6915385576804, 2414.5291668124723, 2435.2085572189108, 2440.45089854783, 2471.542764588548, 2473.3692908308444, 2428.9271321860374, 2433.6106223004413, 2448.20433359159, 2450.1791899713617, 2455.472073504205, 8584.399092063559, 8617.224449799549, 8619.913800861974, 8647.567621618893, 8659.090795466449, 5273.34083239595, 5444.428335024844, 5480.424555421663, 5482.506574408282, 5488.890222195534, 3137.8587963541695, 3550.91122721934, 3599.1002249437643, 3714.1457464783252, 3726.329260733067, 1060.8355704865758, 1062.6333914799459, 1065.2702898514542, 1080.8540846985713, 1084.4035780320871, 9716.562754676057, 11391.0, 11472.369019703912, 11542.134339924456, 11565.190436669436, 4054.7567145970747, 4373.431453911035, 4813.109574728616, 4942.777575009133, 4981.526754958273, 10018.74953126163, 10023.799524009624, 10033.849492257623, 10048.899511004942, 10065.798684026426, 5460.672359658433, 5470.835874923759, 5490.423505531861, 5513.5037846594, 5517.4482551745305, 4913.582345500601, 4955.529224723646, 4981.950180498148, 5016.924746128811, 5025.020121076428, 3704.870329538453, 3755.7746535207975, 3756.2111956489443, 3788.791616461066, 3799.639034291738, 1132.5243397772956, 1158.976820463586, 1167.9416029198505, 1179.8584169899666, 1195.6413076077142, 1125.358545629, 1131.660501849442, 1193.8209268609605, 1307.5619667411333, 1368.3500337339883, 7791.0650721913735, 7829.3736501079775, 7858.371330293563, 7984.760457186294, 7995.0, 1197.7245233596323, 1207.927524348542, 1209.4255228766265, 1231.6428235811513, 1235.5737270641614, 5219.347581552306, 6037.909431358533, 6118.541109416722, 6126.23422072241, 6220.440160385587, 9450.243980481546, 9516.38143520669, 10326.432046237529, 10335.22485813552, 10453.0, 9965.252606054575, 10237.027482389161, 10277.280590358752, 10338.37969721804, 10407.635732749317, 6760.0, 7933.246341597539, 8027.8359637853355, 8073.798155046054, 8117.959410202911, 7877.960610196912, 7897.644605992859, 7920.801979950547, 7942.880856787037, 8125.146859579659, 9092.545372731205, 9495.66765163216, 9513.762155946157, 9529.714108576754, 9558.28312876551, 8604.61279242423, 9619.807603848023, 9670.56482458277, 9710.465924373944, 9860.71810664609, 7955.801104972422, 8067.112617611941, 8167.183281671785, 8196.54918979462, 8224.054233762954, 8070.596470176585, 8071.394645401736, 8101.918980810116, 8146.0, 8157.428979971345, 6298.433141017331, 6431.421172094534, 7251.093613298338, 7478.307809188579, 7494.6252687366505, 7018.473614478832, 7116.252793456612, 7165.104361954755, 7183.066201393785, 7191.42468602521, 7473.813154671177, 7502.924970750222, 7548.0, 7552.735654252075, 7556.546607203585, 6835.624040677611, 6866.588004719732, 6875.656217189021, 6877.965610171917, 6879.793606191823, 6770.729170833111, 6962.408195303456, 6989.091418115612, 7012.228654848064, 7016.228214896255], "unit": "score", "name": "mootools.html", "value": 4867.727946471736}, {"lowerIsBetter": false, "replicates": [295.51387966794624, 327.7541843617287, 328.6713286713287, 332.1778597970024, 336.71042903103313, 6578.144841170653, 6760.729570817161, 6807.7957661270175, 6849.178098628166, 6856.52004359695, 6717.0, 6754.594724316532, 6794.592324460536, 6806.727730890759, 6835.829104272383, 4992.550670439659, 5014.448410674814, 5016.072026675059, 5018.7992480300745, 5024.221245706921, 3887.319719049169, 4041.6160464755803, 5022.698638081727, 5039.949600504003, 5062.9240561391425, 4101.487314085739, 4893.975530122344, 4965.503449655023, 4969.2049272116465, 4981.352424184869, 4707.152712511746, 4917.336159618477, 4989.3513843200335, 4993.226049962243, 5001.624878134118, 3365.4951757236367, 4098.0, 4102.979485102585, 4113.095119073799, 4133.607307305801, 6379.075034120073, 6401.455876250524, 6427.132337134473, 6448.45188159007, 6485.092087107809, 5579.302587176603, 5667.688277144755, 5711.657300561979, 5717.48542631161, 5724.513416359614, 7089.5037347385705, 7092.645367731593, 7102.92897071033, 7112.431005519546, 7118.07465029548, 4559.110973360196, 4595.218812801798, 4609.354690343354, 4611.723296602181, 4617.030423611046, 7586.544807311579, 7611.0, 7613.0483689538805, 7627.199144089846, 7690.538567685957, 4476.955230447654, 4628.352030715702, 4634.976825115853, 4650.4186976627925, 4653.813847446132, 3936.193080418507, 4692.718436893797, 4728.219843725816, 4741.336212930192, 4742.478327383985, 5630.5495560355075, 5636.802711905064, 5641.858953526113, 5647.322321321386, 5673.461021202979, 7230.746923857745, 7234.927650723425, 7237.674304656303, 7263.382612477999, 7291.927080729125, 1622.7890374251272, 1647.5139833749072, 1650.5048485454315, 1651.5953591370192, 1652.2977734463045, 992.2211064314479, 1023.8924912884189, 1043.7860238651058, 1056.3133962924007, 1072.828347464402, 5338.546223570962, 6786.4910131739325, 6811.863762724718, 6843.555168914005, 6851.177858656993, 6051.062085376686, 6105.877882442415, 7505.6997720090585, 7515.962420187864, 7522.924770752223, 6808.4212841908, 6824.18109826824, 6827.702736480053, 6832.59004459734, 6842.281560436182, 3870.1666376933854, 3955.0705584187695, 3982.900427489336, 3992.640662340403, 3996.320625493615, 5397.0, 7640.541567505968, 7769.689212431553, 7831.725889593951, 7858.803529911684, 7635.465517413728, 7664.846703065908, 7673.271039251262, 7677.808054798563, 7701.537907725555, 7793.220677932161, 7817.218278172251, 7825.726099586487, 7843.803904902309, 7849.686012559548, 7188.964055179691, 7394.482386232912, 7465.253474652492, 7479.962600187182, 7505.624718764149, 7271.41828653717, 7315.6342182889575, 7321.63391830417, 7339.9633001834645, 7342.0, 6310.968445157745, 7782.455228133977, 7802.648880800264, 7813.179616140451, 7852.764417067498, 4662.184117779443, 4674.135284972155, 4677.766111694334, 4679.485256621837, 4704.129735998851, 6550.967245163743, 7014.859702806018, 7230.602316872622, 7428.9628551856895, 7451.913464230024, 6197.597156184834, 7335.8532829344185, 7366.594837284001, 7373.193567575764, 7374.225706300761, 7323.963380183065, 7356.4114870809135, 7372.926270737438, 7376.7049318026675, 7379.557226566423, 7144.642767861482, 7157.141143062866, 7157.534760240567, 7173.1392232932385, 7184.353408193288, 7066.681999310146, 7266.273372662691, 7282.162551306667, 7350.301721336465, 7350.77947661571, 6191.133241346125, 6721.899171512529, 7063.223045464892, 7072.858542829217, 7147.748459235324], "unit": "score", "name": "prototype.html", "value": 5197.524621530066}, {"lowerIsBetter": false, "replicates": [622.8723111762089, 659.518551457436, 665.0888283052219, 671.4963777167123, 737.3363972424813, 14645.487407940738, 14678.192699401528, 14787.704245915089, 17074.487765367026, 17334.0, 15740.212989350515, 15837.0, 15930.920345398257, 15971.92014039931, 15976.680466390666, 705.3546005405049, 856.5931182688236, 861.9224269815732, 866.077627326898, 879.7360791762478, 868.5223127280002, 874.6501399440211, 875.8948926128874, 876.2289185516736, 877.55244825139, 905.2441211588332, 916.7708072981754, 919.7240827751681, 920.4109370003204, 923.6628630549868, 877.9517126558037, 898.1691934960136, 917.4357769971419, 917.6467060181844, 922.3866129024191, 669.0432681265788, 682.8907374820005, 682.9180498340181, 684.0696652552524, 684.3737979748524, 15139.015963962418, 15172.620684482867, 15197.088174709554, 15199.468018619295, 15199.772003419957, 11897.643070707893, 12327.753444931051, 12482.126251162423, 12506.437210325466, 12539.93730031344, 10108.241881858816, 10171.288009839314, 10238.385696858213, 10250.17998560121, 10251.89748102517, 3416.538767266412, 3468.930621387558, 3469.063352894704, 3472.149323415754, 3479.425894727367, 85448.59135564858, 85967.28065438718, 86109.0, 87425.0, 87626.0, 9169.08309169091, 9211.380864322971, 9242.399244049115, 9298.814023719488, 9493.19307858826, 20376.796232037785, 20420.285290014777, 20429.591408171753, 20477.38567842967, 20505.17979280812, 7230.927690723131, 7237.565746055254, 7386.409087273005, 7392.593407362539, 7578.810529736801, 3558.484019817112, 4040.9797951010055, 4083.5099788025627, 4085.162541678949, 4088.652464540488, 3456.1359660084977, 3491.4064609016527, 3506.1234691327168, 3508.8421021053605, 3525.3654342218133, 541.3936391241756, 549.4148731600833, 640.2509064394669, 648.597869321024, 660.7423104989058, 571.5199232644599, 581.5725441800273, 592.0, 618.4804763998263, 622.9974198596555, 6836.0, 7787.221277872168, 8267.462614930011, 8337.458065225741, 8380.120087390858, 464.30818081058976, 507.57363814396086, 582.3586019425175, 585.233344318935, 631.2771876201723, 4018.1561872007205, 4065.2072845794787, 4074.490688663917, 4126.628603425706, 4147.668186545069, 84471.0, 85313.0, 86182.13817861867, 86411.0, 86821.56589217014, 71896.0, 72543.0, 74181.62909185527, 74902.62548687222, 76859.46281074347, 66634.33365666281, 68940.27649308708, 69164.6541767298, 69588.30411695919, 70042.0, 8015.7595272141925, 8034.0, 8160.0, 8249.670013199644, 8343.582820859054, 47312.0, 47541.28688069613, 47841.76079119582, 48198.51801482081, 48443.0, 59723.027697231664, 64671.70656586748, 70049.0, 70821.0, 73901.0, 9593.520323983634, 11310.095192384753, 11453.19827612059, 11663.008644264994, 12104.676670614152, 11836.70408239801, 11840.289582624726, 11870.525178992744, 12280.017598591912, 12589.24464532131, 11094.445277736242, 11603.419829008348, 11634.534618615498, 11929.224600400947, 12130.818037729265, 11183.0, 11400.372979486208, 11503.252288601214, 11659.88340116588, 12345.321007344683, 11100.333979961228, 11362.0, 11461.885381146416, 11592.004550580217, 12233.816492752438, 9251.259899208182, 9498.525073746423, 9503.904960950302, 9735.0, 9920.0, 8879.289656827568, 9186.954065229631, 9493.95253023758, 9804.509774511389, 9836.409815411098], "unit": "score", "name": "yui.html", "value": 6836.01074453597}], "name": "dromaeo_css", "value": 7438.764459588451}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 109.0, 97.0, 162.0, 174.0, 130.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 124.4}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 149.0, 152.0, 125.0, 138.0, 141.0, 130.0, 161.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 140.1}, {"lowerIsBetter": true, "replicates": [192.0, 197.0, 203.0, 214.0, 213.0, 204.0, 195.0, 202.0, 204.0, 203.0], "unit": "score", "name": "audio-dft", "value": 202.7}, {"lowerIsBetter": true, "replicates": [60.0, 67.0, 66.0, 72.0, 105.0, 62.0, 86.0, 87.0, 94.0, 128.0], "unit": "score", "name": "audio-fft", "value": 82.7}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 116.0, 80.0, 78.0, 83.0, 129.0, 116.0, 119.0, 127.0], "unit": "score", "name": "audio-oscillator", "value": 101.2}, {"lowerIsBetter": true, "replicates": [87.0, 96.0, 129.0, 94.0, 87.0, 131.0, 87.0, 93.0, 88.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 98.0, 96.0, 96.0, 98.0, 97.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 96.3}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 89.0, 94.0, 94.0, 125.0, 90.0, 144.0, 149.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 106.1}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 54.0, 57.0, 57.0, 58.0, 57.0, 65.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.1}, {"lowerIsBetter": true, "replicates": [70.0, 92.0, 91.0, 70.0, 80.0, 72.0, 59.0, 78.0, 96.0, 93.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 80.1}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 87.0, 83.0, 87.0, 87.0, 83.0, 91.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.0}, {"lowerIsBetter": true, "replicates": [126.0, 133.0, 132.0, 135.0, 135.0, 134.0, 129.0, 134.0, 134.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.5}, {"lowerIsBetter": true, "replicates": [173.0, 175.0, 132.0, 186.0, 187.0, 169.0, 178.0, 154.0, 141.0, 152.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 164.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 72.0, 70.0, 77.0, 98.0, 94.0, 95.0, 94.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 80.6}], "name": "kraken", "value": 1553.0}]} 08:30:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1553.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7438.76"}}} 08:30:15 INFO - Return code: 0 08:30:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:30:15 ERROR - # TBPL SUCCESS # 08:30:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:30:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:30:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:30:15 INFO - 2016-02-24 08:30:15.863 screenresolution[1701:10622] starting screenresolution argv=screenresolution get 08:30:15 INFO - 2016-02-24 08:30:15.866 screenresolution[1701:10622] Display 0: 1600x1200x32@60 08:30:15 INFO - 2016-02-24 08:30:15.872 screenresolution[1702:10625] starting screenresolution argv=screenresolution list 08:30:15 INFO - Available Modes on Display 0 08:30:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:30:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:30:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:30:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:30:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:30:16 INFO - Intel Iris: 08:30:16 INFO - Chipset Model: Intel Iris 08:30:16 INFO - Type: GPU 08:30:16 INFO - Bus: Built-In 08:30:16 INFO - VRAM (Dynamic, Max): 1536 MB 08:30:16 INFO - Vendor: Intel (0x8086) 08:30:16 INFO - Device ID: 0x0a2e 08:30:16 INFO - Revision ID: 0x0009 08:30:16 INFO - Displays: 08:30:16 INFO - Display: 08:30:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:30:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:30:16 INFO - Display Serial Number: 1600x1200 60 08:30:16 INFO - Main Display: Yes 08:30:16 INFO - Mirror: Off 08:30:16 INFO - Online: Yes 08:30:16 INFO - Rotation: Supported 08:30:16 INFO - Return code: 0 08:30:16 INFO - Running post-action listener: _resource_record_post_action 08:30:16 INFO - Running post-run listener: _resource_record_post_run 08:30:17 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 34082304; Write bytes: 707574784; Read time: 358; Write time: 2245 08:30:17 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 389118464; Write bytes: 382649856; Read time: 30099; Write time: 946 08:30:17 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 33160704; Write bytes: 301618688; Read time: 345; Write time: 1248 08:30:17 INFO - Running post-run listener: _upload_blobber_files 08:30:17 INFO - Blob upload gear active. 08:30:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:30:17 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:30:17 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:30:17 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:30:17 INFO - (blobuploader) - INFO - Open directory for files ... 08:30:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:30:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:30:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:18 INFO - (blobuploader) - INFO - Done attempting. 08:30:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:30:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:30:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:19 INFO - (blobuploader) - INFO - Done attempting. 08:30:19 INFO - (blobuploader) - INFO - Iteration through files over. 08:30:19 INFO - Return code: 0 08:30:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:30:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:30:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79236a21d2d1586ad15bbc6db29dfbaf0a85b09320f9c8be4bbae3bfe1476342298d58d1830473b5a803e4017f68fc4eb8ddfe469cbdc5f1be2889e055db9687", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba89403dd6e51837f6b522160a0587dc027ff5cca23857cda723fe2f90df3accb7b33bd57deed6fac6615e98ceef96e82350cd099bca6669aead82b93b54f0ea"} 08:30:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:30:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:30:19 INFO - Contents: 08:30:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79236a21d2d1586ad15bbc6db29dfbaf0a85b09320f9c8be4bbae3bfe1476342298d58d1830473b5a803e4017f68fc4eb8ddfe469cbdc5f1be2889e055db9687", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba89403dd6e51837f6b522160a0587dc027ff5cca23857cda723fe2f90df3accb7b33bd57deed6fac6615e98ceef96e82350cd099bca6669aead82b93b54f0ea"} 08:30:19 INFO - Running post-run listener: copy_logs_to_upload_dir 08:30:19 INFO - Copying logs to upload dir... 08:30:19 INFO - mkdir: /builds/slave/test/build/upload/logs 08:30:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.106916 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-24 08:30:19.501449) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 08:30:19.505569) ========= 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.lkEySxx1SU/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.kew7k8r0FL/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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/79236a21d2d1586ad15bbc6db29dfbaf0a85b09320f9c8be4bbae3bfe1476342298d58d1830473b5a803e4017f68fc4eb8ddfe469cbdc5f1be2889e055db9687", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba89403dd6e51837f6b522160a0587dc027ff5cca23857cda723fe2f90df3accb7b33bd57deed6fac6615e98ceef96e82350cd099bca6669aead82b93b54f0ea"} build_url:https://queue.taskcluster.net/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010708 build_url: 'https://queue.taskcluster.net/v1/task/GNQgvo7QRIeRxsCjEPc3Kg/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/79236a21d2d1586ad15bbc6db29dfbaf0a85b09320f9c8be4bbae3bfe1476342298d58d1830473b5a803e4017f68fc4eb8ddfe469cbdc5f1be2889e055db9687", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ba89403dd6e51837f6b522160a0587dc027ff5cca23857cda723fe2f90df3accb7b33bd57deed6fac6615e98ceef96e82350cd099bca6669aead82b93b54f0ea"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 08:30:19.555427) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:30:19.555799) ========= 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.lkEySxx1SU/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.kew7k8r0FL/Listeners TMPDIR=/var/folders/5h/cmwhq37s15q4p6v6d2gyhw5w00000w/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.004945 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 08:30:19.643248) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 08:30:19.643811) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 08:30:19.644803) ========= ========= Total master_lag: 0.34 =========