builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0044 starttime: 1460564751.63 results: success (0) buildid: 20160413073852 builduid: 75dee8d45e82418ea9cb966aa480bf92 revision: 0b38f4474a28f269761d16ec80fec219db3697e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.630425) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.630878) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.631181) ========= 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.DKXTWa8R5r/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.eg57aZURwn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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.005543 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.666824) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.670237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.695664) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.696050) ========= 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.DKXTWa8R5r/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.eg57aZURwn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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.005498 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.745671) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.748983) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.749344) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.749615) ========= 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.DKXTWa8R5r/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.eg57aZURwn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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-04-13 09:25:51-- 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.8M=0.001s 2016-04-13 09:25:51 (15.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171408 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.942827) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.946168) ========= 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.DKXTWa8R5r/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.eg57aZURwn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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.026463 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:51.994534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 09:25:51.994926) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0b38f4474a28f269761d16ec80fec219db3697e3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0b38f4474a28f269761d16ec80fec219db3697e3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DKXTWa8R5r/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.eg57aZURwn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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-04-13 09:25:52,076 truncating revision to first 12 chars 2016-04-13 09:25:52,076 Setting DEBUG logging. 2016-04-13 09:25:52,076 attempt 1/10 2016-04-13 09:25:52,076 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0b38f4474a28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-13 09:25:53,560 unpacking tar archive at: mozilla-aurora-0b38f4474a28/testing/mozharness/ program finished with exit code 0 elapsedTime=1.726289 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-13 09:25:53.741236) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:53.741660) ========= echo 0b38f4474a28f269761d16ec80fec219db3697e3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0b38f4474a28f269761d16ec80fec219db3697e3'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DKXTWa8R5r/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.eg57aZURwn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 0b38f4474a28f269761d16ec80fec219db3697e3 program finished with exit code 0 elapsedTime=0.005470 script_repo_revision: '0b38f4474a28f269761d16ec80fec219db3697e3' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:53.795164) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:53.795561) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-13 09:25:53.807462) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-13 09:25:53.807882) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DKXTWa8R5r/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.eg57aZURwn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 09:25:53 INFO - MultiFileLogger online at 20160413 09:25:53 in /builds/slave/test 09:25:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:25:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:25:54 INFO - {'append_to_log': False, 09:25:54 INFO - 'base_work_dir': '/builds/slave/test', 09:25:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:25:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:25:54 INFO - 'branch': 'Mozilla-Aurora', 09:25:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:25:54 INFO - 'config_files': ('talos/mac_config.py',), 09:25:54 INFO - 'default_actions': ('clobber', 09:25:54 INFO - 'read-buildbot-config', 09:25:54 INFO - 'download-and-extract', 09:25:54 INFO - 'populate-webroot', 09:25:54 INFO - 'create-virtualenv', 09:25:54 INFO - 'install', 09:25:54 INFO - 'run-tests'), 09:25:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:25:54 INFO - 'download_minidump_stackwalk': True, 09:25:54 INFO - 'download_symbols': 'ondemand', 09:25:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:25:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:25:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:25:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:25:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:25:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:25:54 INFO - 'installer_path': 'installer.exe', 09:25:54 INFO - 'log_level': 'info', 09:25:54 INFO - 'log_name': 'talos', 09:25:54 INFO - 'log_to_console': True, 09:25:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:25:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:25:54 INFO - 'opt_config_files': (), 09:25:54 INFO - 'pip_index': False, 09:25:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:25:54 INFO - 'cmd': ('bash', 09:25:54 INFO - '-c', 09:25:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:25:54 INFO - 'enabled': True, 09:25:54 INFO - 'halt_on_failure': False, 09:25:54 INFO - 'name': 'check_screen_resolution'},), 09:25:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:25:54 INFO - 'cmd': ('bash', 09:25:54 INFO - '-c', 09:25:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:25:54 INFO - 'enabled': True, 09:25:54 INFO - 'halt_on_failure': False, 09:25:54 INFO - 'name': 'check_screen_resolution'},), 09:25:54 INFO - 'run_cmd_checks_enabled': True, 09:25:54 INFO - 'sps_profile': False, 09:25:54 INFO - 'sps_profile_interval': 0, 09:25:54 INFO - 'suite': 'dromaeojs-e10s', 09:25:54 INFO - 'system_bits': '32', 09:25:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:25:54 INFO - 'title': 't-yosemite-r7-0044', 09:25:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:25:54 INFO - 'use_talos_json': True, 09:25:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:25:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:25:54 INFO - 'work_dir': 'build'} 09:25:54 INFO - ##### 09:25:54 INFO - ##### Running clobber step. 09:25:54 INFO - ##### 09:25:54 INFO - Running pre-action listener: _resource_record_pre_action 09:25:54 INFO - Running main action method: clobber 09:25:54 INFO - rmtree: /builds/slave/test/build 09:25:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:25:55 INFO - Running post-action listener: _resource_record_post_action 09:25:55 INFO - ##### 09:25:55 INFO - ##### Running read-buildbot-config step. 09:25:55 INFO - ##### 09:25:55 INFO - Running pre-action listener: _resource_record_pre_action 09:25:55 INFO - Running main action method: read_buildbot_config 09:25:55 INFO - Using buildbot properties: 09:25:55 INFO - { 09:25:55 INFO - "project": "", 09:25:55 INFO - "product": "firefox", 09:25:55 INFO - "script_repo_revision": "production", 09:25:55 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 09:25:55 INFO - "repository": "", 09:25:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 09:25:55 INFO - "buildid": "20160413073852", 09:25:55 INFO - "pgo_build": "False", 09:25:55 INFO - "basedir": "/builds/slave/test", 09:25:55 INFO - "buildnumber": 243, 09:25:55 INFO - "slavename": "t-yosemite-r7-0044", 09:25:55 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:25:55 INFO - "platform": "yosemite_r7", 09:25:55 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:25:55 INFO - "branch": "mozilla-aurora", 09:25:55 INFO - "repo_path": "releases/mozilla-aurora", 09:25:55 INFO - "revision": "0b38f4474a28f269761d16ec80fec219db3697e3", 09:25:55 INFO - "stage_platform": "macosx64", 09:25:55 INFO - "builduid": "75dee8d45e82418ea9cb966aa480bf92", 09:25:55 INFO - "slavebuilddir": "test" 09:25:55 INFO - } 09:25:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 09:25:55 INFO - Running post-action listener: _resource_record_post_action 09:25:55 INFO - ##### 09:25:55 INFO - ##### Running download-and-extract step. 09:25:55 INFO - ##### 09:25:55 INFO - Running pre-action listener: _resource_record_pre_action 09:25:55 INFO - Running main action method: download_and_extract 09:25:55 INFO - mkdir: /builds/slave/test/build/tests 09:25:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:55 INFO - https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:25:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 09:25:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 09:25:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 09:25:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 09:25:57 INFO - Downloaded 1277 bytes. 09:25:57 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 09:25:57 INFO - Using the following test package requirements: 09:25:57 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 09:25:57 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:25:57 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 09:25:57 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:25:57 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 09:25:57 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:25:57 INFO - u'jsshell-mac.zip'], 09:25:57 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:25:57 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 09:25:57 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 09:25:57 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:25:57 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 09:25:57 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:25:57 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 09:25:57 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:25:57 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 09:25:57 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 09:25:57 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:25:57 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 09:25:57 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:25: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')]} 09:25:57 INFO - https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:25:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:25:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:25:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:25:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:25:58 INFO - Downloaded 17910985 bytes. 09:25:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:25:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:26:01 INFO - Return code: 0 09:26:01 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:26: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')]} 09:26:01 INFO - https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:26:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:26:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:26:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:26:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:26:04 INFO - Downloaded 17910985 bytes. 09:26:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:26:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:26:08 INFO - Return code: 0 09:26:08 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')]} 09:26:08 INFO - https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:26:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 09:26:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 09:26:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 09:26:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:26:09 INFO - Downloaded 10845168 bytes. 09:26:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:26:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:26:09 INFO - Return code: 0 09:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:09 INFO - https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 09:26:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:26:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:26:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 09:26:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 09:26:12 INFO - Downloaded 115214686 bytes. 09:26:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:26:12 INFO - mkdir: /builds/slave/test/properties 09:26:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:26:12 INFO - Writing to file /builds/slave/test/properties/build_url 09:26:12 INFO - Contents: 09:26:12 INFO - build_url:https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:26:14 INFO - Running post-action listener: _resource_record_post_action 09:26:14 INFO - Running post-action listener: set_extra_try_arguments 09:26:14 INFO - ##### 09:26:14 INFO - ##### Running populate-webroot step. 09:26:14 INFO - ##### 09:26:14 INFO - Running pre-action listener: _resource_record_pre_action 09:26:14 INFO - Running main action method: populate_webroot 09:26:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:26:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:26:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:26:14 INFO - '--tppagecycles', 09:26:14 INFO - '7'], 09:26:14 INFO - 'tests': ['tsvgm']}}, 09:26:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:26:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:26:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:26:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:26:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:26:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:26:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:14 INFO - 'talos_options': ['--e10s'], 09:26:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:26:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:14 INFO - 'tests': ['damp', 'tps']}, 09:26:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:14 INFO - 'talos_options': ['--e10s'], 09:26:14 INFO - 'tests': ['damp', 'tps']}, 09:26:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:26:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:26:14 INFO - 'other': {'tests': ['a11yr', 09:26:14 INFO - 'ts_paint', 09:26:14 INFO - 'tpaint', 09:26:14 INFO - 'sessionrestore', 09:26:14 INFO - 'sessionrestore_no_auto_restore', 09:26:14 INFO - 'tabpaint']}, 09:26:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:26:14 INFO - 'tests': ['a11yr', 09:26:14 INFO - 'ts_paint', 09:26:14 INFO - 'tpaint', 09:26:14 INFO - 'sessionrestore', 09:26:14 INFO - 'sessionrestore_no_auto_restore', 09:26:14 INFO - 'tabpaint']}, 09:26:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:26:14 INFO - 'tests': ['a11yr', 09:26:14 INFO - 'ts_paint', 09:26:14 INFO - 'tpaint', 09:26:14 INFO - 'sessionrestore', 09:26:14 INFO - 'sessionrestore_no_auto_restore', 09:26:14 INFO - 'tabpaint']}, 09:26:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:26:14 INFO - 'tests': ['a11yr', 09:26:14 INFO - 'ts_paint', 09:26:14 INFO - 'tpaint', 09:26:14 INFO - 'sessionrestore', 09:26:14 INFO - 'sessionrestore_no_auto_restore', 09:26:14 INFO - 'tabpaint']}, 09:26:14 INFO - 'other_l64': {'tests': ['a11yr', 09:26:14 INFO - 'ts_paint', 09:26:14 INFO - 'tpaint', 09:26:14 INFO - 'sessionrestore', 09:26:14 INFO - 'sessionrestore_no_auto_restore', 09:26:14 INFO - 'tabpaint']}, 09:26:14 INFO - 'other_nol64': {'tests': ['a11yr', 09:26:14 INFO - 'ts_paint', 09:26:14 INFO - 'tpaint', 09:26:14 INFO - 'sessionrestore', 09:26:14 INFO - 'sessionrestore_no_auto_restore', 09:26:14 INFO - 'tabpaint']}, 09:26:14 INFO - 'svgr': {'tests': ['tsvgx', 09:26:14 INFO - 'tsvgr_opacity', 09:26:14 INFO - 'tart', 09:26:14 INFO - 'tscrollx', 09:26:14 INFO - 'cart']}, 09:26:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:26:14 INFO - 'tests': ['tsvgx', 09:26:14 INFO - 'tsvgr_opacity', 09:26:14 INFO - 'tart', 09:26:14 INFO - 'tscrollx', 09:26:14 INFO - 'cart']}, 09:26:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:14 INFO - 'tests': ['tp5o']}, 09:26:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:14 INFO - 'talos_options': ['--e10s'], 09:26:14 INFO - 'tests': ['tp5o']}, 09:26:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:14 INFO - 'talos_options': ['--xperf_path', 09:26:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:14 INFO - 'tests': ['tp5n']}, 09:26:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:26:14 INFO - 'talos_options': ['--e10s', 09:26:14 INFO - '--xperf_path', 09:26:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:26:14 INFO - 'tests': ['tp5n']}}, 09:26:14 INFO - 'talos.zip': {'path': '', 09:26:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:26:14 INFO - Running post-action listener: _resource_record_post_action 09:26:14 INFO - ##### 09:26:14 INFO - ##### Running create-virtualenv step. 09:26:14 INFO - ##### 09:26:14 INFO - Running pre-action listener: _resource_record_pre_action 09:26:14 INFO - Running main action method: create_virtualenv 09:26:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:26:14 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 09:26:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:26:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:26:14 INFO - Using real prefix '/tools/python27' 09:26:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:26:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:26:17 INFO - Installing pip.................done. 09:26:17 INFO - Return code: 0 09:26:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:26:17 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')]} 09:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:17 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')]} 09:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:17 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 0x10b792a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9efb599e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b636d30>, '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 0x10b49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b62db20>, '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.DKXTWa8R5r/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.eg57aZURwn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 09:26:17 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 09:26:17 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 09:26:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DKXTWa8R5r/Render', 09:26:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:17 INFO - 'HOME': '/Users/cltbld', 09:26:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:17 INFO - 'LOGNAME': 'cltbld', 09:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:17 INFO - 'MOZ_NO_REMOTE': '1', 09:26:17 INFO - 'NO_EM_RESTART': '1', 09:26:17 INFO - 'PAGER': '/bin/cat', 09:26:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:17 INFO - 'PWD': '/builds/slave/test', 09:26:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:17 INFO - 'SHELL': '/bin/bash', 09:26:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eg57aZURwn/Listeners', 09:26:17 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 09:26:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:17 INFO - 'USER': 'cltbld', 09:26:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:17 INFO - 'XPC_FLAGS': '0x0', 09:26:17 INFO - 'XPC_SERVICE_NAME': '0', 09:26:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:18 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 09:26:18 INFO - Cleaning up... 09:26:18 INFO - Return code: 0 09:26:18 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b792a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9efb599e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b636d30>, '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 0x10b49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b62db20>, '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.DKXTWa8R5r/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.eg57aZURwn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 09:26:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:26:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:26:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DKXTWa8R5r/Render', 09:26:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:18 INFO - 'HOME': '/Users/cltbld', 09:26:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:18 INFO - 'LOGNAME': 'cltbld', 09:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:18 INFO - 'MOZ_NO_REMOTE': '1', 09:26:18 INFO - 'NO_EM_RESTART': '1', 09:26:18 INFO - 'PAGER': '/bin/cat', 09:26:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:18 INFO - 'PWD': '/builds/slave/test', 09:26:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:18 INFO - 'SHELL': '/bin/bash', 09:26:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eg57aZURwn/Listeners', 09:26:18 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 09:26:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:18 INFO - 'USER': 'cltbld', 09:26:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:18 INFO - 'XPC_FLAGS': '0x0', 09:26:18 INFO - 'XPC_SERVICE_NAME': '0', 09:26:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:18 INFO - Downloading/unpacking psutil>=0.7.1 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26: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 09:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:26:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:21 INFO - Installing collected packages: psutil 09:26:21 INFO - Running setup.py install for psutil 09:26:21 INFO - building 'psutil._psutil_osx' extension 09:26:21 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 09:26:21 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 09:26:22 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 09:26:22 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 09:26:22 INFO - building 'psutil._psutil_posix' extension 09:26:22 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 09:26:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:26:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:26:22 INFO - ^ 09:26:22 INFO - 1 warning generated. 09:26:22 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 09:26:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:26:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:26:22 INFO - Successfully installed psutil 09:26:22 INFO - Cleaning up... 09:26:22 INFO - Return code: 0 09:26:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:26:22 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')]} 09:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:22 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')]} 09:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:22 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 0x10b792a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9efb599e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b636d30>, '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 0x10b49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b62db20>, '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.DKXTWa8R5r/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.eg57aZURwn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 09:26:22 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 09:26:22 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 09:26:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DKXTWa8R5r/Render', 09:26:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:22 INFO - 'HOME': '/Users/cltbld', 09:26:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:22 INFO - 'LOGNAME': 'cltbld', 09:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:22 INFO - 'MOZ_NO_REMOTE': '1', 09:26:22 INFO - 'NO_EM_RESTART': '1', 09:26:22 INFO - 'PAGER': '/bin/cat', 09:26:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:22 INFO - 'PWD': '/builds/slave/test', 09:26:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:22 INFO - 'SHELL': '/bin/bash', 09:26:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eg57aZURwn/Listeners', 09:26:22 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 09:26:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:22 INFO - 'USER': 'cltbld', 09:26:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:22 INFO - 'XPC_FLAGS': '0x0', 09:26:22 INFO - 'XPC_SERVICE_NAME': '0', 09:26:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:26:25 INFO - Installing collected packages: mozsystemmonitor 09:26:25 INFO - Running setup.py install for mozsystemmonitor 09:26:25 INFO - Successfully installed mozsystemmonitor 09:26:25 INFO - Cleaning up... 09:26:25 INFO - Return code: 0 09:26:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:25 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 0x10b792a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9efb599e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b636d30>, '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 0x10b49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b62db20>, '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.DKXTWa8R5r/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.eg57aZURwn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 09:26:25 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 09:26:25 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 09:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DKXTWa8R5r/Render', 09:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:25 INFO - 'HOME': '/Users/cltbld', 09:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:25 INFO - 'LOGNAME': 'cltbld', 09:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:25 INFO - 'MOZ_NO_REMOTE': '1', 09:26:25 INFO - 'NO_EM_RESTART': '1', 09:26:25 INFO - 'PAGER': '/bin/cat', 09:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:25 INFO - 'PWD': '/builds/slave/test', 09:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:25 INFO - 'SHELL': '/bin/bash', 09:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eg57aZURwn/Listeners', 09:26:25 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 09:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:25 INFO - 'USER': 'cltbld', 09:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:25 INFO - 'XPC_FLAGS': '0x0', 09:26:25 INFO - 'XPC_SERVICE_NAME': '0', 09:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:25 INFO - Downloading/unpacking blobuploader==1.2.4 09:26:25 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 09:26:25 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 09:26:25 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 09:26:25 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 09:26:25 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 09:26:25 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 09:26:28 INFO - Downloading blobuploader-1.2.4.tar.gz 09:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:26:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:26:28 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 09:26:28 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 09:26:28 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 09:26:28 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 09:26:28 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 09:26:28 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 09:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:26:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:26:28 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 09:26:28 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 09:26:28 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 09:26:28 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 09:26:28 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 09:26:28 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 09:26:29 INFO - Downloading docopt-0.6.1.tar.gz 09:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:26:29 INFO - Installing collected packages: blobuploader, requests, docopt 09:26:29 INFO - Running setup.py install for blobuploader 09:26:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:26:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:26:29 INFO - Running setup.py install for requests 09:26:30 INFO - Running setup.py install for docopt 09:26:30 INFO - Successfully installed blobuploader requests docopt 09:26:30 INFO - Cleaning up... 09:26:30 INFO - Return code: 0 09:26:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:30 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 0x10b792a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9efb599e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b636d30>, '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 0x10b49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b62db20>, '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.DKXTWa8R5r/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.eg57aZURwn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 09:26:30 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 09:26:30 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 09:26:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DKXTWa8R5r/Render', 09:26:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:30 INFO - 'HOME': '/Users/cltbld', 09:26:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:30 INFO - 'LOGNAME': 'cltbld', 09:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:30 INFO - 'MOZ_NO_REMOTE': '1', 09:26:30 INFO - 'NO_EM_RESTART': '1', 09:26:30 INFO - 'PAGER': '/bin/cat', 09:26:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:30 INFO - 'PWD': '/builds/slave/test', 09:26:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:30 INFO - 'SHELL': '/bin/bash', 09:26:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eg57aZURwn/Listeners', 09:26:30 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 09:26:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:30 INFO - 'USER': 'cltbld', 09:26:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:30 INFO - 'XPC_FLAGS': '0x0', 09:26:30 INFO - 'XPC_SERVICE_NAME': '0', 09:26:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:30 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-s2GkHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:30 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-m395b0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:30 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-T90nem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:30 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-hIKlVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:30 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-pBkSxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:31 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-eS4NG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:31 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-rM1hIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:31 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-d60Bd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:31 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-gYSH7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:31 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-obqQwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:31 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-HeXsC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:31 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-Pec_OA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:31 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-qbIorz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:31 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-cB8OoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:31 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-Nb7s5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:32 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-fWZe5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:32 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-nSvBVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:26:32 INFO - Running setup.py install for manifestparser 09:26:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:26:32 INFO - Running setup.py install for mozcrash 09:26:32 INFO - Running setup.py install for mozdebug 09:26:32 INFO - Running setup.py install for mozdevice 09:26:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:26:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:26:32 INFO - Running setup.py install for mozfile 09:26:32 INFO - Running setup.py install for mozhttpd 09:26:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:26:33 INFO - Running setup.py install for mozinfo 09:26:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:26:33 INFO - Running setup.py install for mozInstall 09:26:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:26:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:26:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:26:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:26:33 INFO - Running setup.py install for mozleak 09:26:33 INFO - Running setup.py install for mozlog 09:26:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:26:33 INFO - Running setup.py install for moznetwork 09:26:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:26:33 INFO - Running setup.py install for mozprocess 09:26:34 INFO - Running setup.py install for mozprofile 09:26:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:26:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:26:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:26:34 INFO - Running setup.py install for mozrunner 09:26:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:26:34 INFO - Running setup.py install for mozscreenshot 09:26:34 INFO - Running setup.py install for moztest 09:26:34 INFO - Running setup.py install for mozversion 09:26:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:26:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:26:34 INFO - Cleaning up... 09:26:34 INFO - Return code: 0 09:26:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:34 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 0x10b792a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9efb599e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b636d30>, '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 0x10b49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b62db20>, '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.DKXTWa8R5r/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.eg57aZURwn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 09:26:34 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 09:26:34 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 09:26:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DKXTWa8R5r/Render', 09:26:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:34 INFO - 'HOME': '/Users/cltbld', 09:26:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:34 INFO - 'LOGNAME': 'cltbld', 09:26:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:34 INFO - 'MOZ_NO_REMOTE': '1', 09:26:34 INFO - 'NO_EM_RESTART': '1', 09:26:34 INFO - 'PAGER': '/bin/cat', 09:26:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:34 INFO - 'PWD': '/builds/slave/test', 09:26:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:34 INFO - 'SHELL': '/bin/bash', 09:26:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eg57aZURwn/Listeners', 09:26:34 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 09:26:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:34 INFO - 'USER': 'cltbld', 09:26:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:34 INFO - 'XPC_FLAGS': '0x0', 09:26:34 INFO - 'XPC_SERVICE_NAME': '0', 09:26:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:26:35 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-IgP8KO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:26:35 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)) 09:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:26:35 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-GZxi3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:26:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 09:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:26:35 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-WPFbmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:26:35 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)) 09:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:26:35 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-ZjOtHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:26:35 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)) 09:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:26:35 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-_oCgH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:26:35 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)) 09:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:26:35 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-GTYJTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:26:35 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)) 09:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:26:35 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-2zX0l0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:26:35 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)) 09:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:26:35 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-kZFmy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:26:35 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)) 09:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:26:35 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-XXTQgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:26:36 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)) 09:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:26:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-EoE2oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:26:36 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)) 09:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:26:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-Srp3oF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:26:36 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)) 09:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:26:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-fAwBA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:26:36 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)) 09:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:26:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-H3vyvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:26:36 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)) 09:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:26:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-OYIWiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:26:36 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)) 09:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-wruWc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:26:36 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)) 09:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:26:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-VX3ACe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:26:36 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)) 09:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:26:36 INFO - Running setup.py (path:/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/pip-sPXVKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:26:36 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)) 09:26:36 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:36 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:26:36 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)) 09:26:36 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)) 09:26:36 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)) 09:26:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:39 INFO - Downloading blessings-1.6.tar.gz 09:26:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:26:39 INFO - Installing collected packages: blessings 09:26:39 INFO - Running setup.py install for blessings 09:26:39 INFO - Successfully installed blessings 09:26:39 INFO - Cleaning up... 09:26:39 INFO - Return code: 0 09:26:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:26:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:26:39 INFO - Reading from file tmpfile_stdout 09:26:39 INFO - Current package versions: 09:26:39 INFO - blessings == 1.6 09:26:39 INFO - blobuploader == 1.2.4 09:26:39 INFO - docopt == 0.6.1 09:26:39 INFO - manifestparser == 1.1 09:26:39 INFO - mozInstall == 1.12 09:26:39 INFO - mozcrash == 0.17 09:26:39 INFO - mozdebug == 0.1 09:26:39 INFO - mozdevice == 0.48 09:26:39 INFO - mozfile == 1.2 09:26:39 INFO - mozhttpd == 0.7 09:26:39 INFO - mozinfo == 0.9 09:26:39 INFO - mozleak == 0.1 09:26:39 INFO - mozlog == 3.1 09:26:39 INFO - moznetwork == 0.27 09:26:39 INFO - mozprocess == 0.22 09:26:39 INFO - mozprofile == 0.28 09:26:39 INFO - mozrunner == 6.11 09:26:39 INFO - mozscreenshot == 0.1 09:26:39 INFO - mozsystemmonitor == 0.0 09:26:39 INFO - moztest == 0.7 09:26:39 INFO - mozversion == 1.4 09:26:39 INFO - psutil == 3.1.1 09:26:39 INFO - requests == 1.2.3 09:26:39 INFO - wsgiref == 0.1.2 09:26:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:39 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 0x10b792a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9efb599e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b636d30>, '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 0x10b49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b62db20>, '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.DKXTWa8R5r/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.eg57aZURwn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 09:26:39 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 09:26:39 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 09:26:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DKXTWa8R5r/Render', 09:26:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:39 INFO - 'HOME': '/Users/cltbld', 09:26:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:39 INFO - 'LOGNAME': 'cltbld', 09:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:39 INFO - 'MOZ_NO_REMOTE': '1', 09:26:39 INFO - 'NO_EM_RESTART': '1', 09:26:39 INFO - 'PAGER': '/bin/cat', 09:26:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:39 INFO - 'PWD': '/builds/slave/test', 09:26:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:39 INFO - 'SHELL': '/bin/bash', 09:26:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eg57aZURwn/Listeners', 09:26:39 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 09:26:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:39 INFO - 'USER': 'cltbld', 09:26:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:39 INFO - 'XPC_FLAGS': '0x0', 09:26:39 INFO - 'XPC_SERVICE_NAME': '0', 09:26:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:40 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)) 09:26:40 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)) 09:26:40 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)) 09:26:40 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)) 09:26:40 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)) 09:26:40 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)) 09:26:40 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)) 09:26:40 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)) 09:26:40 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)) 09:26:40 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)) 09:26:40 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)) 09:26:40 INFO - Cleaning up... 09:26:40 INFO - Return code: 0 09:26:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:26: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')]} 09:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26: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')]} 09:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:40 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 0x10b792a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9efb599e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b636d30>, '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 0x10b49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b62db20>, '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.DKXTWa8R5r/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.eg57aZURwn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 09:26:40 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 09:26:40 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 09:26:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DKXTWa8R5r/Render', 09:26:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:40 INFO - 'HOME': '/Users/cltbld', 09:26:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:40 INFO - 'LOGNAME': 'cltbld', 09:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:40 INFO - 'MOZ_NO_REMOTE': '1', 09:26:40 INFO - 'NO_EM_RESTART': '1', 09:26:40 INFO - 'PAGER': '/bin/cat', 09:26:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:40 INFO - 'PWD': '/builds/slave/test', 09:26:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:40 INFO - 'SHELL': '/bin/bash', 09:26:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eg57aZURwn/Listeners', 09:26:40 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 09:26:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:40 INFO - 'USER': 'cltbld', 09:26:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:40 INFO - 'XPC_FLAGS': '0x0', 09:26:40 INFO - 'XPC_SERVICE_NAME': '0', 09:26:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:40 INFO - Downloading/unpacking jsonschema 09:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:26:42 INFO - Downloading/unpacking functools32 (from jsonschema) 09:26:42 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 09:26:42 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 09:26:42 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 09:26:42 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 09:26:42 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 09:26:42 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 09:26:43 INFO - Downloading functools32-3.2.3-2.tar.gz 09:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:26:43 INFO - warning: no files found matching '*.txt' 09:26:43 INFO - no previously-included directories found matching 'build' 09:26:43 INFO - no previously-included directories found matching 'dist' 09:26:43 INFO - no previously-included directories found matching '.git*' 09:26:43 INFO - Installing collected packages: jsonschema, functools32 09:26:43 INFO - Running setup.py install for functools32 09:26:43 INFO - warning: no files found matching '*.txt' 09:26:43 INFO - no previously-included directories found matching 'build' 09:26:43 INFO - no previously-included directories found matching 'dist' 09:26:43 INFO - no previously-included directories found matching '.git*' 09:26:43 INFO - Successfully installed jsonschema functools32 09:26:43 INFO - Cleaning up... 09:26:43 INFO - Return code: 0 09:26:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:26:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b792a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b7994c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9efb599e10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b636d30>, '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 0x10b49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b62db20>, '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.DKXTWa8R5r/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.eg57aZURwn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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 09:26:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:26:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DKXTWa8R5r/Render', 09:26:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:26:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:26:43 INFO - 'HOME': '/Users/cltbld', 09:26:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:26:43 INFO - 'LOGNAME': 'cltbld', 09:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:26:43 INFO - 'MOZ_NO_REMOTE': '1', 09:26:43 INFO - 'NO_EM_RESTART': '1', 09:26:43 INFO - 'PAGER': '/bin/cat', 09:26:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:26:43 INFO - 'PWD': '/builds/slave/test', 09:26:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:26:43 INFO - 'SHELL': '/bin/bash', 09:26:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eg57aZURwn/Listeners', 09:26:43 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 09:26:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:26:43 INFO - 'USER': 'cltbld', 09:26:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:26:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:26:43 INFO - 'XPC_FLAGS': '0x0', 09:26:43 INFO - 'XPC_SERVICE_NAME': '0', 09:26:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:26:43 INFO - Downloading/unpacking flake8 09:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:26:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:26:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:26:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:26:47 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 09:26:47 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 09:26:47 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 09:26:47 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 09:26:47 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 09:26:47 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 09:26:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:26:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:26:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:26:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:26:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:26:47 INFO - no previously-included directories found matching 'docs/_build' 09:26:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:26:47 INFO - Running setup.py install for pep8 09:26:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:26:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:26:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:26:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:26:47 INFO - no previously-included directories found matching 'docs/_build' 09:26:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:26:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:26:47 INFO - Cleaning up... 09:26:47 INFO - Return code: 0 09:26:47 INFO - Running post-action listener: _resource_record_post_action 09:26:47 INFO - Running post-action listener: _start_resource_monitoring 09:26:47 INFO - Starting resource monitoring. 09:26:47 INFO - ##### 09:26:47 INFO - ##### Running install step. 09:26:47 INFO - ##### 09:26:47 INFO - Running pre-action listener: _resource_record_pre_action 09:26:47 INFO - Running main action method: install 09:26:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:26:48 INFO - Reading from file tmpfile_stdout 09:26:48 INFO - Detecting whether we're running mozinstall >=1.0... 09:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:26:48 INFO - Reading from file tmpfile_stdout 09:26:48 INFO - Output received: 09:26:48 INFO - Usage: mozinstall [options] installer 09:26:48 INFO - Options: 09:26:48 INFO - -h, --help show this help message and exit 09:26:48 INFO - -d DEST, --destination=DEST 09:26:48 INFO - Directory to install application into. [default: 09:26:48 INFO - "/builds/slave/test"] 09:26:48 INFO - --app=APP Application being installed. [default: firefox] 09:26:48 INFO - mkdir: /builds/slave/test/build/application 09:26:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:27:19 INFO - Reading from file tmpfile_stdout 09:27:19 INFO - Output received: 09:27:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:27:19 INFO - Running post-action listener: _resource_record_post_action 09:27:19 INFO - ##### 09:27:19 INFO - ##### Running run-tests step. 09:27:19 INFO - ##### 09:27:19 INFO - Running pre-action listener: _resource_record_pre_action 09:27:19 INFO - Running main action method: run_tests 09:27:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:27:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:27:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:27:20 INFO - 2016-04-13 09:27:20.002 screenresolution[1645:7580] starting screenresolution argv=screenresolution get 09:27:20 INFO - 2016-04-13 09:27:20.004 screenresolution[1645:7580] Display 0: 1600x1200x32@60 09:27:20 INFO - 2016-04-13 09:27:20.010 screenresolution[1646:7582] starting screenresolution argv=screenresolution list 09:27:20 INFO - Available Modes on Display 0 09:27:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:27:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:27:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:27:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:27:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:27:20 INFO - Intel Iris: 09:27:20 INFO - Chipset Model: Intel Iris 09:27:20 INFO - Type: GPU 09:27:20 INFO - Bus: Built-In 09:27:20 INFO - VRAM (Dynamic, Max): 1536 MB 09:27:20 INFO - Vendor: Intel (0x8086) 09:27:20 INFO - Device ID: 0x0a2e 09:27:20 INFO - Revision ID: 0x0009 09:27:20 INFO - Displays: 09:27:20 INFO - Display: 09:27:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:27:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:27:20 INFO - Display Serial Number: 1600x1200 60 09:27:20 INFO - Main Display: Yes 09:27:20 INFO - Mirror: Off 09:27:20 INFO - Online: Yes 09:27:20 INFO - Rotation: Supported 09:27:20 INFO - Return code: 0 09:27:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:27:20 INFO - Python 2.7.3 09:27:20 INFO - Return code: 0 09:27:20 INFO - grabbing minidump binary from tooltool 09:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:27:20 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 0x10b636d30>, '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 0x10b49adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b62db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:27:20 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 09:27:20 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 09:27:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:27:20 INFO - Return code: 0 09:27:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:27:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:27:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:27:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:27:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:27:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:27:21 INFO - Return code: 0 09:27:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0044', '--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 09:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0044 --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 09:27:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DKXTWa8R5r/Render', 09:27:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:27:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:27:21 INFO - 'HOME': '/Users/cltbld', 09:27:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:27:21 INFO - 'LOGNAME': 'cltbld', 09:27:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:27:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:27:21 INFO - 'MOZ_NO_REMOTE': '1', 09:27:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:27:21 INFO - 'NO_EM_RESTART': '1', 09:27:21 INFO - 'PAGER': '/bin/cat', 09:27:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:27:21 INFO - 'PWD': '/builds/slave/test', 09:27:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:27:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:27:21 INFO - 'SHELL': '/bin/bash', 09:27:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eg57aZURwn/Listeners', 09:27:21 INFO - 'TMPDIR': '/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/', 09:27:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:27:21 INFO - 'USER': 'cltbld', 09:27:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:27:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:27:21 INFO - 'XPC_FLAGS': '0x0', 09:27:21 INFO - 'XPC_SERVICE_NAME': '0', 09:27:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:27:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0044', '--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 09:27:21 INFO - mozversion application_buildid: 20160413073852 09:27:21 INFO - mozversion application_changeset: 0b38f4474a28f269761d16ec80fec219db3697e3 09:27:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:27:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:27:21 INFO - mozversion application_name: Firefox 09:27:21 INFO - mozversion application_remotingname: firefox-dev 09:27:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:27:21 INFO - mozversion application_vendor: Mozilla 09:27:21 INFO - mozversion application_version: 47.0a2 09:27:21 INFO - mozversion platform_buildid: 20160413073852 09:27:21 INFO - mozversion platform_changeset: 0b38f4474a28f269761d16ec80fec219db3697e3 09:27:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:27:21 INFO - mozversion platform_version: 47.0a2 09:27:21 INFO - using testdate: 1460564841 09:27:21 INFO - actual date: 1460564841 09:27:21 INFO - starting webserver on 'localhost:49277' 09:27:21 INFO - SUITE-START | Running 2 tests 09:27:21 INFO - TEST-START | dromaeo_css 09:27:21 INFO - operating with platform_type : mac_ 09:27:21 INFO - Initialising browser for dromaeo_css test... 09:27:21 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmp9Tk2zb/profile http://localhost:49277/getInfo.html) 09:27:24 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 09:27:24 INFO - PROCESS | 1664 | colorDepth:24 09:27:24 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 09:27:24 INFO - PROCESS | 1664 | __metrics 09:27:24 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:27:25 INFO - TEST-INFO | 1664: exit 0 09:27:25 INFO - Browser initialized. 09:27:25 INFO - Running cycle 1/1 for dromaeo_css test... 09:27:25 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmp9Tk2zb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:27:37 INFO - PROCESS | 1667 | RSS: Main: 217690112 09:27:37 INFO - PROCESS | 1667 | 09:28:26 INFO - PROCESS | 1667 | 1460564906858 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] 09:30:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 09:30:39 INFO - PROCESS | 1667 | RSS: Main: 229638144 09:30:39 INFO - PROCESS | 1667 | 09:33:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 09:33:42 INFO - PROCESS | 1667 | RSS: Main: 241430528 09:33:42 INFO - PROCESS | 1667 | 09:36:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 09:36:44 INFO - PROCESS | 1667 | RSS: Main: 244355072 09:36:44 INFO - PROCESS | 1667 | 09:39:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 09:39:46 INFO - PROCESS | 1667 | RSS: Main: 245006336 09:39:46 INFO - PROCESS | 1667 | 09:42:49 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 09:42:50 INFO - PROCESS | 1667 | RSS: Main: 247762944 09:42:50 INFO - PROCESS | 1667 | 09:45:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 09:45:52 INFO - PROCESS | 1667 | RSS: Main: 249307136 09:45:52 INFO - PROCESS | 1667 | 09:45:52 INFO - PROCESS | 1667 | __start_tp_report 09:45:52 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 09:45:52 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 09:45:52 INFO - PROCESS | 1667 | |i|pagename|runs| 09:45:52 INFO - PROCESS | 1667 | |0;dojo.html;3024.3195281061758;3500.5274287971124;3559.7686150400236;3562.394392953198;3590.38963376226;5863.442972917572;5869.8239052828485;5878.353381128072;5882.764689412424;5882.882342353156;5866.76532938682;5926.318473375563;5930.347661757203;5949.791757288495;5950.9107363389585;5326.786928522854;5349.598780091489;5404.91892621611;5420.7018613976215;5466.289382380285;5299.072662284085;5437.755301011444;5443.918341224885;5455;5463.262459567967;5303.071962406563;5401.973625011255;5412.2152287918225;5419.864503387407;5421.593380496479;3846.884403522975;5094.999999999982;5412.4587541245955;5421.213923981;5429.914017196576;5280.445553216934;5327.653702509325;5336.785234127832;5356.143017117242;5446.618736688433;4483.3947417098925;5632.746526406321;5698.202251684767;5751.22358481608;6003.429674180989;6206.2862770781485;6211.689415529206;6212.316645169028;6218.875622487525;6236.376362363772;5240.371155461331;6229.688515574248;6297.685115744194;6301.905471417932;6313.053042043684;5856.736446859902;5978.820635380902;6057.515398768088;6062.090686397031;6109.755609775648;6391.07329437229;6433.420992110732;6438.420542151229;6439.8068057958335;6457.5479716419395;6267.561270711098;6273.96863015682;6294.213223347082;6302.590331628429;6315.084312774622;6160.907586386208;6228.34602366754;6290.276618188876;6324.873502529924;6332.873342533216;6228.22147231596;6232.407921247474;6276.874462510724;6278.717457714322;6309.747610095636;6146.877062458726;6214.658193799384;6274.466670332981;6285.402886725754;6296.055591661196;4944.060628480577;5023.49765023502;5027.120253955543;5027.396712394536;5064.49355064498;4458.264386376277;4492.797824097924;4523.932141017887;4530.886727831765;4531.954680453219;5751.539876809845;5884;5899.646021238739;5954.345022047572;5976.9402305977255;6194.225721784777;6233.189685340877;6273.247210334789;6298.527610429236;6337.841553961096;4891.217405215149;5022.522860328263;5216.21756736485;5597.608167428322;5933.3769954154195;4689.953100468952;5400.108982017923;5495.477929596682;5500.697461639568;5567.554595632339;6410.711517981609;6472.061551075162;6493.902591461037;6499.2200935887995;6510.3489651034515;5425.891482170414;6200.149737958573;6304.779332723333;6326.082718005771;6328;6273.686315684289;6398.232212134573;6517.859374609519;6534.869302613826;6553.934460655332;5040.949590504195;6225.719842607185;6261.154744109669;6266.310705822265;6278.246610406781;6241.843953901189;6267.435930766253;6276.027215781562;6276.246850377984;6282.968585157045;4989.55094041538;6072.301685306246;6136.917362303726;6223.875522489616;6240.157578726814;6190.597611155261;6221.875562488634;6223.688815559294;6225.097360882556;6236.937630623635;5959.523238140851;6004.1294012368835;6129.632222066691;6134;6157.84605384869;6055.2733671957885;6059.727312271047;6137.8366772191985;6204.875902482016;6225.408586184305;6111.297200821962;6163.84590385244;6181.690915454299;6193;6197.287311959182 09:45:52 INFO - PROCESS | 1667 | |1;ext.html;453.1910539686658;577.517772659829;618.0667192539264;675.4393853101926;678.9035707332656;30880.845595772018;38955.61044389555;39064.21871562567;39631.80184099075;39666.603333966654;36478.63521364785;41681.166376672445;41713.95715107124;41830.58169418305;41841.74474765754;9503.667371641994;9813.852792208123;9847;9854.310198286123;9855;9707.077827606367;9811.264155188353;9828.36115652484;9829.4102353859;9880.703578892644;9786.657466988658;9857.753556161082;9870.753231169243;9875;9922.206223502139;9761.023897610254;9837.754056148618;9848.409095454224;9852.852207216825;9897.802043959116;9633.421994680271;9723.124918757347;9748.366356186825;9766.511674416251;9775.853362199572;34606;40691.7965410171;40770.59229407727;40937.38593921094;41327;3049.252933031399;3198.616166060064;3384.813835239061;3538.929221415557;3983.4821473208585;27416.588751168747;29416.705832941825;29542.113736587937;29863.70136298631;29890.85054574735;2745.8764355604044;2749.766269867064;2767.0868613357543;2793.0922450203766;2823;444372;447160;447418;448086;449031;68689.65655171692;69191.65404173048;69319;69648.6517567419;69703.30296696968;78346.60826695945;78710.6064469674;79377.60311198523;79576;79719.60140199262;18067.45797626073;18193.545161371072;18272;18291;18291.085445727662;13432.395542200624;13573.524926627719;13661.658458538417;13664.863351366359;13673.17960922328;22634.868256587106;23155.768442315697;23213.071477141064;23400;23909.402264943168;9320.627174913063;9497.952510237405;9576.712698619052;9615.90384096164;9642.469664168399;956.4022485946283;981.3670182732097;986.5609803637312;1080.8540846985557;1115.1803424482998;25356.112536061148;30412.84793576018;30746.692533074383;31349.373012540076;31448.899288524794;1074.4520294649785;1090.465671820802;1129.6215767717742;1198.4127777389017;1214.1908556251121;15215.61960950963;15821.050736955589;16008.519744407686;16087.517374478784;16396.75404868928;540890;542235;542614;542633;546672;63297.68351158307;63327.733445330836;63488.68255658692;63680.68159659265;63773;1470.0958910270108;1514.5456363091248;1516.6208447888027;1521.1025494958028;1533.2257210108824;30594.08217753471;30949.535756964113;30954.380912382076;31548.369032619677;31750.364992699553;55418.44581554133;55764.88470230654;55885;56014;56051.15923261073;470194;509503;510688;511428;514198;34597.01300054054;35490.93527194188;36392.27215455729;36445.27109457743;36576.81711591425;47570;47816.521834781204;48035;48980.51019489902;49949;39450;39805.203895922496;39847.203055939295;40103;40929;38187.854364369116;38655.61344386633;39054.60945390623;39366.40950385689;39772.80681579557;33492.33015339631;39366;40441.79779101203;40622.59377406188;41382.1723565533;32508;33902.43415403607;34127.488087678204;34327.141821454665;34506.65493345034;26007.60988585135;26074.43553386803;26332;27722.722772772013;28187.577186341812 09:45:52 INFO - PROCESS | 1667 | |2;jquery.html;377.658219311523;378.1397321094511;382.2794033247328;385.8649472684559;388.5046565628823;16473;21062.684059739116;21088.683669744947;22020.779792202073;22050.88974555129;20722.585548289026;21151.365459036217;21781;21891.452713682167;22129.66805497915;5919.023361145406;5952.404759524056;6166.537509686769;6181;6193.225846769154;5927.407259274081;5957.434043765836;5997.130416089664;6029.336772954972;6053.939460605404;5946.910796338058;5965.075413310944;5976.462118409342;5986.940130598682;6910.723571057177;6310.305866354697;6988.93011069893;7150.964245178767;7174.139103307584;7228.855422891539;6345.111684364193;7092.290770922918;7270.727622666065;7287.089113860768;7293.452991025694;22642.547149056925;27092.322691932663;27576.448471030468;28137.155885323475;28325;2293.5183611441616;2294.070901284982;2303.6544518322216;2328.8602683838853;2497.5254701606636;12800.61598152057;15057.795376369864;15932;16311.184440778032;16605.83394166067;1488.3228131200385;1833.0834582708646;1833.1769075623524;1920.9711854322197;1922.1350392323511;110411.44794276057;112546;112928.87071129266;126175;127166.3641681795;19612.54843144607;20655;20778;20865.89567052155;20893.955302235132;29903.850480747456;30226.54660180099;30653.69346306553;30723.69276307253;31284.843575781975;9566.378185417925;11289.15331350152;11579;11587.899149580944;11591.130665200144;8002.679892804339;9862.45756483386;9894.307398482037;10017.198624110053;10102.343347682525;9053.864192037125;9215.723528294162;9337.533123343806;9341.346105772667;9352.111549402796;2978.851057447119;3205.326881354895;3413.675700808419;3592.1558433768046;3668.9082772930356;875.1685898396548;950.7337945375306;1083.967480975572;1102.1403305421784;1102.9448527573588;20473.07871145802;21557.245496407864;21690;21715.34853954384;22081.889590552266;1001.3541265883464;1002.904724051214;1008.5007921079113;1010.2372708604956;1073.2755390111643;11403.42982850854;11735.765284694258;11772.470238839102;11814.173007889538;11948.163628545919;602173;638161;647009;663439;665487;118382;127087;128034.35982820026;129473;131244;937.3813283233034;998.5306905754284;1034.7361422837128;1046.053321743823;1050.5062620568322;15125.016873903161;18434.33081880391;18955.957422341904;19150.808491914904;19481.415557533295;36388.81805591061;50404.74797625988;50648;51117;51642.741786290826;70964.09697466689;73372;74812.62593686997;75031.62484187544;76045.47909041677;7653.272939070779;8126.715564955198;8412;8429.494230345954;8592.398532102692;9566.952165239129;12803.743925121631;13275;13681.179129252278;13797.448102075805;11341;11545.711357216136;11856.407179641155;11873.287602743863;12128.939355303168;11394.03150732197;11435.656930292105;11728.003119734918;11763.529458821893;11952.58165964187;11566.016888564567;11703.414829258332;12093.274403535816;12149.81775273354;12238.571649992207;8049.758507244792;8275.420720549504;8396.748097556838;8497.107803680525;8528.658853645784;8761.649534018568;11329.71675708114;11989.460474278852;12018.939905300418;12184.390780460764 09:45:52 INFO - PROCESS | 1667 | |3;mootools.html;1479.1347061968747;1498.8725958293544;1560.1731082526262;2004.729361536192;2011.4569066352094;8358.414910956235;8988.595513201904;9251.213646840019;9497.667581634636;9513.904860951397;7641.923580764191;8415.242628163463;8686.739397818075;9178.495182764946;9218.677346292881;2100.789921007902;2216.9247914761327;2483.627455881623;2543.7710606045453;2544.605586134143;2511.573032584456;2542.1610868413472;2561.308446719385;2562.5643640581147;2572.536943350196;2183.9890800545977;2474.9110391427803;2568.4349443122483;2578.1105518596055;2587.79297656188;2537.5432422163913;2543.326018605071;2553.8850751716122;2570.6144078388206;2579.974200258011;2226.6882636430914;2560.219133164384;2583.8191326607143;2599.077327548731;2605.7263987281253;9422.387544809566;9458.243340532741;9494.192993595552;9519.190868776162;9528.190103841182;5608.327000759894;5722.7424765885635;5725.513331366838;5757.366689664133;5770.394108618577;3612.440071788877;3724.0689827543115;3734.0291524203903;3765.3410653135866;3767.773933563995;913.3515204205022;1055.6358056470583;1068.7456694365676;1078.336822853947;1092.7759809239167;10898.509567069501;11929.284242945365;12508.3745812709;12760.617181484571;12764.106512544126;4207;5021.347224860818;5072.898542029138;5106.617003724736;5121.462246464068;10686.786264274671;10744.623938162284;10782.46087695612;10818.513166907507;10835.458227088615;5720.513756330675;5727.398623144593;5789.1026890831145;5791.218185544897;5804.390538993345;4588.6099681526775;5017.498250174954;5055.646104772631;5113.590912726973;5208.791648334024;4171.541130475645;4176.644985176294;4185.9581404185565;4200.159968006411;4227.577242275748;1339.7990301454665;1341.1416693316285;1346.2662848747457;1367;1371.1019282370064;1173.2370268018692;1192.9164958452998;1193.7493126443544;1417.4471955937192;1453.7673972164403;7142.785716428515;8537;8673.132686731276;8736.257418119403;8770.649174033095;520.6485622205072;524.6747016849578;528.3791544934686;528.6827903258014;529.7986765029265;6439.678016099177;6450.419462248326;6454.354564543602;6505.967470162619;6513.2509761377105;11235.494402751896;11253.774924501628;11417.657470275904;11594.826077608843;11702.590409335633;10688.839667404995;11020.614278500214;11230.989210971053;11499.367534785668;11524.366159861289;8781.385303028854;8876.20114189726;8963.551822408854;8964.013958464564;8965.148310910454;8544.145585441405;8666.610002549774;8731.039585645447;8746.037935827182;8832.160944710242;10143.7464063399;10239.232057595562;10264.230182736175;10329.638462653771;10386.117180039479;10488.580456781643;10491.790164196826;10680.305780124267;10739.785204296026;10863.67408977732;7189.892151617834;7572.924270757222;7717.614119294125;7870.134285228734;7988.320992715684;8459.619317130868;8563.95718021406;8681.392302538761;8692.52191129494;8752.081031491602;7547.773566793005;7726.884096738441;7742.690292388242;7763.767086987399;7781.649825757741;7545.811354716176;7589.468737188344;7628.694852206072;7686.769396918102;7690.00029996097;8078.23256790604;8117.350611951148;8132.3494120471405;8138.755837324889;8168.224018718212;7236.782896513113;7351.338379545867;7354.1910389856;7380.483366164317;7387.889181662172;6176.81469555914;7423.369013633902;7487.588182650006;7497.362724168507;7523.322900938723 09:45:52 INFO - PROCESS | 1667 | |4;prototype.html;338.19509567229994;340.7103961632611;342.6248258157317;349.5368636556563;350.84562792371355;5691.3170419549715;6991.860162796747;6992.755253566126;7002.754903578376;7075.186353569328;6954.165500139978;6965;6977.162740471151;6991.126109236346;6997.09037825082;4897.3878265216845;4977.850664480072;5071.974640126813;5081.364829396325;5104.33643626329;3843.673287770543;5051.570616497602;5064.797408103672;5073.162928116856;5084.491550844905;5001.774920128585;5002.399712034561;5032.320636714052;5041.697498150104;5075.213341931988;3884.6309600587897;4321.848735294266;4349.28236840924;4959.578435832958;5139.511746384106;4388.517263101056;4390.868273951786;4391.231534481485;4404.5815647513755;4409.933850992237;6408.615483070984;6741.629210393427;6744.7976560703255;6769.221539522969;6788.8302792430095;5858.882822343572;5913.05391137416;5922.31893332268;5925.555583331225;5930;6072.362401947776;7461.253874612549;7474.813129671802;7484.625768711543;7484.775456736252;4735.1713450146435;4735.83424580138;4736.2895565665085;4743.407074115736;4744.952550474485;6484;7472.439567032494;7787.493812902143;7813.101493328283;7927.048754149481;3890.657723085531;4568.291914753218;4649.395578574764;4737.28940658904;4775.2359622460235;4869.099216644932;4878.780454879539;4884.731339776346;4886.776516684899;4897.844948222771;5910;5914.497267732291;5920.407959204045;5932.3474417814;5933.465988061095;6561.835954101186;7455.25447455261;7478.551286922802;7483.738069167553;7493.550386976799;1250.5373011985623;1405.4729476446332;1688.1981058996878;1701.4045084220672;1702.4381953955165;864.3906046237388;999.14073896449;1039.153090231459;1075.2634445404922;1077.849101125843;5653.434656534314;6757.695903684346;6887.724491020404;6890.379865812101;6925.272846351161;7699.11460182075;7732.574708391093;7736.4584479085925;7742.6902923883545;7770.0287464067;6001.969990150109;6556;6852.211995620468;6867.381935625718;6889.896651550231;3677.9080522987138;4084.71407001513;4102.446169767103;4103.528094269197;4107.342825148022;6500.219973603103;7818.569978651115;8102.149274326229;8217.219364160395;8229;7921;8012.0786109596975;8016.198380162054;8022.9197708022175;8104.149064348277;7401.629918504053;8166.714165004197;8185.71350002747;8206.153615436479;8217.424780265324;7632.694692212472;7763.805904852198;7898.3681305496575;7899.131095579367;7899.84200316002;7696.15342312334;7704;7708.730194443167;7734.265244801735;7734.806629834299;8141.633626486704;8147.83704325922;8155.306798922158;8182.509049457051;8185.918140818516;5017.67385119966;5081.644284900021;5083;5086.694798312114;5105.846824595268;7465.216152303929;7651.043619547557;7769;7793.922060779547;7815.101263354787;7488.7004519820775;7516.812079698051;7530.548167109991;7535.208803075818;7552.244775522404;6164.876702466016;7522.210167932289;7524.134724506533;7542.47202695806;7562.924370756222;7109.360157585842;7279.344858962719;7342.082239720035;7356.117265928123;7379.040724705754;7446.920196571575;7517.285857843496;7518.947347371482;7525.774226773206;7534.284242996907;7327.560346379234;7339.59632220233;7341.265873412616;7346.228645992094;7358.969744235705 09:45:52 INFO - PROCESS | 1667 | |5;yui.html;703.6657587645869;761.7143571160811;774.1755030892103;784.5880912520928;789.403999980015;15166.772498412518;15328.310226039826;15509.844901550981;15511.379544818208;15543.533693989184;13782.379792909318;13799.586012419644;13821.101628394172;13821.447142114303;13895.096818706777;816.5223344343536;947.8009617980232;955.0926619711267;981.7692842182081;986.1420564109235;951.9571619277115;960.13108137136;966.7631430299551;967.5162418790604;986.9802603947917;979.3829887171108;997.0976266478812;1002.9247806414512;1005.4821766790109;1018.9847152292722;950.1211379473959;957.3011701457974;963.5519483440199;972.222222222223;1010.1111022300365;754.6000619671582;762.6225018615766;763.9686423328518;765.4029856711774;767.0871662721344;15385.153816540085;15421.306041228172;15502.379904803794;15615.375384984587;15623.375064997386;11741.679076045006;12077;13051.934740326238;13108.541201058013;13262.270575118364;9828.852567211497;10205.132563732092;10309.793804123876;10450.581976720921;10636.57453701851;3577.964220357789;3584.5877724061806;3586.982065089684;3590.2460483298537;3666.156783939709;80536.3892722154;82531;82677;82985.58507207426;83138.75291870626;7963.800904977422;9765.609375625038;9874.60501579943;9896.752581185528;9912.65305714311;22031.559368812534;22909.312720618407;22912.083516659146;22933.770662293162;22976.966036528396;7134.2509036551455;7644.350230230492;7765.262300081483;7768.300852923151;7849.646765895434;4178.811953462102;4179;4179.728317659403;4249.383839343278;4347.739135651871;3743.756655817363;3756.511653485084;3786.261678972629;3802.448644946467;3807.4669546263544;614.0635530815542;672.7409947170374;678.4063944048958;679.6431873266574;680.9659517024129;542.9837104886859;598.5451057196475;609.9664518451439;618.137697911411;630.7949916277137;8080.83838323242;8320.66717331312;8490.448120872123;8612.956935215283;8681.826363472695;501.07801644973426;592.1177445606102;605.8152263559657;608.4189598933008;623.2054130982942;3892.785896775648;3908.902277443087;3917.4123881418013;3980.2536249987415;4073.579528469186;100711.48932766015;101017;101985.49007254916;102388;102430;85100;85354;85667;86242.56878715692;86959;74080;74477.5104497907;76158;76645.23354766493;77255.22744772593;7722.613869306625;7919.881201782093;7954.244346787046;7961.452116300745;7963.0046244219475;50640.74679626578;50664;50681.98636027185;51364.74317628388;52339;64879.35120648922;68568;68649.59726409552;69144.6542767283;69196.65401672959;10024;10206.925381453437;10269.229807764297;10294.485275736033;10298.536565854405;10737.463126843782;10775.6228532001;10823.891761082288;11036.006759391694;11696.181267311547;10471.162307015573;10495.842562361724;10502.159827213958;10878.782424351626;11012.229143959847;10412.791744165226;10566.788664226826;10702.357858528514;10783.137349012217;10888.67333979982;10249.12882405004;10345.948270258601;10410.427426491615;10431.791364172826;10655.786884262427;8476.872652646402;8774.912394613291;8842.734717958472;9010.86483702758;9022.323325750725;8802.38383313162;8928.429344366625;8990.86513702282;8997.64009439615;9049.321300902327 09:45:52 INFO - PROCESS | 1667 | __end_tp_report 09:45:52 INFO - PROCESS | 1667 | __start_cc_report 09:45:52 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,357 09:45:52 INFO - PROCESS | 1667 | __end_cc_report 09:45:52 INFO - PROCESS | 1667 | __startTimestamp1460565952295__endTimestamp 09:45:52 INFO - PROCESS | 1667 | 09:45:52 INFO - PROCESS | 1667 | ------- Summary: start ------- 09:45:52 INFO - PROCESS | 1667 | Number of tests: 6 09:45:52 INFO - PROCESS | 1667 | 09:45:52 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5799.39 Median:6072.30 stddev:675.42 (11.1%) stddev-sans-first:641.44 09:45:52 INFO - PROCESS | 1667 | Values: 3024.3 3500.5 3559.8 3562.4 3590.4 5863.4 5869.8 5878.4 5882.8 5882.9 5866.8 5926.3 5930.3 5949.8 5950.9 5326.8 5349.6 5404.9 5420.7 5466.3 5299.1 5437.8 5443.9 5455.0 5463.3 5303.1 5402.0 5412.2 5419.9 5421.6 3846.9 5095.0 5412.5 5421.2 5429.9 5280.4 5327.7 5336.8 5356.1 5446.6 4483.4 5632.7 5698.2 5751.2 6003.4 6206.3 6211.7 6212.3 6218.9 6236.4 5240.4 6229.7 6297.7 6301.9 6313.1 5856.7 5978.8 6057.5 6062.1 6109.8 6391.1 6433.4 6438.4 6439.8 6457.5 6267.6 6274.0 6294.2 6302.6 6315.1 6160.9 6228.3 6290.3 6324.9 6332.9 6228.2 6232.4 6276.9 6278.7 6309.7 6146.9 6214.7 6274.5 6285.4 6296.1 4944.1 5023.5 5027.1 5027.4 5064.5 4458.3 4492.8 4523.9 4530.9 4532.0 5751.5 5884.0 5899.6 5954.3 5976.9 6194.2 6233.2 6273.2 6298.5 6337.8 4891.2 5022.5 5216.2 5597.6 5933.4 4690.0 5400.1 5495.5 5500.7 5567.6 6410.7 6472.1 6493.9 6499.2 6510.3 5425.9 6200.1 6304.8 6326.1 6328.0 6273.7 6398.2 6517.9 6534.9 6553.9 5040.9 6225.7 6261.2 6266.3 6278.2 6241.8 6267.4 6276.0 6276.2 6283.0 4989.6 6072.3 6136.9 6223.9 6240.2 6190.6 6221.9 6223.7 6225.1 6236.9 5959.5 6004.1 6129.6 6134.0 6157.8 6055.3 6059.7 6137.8 6204.9 6225.4 6111.3 6163.8 6181.7 6193.0 6197.3 09:45:52 INFO - PROCESS | 1667 | 09:45:52 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:65908.75 Median:40532.20 stddev:132620.46 (327.2%) stddev-sans-first:132901.44 09:45:52 INFO - PROCESS | 1667 | Values: 453.2 577.5 618.1 675.4 678.9 30880.8 38955.6 39064.2 39631.8 39666.6 36478.6 41681.2 41714.0 41830.6 41841.7 9503.7 9813.9 9847.0 9854.3 9855.0 9707.1 9811.3 9828.4 9829.4 9880.7 9786.7 9857.8 9870.8 9875.0 9922.2 9761.0 9837.8 9848.4 9852.9 9897.8 9633.4 9723.1 9748.4 9766.5 9775.9 34606.0 40691.8 40770.6 40937.4 41327.0 3049.3 3198.6 3384.8 3538.9 3983.5 27416.6 29416.7 29542.1 29863.7 29890.9 2745.9 2749.8 2767.1 2793.1 2823.0 444372.0 447160.0 447418.0 448086.0 449031.0 68689.7 69191.7 69319.0 69648.7 69703.3 78346.6 78710.6 79377.6 79576.0 79719.6 18067.5 18193.5 18272.0 18291.0 18291.1 13432.4 13573.5 13661.7 13664.9 13673.2 22634.9 23155.8 23213.1 23400.0 23909.4 9320.6 9498.0 9576.7 9615.9 9642.5 956.4 981.4 986.6 1080.9 1115.2 25356.1 30412.8 30746.7 31349.4 31448.9 1074.5 1090.5 1129.6 1198.4 1214.2 15215.6 15821.1 16008.5 16087.5 16396.8 540890.0 542235.0 542614.0 542633.0 546672.0 63297.7 63327.7 63488.7 63680.7 63773.0 1470.1 1514.5 1516.6 1521.1 1533.2 30594.1 30949.5 30954.4 31548.4 31750.4 55418.4 55764.9 55885.0 56014.0 56051.2 470194.0 509503.0 510688.0 511428.0 514198.0 34597.0 35490.9 36392.3 36445.3 36576.8 47570.0 47816.5 48035.0 48980.5 49949.0 39450.0 39805.2 39847.2 40103.0 40929.0 38187.9 38655.6 39054.6 39366.4 39772.8 33492.3 39366.0 40441.8 40622.6 41382.2 32508.0 33902.4 34127.5 34327.1 34506.7 26007.6 26074.4 26332.0 27722.7 28187.6 09:45:52 INFO - PROCESS | 1667 | 09:45:52 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:37382.99 Median:12468.03 stddev:106675.19 (855.6%) stddev-sans-first:106938.25 09:45:52 INFO - PROCESS | 1667 | Values: 377.7 378.1 382.3 385.9 388.5 16473.0 21062.7 21088.7 22020.8 22050.9 20722.6 21151.4 21781.0 21891.5 22129.7 5919.0 5952.4 6166.5 6181.0 6193.2 5927.4 5957.4 5997.1 6029.3 6053.9 5946.9 5965.1 5976.5 5986.9 6910.7 6310.3 6988.9 7151.0 7174.1 7228.9 6345.1 7092.3 7270.7 7287.1 7293.5 22642.5 27092.3 27576.4 28137.2 28325.0 2293.5 2294.1 2303.7 2328.9 2497.5 12800.6 15057.8 15932.0 16311.2 16605.8 1488.3 1833.1 1833.2 1921.0 1922.1 110411.4 112546.0 112928.9 126175.0 127166.4 19612.5 20655.0 20778.0 20865.9 20894.0 29903.9 30226.5 30653.7 30723.7 31284.8 9566.4 11289.2 11579.0 11587.9 11591.1 8002.7 9862.5 9894.3 10017.2 10102.3 9053.9 9215.7 9337.5 9341.3 9352.1 2978.9 3205.3 3413.7 3592.2 3668.9 875.2 950.7 1084.0 1102.1 1102.9 20473.1 21557.2 21690.0 21715.3 22081.9 1001.4 1002.9 1008.5 1010.2 1073.3 11403.4 11735.8 11772.5 11814.2 11948.2 602173.0 638161.0 647009.0 663439.0 665487.0 118382.0 127087.0 128034.4 129473.0 131244.0 937.4 998.5 1034.7 1046.1 1050.5 15125.0 18434.3 18956.0 19150.8 19481.4 36388.8 50404.7 50648.0 51117.0 51642.7 70964.1 73372.0 74812.6 75031.6 76045.5 7653.3 8126.7 8412.0 8429.5 8592.4 9567.0 12803.7 13275.0 13681.2 13797.4 11341.0 11545.7 11856.4 11873.3 12128.9 11394.0 11435.7 11728.0 11763.5 11952.6 11566.0 11703.4 12093.3 12149.8 12238.6 8049.8 8275.4 8396.7 8497.1 8528.7 8761.6 11329.7 11989.5 12018.9 12184.4 09:45:52 INFO - PROCESS | 1667 | 09:45:52 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:6339.55 Median:5110.10 stddev:3416.99 (66.9%) stddev-sans-first:3407.04 09:45:52 INFO - PROCESS | 1667 | Values: 1479.1 1498.9 1560.2 2004.7 2011.5 8358.4 8988.6 9251.2 9497.7 9513.9 7641.9 8415.2 8686.7 9178.5 9218.7 2100.8 2216.9 2483.6 2543.8 2544.6 2511.6 2542.2 2561.3 2562.6 2572.5 2184.0 2474.9 2568.4 2578.1 2587.8 2537.5 2543.3 2553.9 2570.6 2580.0 2226.7 2560.2 2583.8 2599.1 2605.7 9422.4 9458.2 9494.2 9519.2 9528.2 5608.3 5722.7 5725.5 5757.4 5770.4 3612.4 3724.1 3734.0 3765.3 3767.8 913.4 1055.6 1068.7 1078.3 1092.8 10898.5 11929.3 12508.4 12760.6 12764.1 4207.0 5021.3 5072.9 5106.6 5121.5 10686.8 10744.6 10782.5 10818.5 10835.5 5720.5 5727.4 5789.1 5791.2 5804.4 4588.6 5017.5 5055.6 5113.6 5208.8 4171.5 4176.6 4186.0 4200.2 4227.6 1339.8 1341.1 1346.3 1367.0 1371.1 1173.2 1192.9 1193.7 1417.4 1453.8 7142.8 8537.0 8673.1 8736.3 8770.6 520.6 524.7 528.4 528.7 529.8 6439.7 6450.4 6454.4 6506.0 6513.3 11235.5 11253.8 11417.7 11594.8 11702.6 10688.8 11020.6 11231.0 11499.4 11524.4 8781.4 8876.2 8963.6 8964.0 8965.1 8544.1 8666.6 8731.0 8746.0 8832.2 10143.7 10239.2 10264.2 10329.6 10386.1 10488.6 10491.8 10680.3 10739.8 10863.7 7189.9 7572.9 7717.6 7870.1 7988.3 8459.6 8564.0 8681.4 8692.5 8752.1 7547.8 7726.9 7742.7 7763.8 7781.6 7545.8 7589.5 7628.7 7686.8 7690.0 8078.2 8117.4 8132.3 8138.8 8168.2 7236.8 7351.3 7354.2 7380.5 7387.9 6176.8 7423.4 7487.6 7497.4 7523.3 09:45:52 INFO - PROCESS | 1667 | 09:45:52 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:6037.04 Median:6888.81 stddev:2000.88 (29.0%) stddev-sans-first:1960.24 09:45:52 INFO - PROCESS | 1667 | Values: 338.2 340.7 342.6 349.5 350.8 5691.3 6991.9 6992.8 7002.8 7075.2 6954.2 6965.0 6977.2 6991.1 6997.1 4897.4 4977.9 5072.0 5081.4 5104.3 3843.7 5051.6 5064.8 5073.2 5084.5 5001.8 5002.4 5032.3 5041.7 5075.2 3884.6 4321.8 4349.3 4959.6 5139.5 4388.5 4390.9 4391.2 4404.6 4409.9 6408.6 6741.6 6744.8 6769.2 6788.8 5858.9 5913.1 5922.3 5925.6 5930.0 6072.4 7461.3 7474.8 7484.6 7484.8 4735.2 4735.8 4736.3 4743.4 4745.0 6484.0 7472.4 7787.5 7813.1 7927.0 3890.7 4568.3 4649.4 4737.3 4775.2 4869.1 4878.8 4884.7 4886.8 4897.8 5910.0 5914.5 5920.4 5932.3 5933.5 6561.8 7455.3 7478.6 7483.7 7493.6 1250.5 1405.5 1688.2 1701.4 1702.4 864.4 999.1 1039.2 1075.3 1077.8 5653.4 6757.7 6887.7 6890.4 6925.3 7699.1 7732.6 7736.5 7742.7 7770.0 6002.0 6556.0 6852.2 6867.4 6889.9 3677.9 4084.7 4102.4 4103.5 4107.3 6500.2 7818.6 8102.1 8217.2 8229.0 7921.0 8012.1 8016.2 8022.9 8104.1 7401.6 8166.7 8185.7 8206.2 8217.4 7632.7 7763.8 7898.4 7899.1 7899.8 7696.2 7704.0 7708.7 7734.3 7734.8 8141.6 8147.8 8155.3 8182.5 8185.9 5017.7 5081.6 5083.0 5086.7 5105.8 7465.2 7651.0 7769.0 7793.9 7815.1 7488.7 7516.8 7530.5 7535.2 7552.2 6164.9 7522.2 7524.1 7542.5 7562.9 7109.4 7279.3 7342.1 7356.1 7379.0 7446.9 7517.3 7518.9 7525.8 7534.3 7327.6 7339.6 7341.3 7346.2 7359.0 09:45:52 INFO - PROCESS | 1667 | 09:45:52 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18954.73 Median:595.33 stddev:27504.54 (4620.0%) stddev-sans-first:27547.56 09:45:52 INFO - PROCESS | 1667 | Values: 703.7 761.7 774.2 784.6 789.4 15166.8 15328.3 15509.8 15511.4 15543.5 13782.4 13799.6 13821.1 13821.4 13895.1 816.5 947.8 955.1 981.8 986.1 952.0 960.1 966.8 967.5 987.0 979.4 997.1 1002.9 1005.5 1019.0 950.1 957.3 963.6 972.2 1010.1 754.6 762.6 764.0 765.4 767.1 15385.2 15421.3 15502.4 15615.4 15623.4 11741.7 12077.0 13051.9 13108.5 13262.3 9828.9 10205.1 10309.8 10450.6 10636.6 3578.0 3584.6 3587.0 3590.2 3666.2 80536.4 82531.0 82677.0 82985.6 83138.8 7963.8 9765.6 9874.6 9896.8 9912.7 22031.6 22909.3 22912.1 22933.8 22977.0 7134.3 7644.4 7765.3 7768.3 7849.6 4178.8 4179.0 4179.7 4249.4 4347.7 3743.8 3756.5 3786.3 3802.4 3807.5 614.1 672.7 678.4 679.6 681.0 543.0 598.5 610.0 618.1 630.8 8080.8 8320.7 8490.4 8613.0 8681.8 501.1 592.1 605.8 608.4 623.2 3892.8 3908.9 3917.4 3980.3 4073.6 100711.5 101017.0 101985.5 102388.0 102430.0 85100.0 85354.0 85667.0 86242.6 86959.0 74080.0 74477.5 76158.0 76645.2 77255.2 7722.6 7919.9 7954.2 7961.5 7963.0 50640.7 50664.0 50682.0 51364.7 52339.0 64879.4 68568.0 68649.6 69144.7 69196.7 10024.0 10206.9 10269.2 10294.5 10298.5 10737.5 10775.6 10823.9 11036.0 11696.2 10471.2 10495.8 10502.2 10878.8 11012.2 10412.8 10566.8 10702.4 10783.1 10888.7 10249.1 10345.9 10410.4 10431.8 10655.8 8476.9 8774.9 8842.7 9010.9 9022.3 8802.4 8928.4 8990.9 8997.6 9049.3 09:45:52 INFO - PROCESS | 1667 | -------- Summary: end -------- 09:45:52 INFO - PROCESS | 1667 | 09:45:52 INFO - TEST-INFO | 1667: exit 0 09:45:52 INFO - TEST-OK | dromaeo_css | took 1111096ms 09:45:52 INFO - TEST-START | kraken 09:45:52 INFO - operating with platform_type : mac_ 09:45:52 INFO - Initialising browser for kraken test... 09:45:52 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmpLyCH42/profile http://localhost:49277/getInfo.html) 09:45:55 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 09:45:55 INFO - PROCESS | 1679 | colorDepth:24 09:45:55 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 09:45:55 INFO - PROCESS | 1679 | __metrics 09:45:55 ERROR - PROCESS | 1679 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:45:56 INFO - TEST-INFO | 1679: exit 0 09:45:56 INFO - Browser initialized. 09:45:56 INFO - Running cycle 1/1 for kraken test... 09:45:56 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/T/tmpLyCH42/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:46:08 INFO - PROCESS | 1682 | RSS: Main: 217767936 09:46:08 INFO - PROCESS | 1682 | 09:46:10 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 09:46:11 INFO - PROCESS | 1682 | RSS: Main: 230191104 09:46:11 INFO - PROCESS | 1682 | 09:46:14 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 09:46:14 INFO - PROCESS | 1682 | RSS: Main: 239198208 09:46:14 INFO - PROCESS | 1682 | 09:46:18 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 09:46:18 INFO - PROCESS | 1682 | RSS: Main: 243322880 09:46:18 INFO - PROCESS | 1682 | 09:46:20 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 09:46:21 INFO - PROCESS | 1682 | RSS: Main: 243159040 09:46:21 INFO - PROCESS | 1682 | 09:46:23 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:46:24 INFO - PROCESS | 1682 | RSS: Main: 243924992 09:46:24 INFO - PROCESS | 1682 | 09:46:26 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 09:46:27 INFO - PROCESS | 1682 | RSS: Main: 244858880 09:46:27 INFO - PROCESS | 1682 | 09:46:30 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 09:46:31 INFO - PROCESS | 1682 | RSS: Main: 245096448 09:46:31 INFO - PROCESS | 1682 | 09:46:34 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 09:46:34 INFO - PROCESS | 1682 | RSS: Main: 245190656 09:46:34 INFO - PROCESS | 1682 | 09:46:36 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:46:36 INFO - PROCESS | 1682 | RSS: Main: 244568064 09:46:36 INFO - PROCESS | 1682 | 09:46:38 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:46:39 INFO - PROCESS | 1682 | RSS: Main: 244543488 09:46:39 INFO - PROCESS | 1682 | 09:46:41 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:46:42 INFO - PROCESS | 1682 | RSS: Main: 245538816 09:46:42 INFO - PROCESS | 1682 | 09:46:44 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:46:45 INFO - PROCESS | 1682 | RSS: Main: 245157888 09:46:45 INFO - PROCESS | 1682 | 09:46:47 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:46:48 INFO - PROCESS | 1682 | RSS: Main: 245665792 09:46:48 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 09:46:50 INFO - PROCESS | 1682 | RSS: Main: 246964224 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | __start_tp_report 09:46:50 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 09:46:50 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 09:46:50 INFO - PROCESS | 1682 | |i|pagename|runs| 09:46:50 INFO - PROCESS | 1682 | |0;ai-astar;116;111;145;94;96;144;106;155;165;143 09:46:50 INFO - PROCESS | 1682 | |1;audio-beat-detection;145;137;176;155;117;139;119;149;151;119 09:46:50 INFO - PROCESS | 1682 | |2;audio-dft;192;197;194;195;191;196;198;198;225;203 09:46:50 INFO - PROCESS | 1682 | |3;audio-fft;77;100;107;160;61;57;71;58;117;56 09:46:50 INFO - PROCESS | 1682 | |4;audio-oscillator;87;82;112;63;82;112;160;121;84;115 09:46:50 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;137;126;88;86;90;86;88;85;123;131 09:46:50 INFO - PROCESS | 1682 | |6;imaging-darkroom;94;96;99;98;94;154;95;122;109;95 09:46:50 INFO - PROCESS | 1682 | |7;imaging-desaturate;115;150;95;95;113;110;146;148;95;145 09:46:50 INFO - PROCESS | 1682 | |8;json-parse-financial;54;61;60;58;59;60;60;69;57;55 09:46:50 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;63;62;69;66;67;71;66;65;64;67 09:46:50 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;82;84;83;84;80;82;74;100;70;114 09:46:50 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;132;141;110;138;136;114;98;132;113;138 09:46:50 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;126;136;136;135;133;142;152;189;172;125 09:46:50 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;65;67;68;68;68;86;100;106;80;66 09:46:50 INFO - PROCESS | 1682 | __end_tp_report 09:46:50 INFO - PROCESS | 1682 | __start_cc_report 09:46:50 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,910 09:46:50 INFO - PROCESS | 1682 | __end_cc_report 09:46:50 INFO - PROCESS | 1682 | __startTimestamp1460566010451__endTimestamp 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | ------- Summary: start ------- 09:46:50 INFO - PROCESS | 1682 | Number of tests: 14 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:127.50 Median:150.00 stddev:25.74 (17.2%) stddev-sans-first:26.96 09:46:50 INFO - PROCESS | 1682 | Values: 116.0 111.0 145.0 94.0 96.0 144.0 106.0 155.0 165.0 143.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:147.00 stddev:18.75 (12.8%) stddev-sans-first:19.82 09:46:50 INFO - PROCESS | 1682 | Values: 145.0 137.0 176.0 155.0 117.0 139.0 119.0 149.0 151.0 119.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:198.90 Median:197.50 stddev:9.78 (5.0%) stddev-sans-first:10.05 09:46:50 INFO - PROCESS | 1682 | Values: 192.0 197.0 194.0 195.0 191.0 196.0 198.0 198.0 225.0 203.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:86.40 Median:57.50 stddev:34.20 (59.5%) stddev-sans-first:36.11 09:46:50 INFO - PROCESS | 1682 | Values: 77.0 100.0 107.0 160.0 61.0 57.0 71.0 58.0 117.0 56.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:101.80 Median:72.50 stddev:27.82 (38.4%) stddev-sans-first:28.98 09:46:50 INFO - PROCESS | 1682 | Values: 87.0 82.0 112.0 63.0 82.0 112.0 160.0 121.0 84.0 115.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:104.00 Median:86.00 stddev:22.06 (25.7%) stddev-sans-first:19.91 09:46:50 INFO - PROCESS | 1682 | Values: 137.0 126.0 88.0 86.0 90.0 86.0 88.0 85.0 123.0 131.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:105.60 Median:95.00 stddev:19.18 (20.2%) stddev-sans-first:19.88 09:46:50 INFO - PROCESS | 1682 | Values: 94.0 96.0 99.0 98.0 94.0 154.0 95.0 122.0 109.0 95.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:121.20 Median:149.00 stddev:23.62 (15.8%) stddev-sans-first:24.94 09:46:50 INFO - PROCESS | 1682 | Values: 115.0 150.0 95.0 95.0 113.0 110.0 146.0 148.0 95.0 145.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:60.00 stddev:4.11 (6.9%) stddev-sans-first:3.89 09:46:50 INFO - PROCESS | 1682 | Values: 54.0 61.0 60.0 58.0 59.0 60.0 60.0 69.0 57.0 55.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.50 stddev:2.71 (4.1%) stddev-sans-first:2.65 09:46:50 INFO - PROCESS | 1682 | Values: 63.0 62.0 69.0 66.0 67.0 71.0 66.0 65.0 64.0 67.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:82.00 stddev:12.74 (15.5%) stddev-sans-first:13.45 09:46:50 INFO - PROCESS | 1682 | Values: 82.0 84.0 83.0 84.0 80.0 82.0 74.0 100.0 70.0 114.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:137.00 stddev:15.02 (11.0%) stddev-sans-first:15.73 09:46:50 INFO - PROCESS | 1682 | Values: 132.0 141.0 110.0 138.0 136.0 114.0 98.0 132.0 113.0 138.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.60 Median:139.00 stddev:20.79 (15.0%) stddev-sans-first:20.93 09:46:50 INFO - PROCESS | 1682 | Values: 126.0 136.0 136.0 135.0 133.0 142.0 152.0 189.0 172.0 125.0 09:46:50 INFO - PROCESS | 1682 | 09:46:50 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:68.00 stddev:15.15 (22.3%) stddev-sans-first:15.39 09:46:50 INFO - PROCESS | 1682 | Values: 65.0 67.0 68.0 68.0 68.0 86.0 100.0 106.0 80.0 66.0 09:46:50 INFO - PROCESS | 1682 | -------- Summary: end -------- 09:46:50 INFO - PROCESS | 1682 | 09:46:51 INFO - TEST-INFO | 1682: exit 0 09:46:51 INFO - TEST-OK | kraken | took 58340ms 09:46:51 INFO - SUITE-END | took 1169s 09:46:51 INFO - Completed test suite (00:19:29) 09:46:51 INFO - javascript benchmark 09:46:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3024.3195281061758, 3500.5274287971124, 3559.7686150400236, 3562.394392953198, 3590.38963376226, 5863.442972917572, 5869.8239052828485, 5878.353381128072, 5882.764689412424, 5882.882342353156, 5866.76532938682, 5926.318473375563, 5930.347661757203, 5949.791757288495, 5950.9107363389585, 5326.786928522854, 5349.598780091489, 5404.91892621611, 5420.7018613976215, 5466.289382380285, 5299.072662284085, 5437.755301011444, 5443.918341224885, 5455.0, 5463.262459567967, 5303.071962406563, 5401.973625011255, 5412.2152287918225, 5419.864503387407, 5421.593380496479, 3846.884403522975, 5094.999999999982, 5412.4587541245955, 5421.213923981, 5429.914017196576, 5280.445553216934, 5327.653702509325, 5336.785234127832, 5356.143017117242, 5446.618736688433, 4483.3947417098925, 5632.746526406321, 5698.202251684767, 5751.22358481608, 6003.429674180989, 6206.2862770781485, 6211.689415529206, 6212.316645169028, 6218.875622487525, 6236.376362363772, 5240.371155461331, 6229.688515574248, 6297.685115744194, 6301.905471417932, 6313.053042043684, 5856.736446859902, 5978.820635380902, 6057.515398768088, 6062.090686397031, 6109.755609775648, 6391.07329437229, 6433.420992110732, 6438.420542151229, 6439.8068057958335, 6457.5479716419395, 6267.561270711098, 6273.96863015682, 6294.213223347082, 6302.590331628429, 6315.084312774622, 6160.907586386208, 6228.34602366754, 6290.276618188876, 6324.873502529924, 6332.873342533216, 6228.22147231596, 6232.407921247474, 6276.874462510724, 6278.717457714322, 6309.747610095636, 6146.877062458726, 6214.658193799384, 6274.466670332981, 6285.402886725754, 6296.055591661196, 4944.060628480577, 5023.49765023502, 5027.120253955543, 5027.396712394536, 5064.49355064498, 4458.264386376277, 4492.797824097924, 4523.932141017887, 4530.886727831765, 4531.954680453219, 5751.539876809845, 5884.0, 5899.646021238739, 5954.345022047572, 5976.9402305977255, 6194.225721784777, 6233.189685340877, 6273.247210334789, 6298.527610429236, 6337.841553961096, 4891.217405215149, 5022.522860328263, 5216.21756736485, 5597.608167428322, 5933.3769954154195, 4689.953100468952, 5400.108982017923, 5495.477929596682, 5500.697461639568, 5567.554595632339, 6410.711517981609, 6472.061551075162, 6493.902591461037, 6499.2200935887995, 6510.3489651034515, 5425.891482170414, 6200.149737958573, 6304.779332723333, 6326.082718005771, 6328.0, 6273.686315684289, 6398.232212134573, 6517.859374609519, 6534.869302613826, 6553.934460655332, 5040.949590504195, 6225.719842607185, 6261.154744109669, 6266.310705822265, 6278.246610406781, 6241.843953901189, 6267.435930766253, 6276.027215781562, 6276.246850377984, 6282.968585157045, 4989.55094041538, 6072.301685306246, 6136.917362303726, 6223.875522489616, 6240.157578726814, 6190.597611155261, 6221.875562488634, 6223.688815559294, 6225.097360882556, 6236.937630623635, 5959.523238140851, 6004.1294012368835, 6129.632222066691, 6134.0, 6157.84605384869, 6055.2733671957885, 6059.727312271047, 6137.8366772191985, 6204.875902482016, 6225.408586184305, 6111.297200821962, 6163.84590385244, 6181.690915454299, 6193.0, 6197.287311959182], "unit": "score", "name": "dojo.html", "value": 5758.677734407644}, {"lowerIsBetter": false, "replicates": [453.1910539686658, 577.517772659829, 618.0667192539264, 675.4393853101926, 678.9035707332656, 30880.845595772018, 38955.61044389555, 39064.21871562567, 39631.80184099075, 39666.603333966654, 36478.63521364785, 41681.166376672445, 41713.95715107124, 41830.58169418305, 41841.74474765754, 9503.667371641994, 9813.852792208123, 9847.0, 9854.310198286123, 9855.0, 9707.077827606367, 9811.264155188353, 9828.36115652484, 9829.4102353859, 9880.703578892644, 9786.657466988658, 9857.753556161082, 9870.753231169243, 9875.0, 9922.206223502139, 9761.023897610254, 9837.754056148618, 9848.409095454224, 9852.852207216825, 9897.802043959116, 9633.421994680271, 9723.124918757347, 9748.366356186825, 9766.511674416251, 9775.853362199572, 34606.0, 40691.7965410171, 40770.59229407727, 40937.38593921094, 41327.0, 3049.252933031399, 3198.616166060064, 3384.813835239061, 3538.929221415557, 3983.4821473208585, 27416.588751168747, 29416.705832941825, 29542.113736587937, 29863.70136298631, 29890.85054574735, 2745.8764355604044, 2749.766269867064, 2767.0868613357543, 2793.0922450203766, 2823.0, 444372.0, 447160.0, 447418.0, 448086.0, 449031.0, 68689.65655171692, 69191.65404173048, 69319.0, 69648.6517567419, 69703.30296696968, 78346.60826695945, 78710.6064469674, 79377.60311198523, 79576.0, 79719.60140199262, 18067.45797626073, 18193.545161371072, 18272.0, 18291.0, 18291.085445727662, 13432.395542200624, 13573.524926627719, 13661.658458538417, 13664.863351366359, 13673.17960922328, 22634.868256587106, 23155.768442315697, 23213.071477141064, 23400.0, 23909.402264943168, 9320.627174913063, 9497.952510237405, 9576.712698619052, 9615.90384096164, 9642.469664168399, 956.4022485946283, 981.3670182732097, 986.5609803637312, 1080.8540846985557, 1115.1803424482998, 25356.112536061148, 30412.84793576018, 30746.692533074383, 31349.373012540076, 31448.899288524794, 1074.4520294649785, 1090.465671820802, 1129.6215767717742, 1198.4127777389017, 1214.1908556251121, 15215.61960950963, 15821.050736955589, 16008.519744407686, 16087.517374478784, 16396.75404868928, 540890.0, 542235.0, 542614.0, 542633.0, 546672.0, 63297.68351158307, 63327.733445330836, 63488.68255658692, 63680.68159659265, 63773.0, 1470.0958910270108, 1514.5456363091248, 1516.6208447888027, 1521.1025494958028, 1533.2257210108824, 30594.08217753471, 30949.535756964113, 30954.380912382076, 31548.369032619677, 31750.364992699553, 55418.44581554133, 55764.88470230654, 55885.0, 56014.0, 56051.15923261073, 470194.0, 509503.0, 510688.0, 511428.0, 514198.0, 34597.01300054054, 35490.93527194188, 36392.27215455729, 36445.27109457743, 36576.81711591425, 47570.0, 47816.521834781204, 48035.0, 48980.51019489902, 49949.0, 39450.0, 39805.203895922496, 39847.203055939295, 40103.0, 40929.0, 38187.854364369116, 38655.61344386633, 39054.60945390623, 39366.40950385689, 39772.80681579557, 33492.33015339631, 39366.0, 40441.79779101203, 40622.59377406188, 41382.1723565533, 32508.0, 33902.43415403607, 34127.488087678204, 34327.141821454665, 34506.65493345034, 26007.60988585135, 26074.43553386803, 26332.0, 27722.722772772013, 28187.577186341812], "unit": "score", "name": "ext.html", "value": 20844.830624550923}, {"lowerIsBetter": false, "replicates": [377.658219311523, 378.1397321094511, 382.2794033247328, 385.8649472684559, 388.5046565628823, 16473.0, 21062.684059739116, 21088.683669744947, 22020.779792202073, 22050.88974555129, 20722.585548289026, 21151.365459036217, 21781.0, 21891.452713682167, 22129.66805497915, 5919.023361145406, 5952.404759524056, 6166.537509686769, 6181.0, 6193.225846769154, 5927.407259274081, 5957.434043765836, 5997.130416089664, 6029.336772954972, 6053.939460605404, 5946.910796338058, 5965.075413310944, 5976.462118409342, 5986.940130598682, 6910.723571057177, 6310.305866354697, 6988.93011069893, 7150.964245178767, 7174.139103307584, 7228.855422891539, 6345.111684364193, 7092.290770922918, 7270.727622666065, 7287.089113860768, 7293.452991025694, 22642.547149056925, 27092.322691932663, 27576.448471030468, 28137.155885323475, 28325.0, 2293.5183611441616, 2294.070901284982, 2303.6544518322216, 2328.8602683838853, 2497.5254701606636, 12800.61598152057, 15057.795376369864, 15932.0, 16311.184440778032, 16605.83394166067, 1488.3228131200385, 1833.0834582708646, 1833.1769075623524, 1920.9711854322197, 1922.1350392323511, 110411.44794276057, 112546.0, 112928.87071129266, 126175.0, 127166.3641681795, 19612.54843144607, 20655.0, 20778.0, 20865.89567052155, 20893.955302235132, 29903.850480747456, 30226.54660180099, 30653.69346306553, 30723.69276307253, 31284.843575781975, 9566.378185417925, 11289.15331350152, 11579.0, 11587.899149580944, 11591.130665200144, 8002.679892804339, 9862.45756483386, 9894.307398482037, 10017.198624110053, 10102.343347682525, 9053.864192037125, 9215.723528294162, 9337.533123343806, 9341.346105772667, 9352.111549402796, 2978.851057447119, 3205.326881354895, 3413.675700808419, 3592.1558433768046, 3668.9082772930356, 875.1685898396548, 950.7337945375306, 1083.967480975572, 1102.1403305421784, 1102.9448527573588, 20473.07871145802, 21557.245496407864, 21690.0, 21715.34853954384, 22081.889590552266, 1001.3541265883464, 1002.904724051214, 1008.5007921079113, 1010.2372708604956, 1073.2755390111643, 11403.42982850854, 11735.765284694258, 11772.470238839102, 11814.173007889538, 11948.163628545919, 602173.0, 638161.0, 647009.0, 663439.0, 665487.0, 118382.0, 127087.0, 128034.35982820026, 129473.0, 131244.0, 937.3813283233034, 998.5306905754284, 1034.7361422837128, 1046.053321743823, 1050.5062620568322, 15125.016873903161, 18434.33081880391, 18955.957422341904, 19150.808491914904, 19481.415557533295, 36388.81805591061, 50404.74797625988, 50648.0, 51117.0, 51642.741786290826, 70964.09697466689, 73372.0, 74812.62593686997, 75031.62484187544, 76045.47909041677, 7653.272939070779, 8126.715564955198, 8412.0, 8429.494230345954, 8592.398532102692, 9566.952165239129, 12803.743925121631, 13275.0, 13681.179129252278, 13797.448102075805, 11341.0, 11545.711357216136, 11856.407179641155, 11873.287602743863, 12128.939355303168, 11394.03150732197, 11435.656930292105, 11728.003119734918, 11763.529458821893, 11952.58165964187, 11566.016888564567, 11703.414829258332, 12093.274403535816, 12149.81775273354, 12238.571649992207, 8049.758507244792, 8275.420720549504, 8396.748097556838, 8497.107803680525, 8528.658853645784, 8761.649534018568, 11329.71675708114, 11989.460474278852, 12018.939905300418, 12184.390780460764], "unit": "score", "name": "jquery.html", "value": 10837.38994256358}, {"lowerIsBetter": false, "replicates": [1479.1347061968747, 1498.8725958293544, 1560.1731082526262, 2004.729361536192, 2011.4569066352094, 8358.414910956235, 8988.595513201904, 9251.213646840019, 9497.667581634636, 9513.904860951397, 7641.923580764191, 8415.242628163463, 8686.739397818075, 9178.495182764946, 9218.677346292881, 2100.789921007902, 2216.9247914761327, 2483.627455881623, 2543.7710606045453, 2544.605586134143, 2511.573032584456, 2542.1610868413472, 2561.308446719385, 2562.5643640581147, 2572.536943350196, 2183.9890800545977, 2474.9110391427803, 2568.4349443122483, 2578.1105518596055, 2587.79297656188, 2537.5432422163913, 2543.326018605071, 2553.8850751716122, 2570.6144078388206, 2579.974200258011, 2226.6882636430914, 2560.219133164384, 2583.8191326607143, 2599.077327548731, 2605.7263987281253, 9422.387544809566, 9458.243340532741, 9494.192993595552, 9519.190868776162, 9528.190103841182, 5608.327000759894, 5722.7424765885635, 5725.513331366838, 5757.366689664133, 5770.394108618577, 3612.440071788877, 3724.0689827543115, 3734.0291524203903, 3765.3410653135866, 3767.773933563995, 913.3515204205022, 1055.6358056470583, 1068.7456694365676, 1078.336822853947, 1092.7759809239167, 10898.509567069501, 11929.284242945365, 12508.3745812709, 12760.617181484571, 12764.106512544126, 4207.0, 5021.347224860818, 5072.898542029138, 5106.617003724736, 5121.462246464068, 10686.786264274671, 10744.623938162284, 10782.46087695612, 10818.513166907507, 10835.458227088615, 5720.513756330675, 5727.398623144593, 5789.1026890831145, 5791.218185544897, 5804.390538993345, 4588.6099681526775, 5017.498250174954, 5055.646104772631, 5113.590912726973, 5208.791648334024, 4171.541130475645, 4176.644985176294, 4185.9581404185565, 4200.159968006411, 4227.577242275748, 1339.7990301454665, 1341.1416693316285, 1346.2662848747457, 1367.0, 1371.1019282370064, 1173.2370268018692, 1192.9164958452998, 1193.7493126443544, 1417.4471955937192, 1453.7673972164403, 7142.785716428515, 8537.0, 8673.132686731276, 8736.257418119403, 8770.649174033095, 520.6485622205072, 524.6747016849578, 528.3791544934686, 528.6827903258014, 529.7986765029265, 6439.678016099177, 6450.419462248326, 6454.354564543602, 6505.967470162619, 6513.2509761377105, 11235.494402751896, 11253.774924501628, 11417.657470275904, 11594.826077608843, 11702.590409335633, 10688.839667404995, 11020.614278500214, 11230.989210971053, 11499.367534785668, 11524.366159861289, 8781.385303028854, 8876.20114189726, 8963.551822408854, 8964.013958464564, 8965.148310910454, 8544.145585441405, 8666.610002549774, 8731.039585645447, 8746.037935827182, 8832.160944710242, 10143.7464063399, 10239.232057595562, 10264.230182736175, 10329.638462653771, 10386.117180039479, 10488.580456781643, 10491.790164196826, 10680.305780124267, 10739.785204296026, 10863.67408977732, 7189.892151617834, 7572.924270757222, 7717.614119294125, 7870.134285228734, 7988.320992715684, 8459.619317130868, 8563.95718021406, 8681.392302538761, 8692.52191129494, 8752.081031491602, 7547.773566793005, 7726.884096738441, 7742.690292388242, 7763.767086987399, 7781.649825757741, 7545.811354716176, 7589.468737188344, 7628.694852206072, 7686.769396918102, 7690.00029996097, 8078.23256790604, 8117.350611951148, 8132.3494120471405, 8138.755837324889, 8168.224018718212, 7236.782896513113, 7351.338379545867, 7354.1910389856, 7380.483366164317, 7387.889181662172, 6176.81469555914, 7423.369013633902, 7487.588182650006, 7497.362724168507, 7523.322900938723], "unit": "score", "name": "mootools.html", "value": 5039.436256903862}, {"lowerIsBetter": false, "replicates": [338.19509567229994, 340.7103961632611, 342.6248258157317, 349.5368636556563, 350.84562792371355, 5691.3170419549715, 6991.860162796747, 6992.755253566126, 7002.754903578376, 7075.186353569328, 6954.165500139978, 6965.0, 6977.162740471151, 6991.126109236346, 6997.09037825082, 4897.3878265216845, 4977.850664480072, 5071.974640126813, 5081.364829396325, 5104.33643626329, 3843.673287770543, 5051.570616497602, 5064.797408103672, 5073.162928116856, 5084.491550844905, 5001.774920128585, 5002.399712034561, 5032.320636714052, 5041.697498150104, 5075.213341931988, 3884.6309600587897, 4321.848735294266, 4349.28236840924, 4959.578435832958, 5139.511746384106, 4388.517263101056, 4390.868273951786, 4391.231534481485, 4404.5815647513755, 4409.933850992237, 6408.615483070984, 6741.629210393427, 6744.7976560703255, 6769.221539522969, 6788.8302792430095, 5858.882822343572, 5913.05391137416, 5922.31893332268, 5925.555583331225, 5930.0, 6072.362401947776, 7461.253874612549, 7474.813129671802, 7484.625768711543, 7484.775456736252, 4735.1713450146435, 4735.83424580138, 4736.2895565665085, 4743.407074115736, 4744.952550474485, 6484.0, 7472.439567032494, 7787.493812902143, 7813.101493328283, 7927.048754149481, 3890.657723085531, 4568.291914753218, 4649.395578574764, 4737.28940658904, 4775.2359622460235, 4869.099216644932, 4878.780454879539, 4884.731339776346, 4886.776516684899, 4897.844948222771, 5910.0, 5914.497267732291, 5920.407959204045, 5932.3474417814, 5933.465988061095, 6561.835954101186, 7455.25447455261, 7478.551286922802, 7483.738069167553, 7493.550386976799, 1250.5373011985623, 1405.4729476446332, 1688.1981058996878, 1701.4045084220672, 1702.4381953955165, 864.3906046237388, 999.14073896449, 1039.153090231459, 1075.2634445404922, 1077.849101125843, 5653.434656534314, 6757.695903684346, 6887.724491020404, 6890.379865812101, 6925.272846351161, 7699.11460182075, 7732.574708391093, 7736.4584479085925, 7742.6902923883545, 7770.0287464067, 6001.969990150109, 6556.0, 6852.211995620468, 6867.381935625718, 6889.896651550231, 3677.9080522987138, 4084.71407001513, 4102.446169767103, 4103.528094269197, 4107.342825148022, 6500.219973603103, 7818.569978651115, 8102.149274326229, 8217.219364160395, 8229.0, 7921.0, 8012.0786109596975, 8016.198380162054, 8022.9197708022175, 8104.149064348277, 7401.629918504053, 8166.714165004197, 8185.71350002747, 8206.153615436479, 8217.424780265324, 7632.694692212472, 7763.805904852198, 7898.3681305496575, 7899.131095579367, 7899.84200316002, 7696.15342312334, 7704.0, 7708.730194443167, 7734.265244801735, 7734.806629834299, 8141.633626486704, 8147.83704325922, 8155.306798922158, 8182.509049457051, 8185.918140818516, 5017.67385119966, 5081.644284900021, 5083.0, 5086.694798312114, 5105.846824595268, 7465.216152303929, 7651.043619547557, 7769.0, 7793.922060779547, 7815.101263354787, 7488.7004519820775, 7516.812079698051, 7530.548167109991, 7535.208803075818, 7552.244775522404, 6164.876702466016, 7522.210167932289, 7524.134724506533, 7542.47202695806, 7562.924370756222, 7109.360157585842, 7279.344858962719, 7342.082239720035, 7356.117265928123, 7379.040724705754, 7446.920196571575, 7517.285857843496, 7518.947347371482, 7525.774226773206, 7534.284242996907, 7327.560346379234, 7339.59632220233, 7341.265873412616, 7346.228645992094, 7358.969744235705], "unit": "score", "name": "prototype.html", "value": 5355.650268031891}, {"lowerIsBetter": false, "replicates": [703.6657587645869, 761.7143571160811, 774.1755030892103, 784.5880912520928, 789.403999980015, 15166.772498412518, 15328.310226039826, 15509.844901550981, 15511.379544818208, 15543.533693989184, 13782.379792909318, 13799.586012419644, 13821.101628394172, 13821.447142114303, 13895.096818706777, 816.5223344343536, 947.8009617980232, 955.0926619711267, 981.7692842182081, 986.1420564109235, 951.9571619277115, 960.13108137136, 966.7631430299551, 967.5162418790604, 986.9802603947917, 979.3829887171108, 997.0976266478812, 1002.9247806414512, 1005.4821766790109, 1018.9847152292722, 950.1211379473959, 957.3011701457974, 963.5519483440199, 972.222222222223, 1010.1111022300365, 754.6000619671582, 762.6225018615766, 763.9686423328518, 765.4029856711774, 767.0871662721344, 15385.153816540085, 15421.306041228172, 15502.379904803794, 15615.375384984587, 15623.375064997386, 11741.679076045006, 12077.0, 13051.934740326238, 13108.541201058013, 13262.270575118364, 9828.852567211497, 10205.132563732092, 10309.793804123876, 10450.581976720921, 10636.57453701851, 3577.964220357789, 3584.5877724061806, 3586.982065089684, 3590.2460483298537, 3666.156783939709, 80536.3892722154, 82531.0, 82677.0, 82985.58507207426, 83138.75291870626, 7963.800904977422, 9765.609375625038, 9874.60501579943, 9896.752581185528, 9912.65305714311, 22031.559368812534, 22909.312720618407, 22912.083516659146, 22933.770662293162, 22976.966036528396, 7134.2509036551455, 7644.350230230492, 7765.262300081483, 7768.300852923151, 7849.646765895434, 4178.811953462102, 4179.0, 4179.728317659403, 4249.383839343278, 4347.739135651871, 3743.756655817363, 3756.511653485084, 3786.261678972629, 3802.448644946467, 3807.4669546263544, 614.0635530815542, 672.7409947170374, 678.4063944048958, 679.6431873266574, 680.9659517024129, 542.9837104886859, 598.5451057196475, 609.9664518451439, 618.137697911411, 630.7949916277137, 8080.83838323242, 8320.66717331312, 8490.448120872123, 8612.956935215283, 8681.826363472695, 501.07801644973426, 592.1177445606102, 605.8152263559657, 608.4189598933008, 623.2054130982942, 3892.785896775648, 3908.902277443087, 3917.4123881418013, 3980.2536249987415, 4073.579528469186, 100711.48932766015, 101017.0, 101985.49007254916, 102388.0, 102430.0, 85100.0, 85354.0, 85667.0, 86242.56878715692, 86959.0, 74080.0, 74477.5104497907, 76158.0, 76645.23354766493, 77255.22744772593, 7722.613869306625, 7919.881201782093, 7954.244346787046, 7961.452116300745, 7963.0046244219475, 50640.74679626578, 50664.0, 50681.98636027185, 51364.74317628388, 52339.0, 64879.35120648922, 68568.0, 68649.59726409552, 69144.6542767283, 69196.65401672959, 10024.0, 10206.925381453437, 10269.229807764297, 10294.485275736033, 10298.536565854405, 10737.463126843782, 10775.6228532001, 10823.891761082288, 11036.006759391694, 11696.181267311547, 10471.162307015573, 10495.842562361724, 10502.159827213958, 10878.782424351626, 11012.229143959847, 10412.791744165226, 10566.788664226826, 10702.357858528514, 10783.137349012217, 10888.67333979982, 10249.12882405004, 10345.948270258601, 10410.427426491615, 10431.791364172826, 10655.786884262427, 8476.872652646402, 8774.912394613291, 8842.734717958472, 9010.86483702758, 9022.323325750725, 8802.38383313162, 8928.429344366625, 8990.86513702282, 8997.64009439615, 9049.321300902327], "unit": "score", "name": "yui.html", "value": 6996.120774435363}], "name": "dromaeo_css", "value": 7913.870711683566}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 111.0, 145.0, 94.0, 96.0, 144.0, 106.0, 155.0, 165.0, 143.0], "unit": "score", "name": "ai-astar", "value": 127.5}, {"lowerIsBetter": true, "replicates": [145.0, 137.0, 176.0, 155.0, 117.0, 139.0, 119.0, 149.0, 151.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 140.7}, {"lowerIsBetter": true, "replicates": [192.0, 197.0, 194.0, 195.0, 191.0, 196.0, 198.0, 198.0, 225.0, 203.0], "unit": "score", "name": "audio-dft", "value": 198.9}, {"lowerIsBetter": true, "replicates": [77.0, 100.0, 107.0, 160.0, 61.0, 57.0, 71.0, 58.0, 117.0, 56.0], "unit": "score", "name": "audio-fft", "value": 86.4}, {"lowerIsBetter": true, "replicates": [87.0, 82.0, 112.0, 63.0, 82.0, 112.0, 160.0, 121.0, 84.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 101.8}, {"lowerIsBetter": true, "replicates": [137.0, 126.0, 88.0, 86.0, 90.0, 86.0, 88.0, 85.0, 123.0, 131.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 104.0}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 99.0, 98.0, 94.0, 154.0, 95.0, 122.0, 109.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 105.6}, {"lowerIsBetter": true, "replicates": [115.0, 150.0, 95.0, 95.0, 113.0, 110.0, 146.0, 148.0, 95.0, 145.0], "unit": "score", "name": "imaging-desaturate", "value": 121.2}, {"lowerIsBetter": true, "replicates": [54.0, 61.0, 60.0, 58.0, 59.0, 60.0, 60.0, 69.0, 57.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 59.3}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 69.0, 66.0, 67.0, 71.0, 66.0, 65.0, 64.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.0}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 83.0, 84.0, 80.0, 82.0, 74.0, 100.0, 70.0, 114.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [132.0, 141.0, 110.0, 138.0, 136.0, 114.0, 98.0, 132.0, 113.0, 138.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [126.0, 136.0, 136.0, 135.0, 133.0, 142.0, 152.0, 189.0, 172.0, 125.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.6}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 68.0, 68.0, 68.0, 86.0, 100.0, 106.0, 80.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.4}], "name": "kraken", "value": 1543.9}]} 09:46:51 INFO - Return code: 0 09:46:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:46:51 ERROR - # TBPL SUCCESS # 09:46:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:46:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:46:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:46:51 INFO - 2016-04-13 09:46:51.776 screenresolution[1687:10642] starting screenresolution argv=screenresolution get 09:46:51 INFO - 2016-04-13 09:46:51.778 screenresolution[1687:10642] Display 0: 1600x1200x32@60 09:46:51 INFO - 2016-04-13 09:46:51.784 screenresolution[1688:10645] starting screenresolution argv=screenresolution list 09:46:51 INFO - Available Modes on Display 0 09:46:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:46:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:46:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:46:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:46:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:46:52 INFO - Intel Iris: 09:46:52 INFO - Chipset Model: Intel Iris 09:46:52 INFO - Type: GPU 09:46:52 INFO - Bus: Built-In 09:46:52 INFO - VRAM (Dynamic, Max): 1536 MB 09:46:52 INFO - Vendor: Intel (0x8086) 09:46:52 INFO - Device ID: 0x0a2e 09:46:52 INFO - Revision ID: 0x0009 09:46:52 INFO - Displays: 09:46:52 INFO - Display: 09:46:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:46:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:46:52 INFO - Display Serial Number: 1600x1200 60 09:46:52 INFO - Main Display: Yes 09:46:52 INFO - Mirror: Off 09:46:52 INFO - Online: Yes 09:46:52 INFO - Rotation: Supported 09:46:52 INFO - Return code: 0 09:46:52 INFO - Running post-action listener: _resource_record_post_action 09:46:52 INFO - Running post-run listener: _resource_record_post_run 09:46:53 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 37692928; Write bytes: 667505664; Read time: 391; Write time: 2008 09:46:53 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 362322432; Write bytes: 363177472; Read time: 28073; Write time: 640 09:46:53 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 35878400; Write bytes: 303480320; Read time: 372; Write time: 1366 09:46:53 INFO - Running post-run listener: _upload_blobber_files 09:46:53 INFO - Blob upload gear active. 09:46:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:46:53 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:46:53 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:46:53 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:46:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:46:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:46:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:46:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:46:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:46:54 INFO - (blobuploader) - INFO - Done attempting. 09:46:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:46:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:46:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:46:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:46:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:46:55 INFO - (blobuploader) - INFO - Done attempting. 09:46:55 INFO - (blobuploader) - INFO - Iteration through files over. 09:46:55 INFO - Return code: 0 09:46:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:46:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:46:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5886fc9ac0d7b516fa54285d57e3cb0c1a9091ac4bbd6badae42230764b55353952625502d953c2bf0f9c17b01caddd7901e801b29513bc594a776c4700ec9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/230f9431fdd2574e4a07901eec8f0254c4ff4d9bb753c16f33c4ceb23ee40f729b94a86024348f8788ff2821b4564d63f4bc585c0a9d0b64ecce1e92f8930d99"} 09:46:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:46:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:46:55 INFO - Contents: 09:46:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5886fc9ac0d7b516fa54285d57e3cb0c1a9091ac4bbd6badae42230764b55353952625502d953c2bf0f9c17b01caddd7901e801b29513bc594a776c4700ec9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/230f9431fdd2574e4a07901eec8f0254c4ff4d9bb753c16f33c4ceb23ee40f729b94a86024348f8788ff2821b4564d63f4bc585c0a9d0b64ecce1e92f8930d99"} 09:46:55 INFO - Running post-run listener: copy_logs_to_upload_dir 09:46:55 INFO - Copying logs to upload dir... 09:46:55 INFO - mkdir: /builds/slave/test/build/upload/logs 09:46:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.867453 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-13 09:46:55.727298) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 09:46:55.730464) ========= 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.DKXTWa8R5r/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.eg57aZURwn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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/Mozilla-Aurora/sha512/c5886fc9ac0d7b516fa54285d57e3cb0c1a9091ac4bbd6badae42230764b55353952625502d953c2bf0f9c17b01caddd7901e801b29513bc594a776c4700ec9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/230f9431fdd2574e4a07901eec8f0254c4ff4d9bb753c16f33c4ceb23ee40f729b94a86024348f8788ff2821b4564d63f4bc585c0a9d0b64ecce1e92f8930d99"} build_url:https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010578 build_url: 'https://queue.taskcluster.net/v1/task/DskjKFoLRSWCdcmAs1_XKg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5886fc9ac0d7b516fa54285d57e3cb0c1a9091ac4bbd6badae42230764b55353952625502d953c2bf0f9c17b01caddd7901e801b29513bc594a776c4700ec9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/230f9431fdd2574e4a07901eec8f0254c4ff4d9bb753c16f33c4ceb23ee40f729b94a86024348f8788ff2821b4564d63f4bc585c0a9d0b64ecce1e92f8930d99"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-13 09:46:55.764631) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:46:55.764977) ========= 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.DKXTWa8R5r/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.eg57aZURwn/Listeners TMPDIR=/var/folders/z1/5zz99xf938j6hh205lswyzgc00000w/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.005308 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-13 09:46:55.813781) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 09:46:55.817195) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-13 09:46:55.817684) ========= ========= Total master_lag: 0.31 =========