builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0006 starttime: 1456246105.96 results: success (0) buildid: 20160223073912 builduid: 6cb7342bebc44c38afd11f5b3069168e revision: 12c77a8f0e4ac5286ab5bc6f738fe8a1283640b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:25.958332) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:25.958813) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:25.959156) ========= 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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.005759 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:25.983355) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:25.983723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:26.002116) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:26.002458) ========= 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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.005742 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:26.050844) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:26.051164) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:26.051534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:26.051843) ========= 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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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-23 08:48:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.3M=0.001s 2016-02-23 08:48:26 (15.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.173218 ========= master_lag: 0.40 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:26.622779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:26.623142) ========= 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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.026236 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:26.669501) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-23 08:48:26.669852) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 12c77a8f0e4ac5286ab5bc6f738fe8a1283640b6 --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 12c77a8f0e4ac5286ab5bc6f738fe8a1283640b6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YqJJY6EeVe/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.Jng8qL7Ote/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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-23 08:48:26,745 truncating revision to first 12 chars 2016-02-23 08:48:26,745 Setting DEBUG logging. 2016-02-23 08:48:26,745 attempt 1/10 2016-02-23 08:48:26,745 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/12c77a8f0e4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 08:48:28,162 unpacking tar archive at: fx-team-12c77a8f0e4a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.676166 ========= master_lag: 0.97 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-23 08:48:29.319940) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:29.320254) ========= echo 12c77a8f0e4ac5286ab5bc6f738fe8a1283640b6 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'12c77a8f0e4ac5286ab5bc6f738fe8a1283640b6'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YqJJY6EeVe/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.Jng8qL7Ote/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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 12c77a8f0e4ac5286ab5bc6f738fe8a1283640b6 program finished with exit code 0 elapsedTime=0.005753 script_repo_revision: '12c77a8f0e4ac5286ab5bc6f738fe8a1283640b6' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:29.366227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:29.366510) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 08:48:29.402048) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-02-23 08:48:29.402328) ========= /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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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:48:29 INFO - MultiFileLogger online at 20160223 08:48:29 in /builds/slave/test 08:48:29 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:48:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:48:29 INFO - {'append_to_log': False, 08:48:29 INFO - 'base_work_dir': '/builds/slave/test', 08:48:29 INFO - 'blob_upload_branch': 'Fx-Team', 08:48:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:48:29 INFO - 'branch': 'Fx-Team', 08:48:29 INFO - 'buildbot_json_path': 'buildprops.json', 08:48:29 INFO - 'config_files': ('talos/mac_config.py',), 08:48:29 INFO - 'default_actions': ('clobber', 08:48:29 INFO - 'read-buildbot-config', 08:48:29 INFO - 'download-and-extract', 08:48:29 INFO - 'populate-webroot', 08:48:29 INFO - 'create-virtualenv', 08:48:29 INFO - 'install', 08:48:29 INFO - 'run-tests'), 08:48:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:48:29 INFO - 'download_minidump_stackwalk': True, 08:48:29 INFO - 'download_symbols': 'ondemand', 08:48:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:48:29 INFO - 'tooltool.py': '/tools/tooltool.py', 08:48:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:48:29 INFO - '/tools/misc-python/virtualenv.py')}, 08:48:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:48:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:48:29 INFO - 'installer_path': 'installer.exe', 08:48:29 INFO - 'log_level': 'info', 08:48:29 INFO - 'log_name': 'talos', 08:48:29 INFO - 'log_to_console': True, 08:48:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:48:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:48:29 INFO - 'opt_config_files': (), 08:48:29 INFO - 'pip_index': False, 08:48:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:48:29 INFO - 'cmd': ('bash', 08:48:29 INFO - '-c', 08:48:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:48:29 INFO - 'enabled': True, 08:48:29 INFO - 'halt_on_failure': False, 08:48:29 INFO - 'name': 'check_screen_resolution'},), 08:48:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:48:29 INFO - 'cmd': ('bash', 08:48:29 INFO - '-c', 08:48:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:48:29 INFO - 'enabled': True, 08:48:29 INFO - 'halt_on_failure': False, 08:48:29 INFO - 'name': 'check_screen_resolution'},), 08:48:29 INFO - 'run_cmd_checks_enabled': True, 08:48:29 INFO - 'sps_profile': False, 08:48:29 INFO - 'sps_profile_interval': 0, 08:48:29 INFO - 'suite': 'dromaeojs-e10s', 08:48:29 INFO - 'system_bits': '32', 08:48:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:48:29 INFO - 'title': 't-yosemite-r7-0006', 08:48:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:48:29 INFO - 'use_talos_json': True, 08:48:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:48:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:48:29 INFO - 'work_dir': 'build'} 08:48:29 INFO - ##### 08:48:29 INFO - ##### Running clobber step. 08:48:29 INFO - ##### 08:48:29 INFO - Running pre-action listener: _resource_record_pre_action 08:48:29 INFO - Running main action method: clobber 08:48:29 INFO - rmtree: /builds/slave/test/build 08:48:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:48:31 INFO - Running post-action listener: _resource_record_post_action 08:48:31 INFO - ##### 08:48:31 INFO - ##### Running read-buildbot-config step. 08:48:31 INFO - ##### 08:48:31 INFO - Running pre-action listener: _resource_record_pre_action 08:48:31 INFO - Running main action method: read_buildbot_config 08:48:31 INFO - Using buildbot properties: 08:48:31 INFO - { 08:48:31 INFO - "project": "", 08:48:31 INFO - "product": "firefox", 08:48:31 INFO - "script_repo_revision": "production", 08:48:31 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:48:31 INFO - "repository": "", 08:48:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:48:31 INFO - "buildid": "20160223073912", 08:48:31 INFO - "pgo_build": "False", 08:48:31 INFO - "basedir": "/builds/slave/test", 08:48:31 INFO - "buildnumber": 490, 08:48:31 INFO - "slavename": "t-yosemite-r7-0006", 08:48:31 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:48:31 INFO - "platform": "yosemite_r7", 08:48:31 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:48:31 INFO - "branch": "fx-team", 08:48:31 INFO - "repo_path": "integration/fx-team", 08:48:31 INFO - "revision": "12c77a8f0e4ac5286ab5bc6f738fe8a1283640b6", 08:48:31 INFO - "stage_platform": "macosx64", 08:48:31 INFO - "builduid": "6cb7342bebc44c38afd11f5b3069168e", 08:48:31 INFO - "slavebuilddir": "test" 08:48:31 INFO - } 08:48:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 08:48:31 INFO - Running post-action listener: _resource_record_post_action 08:48:31 INFO - ##### 08:48:31 INFO - ##### Running download-and-extract step. 08:48:31 INFO - ##### 08:48:31 INFO - Running pre-action listener: _resource_record_pre_action 08:48:31 INFO - Running main action method: download_and_extract 08:48:31 INFO - mkdir: /builds/slave/test/build/tests 08:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:31 INFO - https://queue.taskcluster.net/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:48:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/test_packages.json 08:48:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/test_packages.json 08:48:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:48:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:48:32 INFO - Downloaded 1277 bytes. 08:48:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:48:32 INFO - Using the following test package requirements: 08:48:32 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:48:32 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:48:32 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 08:48:32 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:48:32 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 08:48:32 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:48:32 INFO - u'jsshell-mac.zip'], 08:48:32 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:48:32 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 08:48:32 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:48:32 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:48:32 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 08:48:32 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:48:32 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 08:48:32 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:48:32 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 08:48:32 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:48:32 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:48:32 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 08:48:32 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:32 INFO - https://queue.taskcluster.net/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:48:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:48:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:48:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/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:48:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/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:48:33 INFO - Downloaded 17825423 bytes. 08:48:33 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:48:33 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:48:36 INFO - Return code: 0 08:48:36 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:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:36 INFO - https://queue.taskcluster.net/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:48:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:48:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:48:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/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:48:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/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:48:37 INFO - Downloaded 17825423 bytes. 08:48:37 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:48:37 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:48:40 INFO - Return code: 0 08:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:40 INFO - https://queue.taskcluster.net/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:48:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:48:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:48:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/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:48:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/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:48:41 INFO - Downloaded 10707015 bytes. 08:48:41 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:48:41 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:48:41 INFO - Return code: 0 08:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:41 INFO - https://queue.taskcluster.net/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:48:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:48:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:48:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 08:48:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CvV9g1qgQEePJNYBFJ8AMA/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:48:44 INFO - Downloaded 111283026 bytes. 08:48:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:48:44 INFO - mkdir: /builds/slave/test/properties 08:48:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:44 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:44 INFO - Contents: 08:48:44 INFO - build_url:https://queue.taskcluster.net/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:48:45 INFO - Running post-action listener: _resource_record_post_action 08:48:45 INFO - Running post-action listener: set_extra_try_arguments 08:48:45 INFO - ##### 08:48:45 INFO - ##### Running populate-webroot step. 08:48:45 INFO - ##### 08:48:45 INFO - Running pre-action listener: _resource_record_pre_action 08:48:45 INFO - Running main action method: populate_webroot 08:48:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:45 INFO - '--tppagecycles', 08:48:45 INFO - '7'], 08:48:45 INFO - 'tests': ['tsvgm']}}, 08:48:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:48:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:48:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:48:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:48:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:48:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:45 INFO - 'talos_options': ['--e10s'], 08:48:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:45 INFO - 'tests': ['damp', 'tps']}, 08:48:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:45 INFO - 'talos_options': ['--e10s'], 08:48:45 INFO - 'tests': ['damp', 'tps']}, 08:48:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:48:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:45 INFO - 'other': {'tests': ['a11yr', 08:48:45 INFO - 'ts_paint', 08:48:45 INFO - 'tpaint', 08:48:45 INFO - 'sessionrestore', 08:48:45 INFO - 'sessionrestore_no_auto_restore']}, 08:48:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:48:45 INFO - 'tests': ['a11yr', 08:48:45 INFO - 'ts_paint', 08:48:45 INFO - 'tpaint', 08:48:45 INFO - 'sessionrestore', 08:48:45 INFO - 'sessionrestore_no_auto_restore']}, 08:48:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:48:45 INFO - 'tests': ['a11yr', 08:48:45 INFO - 'ts_paint', 08:48:45 INFO - 'tpaint', 08:48:45 INFO - 'sessionrestore', 08:48:45 INFO - 'sessionrestore_no_auto_restore']}, 08:48:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:48:45 INFO - 'tests': ['a11yr', 08:48:45 INFO - 'ts_paint', 08:48:45 INFO - 'tpaint', 08:48:45 INFO - 'sessionrestore', 08:48:45 INFO - 'sessionrestore_no_auto_restore']}, 08:48:45 INFO - 'other_l64': {'tests': ['a11yr', 08:48:45 INFO - 'ts_paint', 08:48:45 INFO - 'tpaint', 08:48:45 INFO - 'sessionrestore', 08:48:45 INFO - 'sessionrestore_no_auto_restore']}, 08:48:45 INFO - 'other_nol64': {'tests': ['a11yr', 08:48:45 INFO - 'ts_paint', 08:48:45 INFO - 'tpaint', 08:48:45 INFO - 'sessionrestore', 08:48:45 INFO - 'sessionrestore_no_auto_restore']}, 08:48:45 INFO - 'svgr': {'tests': ['tsvgx', 08:48:45 INFO - 'tsvgr_opacity', 08:48:45 INFO - 'tart', 08:48:45 INFO - 'tscrollx', 08:48:45 INFO - 'cart']}, 08:48:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:48:45 INFO - 'tests': ['tsvgx', 08:48:45 INFO - 'tsvgr_opacity', 08:48:45 INFO - 'tart', 08:48:45 INFO - 'tscrollx', 08:48:45 INFO - 'cart']}, 08:48:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:45 INFO - 'tests': ['tp5o']}, 08:48:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:45 INFO - 'talos_options': ['--e10s'], 08:48:45 INFO - 'tests': ['tp5o']}, 08:48:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:45 INFO - 'talos_options': ['--xperf_path', 08:48:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:45 INFO - 'tests': ['tp5n']}, 08:48:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:45 INFO - 'talos_options': ['--e10s', 08:48:45 INFO - '--xperf_path', 08:48:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:45 INFO - 'tests': ['tp5n']}}, 08:48:45 INFO - 'talos.zip': {'path': '', 08:48:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:45 INFO - Running post-action listener: _resource_record_post_action 08:48:45 INFO - ##### 08:48:45 INFO - ##### Running create-virtualenv step. 08:48:45 INFO - ##### 08:48:45 INFO - Running pre-action listener: _resource_record_pre_action 08:48:45 INFO - Running main action method: create_virtualenv 08:48:45 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:45 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:48:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:46 INFO - Using real prefix '/tools/python27' 08:48:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:46 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:49 INFO - Installing pip.................done. 08:48:49 INFO - Return code: 0 08:48:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:49 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:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:49 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:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:49 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 0x1042cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042d64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962d51060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104173d30>, '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 0x103f97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10416ab20>, '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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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:48:49 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:48:49 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:48:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqJJY6EeVe/Render', 08:48:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:49 INFO - 'HOME': '/Users/cltbld', 08:48:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:49 INFO - 'LOGNAME': 'cltbld', 08:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:49 INFO - 'MOZ_NO_REMOTE': '1', 08:48:49 INFO - 'NO_EM_RESTART': '1', 08:48:49 INFO - 'PAGER': '/bin/cat', 08:48:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:49 INFO - 'PWD': '/builds/slave/test', 08:48:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:49 INFO - 'SHELL': '/bin/bash', 08:48:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jng8qL7Ote/Listeners', 08:48:49 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 08:48:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:49 INFO - 'USER': 'cltbld', 08:48:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:49 INFO - 'XPC_FLAGS': '0x0', 08:48:49 INFO - 'XPC_SERVICE_NAME': '0', 08:48:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:49 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:48:49 INFO - Cleaning up... 08:48:50 INFO - Return code: 0 08:48:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:50 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 0x1042cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042d64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962d51060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104173d30>, '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 0x103f97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10416ab20>, '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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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:48:50 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:48:50 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:48:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqJJY6EeVe/Render', 08:48:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:50 INFO - 'HOME': '/Users/cltbld', 08:48:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:50 INFO - 'LOGNAME': 'cltbld', 08:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:50 INFO - 'MOZ_NO_REMOTE': '1', 08:48:50 INFO - 'NO_EM_RESTART': '1', 08:48:50 INFO - 'PAGER': '/bin/cat', 08:48:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:50 INFO - 'PWD': '/builds/slave/test', 08:48:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:50 INFO - 'SHELL': '/bin/bash', 08:48:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jng8qL7Ote/Listeners', 08:48:50 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 08:48:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:50 INFO - 'USER': 'cltbld', 08:48:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:50 INFO - 'XPC_FLAGS': '0x0', 08:48:50 INFO - 'XPC_SERVICE_NAME': '0', 08:48:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:50 INFO - Downloading/unpacking psutil>=0.7.1 08:48:50 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:48:50 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:48:50 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:48:50 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:48:50 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:48:50 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:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:53 INFO - Installing collected packages: psutil 08:48:53 INFO - Running setup.py install for psutil 08:48:53 INFO - building 'psutil._psutil_osx' extension 08:48:53 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:48:53 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:48:53 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:48:53 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:48:54 INFO - building 'psutil._psutil_posix' extension 08:48:54 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:48:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:48:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:48:54 INFO - ^ 08:48:54 INFO - 1 warning generated. 08:48:54 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:48:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:54 INFO - Successfully installed psutil 08:48:54 INFO - Cleaning up... 08:48:54 INFO - Return code: 0 08:48:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:54 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 0x1042cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042d64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962d51060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104173d30>, '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 0x103f97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10416ab20>, '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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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:48:54 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:48:54 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:48:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqJJY6EeVe/Render', 08:48:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:54 INFO - 'HOME': '/Users/cltbld', 08:48:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:54 INFO - 'LOGNAME': 'cltbld', 08:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:54 INFO - 'MOZ_NO_REMOTE': '1', 08:48:54 INFO - 'NO_EM_RESTART': '1', 08:48:54 INFO - 'PAGER': '/bin/cat', 08:48:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:54 INFO - 'PWD': '/builds/slave/test', 08:48:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:54 INFO - 'SHELL': '/bin/bash', 08:48:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jng8qL7Ote/Listeners', 08:48:54 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 08:48:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:54 INFO - 'USER': 'cltbld', 08:48:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:54 INFO - 'XPC_FLAGS': '0x0', 08:48:54 INFO - 'XPC_SERVICE_NAME': '0', 08:48:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:48:54 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:48:54 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:48:54 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:48:54 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:48:54 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:48:54 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:48:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:48:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:56 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:48:56 INFO - Installing collected packages: mozsystemmonitor 08:48:56 INFO - Running setup.py install for mozsystemmonitor 08:48:57 INFO - Successfully installed mozsystemmonitor 08:48:57 INFO - Cleaning up... 08:48:57 INFO - Return code: 0 08:48:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:57 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 0x1042cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042d64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962d51060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104173d30>, '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 0x103f97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10416ab20>, '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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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:48:57 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:48:57 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:48:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqJJY6EeVe/Render', 08:48:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:48:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:48:57 INFO - 'HOME': '/Users/cltbld', 08:48:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:48:57 INFO - 'LOGNAME': 'cltbld', 08:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:57 INFO - 'MOZ_NO_REMOTE': '1', 08:48:57 INFO - 'NO_EM_RESTART': '1', 08:48:57 INFO - 'PAGER': '/bin/cat', 08:48:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:57 INFO - 'PWD': '/builds/slave/test', 08:48:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:48:57 INFO - 'SHELL': '/bin/bash', 08:48:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jng8qL7Ote/Listeners', 08:48:57 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 08:48:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:48:57 INFO - 'USER': 'cltbld', 08:48:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:48:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:57 INFO - 'XPC_FLAGS': '0x0', 08:48:57 INFO - 'XPC_SERVICE_NAME': '0', 08:48:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:57 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:57 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:48:57 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:48:57 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:48:57 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:48:57 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:48:57 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:48:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:49:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:00 INFO - Downloading docopt-0.6.1.tar.gz 08:49:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:49:01 INFO - Installing collected packages: blobuploader, requests, docopt 08:49:01 INFO - Running setup.py install for blobuploader 08:49:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:49:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:49:01 INFO - Running setup.py install for requests 08:49:01 INFO - Running setup.py install for docopt 08:49:01 INFO - Successfully installed blobuploader requests docopt 08:49:01 INFO - Cleaning up... 08:49:01 INFO - Return code: 0 08:49:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49: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:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49: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:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:01 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 0x1042cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042d64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962d51060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104173d30>, '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 0x103f97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10416ab20>, '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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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:49:01 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:49:01 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:49:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqJJY6EeVe/Render', 08:49:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:01 INFO - 'HOME': '/Users/cltbld', 08:49:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:01 INFO - 'LOGNAME': 'cltbld', 08:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:01 INFO - 'MOZ_NO_REMOTE': '1', 08:49:01 INFO - 'NO_EM_RESTART': '1', 08:49:01 INFO - 'PAGER': '/bin/cat', 08:49:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:01 INFO - 'PWD': '/builds/slave/test', 08:49:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:01 INFO - 'SHELL': '/bin/bash', 08:49:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jng8qL7Ote/Listeners', 08:49:01 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 08:49:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:01 INFO - 'USER': 'cltbld', 08:49:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:01 INFO - 'XPC_FLAGS': '0x0', 08:49:01 INFO - 'XPC_SERVICE_NAME': '0', 08:49:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:02 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-4lxGu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:02 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-vg4WdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:02 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-0Qb61A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:02 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-eMWnhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:02 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-MGeCbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:02 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-jvWgQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:02 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-coeCN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:02 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-ekCJW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:02 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-3aCRC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-CBdJba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-CQSta1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-15Gcub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-iUeu2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-hI_fav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-IQv_wB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-bdMPvT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:03 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-NYW8Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:49:03 INFO - Running setup.py install for manifestparser 08:49:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:49:04 INFO - Running setup.py install for mozcrash 08:49:04 INFO - Running setup.py install for mozdebug 08:49:04 INFO - Running setup.py install for mozdevice 08:49:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:49:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:49:04 INFO - Running setup.py install for mozfile 08:49:04 INFO - Running setup.py install for mozhttpd 08:49:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:49:04 INFO - Running setup.py install for mozinfo 08:49:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:49:04 INFO - Running setup.py install for mozInstall 08:49:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:49:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:49:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:49:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:49:05 INFO - Running setup.py install for mozleak 08:49:05 INFO - Running setup.py install for mozlog 08:49:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:49:05 INFO - Running setup.py install for moznetwork 08:49:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:49:05 INFO - Running setup.py install for mozprocess 08:49:05 INFO - Running setup.py install for mozprofile 08:49:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:49:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:49:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:49:05 INFO - Running setup.py install for mozrunner 08:49:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:49:05 INFO - Running setup.py install for mozscreenshot 08:49:06 INFO - Running setup.py install for moztest 08:49:06 INFO - Running setup.py install for mozversion 08:49:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:49:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:49:06 INFO - Cleaning up... 08:49:06 INFO - Return code: 0 08:49:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:06 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:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:06 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:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:06 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 0x1042cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042d64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962d51060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104173d30>, '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 0x103f97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10416ab20>, '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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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:49:06 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:49:06 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:49:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqJJY6EeVe/Render', 08:49:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:06 INFO - 'HOME': '/Users/cltbld', 08:49:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:06 INFO - 'LOGNAME': 'cltbld', 08:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:06 INFO - 'MOZ_NO_REMOTE': '1', 08:49:06 INFO - 'NO_EM_RESTART': '1', 08:49:06 INFO - 'PAGER': '/bin/cat', 08:49:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:06 INFO - 'PWD': '/builds/slave/test', 08:49:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:06 INFO - 'SHELL': '/bin/bash', 08:49:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jng8qL7Ote/Listeners', 08:49:06 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 08:49:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:06 INFO - 'USER': 'cltbld', 08:49:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:06 INFO - 'XPC_FLAGS': '0x0', 08:49:06 INFO - 'XPC_SERVICE_NAME': '0', 08:49:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:49:06 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-iSJpDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:49:06 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:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:49:06 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-bf7Wuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:49:06 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:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:49:06 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-M6ALC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:49:06 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:49:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:49:07 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-gHeN5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:49:07 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:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:49:07 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-M2Asdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:49:07 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:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:49:07 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-FvAg2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:49:07 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:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:49:07 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-RxzMSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:49:07 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:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:49:07 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-8Unx10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:49:07 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:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:49:07 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-TwfWIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:49:07 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:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:49:07 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-Myaigf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:49:07 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:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:49:07 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-uyxjPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:49:07 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:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:49:07 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-7B5pgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:49:07 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:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:49:07 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-HqH0D2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:49:08 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:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:49:08 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-U400Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:49:08 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:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:08 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-fxzulw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:49:08 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:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:49:08 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-7I8KN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:49:08 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:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:49:08 INFO - Running setup.py (path:/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/pip-F0nuqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:49:08 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:49:08 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:49:08 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:49:08 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:49:08 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:49:08 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:49:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:49:08 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:49:08 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:49:08 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:49:08 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:49:08 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:49:08 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:49:10 INFO - Downloading blessings-1.6.tar.gz 08:49:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:49:10 INFO - Installing collected packages: blessings 08:49:10 INFO - Running setup.py install for blessings 08:49:11 INFO - Successfully installed blessings 08:49:11 INFO - Cleaning up... 08:49:11 INFO - Return code: 0 08:49:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:49:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:11 INFO - Reading from file tmpfile_stdout 08:49:11 INFO - Current package versions: 08:49:11 INFO - blessings == 1.6 08:49:11 INFO - blobuploader == 1.2.4 08:49:11 INFO - docopt == 0.6.1 08:49:11 INFO - manifestparser == 1.1 08:49:11 INFO - mozInstall == 1.12 08:49:11 INFO - mozcrash == 0.16 08:49:11 INFO - mozdebug == 0.1 08:49:11 INFO - mozdevice == 0.48 08:49:11 INFO - mozfile == 1.2 08:49:11 INFO - mozhttpd == 0.7 08:49:11 INFO - mozinfo == 0.9 08:49:11 INFO - mozleak == 0.1 08:49:11 INFO - mozlog == 3.1 08:49:11 INFO - moznetwork == 0.27 08:49:11 INFO - mozprocess == 0.22 08:49:11 INFO - mozprofile == 0.28 08:49:11 INFO - mozrunner == 6.11 08:49:11 INFO - mozscreenshot == 0.1 08:49:11 INFO - mozsystemmonitor == 0.0 08:49:11 INFO - moztest == 0.7 08:49:11 INFO - mozversion == 1.4 08:49:11 INFO - psutil == 3.1.1 08:49:11 INFO - requests == 1.2.3 08:49:11 INFO - wsgiref == 0.1.2 08:49:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:49:11 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:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:11 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:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:11 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 0x1042cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042d64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962d51060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104173d30>, '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 0x103f97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10416ab20>, '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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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:49:11 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:49:11 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:49:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqJJY6EeVe/Render', 08:49:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:11 INFO - 'HOME': '/Users/cltbld', 08:49:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:11 INFO - 'LOGNAME': 'cltbld', 08:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:11 INFO - 'MOZ_NO_REMOTE': '1', 08:49:11 INFO - 'NO_EM_RESTART': '1', 08:49:11 INFO - 'PAGER': '/bin/cat', 08:49:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:11 INFO - 'PWD': '/builds/slave/test', 08:49:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:11 INFO - 'SHELL': '/bin/bash', 08:49:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jng8qL7Ote/Listeners', 08:49:11 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 08:49:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:11 INFO - 'USER': 'cltbld', 08:49:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:11 INFO - 'XPC_FLAGS': '0x0', 08:49:11 INFO - 'XPC_SERVICE_NAME': '0', 08:49:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:11 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:49:11 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:49:11 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:49:11 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:49:11 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:49:11 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:49:11 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:49:11 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:49:11 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:49:11 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:49:11 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:49:11 INFO - Cleaning up... 08:49:11 INFO - Return code: 0 08:49:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:49:11 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:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:11 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:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:11 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 0x1042cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042d64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962d51060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104173d30>, '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 0x103f97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10416ab20>, '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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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:49:11 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:49:11 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:49:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqJJY6EeVe/Render', 08:49:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:11 INFO - 'HOME': '/Users/cltbld', 08:49:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:11 INFO - 'LOGNAME': 'cltbld', 08:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:11 INFO - 'MOZ_NO_REMOTE': '1', 08:49:11 INFO - 'NO_EM_RESTART': '1', 08:49:11 INFO - 'PAGER': '/bin/cat', 08:49:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:11 INFO - 'PWD': '/builds/slave/test', 08:49:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:11 INFO - 'SHELL': '/bin/bash', 08:49:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jng8qL7Ote/Listeners', 08:49:11 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 08:49:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:11 INFO - 'USER': 'cltbld', 08:49:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:11 INFO - 'XPC_FLAGS': '0x0', 08:49:11 INFO - 'XPC_SERVICE_NAME': '0', 08:49:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:11 INFO - Downloading/unpacking jsonschema 08:49:11 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:49:11 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:49:11 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:49:11 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:49:11 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:49:11 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:49:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:49:14 INFO - Downloading/unpacking functools32 (from jsonschema) 08:49:14 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:49:14 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:49:14 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:49:14 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:49:14 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:49:14 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:49:14 INFO - Downloading functools32-3.2.3-2.tar.gz 08:49:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:49:14 INFO - warning: no files found matching '*.txt' 08:49:14 INFO - no previously-included directories found matching 'build' 08:49:14 INFO - no previously-included directories found matching 'dist' 08:49:14 INFO - no previously-included directories found matching '.git*' 08:49:14 INFO - Installing collected packages: jsonschema, functools32 08:49:14 INFO - Running setup.py install for functools32 08:49:14 INFO - warning: no files found matching '*.txt' 08:49:14 INFO - no previously-included directories found matching 'build' 08:49:14 INFO - no previously-included directories found matching 'dist' 08:49:14 INFO - no previously-included directories found matching '.git*' 08:49:14 INFO - Successfully installed jsonschema functools32 08:49:14 INFO - Cleaning up... 08:49:14 INFO - Return code: 0 08:49:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:49:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:49:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:49:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:49:14 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 0x1042cfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042d64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8962d51060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104173d30>, '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 0x103f97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10416ab20>, '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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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:49:14 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:49:14 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:49:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqJJY6EeVe/Render', 08:49:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:14 INFO - 'HOME': '/Users/cltbld', 08:49:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:14 INFO - 'LOGNAME': 'cltbld', 08:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:14 INFO - 'MOZ_NO_REMOTE': '1', 08:49:14 INFO - 'NO_EM_RESTART': '1', 08:49:14 INFO - 'PAGER': '/bin/cat', 08:49:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:14 INFO - 'PWD': '/builds/slave/test', 08:49:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:14 INFO - 'SHELL': '/bin/bash', 08:49:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jng8qL7Ote/Listeners', 08:49:14 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 08:49:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:14 INFO - 'USER': 'cltbld', 08:49:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:14 INFO - 'XPC_FLAGS': '0x0', 08:49:14 INFO - 'XPC_SERVICE_NAME': '0', 08:49:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:49:15 INFO - Downloading/unpacking flake8 08:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:49:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:49:17 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:49:17 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:49:17 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:49:17 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:49:17 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:49:17 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:49:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:49:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:49:17 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:49:17 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:49:17 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:49:17 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:49:17 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:49:17 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:49:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:49:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:49:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:49:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:49:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:49:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:49:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:49:18 INFO - no previously-included directories found matching 'docs/_build' 08:49:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:49:18 INFO - Running setup.py install for pep8 08:49:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:49:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:49:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:49:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:49:19 INFO - no previously-included directories found matching 'docs/_build' 08:49:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:49:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:49:19 INFO - Cleaning up... 08:49:19 INFO - Return code: 0 08:49:19 INFO - Running post-action listener: _resource_record_post_action 08:49:19 INFO - Running post-action listener: _start_resource_monitoring 08:49:19 INFO - Starting resource monitoring. 08:49:19 INFO - ##### 08:49:19 INFO - ##### Running install step. 08:49:19 INFO - ##### 08:49:19 INFO - Running pre-action listener: _resource_record_pre_action 08:49:19 INFO - Running main action method: install 08:49:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:49:19 INFO - Reading from file tmpfile_stdout 08:49:19 INFO - Detecting whether we're running mozinstall >=1.0... 08:49:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:49:19 INFO - Reading from file tmpfile_stdout 08:49:19 INFO - Output received: 08:49:19 INFO - Usage: mozinstall [options] installer 08:49:19 INFO - Options: 08:49:19 INFO - -h, --help show this help message and exit 08:49:19 INFO - -d DEST, --destination=DEST 08:49:19 INFO - Directory to install application into. [default: 08:49:19 INFO - "/builds/slave/test"] 08:49:19 INFO - --app=APP Application being installed. [default: firefox] 08:49:19 INFO - mkdir: /builds/slave/test/build/application 08:49:19 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:49:19 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:49:53 INFO - Reading from file tmpfile_stdout 08:49:53 INFO - Output received: 08:49:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:49:53 INFO - Running post-action listener: _resource_record_post_action 08:49:53 INFO - ##### 08:49:53 INFO - ##### Running run-tests step. 08:49:53 INFO - ##### 08:49:53 INFO - Running pre-action listener: _resource_record_pre_action 08:49:53 INFO - Running main action method: run_tests 08:49:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:49:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:49:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:49:53 INFO - 2016-02-23 08:49:53.576 screenresolution[1651:7419] starting screenresolution argv=screenresolution get 08:49:53 INFO - 2016-02-23 08:49:53.579 screenresolution[1651:7419] Display 0: 1600x1200x32@60 08:49:53 INFO - 2016-02-23 08:49:53.585 screenresolution[1652:7421] starting screenresolution argv=screenresolution list 08:49:53 INFO - Available Modes on Display 0 08:49:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:49:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:49:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:49:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:49:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:49:53 INFO - Intel Iris: 08:49:53 INFO - Chipset Model: Intel Iris 08:49:53 INFO - Type: GPU 08:49:53 INFO - Bus: Built-In 08:49:53 INFO - VRAM (Dynamic, Max): 1536 MB 08:49:53 INFO - Vendor: Intel (0x8086) 08:49:53 INFO - Device ID: 0x0a2e 08:49:53 INFO - Revision ID: 0x0009 08:49:53 INFO - Displays: 08:49:53 INFO - Display: 08:49:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:49:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:49:53 INFO - Display Serial Number: 1600x1200 60 08:49:53 INFO - Main Display: Yes 08:49:53 INFO - Mirror: Off 08:49:53 INFO - Online: Yes 08:49:53 INFO - Rotation: Supported 08:49:53 INFO - Return code: 0 08:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:49:53 INFO - Python 2.7.3 08:49:53 INFO - Return code: 0 08:49:53 INFO - grabbing minidump binary from tooltool 08:49:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:49:53 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 0x104173d30>, '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 0x103f97db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10416ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:49:53 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:49:53 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:49:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:49:53 INFO - Return code: 0 08:49:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:49:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:49:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:49:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:49:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:49:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:49:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:49:55 INFO - Return code: 0 08:49:55 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/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0006', '--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:49:55 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/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0006 --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:49:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YqJJY6EeVe/Render', 08:49:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:49:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:49:55 INFO - 'HOME': '/Users/cltbld', 08:49:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:49:55 INFO - 'LOGNAME': 'cltbld', 08:49:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:49:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:55 INFO - 'MOZ_NO_REMOTE': '1', 08:49:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:49:55 INFO - 'NO_EM_RESTART': '1', 08:49:55 INFO - 'PAGER': '/bin/cat', 08:49:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:55 INFO - 'PWD': '/builds/slave/test', 08:49:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:49:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:49:55 INFO - 'SHELL': '/bin/bash', 08:49:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Jng8qL7Ote/Listeners', 08:49:55 INFO - 'TMPDIR': '/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/', 08:49:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:49:55 INFO - 'USER': 'cltbld', 08:49:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:49:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:55 INFO - 'XPC_FLAGS': '0x0', 08:49:55 INFO - 'XPC_SERVICE_NAME': '0', 08:49:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:49:55 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/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0006', '--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:49:55 INFO - mozversion application_buildid: 20160223073912 08:49:55 INFO - mozversion application_changeset: 12c77a8f0e4ac5286ab5bc6f738fe8a1283640b6 08:49:55 INFO - mozversion application_display_name: Nightly 08:49:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:49:55 INFO - mozversion application_name: Firefox 08:49:55 INFO - mozversion application_remotingname: firefox 08:49:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:49:55 INFO - mozversion application_vendor: Mozilla 08:49:55 INFO - mozversion application_version: 47.0a1 08:49:55 INFO - mozversion platform_buildid: 20160223073912 08:49:55 INFO - mozversion platform_changeset: 12c77a8f0e4ac5286ab5bc6f738fe8a1283640b6 08:49:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:49:55 INFO - mozversion platform_version: 47.0a1 08:49:55 INFO - using testdate: 1456246195 08:49:55 INFO - actual date: 1456246195 08:49:55 INFO - starting webserver on 'localhost:49278' 08:49:55 INFO - SUITE-START | Running 2 tests 08:49:55 INFO - TEST-START | dromaeo_css 08:49:55 INFO - operating with platform_type : mac_ 08:49:55 INFO - Initialising browser for dromaeo_css test... 08:49:55 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmp6ic1gW/profile http://localhost:49278/getInfo.html) 08:49:58 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 08:49:58 INFO - PROCESS | 1670 | colorDepth:24 08:49:58 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 08:49:58 INFO - PROCESS | 1670 | __metrics 08:49:58 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 08:49:59 INFO - TEST-INFO | 1670: exit 0 08:49:59 INFO - Browser initialized. 08:49:59 INFO - Running cycle 1/1 for dromaeo_css test... 08:49:59 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmp6ic1gW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:50:11 INFO - PROCESS | 1674 | RSS: Main: 256679936 08:50:11 INFO - PROCESS | 1674 | 08:51:01 INFO - PROCESS | 1674 | 1456246261152 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:53:12 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 08:53:13 INFO - PROCESS | 1674 | RSS: Main: 269459456 08:53:13 INFO - PROCESS | 1674 | 08:56:15 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 08:56:16 INFO - PROCESS | 1674 | RSS: Main: 280391680 08:56:16 INFO - PROCESS | 1674 | 08:59:18 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 08:59:18 INFO - PROCESS | 1674 | RSS: Main: 282308608 08:59:18 INFO - PROCESS | 1674 | 09:02:20 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 09:02:20 INFO - PROCESS | 1674 | RSS: Main: 284270592 09:02:20 INFO - PROCESS | 1674 | 09:05:23 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 09:05:24 INFO - PROCESS | 1674 | RSS: Main: 287064064 09:05:24 INFO - PROCESS | 1674 | 09:08:26 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 09:08:26 INFO - PROCESS | 1674 | RSS: Main: 287485952 09:08:26 INFO - PROCESS | 1674 | 09:08:26 INFO - PROCESS | 1674 | __start_tp_report 09:08:26 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 09:08:26 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 09:08:26 INFO - PROCESS | 1674 | |i|pagename|runs| 09:08:26 INFO - PROCESS | 1674 | |0;dojo.html;3525.2949410117976;3529.911752206193;3570.8750193743226;3608.386574282372;3621.782693038417;5175.327207463034;5646.830595082144;5815.302163740352;5821;5821.621594596349;5743.798967036144;5819;5851.297844258695;5869.50109240714;5902.321233058199;5206.947930520693;5245.737713114329;5298.708571028592;5317.9468205317835;5350.8394748157425;5143.228515722634;5147.330846989886;5296.602754793386;5320.255164277004;5343.65266257692;4532.750698711569;4556.863294101166;5250.8687282817855;5251.028559716465;5266.131088370415;5263.894722105575;5279.841604751864;5303.946960530384;5304;5318.707471089088;5158.716270605115;5213.765380557884;5245.711485868275;5251.973740131275;5281.63028587999;5508.366537848158;5687.317521897398;5720.2849643794525;5790.33411157718;5791.5656325775735;6136.948001697505;6330.145430366933;6338.461230795388;6340.714667839959;6342;6220.720067596969;6295.055741638745;6298.149749783766;6303.527235457359;6318.494520438354;5865.648061116304;5920.674362909996;5922.97038514809;5930.495907847795;5965.075413310944;6232.75068997235;6234.470070044006;6337.493000559944;6340.1440805490665;6344.238691357066;6189.690515474208;6196.659183744938;6216.378362163748;6220.34686357935;6239.469645080128;6250.406211409909;6286.339934306832;6293.244810622755;6305.085762564402;6320.462760665303;6102.913431175824;6217.285012223652;6295.307516173218;6299.874002519924;6301.6219026858535;6144.941444616104;6166.876662466726;6290.119383286344;6294.181756371642;6325.430711236011;4133.545310015896;4232.936505952413;4854.344663470457;4982.202847544376;4985.451600323961;4421.11577684458;4448.888777780517;4482.103579284091;4508.143452744033;4558.931616025762;5641.928033673589;5764;5834.212381328552;5848.239728835224;5852.795152169739;5160.432352441228;5435.347758269033;6144.41628045335;6206.596571222856;6297.4332310091395;4946.9010619787405;5884.382139875337;5890.322612899486;5896.6756828374855;5898.8230353089475;5469.206964990054;5469.917951230735;5490.368607610096;5502.367227768777;5504.614676972574;5395.999999999922;6264.060390941304;6366.872662546723;6421.775237866652;6442.774502892376;6284.151639528605;6294.4964402846745;6315.905261421174;6326.9683651581445;6338.809835704937;6238.282597501164;6370.77702280418;6452.451541619015;6480.351964803482;6494.610323380423;5199.246109314053;6275.184226050585;6278.058291256348;6280.152179455715;6309.936900630935;5392.164214546751;6271.6550589718;6289.088082228142;6291.559590828598;6322.36776322364;6021.969890150521;6124.510039196764;6245.718942647501;6248.375162483715;6254.061890716429;5515.669059856261;5984.1921340618455;5994.28068631767;6105.429421494235;6214.316425193316;5989.580729348903;6092.695365231632;6116.755329786759;6120.7857724981195;6127.019676851683;5214.087534681492;6131.920117368776;6263.029230469285;6276.4351208389635;6281.71732272058;6095.786647467317;6098.420650038239;6107.144999700135;6124.571280010535;6147.907781383372 09:08:26 INFO - PROCESS | 1674 | |1;ext.html;442.38950248656846;471.56144785349613;498.35214221512035;565.9349174844892;579.8347470970768;27968.02111926083;29413.117606471787;37407.877763667064;38201;38210.85367438974;40498.19003619926;40711;40856.59143408565;40861.7956910215;41039.589604104025;9580.999999999982;9770.755731106743;9801.509924503745;9814.656487022956;9862.211023118134;9657.903420965806;9756.804863902718;9769.071938165864;9789.608415663364;9824.901750982506;9706.611735530605;9809.803803923916;9816;9821;9835.90164098357;8422.778697088888;9696.224302055854;9792.510374481319;9809.950950245238;9845.015498450133;9588.616455341778;9665.371750836244;9673;9682.273829462818;9696.127348538665;39227;39324.803375983225;39388.01529961745;39447.8027609863;39684;3064.5403189521526;3110.4867696829997;3505.509228707983;3711.7030637548933;3761.887143385703;28679.856600716863;28856.855715721496;29275.268118297;29556.556651650244;29559;2718.3340081680117;2772.542530482468;2822.788290878192;2881.7406433420883;2937.2510009947327;497776;499336;502574;502733;688609.999999995;66147.33852661509;66307.66846165835;66637;67134;67299;70587.29412705808;70971.2902870975;71081.64459177671;71220.93168602475;71331.28668713247;16323.510294691177;16334.264958076677;16511.587210319838;16541.172941352885;16547.83452165487;12502.249865008129;12682.302473363869;12835.614931552069;12877.549285774952;12899.161554498927;17276.481705548853;21271.936403179778;21660.675089873665;21667.89166054191;21743.347699568723;7658.463907526531;8965.641374344954;9116.8632470513;9191.816163676824;9212.907870921204;882.668999125328;962.2206013129247;977.2670497127154;990.4898977026693;1068.8450174724621;30033;30061.69938300589;30209.09372718822;30286.939957101837;30289.24276893095;851.0046029804961;1108.2685427617735;1155.0759392486145;1163.5404015413865;1170.584442522909;13892.444302227797;14353;14455.710885782226;14479.855201448061;14627.341769620392;643293;655503;665061.6746916331;665096;669035;57415.42584574184;59117.704411477665;59402.405975939684;59440.40559594435;59696.522760793116;1445.6747231872955;1468.647524594111;1470.4559313054237;1480.2376775960388;1487.620656732548;24422.26733198007;26809.329766755985;28282;28347.866085356356;28682.56198223091;36691.81654091713;49271;49902;50004.999999998545;50416.74791626018;523811;524566;525464;529168;531316;33089.172770679965;33467.83266083654;33551.16122096967;42773;44290.77854610706;42376.94057648583;43001.13997719966;43602.56397436112;43967.56032439763;44000.67997960066;36864.63135368612;37056.81471592733;37205.44191837179;37210.62789372072;37467.06332341713;32356.83821580877;37476.06309842167;38991;39369;40237.39643905402;37749.05627359338;37952;37982.8100859505;39030.4145437813;39127.02182445348;28961.275968100967;32164.87422940186;32472.837635812615;32595.022149335557;32724;21954.451138721022;24314.149004784747;24446;24908.62637060409;24955.875220624508 09:08:26 INFO - PROCESS | 1674 | |2;jquery.html;342.4965301007519;360.82499987506054;363.3042723185101;369.62113833320825;371.5912496254121;10674.679759607225;15554.844451555495;16128.435504757335;16981.490555283344;19124.713129303072;19580.804191958076;19650.705239421386;19760.802391976074;19899.701504477445;20067.799322006813;5459.808906688267;5489.890202195964;5672;5694.487496125348;5705.286839145107;5601.8599535011745;5626.718664066801;5681.545476361881;5703.258576385064;5729.3411257705275;4883.584895283905;5670.829875103733;5688.857778555528;5772.971135144339;5824.767009319643;5654.293213348332;5712.485876271135;5749.827505174831;5753.884922301572;5755.827325180251;4354.7604881731495;4587.472440669332;5665.461781130827;5733.512651424634;5735.225744524478;13192.604221873358;13484.662883427894;15832.92083539575;25403.49193016148;25478.36304092394;2187.496875718578;2230.4200907763934;2250.324902529235;2301.2866011536476;2555.961660575093;10079.647212347605;10084.94957525215;11878.762424751456;13914.165150091027;14696;1690.315422253989;1708.3849814066925;1735.8698097642728;1783.509534877906;1783.5362805670488;99884.50057749737;117592.41203794011;119218;119331.4033429836;119395;9084.091590840995;10816.513256903458;11080;11164.162687798447;11167.83248251277;12112.39438028095;12784.232946023269;13377.531786387624;13425.597232083053;13523;8250.092489826115;8355.164483551596;8375.581220938928;8430.199131082538;8470.534120623302;8568.314534837198;8575.485470871768;8591.742247732578;8607.784805379915;8690.78273043179;4290.528041915387;4365.323374876899;4370.191514569815;4379.321205213197;4417.712848664826;1843.207420809065;1890.8676392652383;1904.7238150468104;1922.9807701923082;1933.1590758020307;712.2485777504783;880.4497189256715;913.5569248914271;923.9769005774775;924.5192499900014;15482.380704771907;20389.796102039087;20412.591748164952;20453.693194602092;20495;962.8507581324906;966.5602151021268;999.9000099990088;1039.1323245090282;1044.8902865199198;10806.675799726021;11005.339679619088;11032.889671103187;11035.503402346914;11036.668899933014;580195.1980480141;664531;674836;677318;687446;117035;118781;121988.39005804915;123912.76087239012;124332;966.709987003896;991.4794732765212;991.5290237137302;996.5266498413196;1000.4697510319543;14328.856711432752;18025.828321159082;18153.092345382942;18190.09004054555;18549.814501855348;41850.58149418467;42117.57882421136;48909;52526.47473525216;54451.72774136104;57359.713201433726;60355;62830.42923926938;67627.32372676407;68892;8127.634256458356;8196.180381961756;8202.097769245498;8297.543635100128;8360.331173506227;9906.900930990598;11383.658490245305;13012.089153759525;13464.08560875293;13898.16611003343;8839.46963182211;11643.301401915913;11846.99300559462;11858.644240672793;11903.583374581847;5037.899242015213;9661;9770.75573110678;11282.097432205568;11616.186866919235;10764.946175269073;10814.621488247874;10933;12059.939700301442;12130.939345303217;8121.106678265504;8136.674533018613;8205.83588328242;8222.794430139294;8229.177082291722;9926.851097233402;10082.899171008195;11215;11759.588414405454;11945.2832830027 09:08:26 INFO - PROCESS | 1674 | |3;mootools.html;1521.2773932382117;1534.3479021415897;1620.5543475544232;1760.1287362755438;1871.7753869535659;7054.964725176374;7509;8623.439476434027;8717.171868672482;9257.722268331952;8642.956785216082;8698.652053917851;8781.736547903558;8782.385233033674;8836.69071582493;2439.438929046325;2451.460678650694;2453.6932883389577;2458.545169143705;2468.753124687526;2432.2824766693866;2477.1577663594376;2481.3424442522655;2485.453200295941;2497.1884137655243;2146.978530214701;2397.9760202398015;2444.4377793107597;2468.1361523466735;2496.2386472125995;2399.8080153587757;2424.333308340203;2428.405040765024;2433.977729353676;2437.3297343230574;2390.1992832401165;2438.9634155487684;2441.963370549443;2445.76765207305;2447.9265622031367;7307.232740562271;8217.137200593912;8676.8698469523;8703.303735701129;8718.910136232971;4440.400545926291;5426.2674538937135;5447.155690867922;5459.12653975366;5461.4811592899005;3176.952345714816;3624.6194149614175;3677.8712745053795;3681.5398075240596;3743.8502459901842;1060.6234786650705;1083.0198670203479;1095.5124969388626;1100.8238681810872;1103.0623969625833;12061.33662648554;12127.454264558028;12196.878031219752;12221.816672749916;12227.816582751355;4889.413270407574;4933.309336692866;4962.106820772224;5021.297018417425;5038.093143234253;10196;10281.794364112826;10303.536340864679;10305.484725763681;10322.329048611817;4562.9771851141195;5532.5573954083575;5547.195656629766;5578.748956296977;5593.8321850344555;4945.777440015136;4977.0792403405485;5023.472535383805;5063;5089.236614507779;3987.322155233617;3996.6403023728003;4001.6198461146146;4021.3163762160502;4042.292598795199;1312.9409176587076;1328.6080606221187;1333.613252156883;1339.2834833364298;1341.745068436994;1027.1885210683477;1110.9333439993627;1144.8740638529755;1242.2422322383338;1373.6977864869712;7895.802604934923;7926.643301051467;8010.639521221559;8059.476134051268;8102.189781021851;1181.149572307937;1188.4473719720372;1191.4817054581113;1204.8433703618473;1215.2951288252968;6185.659788711574;6195.96902015496;6253.593516421418;6261.686915654199;6295.464885484785;10281.074703276741;10483.842742358871;10583.364998100138;10655.520501577448;10671.039606435457;10306.175505959505;10407.323523970917;10456.843147352796;10481.633142839964;10500.369977801356;8126.187381261827;8202.671893124327;8256.050554186226;8265.876011859827;8329.292010179082;7999.400044996765;8040.83918321642;8072.556009419538;8084.878726818984;8247.711330103417;9642.855357169508;9711.56297966579;9771.80456390854;9772.120509153925;9828.459434731158;8327.916720832956;9864;10109.696709098738;10122.392656440637;10243.590256389662;6235.719392627252;7568.735094271674;7661.885071723817;7672;7673.386129109769;8300.958495207486;8321.209485098905;8375.664973401239;8378.622961966848;8391.035030971272;6940.6529673515115;7479;7553.169151393233;7724.382049436144;7760.340371068297;7383.520071195355;7423.257674232534;7465.29079737424;7487.700491980478;7594.5063570867715;7811.336036436966;7819.530828150329;7875.724349647735;7889.13219545861;7937.920620793949;6843.794686159423;7028.262032486516;7091.290870912868;7132.1441427029085;7155.606441645759;5977.133315669291;7105.218425973036;7113.466490013373;7143.428525718034;7151.034610327539 09:08:26 INFO - PROCESS | 1674 | |4;prototype.html;328.24339896538476;332.08179384003233;334.62856229585174;337.1402922547504;341.99487007694876;6574.342565743424;6690.397864192234;6728.158980127484;6764.661766911653;6789.151356080496;5250.527452529272;5335.813246536372;5454.236406903027;6775.119234499521;6827.385535301822;4957.553820156176;4987.177115775893;4987.426445958725;4989.57588604969;5017.19724844025;5001.474845141262;5003.624728145385;5004.923941352608;5005.499450055002;5018.774155163026;3949.763014219156;4939.357883475143;4940.308356830046;4940.950590494085;4959.859232376555;3854.710896682746;4610.2623580227;4668.486466488666;4909.803607855682;4953.058918805452;3509.3683137035323;4057.1277175407135;4098.180363927197;4098.790856697281;4103.651189648884;6430.871382572369;6464.127342808708;6476.514261430364;6503.479721622306;6512.479001679854;5763.221965034709;5808.215890854723;5811.709414529257;5812.82561523155;5820.592558520905;7226.819329516751;7241.818954526179;7265.564066155995;7266.346028857428;7277.6725047372465;4429.446319210098;4648.581627653493;4649.558291962258;4655.022445286494;4657.534246575349;7453.105627324756;7615.200403957616;7630.504017238917;7689.461737678364;7699.730509432143;4690.882727931829;4709.293605959065;4712.128256272601;4715.221988371949;4721.716696998191;4790.209615413488;4792.688475249098;4793.49668284832;4802.903941921212;4812.855614331505;5764.308283005982;5764.538836893039;5770.509506691894;5776.220210271644;5779.3642699303045;6982.965085174643;7271.454640901953;7294.015307933467;7294.635268236673;7326.194118646945;1634.3462614954115;1646.2345009570606;1656.403694669918;1662.6342204714942;1666.641672040517;995.875515560555;1048.1352883870836;1051.4269723000982;1064.7338165458636;1069.1660504806264;5359.946400536022;6312.873742525216;6781.847085995392;6858.897116543256;6868.62222577753;6725.66371681414;7712.768616941501;7714.768556943301;7725.729599463992;7752.612369381508;6764.323567643196;6794.72821087151;6802.14973128359;6809.659517024129;6817.943218801094;3913.2173565287057;4007.8797636070963;4041.2927737646382;4044.757314561136;4064.313309976386;7879.881801772978;7963.243491868263;7991.320737737357;8000.63997120131;8025.036995560454;7010.579365238102;7169.462290328246;7827.608619568999;7844.019497562805;7868.370530357558;7053.647317634098;7220.638968051577;7939.761807145679;7947.324477419368;7997.400194985399;6860.828479288058;7399.371053460516;7410.296021877913;7660.119086304923;7675.501092429197;7421.666025028779;7466.066741657293;7481.326680598772;7492.550446973199;7506.437017223621;7142.750003749844;7976.680932762624;7980.84038319242;7985.960070199611;7997.240262175084;4688.109259240733;4716.764161791828;4727.881802954954;4728.007118505152;4730.952690473051;7302.452316076209;7588.354989825927;7598.240175982358;7652.961735191511;7656.387489000978;6462.870742585216;6792.72829086831;7265.273472652692;7341.926580734124;7359.889601655872;7304.598247096461;7306.41548676094;7319.085114360705;7326.194118647051;7338.119425668954;5727.369989301257;7111.822204444723;7115.501914865909;7149.7497587584185;7168.211496735459;6483.443973446245;6594.615130822581;6991;7267.563946163247;7310.122785265802;6881.346272104142;7005.894911576229;7119.216886142417;7138.750143745152;7214.134303883568 09:08:26 INFO - PROCESS | 1674 | |5;yui.html;586.3698917010709;683.7470136049661;684.9726010959562;726.69115625859;728.3190217146964;13728;14915.701685966287;15107.395704171848;15304.005239659427;17009.554187894013;12336.259824410541;15447.536573902773;15552.066875987448;15571.299291531908;15627.921860390683;869.7564681889081;871.9258862996653;872.690194980779;873.0701802580231;882.4176043811086;790.3716545346434;816.5304949653943;878.6617152396342;878.6880657366606;884.3632584539154;906.5421961909227;909.5270459361128;917.3624331089895;926.0415469988563;927.6150397584994;912.2291663544295;918.5820451694462;918.9908100918972;919.8574220995756;921.3412410126758;646.6831252686197;669.0967194287721;675.2909445082693;677.1873751498222;678.091357580844;14563.417463301455;14578;14590.70818583633;14600.269986500738;14859.2570371481;11286.379249141293;11569.595064172714;12860.292683902382;13082.280474573894;13426.32868356588;9990.700278991642;10002.299839011272;10064.39613623185;10188.337758045704;10213.387196768143;3245.7727959042877;3297.7187698240164;3516.9472457913153;3595.227026189356;3721.6278372162838;63351;85470.57264713699;85811.57094214551;85896.57051714702;88005.67991480132;9578.952105239428;9747.720122655388;9981.900180998242;10021.39871607706;10385.63650272237;22392.888035559718;22408.887955560444;22492.550148997256;22515.211967581057;22522.32433027012;7401.111866576045;7425.8143546411775;7521.172671006185;7586.317231449196;7767.223277672188;3848.1534062506203;3939;3977;4059.91880162401;4126.938095928564;3563.4476656118345;3567.2687099145132;3590.1024743814046;3607;3615.6022837487853;655.4101308822098;661.0513912535527;662.6156829039242;666.6366830077619;670.3932940688685;498.60610118006366;531.5349069564131;583.629395333966;590.539379284159;596.3321080389991;8598.269147122564;8638.611262493077;8653.697120600875;8893.510856902933;8894.332925030649;501.90965626187636;515.744706370349;523.7381309345327;603.6709993053796;623.3268070483866;3941.881743547698;4013.1572369802084;4053.0677944073027;4076.7553946763287;4214.283571792803;88377.55811220902;90905.09094908966;95086;96088.51955740177;96215;79109;79523.20476795273;80190.39619207583;81850.18149818426;82394;68943.65528172227;69730.30269697339;70196.29803702;70250.64874675697;70853;7052.400545953651;7069.575825450283;7800.960995194988;8081.797955051171;8381.49711017341;47489;49109.50890491192;49492.010159795886;49508.50491495039;49696.509104726916;65111;69382.65308673626;69531.65234173796;69857.30142698508;70284.94572581518;9774.169195618168;9813.509324533887;9827.066428689262;9890.664760257274;10114.848277275994;10917.454127293762;11308.717282068013;11452.713682157679;11487.081033517132;12062.336571488302;10800.837987430037;11252.099832013255;11448.656540303804;11553.768924621629;11890.10824188172;11042.944785276022;11541.192116551762;11601.941990289995;11634.767304653691;12250.019998399928;10910.563577457131;10961.616343427942;10992.615258465916;11195.72010699739;12032.338221397556;8346.33229341639;8443.451175673561;9373;9560.952195238979;9794.951025244829;8854.557272136497;9449.622015119317;9742.171915387271;9856.753581160528;10008.649697260853 09:08:26 INFO - PROCESS | 1674 | __end_tp_report 09:08:26 INFO - PROCESS | 1674 | __start_cc_report 09:08:26 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,341 09:08:26 INFO - PROCESS | 1674 | __end_cc_report 09:08:26 INFO - PROCESS | 1674 | __startTimestamp1456247306731__endTimestamp 09:08:26 INFO - PROCESS | 1674 | 09:08:26 INFO - PROCESS | 1674 | ------- Summary: start ------- 09:08:26 INFO - PROCESS | 1674 | Number of tests: 6 09:08:26 INFO - PROCESS | 1674 | 09:08:26 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5757.50 Median:5984.19 stddev:661.16 (11.0%) stddev-sans-first:639.57 09:08:26 INFO - PROCESS | 1674 | Values: 3525.3 3529.9 3570.9 3608.4 3621.8 5175.3 5646.8 5815.3 5821.0 5821.6 5743.8 5819.0 5851.3 5869.5 5902.3 5206.9 5245.7 5298.7 5317.9 5350.8 5143.2 5147.3 5296.6 5320.3 5343.7 4532.8 4556.9 5250.9 5251.0 5266.1 5263.9 5279.8 5303.9 5304.0 5318.7 5158.7 5213.8 5245.7 5252.0 5281.6 5508.4 5687.3 5720.3 5790.3 5791.6 6136.9 6330.1 6338.5 6340.7 6342.0 6220.7 6295.1 6298.1 6303.5 6318.5 5865.6 5920.7 5923.0 5930.5 5965.1 6232.8 6234.5 6337.5 6340.1 6344.2 6189.7 6196.7 6216.4 6220.3 6239.5 6250.4 6286.3 6293.2 6305.1 6320.5 6102.9 6217.3 6295.3 6299.9 6301.6 6144.9 6166.9 6290.1 6294.2 6325.4 4133.5 4232.9 4854.3 4982.2 4985.5 4421.1 4448.9 4482.1 4508.1 4558.9 5641.9 5764.0 5834.2 5848.2 5852.8 5160.4 5435.3 6144.4 6206.6 6297.4 4946.9 5884.4 5890.3 5896.7 5898.8 5469.2 5469.9 5490.4 5502.4 5504.6 5396.0 6264.1 6366.9 6421.8 6442.8 6284.2 6294.5 6315.9 6327.0 6338.8 6238.3 6370.8 6452.5 6480.4 6494.6 5199.2 6275.2 6278.1 6280.2 6309.9 5392.2 6271.7 6289.1 6291.6 6322.4 6022.0 6124.5 6245.7 6248.4 6254.1 5515.7 5984.2 5994.3 6105.4 6214.3 5989.6 6092.7 6116.8 6120.8 6127.0 5214.1 6131.9 6263.0 6276.4 6281.7 6095.8 6098.4 6107.1 6124.6 6147.9 09:08:26 INFO - PROCESS | 1674 | 09:08:26 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:70879.73 Median:39417.91 stddev:155010.17 (393.2%) stddev-sans-first:155354.80 09:08:26 INFO - PROCESS | 1674 | Values: 442.4 471.6 498.4 565.9 579.8 27968.0 29413.1 37407.9 38201.0 38210.9 40498.2 40711.0 40856.6 40861.8 41039.6 9581.0 9770.8 9801.5 9814.7 9862.2 9657.9 9756.8 9769.1 9789.6 9824.9 9706.6 9809.8 9816.0 9821.0 9835.9 8422.8 9696.2 9792.5 9810.0 9845.0 9588.6 9665.4 9673.0 9682.3 9696.1 39227.0 39324.8 39388.0 39447.8 39684.0 3064.5 3110.5 3505.5 3711.7 3761.9 28679.9 28856.9 29275.3 29556.6 29559.0 2718.3 2772.5 2822.8 2881.7 2937.3 497776.0 499336.0 502574.0 502733.0 688610.0 66147.3 66307.7 66637.0 67134.0 67299.0 70587.3 70971.3 71081.6 71220.9 71331.3 16323.5 16334.3 16511.6 16541.2 16547.8 12502.2 12682.3 12835.6 12877.5 12899.2 17276.5 21271.9 21660.7 21667.9 21743.3 7658.5 8965.6 9116.9 9191.8 9212.9 882.7 962.2 977.3 990.5 1068.8 30033.0 30061.7 30209.1 30286.9 30289.2 851.0 1108.3 1155.1 1163.5 1170.6 13892.4 14353.0 14455.7 14479.9 14627.3 643293.0 655503.0 665061.7 665096.0 669035.0 57415.4 59117.7 59402.4 59440.4 59696.5 1445.7 1468.6 1470.5 1480.2 1487.6 24422.3 26809.3 28282.0 28347.9 28682.6 36691.8 49271.0 49902.0 50005.0 50416.7 523811.0 524566.0 525464.0 529168.0 531316.0 33089.2 33467.8 33551.2 42773.0 44290.8 42376.9 43001.1 43602.6 43967.6 44000.7 36864.6 37056.8 37205.4 37210.6 37467.1 32356.8 37476.1 38991.0 39369.0 40237.4 37749.1 37952.0 37982.8 39030.4 39127.0 28961.3 32164.9 32472.8 32595.0 32724.0 21954.5 24314.1 24446.0 24908.6 24955.9 09:08:26 INFO - PROCESS | 1674 | 09:08:26 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:35347.05 Median:351.66 stddev:109052.95 (31010.8%) stddev-sans-first:109327.20 09:08:26 INFO - PROCESS | 1674 | Values: 342.5 360.8 363.3 369.6 371.6 10674.7 15554.8 16128.4 16981.5 19124.7 19580.8 19650.7 19760.8 19899.7 20067.8 5459.8 5489.9 5672.0 5694.5 5705.3 5601.9 5626.7 5681.5 5703.3 5729.3 4883.6 5670.8 5688.9 5773.0 5824.8 5654.3 5712.5 5749.8 5753.9 5755.8 4354.8 4587.5 5665.5 5733.5 5735.2 13192.6 13484.7 15832.9 25403.5 25478.4 2187.5 2230.4 2250.3 2301.3 2556.0 10079.6 10084.9 11878.8 13914.2 14696.0 1690.3 1708.4 1735.9 1783.5 1783.5 99884.5 117592.4 119218.0 119331.4 119395.0 9084.1 10816.5 11080.0 11164.2 11167.8 12112.4 12784.2 13377.5 13425.6 13523.0 8250.1 8355.2 8375.6 8430.2 8470.5 8568.3 8575.5 8591.7 8607.8 8690.8 4290.5 4365.3 4370.2 4379.3 4417.7 1843.2 1890.9 1904.7 1923.0 1933.2 712.2 880.4 913.6 924.0 924.5 15482.4 20389.8 20412.6 20453.7 20495.0 962.9 966.6 999.9 1039.1 1044.9 10806.7 11005.3 11032.9 11035.5 11036.7 580195.2 664531.0 674836.0 677318.0 687446.0 117035.0 118781.0 121988.4 123912.8 124332.0 966.7 991.5 991.5 996.5 1000.5 14328.9 18025.8 18153.1 18190.1 18549.8 41850.6 42117.6 48909.0 52526.5 54451.7 57359.7 60355.0 62830.4 67627.3 68892.0 8127.6 8196.2 8202.1 8297.5 8360.3 9906.9 11383.7 13012.1 13464.1 13898.2 8839.5 11643.3 11847.0 11858.6 11903.6 5037.9 9661.0 9770.8 11282.1 11616.2 10764.9 10814.6 10933.0 12059.9 12130.9 8121.1 8136.7 8205.8 8222.8 8229.2 9926.9 10082.9 11215.0 11759.6 11945.3 09:08:26 INFO - PROCESS | 1674 | 09:08:26 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:6057.75 Median:5022.38 stddev:3183.98 (63.4%) stddev-sans-first:3174.65 09:08:26 INFO - PROCESS | 1674 | Values: 1521.3 1534.3 1620.6 1760.1 1871.8 7055.0 7509.0 8623.4 8717.2 9257.7 8643.0 8698.7 8781.7 8782.4 8836.7 2439.4 2451.5 2453.7 2458.5 2468.8 2432.3 2477.2 2481.3 2485.5 2497.2 2147.0 2398.0 2444.4 2468.1 2496.2 2399.8 2424.3 2428.4 2434.0 2437.3 2390.2 2439.0 2442.0 2445.8 2447.9 7307.2 8217.1 8676.9 8703.3 8718.9 4440.4 5426.3 5447.2 5459.1 5461.5 3177.0 3624.6 3677.9 3681.5 3743.9 1060.6 1083.0 1095.5 1100.8 1103.1 12061.3 12127.5 12196.9 12221.8 12227.8 4889.4 4933.3 4962.1 5021.3 5038.1 10196.0 10281.8 10303.5 10305.5 10322.3 4563.0 5532.6 5547.2 5578.7 5593.8 4945.8 4977.1 5023.5 5063.0 5089.2 3987.3 3996.6 4001.6 4021.3 4042.3 1312.9 1328.6 1333.6 1339.3 1341.7 1027.2 1110.9 1144.9 1242.2 1373.7 7895.8 7926.6 8010.6 8059.5 8102.2 1181.1 1188.4 1191.5 1204.8 1215.3 6185.7 6196.0 6253.6 6261.7 6295.5 10281.1 10483.8 10583.4 10655.5 10671.0 10306.2 10407.3 10456.8 10481.6 10500.4 8126.2 8202.7 8256.1 8265.9 8329.3 7999.4 8040.8 8072.6 8084.9 8247.7 9642.9 9711.6 9771.8 9772.1 9828.5 8327.9 9864.0 10109.7 10122.4 10243.6 6235.7 7568.7 7661.9 7672.0 7673.4 8301.0 8321.2 8375.7 8378.6 8391.0 6940.7 7479.0 7553.2 7724.4 7760.3 7383.5 7423.3 7465.3 7487.7 7594.5 7811.3 7819.5 7875.7 7889.1 7937.9 6843.8 7028.3 7091.3 7132.1 7155.6 5977.1 7105.2 7113.5 7143.4 7151.0 09:08:26 INFO - PROCESS | 1674 | 09:08:26 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5871.44 Median:6726.91 stddev:1918.86 (28.5%) stddev-sans-first:1878.59 09:08:26 INFO - PROCESS | 1674 | Values: 328.2 332.1 334.6 337.1 342.0 6574.3 6690.4 6728.2 6764.7 6789.2 5250.5 5335.8 5454.2 6775.1 6827.4 4957.6 4987.2 4987.4 4989.6 5017.2 5001.5 5003.6 5004.9 5005.5 5018.8 3949.8 4939.4 4940.3 4941.0 4959.9 3854.7 4610.3 4668.5 4909.8 4953.1 3509.4 4057.1 4098.2 4098.8 4103.7 6430.9 6464.1 6476.5 6503.5 6512.5 5763.2 5808.2 5811.7 5812.8 5820.6 7226.8 7241.8 7265.6 7266.3 7277.7 4429.4 4648.6 4649.6 4655.0 4657.5 7453.1 7615.2 7630.5 7689.5 7699.7 4690.9 4709.3 4712.1 4715.2 4721.7 4790.2 4792.7 4793.5 4802.9 4812.9 5764.3 5764.5 5770.5 5776.2 5779.4 6983.0 7271.5 7294.0 7294.6 7326.2 1634.3 1646.2 1656.4 1662.6 1666.6 995.9 1048.1 1051.4 1064.7 1069.2 5359.9 6312.9 6781.8 6858.9 6868.6 6725.7 7712.8 7714.8 7725.7 7752.6 6764.3 6794.7 6802.1 6809.7 6817.9 3913.2 4007.9 4041.3 4044.8 4064.3 7879.9 7963.2 7991.3 8000.6 8025.0 7010.6 7169.5 7827.6 7844.0 7868.4 7053.6 7220.6 7939.8 7947.3 7997.4 6860.8 7399.4 7410.3 7660.1 7675.5 7421.7 7466.1 7481.3 7492.6 7506.4 7142.8 7976.7 7980.8 7986.0 7997.2 4688.1 4716.8 4727.9 4728.0 4731.0 7302.5 7588.4 7598.2 7653.0 7656.4 6462.9 6792.7 7265.3 7341.9 7359.9 7304.6 7306.4 7319.1 7326.2 7338.1 5727.4 7111.8 7115.5 7149.7 7168.2 6483.4 6594.6 6991.0 7267.6 7310.1 6881.3 7005.9 7119.2 7138.8 7214.1 09:08:26 INFO - PROCESS | 1674 | 09:08:26 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:18423.32 Median:32878.84 stddev:26103.55 (79.4%) stddev-sans-first:26142.41 09:08:26 INFO - PROCESS | 1674 | Values: 586.4 683.7 685.0 726.7 728.3 13728.0 14915.7 15107.4 15304.0 17009.6 12336.3 15447.5 15552.1 15571.3 15627.9 869.8 871.9 872.7 873.1 882.4 790.4 816.5 878.7 878.7 884.4 906.5 909.5 917.4 926.0 927.6 912.2 918.6 919.0 919.9 921.3 646.7 669.1 675.3 677.2 678.1 14563.4 14578.0 14590.7 14600.3 14859.3 11286.4 11569.6 12860.3 13082.3 13426.3 9990.7 10002.3 10064.4 10188.3 10213.4 3245.8 3297.7 3516.9 3595.2 3721.6 63351.0 85470.6 85811.6 85896.6 88005.7 9579.0 9747.7 9981.9 10021.4 10385.6 22392.9 22408.9 22492.6 22515.2 22522.3 7401.1 7425.8 7521.2 7586.3 7767.2 3848.2 3939.0 3977.0 4059.9 4126.9 3563.4 3567.3 3590.1 3607.0 3615.6 655.4 661.1 662.6 666.6 670.4 498.6 531.5 583.6 590.5 596.3 8598.3 8638.6 8653.7 8893.5 8894.3 501.9 515.7 523.7 603.7 623.3 3941.9 4013.2 4053.1 4076.8 4214.3 88377.6 90905.1 95086.0 96088.5 96215.0 79109.0 79523.2 80190.4 81850.2 82394.0 68943.7 69730.3 70196.3 70250.6 70853.0 7052.4 7069.6 7801.0 8081.8 8381.5 47489.0 49109.5 49492.0 49508.5 49696.5 65111.0 69382.7 69531.7 69857.3 70284.9 9774.2 9813.5 9827.1 9890.7 10114.8 10917.5 11308.7 11452.7 11487.1 12062.3 10800.8 11252.1 11448.7 11553.8 11890.1 11042.9 11541.2 11601.9 11634.8 12250.0 10910.6 10961.6 10992.6 11195.7 12032.3 8346.3 8443.5 9373.0 9561.0 9795.0 8854.6 9449.6 9742.2 9856.8 10008.6 09:08:26 INFO - PROCESS | 1674 | -------- Summary: end -------- 09:08:26 INFO - PROCESS | 1674 | 09:08:27 INFO - TEST-INFO | 1674: exit 0 09:08:27 INFO - TEST-OK | dromaeo_css | took 1111480ms 09:08:27 INFO - TEST-START | kraken 09:08:27 INFO - operating with platform_type : mac_ 09:08:27 INFO - Initialising browser for kraken test... 09:08:27 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpTudA6I/profile http://localhost:49278/getInfo.html) 09:08:30 INFO - PROCESS | 1686 | __metrics Screen width/height:1600/1200 09:08:30 INFO - PROCESS | 1686 | colorDepth:24 09:08:30 INFO - PROCESS | 1686 | Browser inner width/height: 1024/689 09:08:30 INFO - PROCESS | 1686 | __metrics 09:08:30 ERROR - PROCESS | 1686 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 09:08:30 INFO - TEST-INFO | 1686: exit 0 09:08:30 INFO - Browser initialized. 09:08:30 INFO - Running cycle 1/1 for kraken test... 09:08:30 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/T/tmpTudA6I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:08:42 INFO - PROCESS | 1689 | RSS: Main: 255483904 09:08:42 INFO - PROCESS | 1689 | 09:08:45 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 09:08:46 INFO - PROCESS | 1689 | RSS: Main: 267538432 09:08:46 INFO - PROCESS | 1689 | 09:08:48 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 09:08:49 INFO - PROCESS | 1689 | RSS: Main: 276148224 09:08:49 INFO - PROCESS | 1689 | 09:08:52 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 09:08:53 INFO - PROCESS | 1689 | RSS: Main: 279666688 09:08:53 INFO - PROCESS | 1689 | 09:08:55 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 09:08:55 INFO - PROCESS | 1689 | RSS: Main: 281395200 09:08:55 INFO - PROCESS | 1689 | 09:08:57 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:08:58 INFO - PROCESS | 1689 | RSS: Main: 283512832 09:08:58 INFO - PROCESS | 1689 | 09:09:01 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:02 INFO - PROCESS | 1689 | RSS: Main: 282869760 09:09:02 INFO - PROCESS | 1689 | 09:09:05 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:05 INFO - PROCESS | 1689 | RSS: Main: 282492928 09:09:05 INFO - PROCESS | 1689 | 09:09:08 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 09:09:09 INFO - PROCESS | 1689 | RSS: Main: 282886144 09:09:09 INFO - PROCESS | 1689 | 09:09:10 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:11 INFO - PROCESS | 1689 | RSS: Main: 283537408 09:09:11 INFO - PROCESS | 1689 | 09:09:13 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:13 INFO - PROCESS | 1689 | RSS: Main: 283455488 09:09:13 INFO - PROCESS | 1689 | 09:09:15 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:16 INFO - PROCESS | 1689 | RSS: Main: 284151808 09:09:16 INFO - PROCESS | 1689 | 09:09:19 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:19 INFO - PROCESS | 1689 | RSS: Main: 283230208 09:09:19 INFO - PROCESS | 1689 | 09:09:22 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:09:22 INFO - PROCESS | 1689 | RSS: Main: 284647424 09:09:22 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 09:09:24 INFO - PROCESS | 1689 | RSS: Main: 285171712 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | __start_tp_report 09:09:24 INFO - PROCESS | 1689 | _x_x_mozilla_page_load 09:09:24 INFO - PROCESS | 1689 | _x_x_mozilla_page_load_details 09:09:24 INFO - PROCESS | 1689 | |i|pagename|runs| 09:09:24 INFO - PROCESS | 1689 | |0;ai-astar;113;105;113;113;125;184;166;167;117;115 09:09:24 INFO - PROCESS | 1689 | |1;audio-beat-detection;155;124;147;149;123;143;124;157;151;121 09:09:24 INFO - PROCESS | 1689 | |2;audio-dft;192;191;197;202;209;208;198;192;197;194 09:09:24 INFO - PROCESS | 1689 | |3;audio-fft;91;107;104;106;53;70;70;52;111;75 09:09:24 INFO - PROCESS | 1689 | |4;audio-oscillator;83;87;113;80;65;88;148;122;124;102 09:09:24 INFO - PROCESS | 1689 | |5;imaging-gaussian-blur;88;116;131;90;81;95;132;143;133;93 09:09:24 INFO - PROCESS | 1689 | |6;imaging-darkroom;102;97;96;96;97;104;95;100;153;153 09:09:24 INFO - PROCESS | 1689 | |7;imaging-desaturate;92;96;92;118;121;91;93;92;89;93 09:09:24 INFO - PROCESS | 1689 | |8;json-parse-financial;57;58;56;57;56;57;57;67;57;55 09:09:24 INFO - PROCESS | 1689 | |9;json-stringify-tinderbox;63;72;74;73;70;72;65;65;64;68 09:09:24 INFO - PROCESS | 1689 | |10;stanford-crypto-aes;85;85;86;84;91;86;85;86;90;86 09:09:24 INFO - PROCESS | 1689 | |11;stanford-crypto-ccm;131;129;129;120;148;141;137;136;137;139 09:09:24 INFO - PROCESS | 1689 | |12;stanford-crypto-pbkdf2;130;143;145;157;140;133;120;142;129;110 09:09:24 INFO - PROCESS | 1689 | |13;stanford-crypto-sha256-iterative;68;70;68;80;60;57;74;96;98;60 09:09:24 INFO - PROCESS | 1689 | __end_tp_report 09:09:24 INFO - PROCESS | 1689 | __start_cc_report 09:09:24 INFO - PROCESS | 1689 | _x_x_mozilla_cycle_collect,889 09:09:24 INFO - PROCESS | 1689 | __end_cc_report 09:09:24 INFO - PROCESS | 1689 | __startTimestamp1456247364700__endTimestamp 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | ------- Summary: start ------- 09:09:24 INFO - PROCESS | 1689 | Number of tests: 14 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#0] ai-astar Cycles:10 Average:131.80 Median:121.00 stddev:28.79 (23.8%) stddev-sans-first:29.72 09:09:24 INFO - PROCESS | 1689 | Values: 113.0 105.0 113.0 113.0 125.0 184.0 166.0 167.0 117.0 115.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:148.00 stddev:14.65 (9.9%) stddev-sans-first:14.41 09:09:24 INFO - PROCESS | 1689 | Values: 155.0 124.0 147.0 149.0 123.0 143.0 124.0 157.0 151.0 121.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#2] audio-dft Cycles:10 Average:198.00 Median:197.50 stddev:6.46 (3.3%) stddev-sans-first:6.48 09:09:24 INFO - PROCESS | 1689 | Values: 192.0 191.0 197.0 202.0 209.0 208.0 198.0 192.0 197.0 194.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#3] audio-fft Cycles:10 Average:83.90 Median:61.50 stddev:22.73 (37.0%) stddev-sans-first:23.96 09:09:24 INFO - PROCESS | 1689 | Values: 91.0 107.0 104.0 106.0 53.0 70.0 70.0 52.0 111.0 75.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#4] audio-oscillator Cycles:10 Average:101.20 Median:72.50 stddev:25.28 (34.9%) stddev-sans-first:25.94 09:09:24 INFO - PROCESS | 1689 | Values: 83.0 87.0 113.0 80.0 65.0 88.0 148.0 122.0 124.0 102.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:84.50 stddev:23.14 (27.4%) stddev-sans-first:23.10 09:09:24 INFO - PROCESS | 1689 | Values: 88.0 116.0 131.0 90.0 81.0 95.0 132.0 143.0 133.0 93.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#6] imaging-darkroom Cycles:10 Average:109.30 Median:95.50 stddev:23.21 (24.3%) stddev-sans-first:24.47 09:09:24 INFO - PROCESS | 1689 | Values: 102.0 97.0 96.0 96.0 97.0 104.0 95.0 100.0 153.0 153.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:92.00 stddev:11.64 (12.7%) stddev-sans-first:12.17 09:09:24 INFO - PROCESS | 1689 | Values: 92.0 96.0 92.0 118.0 121.0 91.0 93.0 92.0 89.0 93.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:3.37 (5.9%) stddev-sans-first:3.56 09:09:24 INFO - PROCESS | 1689 | Values: 57.0 58.0 56.0 57.0 56.0 57.0 57.0 67.0 57.0 55.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:71.00 stddev:4.12 (5.8%) stddev-sans-first:3.83 09:09:24 INFO - PROCESS | 1689 | Values: 63.0 72.0 74.0 73.0 70.0 72.0 65.0 65.0 64.0 68.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:2.27 (2.6%) stddev-sans-first:2.35 09:09:24 INFO - PROCESS | 1689 | Values: 85.0 85.0 86.0 84.0 91.0 86.0 85.0 86.0 90.0 86.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:137.00 stddev:7.76 (5.7%) stddev-sans-first:8.12 09:09:24 INFO - PROCESS | 1689 | Values: 131.0 129.0 129.0 120.0 148.0 141.0 137.0 136.0 137.0 139.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.90 Median:141.00 stddev:13.49 (9.6%) stddev-sans-first:14.19 09:09:24 INFO - PROCESS | 1689 | Values: 130.0 143.0 145.0 157.0 140.0 133.0 120.0 142.0 129.0 110.0 09:09:24 INFO - PROCESS | 1689 | 09:09:24 INFO - PROCESS | 1689 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:72.00 stddev:14.36 (19.9%) stddev-sans-first:15.12 09:09:24 INFO - PROCESS | 1689 | Values: 68.0 70.0 68.0 80.0 60.0 57.0 74.0 96.0 98.0 60.0 09:09:24 INFO - PROCESS | 1689 | -------- Summary: end -------- 09:09:24 INFO - PROCESS | 1689 | 09:09:25 INFO - TEST-INFO | 1689: exit 0 09:09:25 INFO - TEST-OK | kraken | took 58153ms 09:09:25 INFO - SUITE-END | took 1169s 09:09:25 INFO - Completed test suite (00:19:30) 09:09:25 INFO - Working with test: dromaeo_css 09:09:25 INFO - Generating results file: dromaeo_css 09:09:25 INFO - Working with test: kraken 09:09:25 INFO - Generating results file: kraken 09:09:25 INFO - javascript benchmark 09:09:25 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:09:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 09:09:26 INFO - process_Request line: dromaeo_css 7560.44 graph.html#tests=[[72,64,61]] 09:09:26 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:09:26 INFO - process_Request line: kraken 1526.90 graph.html#tests=[[232,64,61]] 09:09:26 INFO - RETURN: dromaeo_css: 7560.44 09:09:26 INFO - RETURN: kraken: 1526.90 09:09:26 INFO - javascript benchmark 09:09:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3525.2949410117976, 3529.911752206193, 3570.8750193743226, 3608.386574282372, 3621.782693038417, 5175.327207463034, 5646.830595082144, 5815.302163740352, 5821.0, 5821.621594596349, 5743.798967036144, 5819.0, 5851.297844258695, 5869.50109240714, 5902.321233058199, 5206.947930520693, 5245.737713114329, 5298.708571028592, 5317.9468205317835, 5350.8394748157425, 5143.228515722634, 5147.330846989886, 5296.602754793386, 5320.255164277004, 5343.65266257692, 4532.750698711569, 4556.863294101166, 5250.8687282817855, 5251.028559716465, 5266.131088370415, 5263.894722105575, 5279.841604751864, 5303.946960530384, 5304.0, 5318.707471089088, 5158.716270605115, 5213.765380557884, 5245.711485868275, 5251.973740131275, 5281.63028587999, 5508.366537848158, 5687.317521897398, 5720.2849643794525, 5790.33411157718, 5791.5656325775735, 6136.948001697505, 6330.145430366933, 6338.461230795388, 6340.714667839959, 6342.0, 6220.720067596969, 6295.055741638745, 6298.149749783766, 6303.527235457359, 6318.494520438354, 5865.648061116304, 5920.674362909996, 5922.97038514809, 5930.495907847795, 5965.075413310944, 6232.75068997235, 6234.470070044006, 6337.493000559944, 6340.1440805490665, 6344.238691357066, 6189.690515474208, 6196.659183744938, 6216.378362163748, 6220.34686357935, 6239.469645080128, 6250.406211409909, 6286.339934306832, 6293.244810622755, 6305.085762564402, 6320.462760665303, 6102.913431175824, 6217.285012223652, 6295.307516173218, 6299.874002519924, 6301.6219026858535, 6144.941444616104, 6166.876662466726, 6290.119383286344, 6294.181756371642, 6325.430711236011, 4133.545310015896, 4232.936505952413, 4854.344663470457, 4982.202847544376, 4985.451600323961, 4421.11577684458, 4448.888777780517, 4482.103579284091, 4508.143452744033, 4558.931616025762, 5641.928033673589, 5764.0, 5834.212381328552, 5848.239728835224, 5852.795152169739, 5160.432352441228, 5435.347758269033, 6144.41628045335, 6206.596571222856, 6297.4332310091395, 4946.9010619787405, 5884.382139875337, 5890.322612899486, 5896.6756828374855, 5898.8230353089475, 5469.206964990054, 5469.917951230735, 5490.368607610096, 5502.367227768777, 5504.614676972574, 5395.999999999922, 6264.060390941304, 6366.872662546723, 6421.775237866652, 6442.774502892376, 6284.151639528605, 6294.4964402846745, 6315.905261421174, 6326.9683651581445, 6338.809835704937, 6238.282597501164, 6370.77702280418, 6452.451541619015, 6480.351964803482, 6494.610323380423, 5199.246109314053, 6275.184226050585, 6278.058291256348, 6280.152179455715, 6309.936900630935, 5392.164214546751, 6271.6550589718, 6289.088082228142, 6291.559590828598, 6322.36776322364, 6021.969890150521, 6124.510039196764, 6245.718942647501, 6248.375162483715, 6254.061890716429, 5515.669059856261, 5984.1921340618455, 5994.28068631767, 6105.429421494235, 6214.316425193316, 5989.580729348903, 6092.695365231632, 6116.755329786759, 6120.7857724981195, 6127.019676851683, 5214.087534681492, 6131.920117368776, 6263.029230469285, 6276.4351208389635, 6281.71732272058, 6095.786647467317, 6098.420650038239, 6107.144999700135, 6124.571280010535, 6147.907781383372], "unit": "score", "name": "dojo.html", "value": 5718.172227934722}, {"lowerIsBetter": false, "replicates": [442.38950248656846, 471.56144785349613, 498.35214221512035, 565.9349174844892, 579.8347470970768, 27968.02111926083, 29413.117606471787, 37407.877763667064, 38201.0, 38210.85367438974, 40498.19003619926, 40711.0, 40856.59143408565, 40861.7956910215, 41039.589604104025, 9580.999999999982, 9770.755731106743, 9801.509924503745, 9814.656487022956, 9862.211023118134, 9657.903420965806, 9756.804863902718, 9769.071938165864, 9789.608415663364, 9824.901750982506, 9706.611735530605, 9809.803803923916, 9816.0, 9821.0, 9835.90164098357, 8422.778697088888, 9696.224302055854, 9792.510374481319, 9809.950950245238, 9845.015498450133, 9588.616455341778, 9665.371750836244, 9673.0, 9682.273829462818, 9696.127348538665, 39227.0, 39324.803375983225, 39388.01529961745, 39447.8027609863, 39684.0, 3064.5403189521526, 3110.4867696829997, 3505.509228707983, 3711.7030637548933, 3761.887143385703, 28679.856600716863, 28856.855715721496, 29275.268118297, 29556.556651650244, 29559.0, 2718.3340081680117, 2772.542530482468, 2822.788290878192, 2881.7406433420883, 2937.2510009947327, 497776.0, 499336.0, 502574.0, 502733.0, 688609.999999995, 66147.33852661509, 66307.66846165835, 66637.0, 67134.0, 67299.0, 70587.29412705808, 70971.2902870975, 71081.64459177671, 71220.93168602475, 71331.28668713247, 16323.510294691177, 16334.264958076677, 16511.587210319838, 16541.172941352885, 16547.83452165487, 12502.249865008129, 12682.302473363869, 12835.614931552069, 12877.549285774952, 12899.161554498927, 17276.481705548853, 21271.936403179778, 21660.675089873665, 21667.89166054191, 21743.347699568723, 7658.463907526531, 8965.641374344954, 9116.8632470513, 9191.816163676824, 9212.907870921204, 882.668999125328, 962.2206013129247, 977.2670497127154, 990.4898977026693, 1068.8450174724621, 30033.0, 30061.69938300589, 30209.09372718822, 30286.939957101837, 30289.24276893095, 851.0046029804961, 1108.2685427617735, 1155.0759392486145, 1163.5404015413865, 1170.584442522909, 13892.444302227797, 14353.0, 14455.710885782226, 14479.855201448061, 14627.341769620392, 643293.0, 655503.0, 665061.6746916331, 665096.0, 669035.0, 57415.42584574184, 59117.704411477665, 59402.405975939684, 59440.40559594435, 59696.522760793116, 1445.6747231872955, 1468.647524594111, 1470.4559313054237, 1480.2376775960388, 1487.620656732548, 24422.26733198007, 26809.329766755985, 28282.0, 28347.866085356356, 28682.56198223091, 36691.81654091713, 49271.0, 49902.0, 50004.999999998545, 50416.74791626018, 523811.0, 524566.0, 525464.0, 529168.0, 531316.0, 33089.172770679965, 33467.83266083654, 33551.16122096967, 42773.0, 44290.77854610706, 42376.94057648583, 43001.13997719966, 43602.56397436112, 43967.56032439763, 44000.67997960066, 36864.63135368612, 37056.81471592733, 37205.44191837179, 37210.62789372072, 37467.06332341713, 32356.83821580877, 37476.06309842167, 38991.0, 39369.0, 40237.39643905402, 37749.05627359338, 37952.0, 37982.8100859505, 39030.4145437813, 39127.02182445348, 28961.275968100967, 32164.87422940186, 32472.837635812615, 32595.022149335557, 32724.0, 21954.451138721022, 24314.149004784747, 24446.0, 24908.62637060409, 24955.875220624508], "unit": "score", "name": "ext.html", "value": 20090.448718439642}, {"lowerIsBetter": false, "replicates": [342.4965301007519, 360.82499987506054, 363.3042723185101, 369.62113833320825, 371.5912496254121, 10674.679759607225, 15554.844451555495, 16128.435504757335, 16981.490555283344, 19124.713129303072, 19580.804191958076, 19650.705239421386, 19760.802391976074, 19899.701504477445, 20067.799322006813, 5459.808906688267, 5489.890202195964, 5672.0, 5694.487496125348, 5705.286839145107, 5601.8599535011745, 5626.718664066801, 5681.545476361881, 5703.258576385064, 5729.3411257705275, 4883.584895283905, 5670.829875103733, 5688.857778555528, 5772.971135144339, 5824.767009319643, 5654.293213348332, 5712.485876271135, 5749.827505174831, 5753.884922301572, 5755.827325180251, 4354.7604881731495, 4587.472440669332, 5665.461781130827, 5733.512651424634, 5735.225744524478, 13192.604221873358, 13484.662883427894, 15832.92083539575, 25403.49193016148, 25478.36304092394, 2187.496875718578, 2230.4200907763934, 2250.324902529235, 2301.2866011536476, 2555.961660575093, 10079.647212347605, 10084.94957525215, 11878.762424751456, 13914.165150091027, 14696.0, 1690.315422253989, 1708.3849814066925, 1735.8698097642728, 1783.509534877906, 1783.5362805670488, 99884.50057749737, 117592.41203794011, 119218.0, 119331.4033429836, 119395.0, 9084.091590840995, 10816.513256903458, 11080.0, 11164.162687798447, 11167.83248251277, 12112.39438028095, 12784.232946023269, 13377.531786387624, 13425.597232083053, 13523.0, 8250.092489826115, 8355.164483551596, 8375.581220938928, 8430.199131082538, 8470.534120623302, 8568.314534837198, 8575.485470871768, 8591.742247732578, 8607.784805379915, 8690.78273043179, 4290.528041915387, 4365.323374876899, 4370.191514569815, 4379.321205213197, 4417.712848664826, 1843.207420809065, 1890.8676392652383, 1904.7238150468104, 1922.9807701923082, 1933.1590758020307, 712.2485777504783, 880.4497189256715, 913.5569248914271, 923.9769005774775, 924.5192499900014, 15482.380704771907, 20389.796102039087, 20412.591748164952, 20453.693194602092, 20495.0, 962.8507581324906, 966.5602151021268, 999.9000099990088, 1039.1323245090282, 1044.8902865199198, 10806.675799726021, 11005.339679619088, 11032.889671103187, 11035.503402346914, 11036.668899933014, 580195.1980480141, 664531.0, 674836.0, 677318.0, 687446.0, 117035.0, 118781.0, 121988.39005804915, 123912.76087239012, 124332.0, 966.709987003896, 991.4794732765212, 991.5290237137302, 996.5266498413196, 1000.4697510319543, 14328.856711432752, 18025.828321159082, 18153.092345382942, 18190.09004054555, 18549.814501855348, 41850.58149418467, 42117.57882421136, 48909.0, 52526.47473525216, 54451.72774136104, 57359.713201433726, 60355.0, 62830.42923926938, 67627.32372676407, 68892.0, 8127.634256458356, 8196.180381961756, 8202.097769245498, 8297.543635100128, 8360.331173506227, 9906.900930990598, 11383.658490245305, 13012.089153759525, 13464.08560875293, 13898.16611003343, 8839.46963182211, 11643.301401915913, 11846.99300559462, 11858.644240672793, 11903.583374581847, 5037.899242015213, 9661.0, 9770.75573110678, 11282.097432205568, 11616.186866919235, 10764.946175269073, 10814.621488247874, 10933.0, 12059.939700301442, 12130.939345303217, 8121.106678265504, 8136.674533018613, 8205.83588328242, 8222.794430139294, 8229.177082291722, 9926.851097233402, 10082.899171008195, 11215.0, 11759.588414405454, 11945.2832830027], "unit": "score", "name": "jquery.html", "value": 9172.052888046048}, {"lowerIsBetter": false, "replicates": [1521.2773932382117, 1534.3479021415897, 1620.5543475544232, 1760.1287362755438, 1871.7753869535659, 7054.964725176374, 7509.0, 8623.439476434027, 8717.171868672482, 9257.722268331952, 8642.956785216082, 8698.652053917851, 8781.736547903558, 8782.385233033674, 8836.69071582493, 2439.438929046325, 2451.460678650694, 2453.6932883389577, 2458.545169143705, 2468.753124687526, 2432.2824766693866, 2477.1577663594376, 2481.3424442522655, 2485.453200295941, 2497.1884137655243, 2146.978530214701, 2397.9760202398015, 2444.4377793107597, 2468.1361523466735, 2496.2386472125995, 2399.8080153587757, 2424.333308340203, 2428.405040765024, 2433.977729353676, 2437.3297343230574, 2390.1992832401165, 2438.9634155487684, 2441.963370549443, 2445.76765207305, 2447.9265622031367, 7307.232740562271, 8217.137200593912, 8676.8698469523, 8703.303735701129, 8718.910136232971, 4440.400545926291, 5426.2674538937135, 5447.155690867922, 5459.12653975366, 5461.4811592899005, 3176.952345714816, 3624.6194149614175, 3677.8712745053795, 3681.5398075240596, 3743.8502459901842, 1060.6234786650705, 1083.0198670203479, 1095.5124969388626, 1100.8238681810872, 1103.0623969625833, 12061.33662648554, 12127.454264558028, 12196.878031219752, 12221.816672749916, 12227.816582751355, 4889.413270407574, 4933.309336692866, 4962.106820772224, 5021.297018417425, 5038.093143234253, 10196.0, 10281.794364112826, 10303.536340864679, 10305.484725763681, 10322.329048611817, 4562.9771851141195, 5532.5573954083575, 5547.195656629766, 5578.748956296977, 5593.8321850344555, 4945.777440015136, 4977.0792403405485, 5023.472535383805, 5063.0, 5089.236614507779, 3987.322155233617, 3996.6403023728003, 4001.6198461146146, 4021.3163762160502, 4042.292598795199, 1312.9409176587076, 1328.6080606221187, 1333.613252156883, 1339.2834833364298, 1341.745068436994, 1027.1885210683477, 1110.9333439993627, 1144.8740638529755, 1242.2422322383338, 1373.6977864869712, 7895.802604934923, 7926.643301051467, 8010.639521221559, 8059.476134051268, 8102.189781021851, 1181.149572307937, 1188.4473719720372, 1191.4817054581113, 1204.8433703618473, 1215.2951288252968, 6185.659788711574, 6195.96902015496, 6253.593516421418, 6261.686915654199, 6295.464885484785, 10281.074703276741, 10483.842742358871, 10583.364998100138, 10655.520501577448, 10671.039606435457, 10306.175505959505, 10407.323523970917, 10456.843147352796, 10481.633142839964, 10500.369977801356, 8126.187381261827, 8202.671893124327, 8256.050554186226, 8265.876011859827, 8329.292010179082, 7999.400044996765, 8040.83918321642, 8072.556009419538, 8084.878726818984, 8247.711330103417, 9642.855357169508, 9711.56297966579, 9771.80456390854, 9772.120509153925, 9828.459434731158, 8327.916720832956, 9864.0, 10109.696709098738, 10122.392656440637, 10243.590256389662, 6235.719392627252, 7568.735094271674, 7661.885071723817, 7672.0, 7673.386129109769, 8300.958495207486, 8321.209485098905, 8375.664973401239, 8378.622961966848, 8391.035030971272, 6940.6529673515115, 7479.0, 7553.169151393233, 7724.382049436144, 7760.340371068297, 7383.520071195355, 7423.257674232534, 7465.29079737424, 7487.700491980478, 7594.5063570867715, 7811.336036436966, 7819.530828150329, 7875.724349647735, 7889.13219545861, 7937.920620793949, 6843.794686159423, 7028.262032486516, 7091.290870912868, 7132.1441427029085, 7155.606441645759, 5977.133315669291, 7105.218425973036, 7113.466490013373, 7143.428525718034, 7151.034610327539], "unit": "score", "name": "mootools.html", "value": 4949.081354553036}, {"lowerIsBetter": false, "replicates": [328.24339896538476, 332.08179384003233, 334.62856229585174, 337.1402922547504, 341.99487007694876, 6574.342565743424, 6690.397864192234, 6728.158980127484, 6764.661766911653, 6789.151356080496, 5250.527452529272, 5335.813246536372, 5454.236406903027, 6775.119234499521, 6827.385535301822, 4957.553820156176, 4987.177115775893, 4987.426445958725, 4989.57588604969, 5017.19724844025, 5001.474845141262, 5003.624728145385, 5004.923941352608, 5005.499450055002, 5018.774155163026, 3949.763014219156, 4939.357883475143, 4940.308356830046, 4940.950590494085, 4959.859232376555, 3854.710896682746, 4610.2623580227, 4668.486466488666, 4909.803607855682, 4953.058918805452, 3509.3683137035323, 4057.1277175407135, 4098.180363927197, 4098.790856697281, 4103.651189648884, 6430.871382572369, 6464.127342808708, 6476.514261430364, 6503.479721622306, 6512.479001679854, 5763.221965034709, 5808.215890854723, 5811.709414529257, 5812.82561523155, 5820.592558520905, 7226.819329516751, 7241.818954526179, 7265.564066155995, 7266.346028857428, 7277.6725047372465, 4429.446319210098, 4648.581627653493, 4649.558291962258, 4655.022445286494, 4657.534246575349, 7453.105627324756, 7615.200403957616, 7630.504017238917, 7689.461737678364, 7699.730509432143, 4690.882727931829, 4709.293605959065, 4712.128256272601, 4715.221988371949, 4721.716696998191, 4790.209615413488, 4792.688475249098, 4793.49668284832, 4802.903941921212, 4812.855614331505, 5764.308283005982, 5764.538836893039, 5770.509506691894, 5776.220210271644, 5779.3642699303045, 6982.965085174643, 7271.454640901953, 7294.015307933467, 7294.635268236673, 7326.194118646945, 1634.3462614954115, 1646.2345009570606, 1656.403694669918, 1662.6342204714942, 1666.641672040517, 995.875515560555, 1048.1352883870836, 1051.4269723000982, 1064.7338165458636, 1069.1660504806264, 5359.946400536022, 6312.873742525216, 6781.847085995392, 6858.897116543256, 6868.62222577753, 6725.66371681414, 7712.768616941501, 7714.768556943301, 7725.729599463992, 7752.612369381508, 6764.323567643196, 6794.72821087151, 6802.14973128359, 6809.659517024129, 6817.943218801094, 3913.2173565287057, 4007.8797636070963, 4041.2927737646382, 4044.757314561136, 4064.313309976386, 7879.881801772978, 7963.243491868263, 7991.320737737357, 8000.63997120131, 8025.036995560454, 7010.579365238102, 7169.462290328246, 7827.608619568999, 7844.019497562805, 7868.370530357558, 7053.647317634098, 7220.638968051577, 7939.761807145679, 7947.324477419368, 7997.400194985399, 6860.828479288058, 7399.371053460516, 7410.296021877913, 7660.119086304923, 7675.501092429197, 7421.666025028779, 7466.066741657293, 7481.326680598772, 7492.550446973199, 7506.437017223621, 7142.750003749844, 7976.680932762624, 7980.84038319242, 7985.960070199611, 7997.240262175084, 4688.109259240733, 4716.764161791828, 4727.881802954954, 4728.007118505152, 4730.952690473051, 7302.452316076209, 7588.354989825927, 7598.240175982358, 7652.961735191511, 7656.387489000978, 6462.870742585216, 6792.72829086831, 7265.273472652692, 7341.926580734124, 7359.889601655872, 7304.598247096461, 7306.41548676094, 7319.085114360705, 7326.194118647051, 7338.119425668954, 5727.369989301257, 7111.822204444723, 7115.501914865909, 7149.7497587584185, 7168.211496735459, 6483.443973446245, 6594.615130822581, 6991.0, 7267.563946163247, 7310.122785265802, 6881.346272104142, 7005.894911576229, 7119.216886142417, 7138.750143745152, 7214.134303883568], "unit": "score", "name": "prototype.html", "value": 5229.558695823426}, {"lowerIsBetter": false, "replicates": [586.3698917010709, 683.7470136049661, 684.9726010959562, 726.69115625859, 728.3190217146964, 13728.0, 14915.701685966287, 15107.395704171848, 15304.005239659427, 17009.554187894013, 12336.259824410541, 15447.536573902773, 15552.066875987448, 15571.299291531908, 15627.921860390683, 869.7564681889081, 871.9258862996653, 872.690194980779, 873.0701802580231, 882.4176043811086, 790.3716545346434, 816.5304949653943, 878.6617152396342, 878.6880657366606, 884.3632584539154, 906.5421961909227, 909.5270459361128, 917.3624331089895, 926.0415469988563, 927.6150397584994, 912.2291663544295, 918.5820451694462, 918.9908100918972, 919.8574220995756, 921.3412410126758, 646.6831252686197, 669.0967194287721, 675.2909445082693, 677.1873751498222, 678.091357580844, 14563.417463301455, 14578.0, 14590.70818583633, 14600.269986500738, 14859.2570371481, 11286.379249141293, 11569.595064172714, 12860.292683902382, 13082.280474573894, 13426.32868356588, 9990.700278991642, 10002.299839011272, 10064.39613623185, 10188.337758045704, 10213.387196768143, 3245.7727959042877, 3297.7187698240164, 3516.9472457913153, 3595.227026189356, 3721.6278372162838, 63351.0, 85470.57264713699, 85811.57094214551, 85896.57051714702, 88005.67991480132, 9578.952105239428, 9747.720122655388, 9981.900180998242, 10021.39871607706, 10385.63650272237, 22392.888035559718, 22408.887955560444, 22492.550148997256, 22515.211967581057, 22522.32433027012, 7401.111866576045, 7425.8143546411775, 7521.172671006185, 7586.317231449196, 7767.223277672188, 3848.1534062506203, 3939.0, 3977.0, 4059.91880162401, 4126.938095928564, 3563.4476656118345, 3567.2687099145132, 3590.1024743814046, 3607.0, 3615.6022837487853, 655.4101308822098, 661.0513912535527, 662.6156829039242, 666.6366830077619, 670.3932940688685, 498.60610118006366, 531.5349069564131, 583.629395333966, 590.539379284159, 596.3321080389991, 8598.269147122564, 8638.611262493077, 8653.697120600875, 8893.510856902933, 8894.332925030649, 501.90965626187636, 515.744706370349, 523.7381309345327, 603.6709993053796, 623.3268070483866, 3941.881743547698, 4013.1572369802084, 4053.0677944073027, 4076.7553946763287, 4214.283571792803, 88377.55811220902, 90905.09094908966, 95086.0, 96088.51955740177, 96215.0, 79109.0, 79523.20476795273, 80190.39619207583, 81850.18149818426, 82394.0, 68943.65528172227, 69730.30269697339, 70196.29803702, 70250.64874675697, 70853.0, 7052.400545953651, 7069.575825450283, 7800.960995194988, 8081.797955051171, 8381.49711017341, 47489.0, 49109.50890491192, 49492.010159795886, 49508.50491495039, 49696.509104726916, 65111.0, 69382.65308673626, 69531.65234173796, 69857.30142698508, 70284.94572581518, 9774.169195618168, 9813.509324533887, 9827.066428689262, 9890.664760257274, 10114.848277275994, 10917.454127293762, 11308.717282068013, 11452.713682157679, 11487.081033517132, 12062.336571488302, 10800.837987430037, 11252.099832013255, 11448.656540303804, 11553.768924621629, 11890.10824188172, 11042.944785276022, 11541.192116551762, 11601.941990289995, 11634.767304653691, 12250.019998399928, 10910.563577457131, 10961.616343427942, 10992.615258465916, 11195.72010699739, 12032.338221397556, 8346.33229341639, 8443.451175673561, 9373.0, 9560.952195238979, 9794.951025244829, 8854.557272136497, 9449.622015119317, 9742.171915387271, 9856.753581160528, 10008.649697260853], "unit": "score", "name": "yui.html", "value": 6847.722887363644}], "name": "dromaeo_css", "value": 7560.443697819968}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 113.0, 113.0, 125.0, 184.0, 166.0, 167.0, 117.0, 115.0], "unit": "score", "name": "ai-astar", "value": 131.8}, {"lowerIsBetter": true, "replicates": [155.0, 124.0, 147.0, 149.0, 123.0, 143.0, 124.0, 157.0, 151.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 139.4}, {"lowerIsBetter": true, "replicates": [192.0, 191.0, 197.0, 202.0, 209.0, 208.0, 198.0, 192.0, 197.0, 194.0], "unit": "score", "name": "audio-dft", "value": 198.0}, {"lowerIsBetter": true, "replicates": [91.0, 107.0, 104.0, 106.0, 53.0, 70.0, 70.0, 52.0, 111.0, 75.0], "unit": "score", "name": "audio-fft", "value": 83.9}, {"lowerIsBetter": true, "replicates": [83.0, 87.0, 113.0, 80.0, 65.0, 88.0, 148.0, 122.0, 124.0, 102.0], "unit": "score", "name": "audio-oscillator", "value": 101.2}, {"lowerIsBetter": true, "replicates": [88.0, 116.0, 131.0, 90.0, 81.0, 95.0, 132.0, 143.0, 133.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [102.0, 97.0, 96.0, 96.0, 97.0, 104.0, 95.0, 100.0, 153.0, 153.0], "unit": "score", "name": "imaging-darkroom", "value": 109.3}, {"lowerIsBetter": true, "replicates": [92.0, 96.0, 92.0, 118.0, 121.0, 91.0, 93.0, 92.0, 89.0, 93.0], "unit": "score", "name": "imaging-desaturate", "value": 97.7}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 56.0, 57.0, 56.0, 57.0, 57.0, 67.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [63.0, 72.0, 74.0, 73.0, 70.0, 72.0, 65.0, 65.0, 64.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 86.0, 84.0, 91.0, 86.0, 85.0, 86.0, 90.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.4}, {"lowerIsBetter": true, "replicates": [131.0, 129.0, 129.0, 120.0, 148.0, 141.0, 137.0, 136.0, 137.0, 139.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 134.7}, {"lowerIsBetter": true, "replicates": [130.0, 143.0, 145.0, 157.0, 140.0, 133.0, 120.0, 142.0, 129.0, 110.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.9}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 80.0, 60.0, 57.0, 74.0, 96.0, 98.0, 60.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.1}], "name": "kraken", "value": 1526.9}]} 09:09:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1526.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7560.44"}}} 09:09:26 INFO - Return code: 0 09:09:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:09:26 ERROR - # TBPL SUCCESS # 09:09:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:09:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:09:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:09:26 INFO - 2016-02-23 09:09:26.554 screenresolution[1694:10408] starting screenresolution argv=screenresolution get 09:09:26 INFO - 2016-02-23 09:09:26.557 screenresolution[1694:10408] Display 0: 1600x1200x32@60 09:09:26 INFO - 2016-02-23 09:09:26.563 screenresolution[1695:10411] starting screenresolution argv=screenresolution list 09:09:26 INFO - Available Modes on Display 0 09:09:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:09:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:09:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:09:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:09:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:09:26 INFO - Intel Iris: 09:09:26 INFO - Chipset Model: Intel Iris 09:09:26 INFO - Type: GPU 09:09:26 INFO - Bus: Built-In 09:09:26 INFO - VRAM (Dynamic, Max): 1536 MB 09:09:26 INFO - Vendor: Intel (0x8086) 09:09:26 INFO - Device ID: 0x0a2e 09:09:26 INFO - Revision ID: 0x0009 09:09:26 INFO - Displays: 09:09:26 INFO - Display: 09:09:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:09:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:09:26 INFO - Display Serial Number: 1600x1200 60 09:09:26 INFO - Main Display: Yes 09:09:26 INFO - Mirror: Off 09:09:26 INFO - Online: Yes 09:09:26 INFO - Rotation: Supported 09:09:26 INFO - Return code: 0 09:09:26 INFO - Running post-action listener: _resource_record_post_action 09:09:26 INFO - Running post-run listener: _resource_record_post_run 09:09:27 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39527936; Write bytes: 709760512; Read time: 421; Write time: 2013 09:09:27 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 399446528; Write bytes: 393053696; Read time: 29865; Write time: 656 09:09:27 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 37713408; Write bytes: 303050752; Read time: 402; Write time: 1319 09:09:27 INFO - Running post-run listener: _upload_blobber_files 09:09:27 INFO - Blob upload gear active. 09:09:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:09:27 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 09:09:27 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'] 09:09:27 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 09:09:28 INFO - (blobuploader) - INFO - Open directory for files ... 09:09:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:09:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:09:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:29 INFO - (blobuploader) - INFO - Done attempting. 09:09:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:09:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:09:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:30 INFO - (blobuploader) - INFO - Done attempting. 09:09:30 INFO - (blobuploader) - INFO - Iteration through files over. 09:09:30 INFO - Return code: 0 09:09:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:09:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:09:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1338d72fcb1a821b88e3c90464b139f55431efb1a921e9fc20a1515fe3a42104cd5a9648ff255f9e07a993cf94745b0502408d0b083f97d29948f120708a89c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd68779889955f9876da32e4c6d9e6990f384a5021132c30580dd256e06fa0011991d912e760e232c3b15f1ce63e8a4288a799a5a524e7fa8ec331d23fcec25c"} 09:09:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:09:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:09:30 INFO - Contents: 09:09:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1338d72fcb1a821b88e3c90464b139f55431efb1a921e9fc20a1515fe3a42104cd5a9648ff255f9e07a993cf94745b0502408d0b083f97d29948f120708a89c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd68779889955f9876da32e4c6d9e6990f384a5021132c30580dd256e06fa0011991d912e760e232c3b15f1ce63e8a4288a799a5a524e7fa8ec331d23fcec25c"} 09:09:30 INFO - Running post-run listener: copy_logs_to_upload_dir 09:09:30 INFO - Copying logs to upload dir... 09:09:30 INFO - mkdir: /builds/slave/test/build/upload/logs 09:09:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.842600 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-02-23 09:09:30.297537) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 09:09:30.301478) ========= 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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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/1338d72fcb1a821b88e3c90464b139f55431efb1a921e9fc20a1515fe3a42104cd5a9648ff255f9e07a993cf94745b0502408d0b083f97d29948f120708a89c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd68779889955f9876da32e4c6d9e6990f384a5021132c30580dd256e06fa0011991d912e760e232c3b15f1ce63e8a4288a799a5a524e7fa8ec331d23fcec25c"} build_url:https://queue.taskcluster.net/v1/task/CvV9g1qgQEePJNYBFJ8AMA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010589 build_url: 'https://queue.taskcluster.net/v1/task/CvV9g1qgQEePJNYBFJ8AMA/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/1338d72fcb1a821b88e3c90464b139f55431efb1a921e9fc20a1515fe3a42104cd5a9648ff255f9e07a993cf94745b0502408d0b083f97d29948f120708a89c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dd68779889955f9876da32e4c6d9e6990f384a5021132c30580dd256e06fa0011991d912e760e232c3b15f1ce63e8a4288a799a5a524e7fa8ec331d23fcec25c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 09:09:30.335784) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:09:30.336153) ========= 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.YqJJY6EeVe/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.Jng8qL7Ote/Listeners TMPDIR=/var/folders/gr/g45hs_z92cb8kdnh3rf3wt0000000w/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.005067 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 09:09:30.387210) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 09:09:30.387862) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 09:09:30.388632) ========= ========= Total master_lag: 1.62 =========