builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0065 starttime: 1456941026.79 results: success (0) buildid: 20160302081822 builduid: 598d82d53bdd4015b54e94a807d542cc revision: f7149b0bcf7491e23edacbffce6fa418b05e776e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:26.795318) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:26.795821) ========= ========= Started set props: basedir (results: 0, elapsed: 4 secs) (at 2016-03-02 09:50:26.796203) ========= 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.YQUtIUzIbe/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.HIbOW9po78/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.006005 basedir: '/builds/slave/test' ========= master_lag: 4.28 ========= ========= Finished set props: basedir (results: 0, elapsed: 4 secs) (at 2016-03-02 09:50:31.083406) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-03-02 09:50:31.083729) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-03-02 09:50:38.772515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:38.772804) ========= 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.YQUtIUzIbe/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.HIbOW9po78/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.005735 ========= master_lag: 0.23 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:39.006764) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:39.010094) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:39.010993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 09:50:39.011298) ========= 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.YQUtIUzIbe/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.HIbOW9po78/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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-03-02 09:50:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-03-02 09:50:39 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158048 ========= master_lag: 1.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-02 09:50:40.174416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:40.174728) ========= 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.YQUtIUzIbe/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.HIbOW9po78/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.019532 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:40.220646) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:40.220988) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f7149b0bcf7491e23edacbffce6fa418b05e776e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev f7149b0bcf7491e23edacbffce6fa418b05e776e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YQUtIUzIbe/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.HIbOW9po78/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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-03-02 09:50:40,294 truncating revision to first 12 chars 2016-03-02 09:50:40,295 Setting DEBUG logging. 2016-03-02 09:50:40,295 attempt 1/10 2016-03-02 09:50:40,295 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f7149b0bcf74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 09:50:40,926 unpacking tar archive at: fx-team-f7149b0bcf74/testing/mozharness/ program finished with exit code 0 elapsedTime=0.881654 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:41.124242) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:41.124585) ========= echo f7149b0bcf7491e23edacbffce6fa418b05e776e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f7149b0bcf7491e23edacbffce6fa418b05e776e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YQUtIUzIbe/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.HIbOW9po78/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 f7149b0bcf7491e23edacbffce6fa418b05e776e program finished with exit code 0 elapsedTime=0.005129 script_repo_revision: 'f7149b0bcf7491e23edacbffce6fa418b05e776e' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:41.176540) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:41.176851) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 09:50:41.194005) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-02 09:50:41.194284) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YQUtIUzIbe/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.HIbOW9po78/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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:50:41 INFO - MultiFileLogger online at 20160302 09:50:41 in /builds/slave/test 09:50:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:50:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:50:41 INFO - {'append_to_log': False, 09:50:41 INFO - 'base_work_dir': '/builds/slave/test', 09:50:41 INFO - 'blob_upload_branch': 'Fx-Team', 09:50:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:50:41 INFO - 'branch': 'Fx-Team', 09:50:41 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:41 INFO - 'config_files': ('talos/mac_config.py',), 09:50:41 INFO - 'default_actions': ('clobber', 09:50:41 INFO - 'read-buildbot-config', 09:50:41 INFO - 'download-and-extract', 09:50:41 INFO - 'populate-webroot', 09:50:41 INFO - 'create-virtualenv', 09:50:41 INFO - 'install', 09:50:41 INFO - 'run-tests'), 09:50:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:41 INFO - 'download_minidump_stackwalk': True, 09:50:41 INFO - 'download_symbols': 'ondemand', 09:50:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:41 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:41 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:41 INFO - 'installer_path': 'installer.exe', 09:50:41 INFO - 'log_level': 'info', 09:50:41 INFO - 'log_name': 'talos', 09:50:41 INFO - 'log_to_console': True, 09:50:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:50:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:50:41 INFO - 'opt_config_files': (), 09:50:41 INFO - 'pip_index': False, 09:50:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:41 INFO - 'cmd': ('bash', 09:50:41 INFO - '-c', 09:50:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:41 INFO - 'enabled': True, 09:50:41 INFO - 'halt_on_failure': False, 09:50:41 INFO - 'name': 'check_screen_resolution'},), 09:50:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:41 INFO - 'cmd': ('bash', 09:50:41 INFO - '-c', 09:50:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:41 INFO - 'enabled': True, 09:50:41 INFO - 'halt_on_failure': False, 09:50:41 INFO - 'name': 'check_screen_resolution'},), 09:50:41 INFO - 'run_cmd_checks_enabled': True, 09:50:41 INFO - 'sps_profile': False, 09:50:41 INFO - 'sps_profile_interval': 0, 09:50:41 INFO - 'suite': 'dromaeojs', 09:50:41 INFO - 'system_bits': '32', 09:50:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:41 INFO - 'title': 't-yosemite-r7-0065', 09:50:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:41 INFO - 'use_talos_json': True, 09:50:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:50:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:41 INFO - 'work_dir': 'build'} 09:50:41 INFO - ##### 09:50:41 INFO - ##### Running clobber step. 09:50:41 INFO - ##### 09:50:41 INFO - Running pre-action listener: _resource_record_pre_action 09:50:41 INFO - Running main action method: clobber 09:50:41 INFO - rmtree: /builds/slave/test/build 09:50:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:50:43 INFO - Running post-action listener: _resource_record_post_action 09:50:43 INFO - ##### 09:50:43 INFO - ##### Running read-buildbot-config step. 09:50:43 INFO - ##### 09:50:43 INFO - Running pre-action listener: _resource_record_pre_action 09:50:43 INFO - Running main action method: read_buildbot_config 09:50:43 INFO - Using buildbot properties: 09:50:43 INFO - { 09:50:43 INFO - "project": "", 09:50:43 INFO - "product": "firefox", 09:50:43 INFO - "script_repo_revision": "production", 09:50:43 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:50:43 INFO - "repository": "", 09:50:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:50:43 INFO - "buildid": "20160302081822", 09:50:43 INFO - "pgo_build": "False", 09:50:43 INFO - "basedir": "/builds/slave/test", 09:50:43 INFO - "buildnumber": 479, 09:50:43 INFO - "slavename": "t-yosemite-r7-0065", 09:50:43 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:50:43 INFO - "platform": "yosemite_r7", 09:50:43 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:50:43 INFO - "branch": "fx-team", 09:50:43 INFO - "repo_path": "integration/fx-team", 09:50:43 INFO - "revision": "f7149b0bcf7491e23edacbffce6fa418b05e776e", 09:50:43 INFO - "stage_platform": "macosx64", 09:50:43 INFO - "builduid": "598d82d53bdd4015b54e94a807d542cc", 09:50:43 INFO - "slavebuilddir": "test" 09:50:43 INFO - } 09:50:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 09:50:43 INFO - Running post-action listener: _resource_record_post_action 09:50:43 INFO - ##### 09:50:43 INFO - ##### Running download-and-extract step. 09:50:43 INFO - ##### 09:50:43 INFO - Running pre-action listener: _resource_record_pre_action 09:50:43 INFO - Running main action method: download_and_extract 09:50:43 INFO - mkdir: /builds/slave/test/build/tests 09:50: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:50:43 INFO - https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 09:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 09:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 09:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 09:50:44 INFO - Downloaded 1277 bytes. 09:50:44 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 09:50:44 INFO - Using the following test package requirements: 09:50:44 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:50:44 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:50:44 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 09:50:44 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:50:44 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 09:50:44 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:50:44 INFO - u'jsshell-mac.zip'], 09:50:44 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:50:44 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 09:50:44 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:50:44 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:50:44 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 09:50:44 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:50:44 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 09:50:44 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:50:44 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 09:50:44 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:50:44 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:50:44 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 09:50:44 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:50:44 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:50:44 INFO - https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:50:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:50:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:50:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:50:45 INFO - Downloaded 17855025 bytes. 09:50:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:50:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:50:49 INFO - Return code: 0 09:50:49 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:49 INFO - https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:50:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:50:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:50:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:50:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:50:50 INFO - Downloaded 17855025 bytes. 09:50:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:50:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:50:53 INFO - Return code: 0 09:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:53 INFO - https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:50:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:50:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:50:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:50:54 INFO - Downloaded 10808263 bytes. 09:50:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:50:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:50:54 INFO - Return code: 0 09:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:54 INFO - https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:50:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:50:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:50:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 09:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 09:50:57 INFO - Downloaded 110960506 bytes. 09:50:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:50:57 INFO - mkdir: /builds/slave/test/properties 09:50:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:50:57 INFO - Writing to file /builds/slave/test/properties/build_url 09:50:57 INFO - Contents: 09:50:57 INFO - build_url:https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:50:58 INFO - Running post-action listener: _resource_record_post_action 09:50:58 INFO - Running post-action listener: set_extra_try_arguments 09:50:58 INFO - ##### 09:50:58 INFO - ##### Running populate-webroot step. 09:50:58 INFO - ##### 09:50:58 INFO - Running pre-action listener: _resource_record_pre_action 09:50:58 INFO - Running main action method: populate_webroot 09:50:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:50:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:50:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:50:58 INFO - '--tppagecycles', 09:50:58 INFO - '7'], 09:50:58 INFO - 'tests': ['tsvgm']}}, 09:50:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:50:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:50:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:50:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:50:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'tests': ['damp', 'tps']}, 09:50:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['damp', 'tps']}, 09:50:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:50:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:50:58 INFO - 'other': {'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore']}, 09:50:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore']}, 09:50:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore']}, 09:50:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore']}, 09:50:58 INFO - 'other_l64': {'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore']}, 09:50:58 INFO - 'other_nol64': {'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore']}, 09:50:58 INFO - 'svgr': {'tests': ['tsvgx', 09:50:58 INFO - 'tsvgr_opacity', 09:50:58 INFO - 'tart', 09:50:58 INFO - 'tscrollx', 09:50:58 INFO - 'cart']}, 09:50:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['tsvgx', 09:50:58 INFO - 'tsvgr_opacity', 09:50:58 INFO - 'tart', 09:50:58 INFO - 'tscrollx', 09:50:58 INFO - 'cart']}, 09:50:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'tests': ['tp5o']}, 09:50:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--e10s'], 09:50:58 INFO - 'tests': ['tp5o']}, 09:50:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--xperf_path', 09:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:58 INFO - 'tests': ['tp5n']}, 09:50:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--e10s', 09:50:58 INFO - '--xperf_path', 09:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:58 INFO - 'tests': ['tp5n']}}, 09:50:58 INFO - 'talos.zip': {'path': '', 09:50:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:50:58 INFO - Running post-action listener: _resource_record_post_action 09:50:58 INFO - ##### 09:50:58 INFO - ##### Running create-virtualenv step. 09:50:58 INFO - ##### 09:50:58 INFO - Running pre-action listener: _resource_record_pre_action 09:50:58 INFO - Running main action method: create_virtualenv 09:50:58 INFO - Creating virtualenv /builds/slave/test/build/venv 09:50:58 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:50:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:50:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:50:58 INFO - Using real prefix '/tools/python27' 09:50:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:50:59 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:02 INFO - Installing pip.................done. 09:51:02 INFO - Return code: 0 09:51:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:02 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 0x1074c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaebc7a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736cd30>, '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 0x107190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107363b20>, '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.YQUtIUzIbe/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.HIbOW9po78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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:51:02 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:51:02 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:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YQUtIUzIbe/Render', 09:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:02 INFO - 'HOME': '/Users/cltbld', 09:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:02 INFO - 'LOGNAME': 'cltbld', 09:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:02 INFO - 'MOZ_NO_REMOTE': '1', 09:51:02 INFO - 'NO_EM_RESTART': '1', 09:51:02 INFO - 'PAGER': '/bin/cat', 09:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:02 INFO - 'PWD': '/builds/slave/test', 09:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:02 INFO - 'SHELL': '/bin/bash', 09:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HIbOW9po78/Listeners', 09:51:02 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 09:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:02 INFO - 'USER': 'cltbld', 09:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:02 INFO - 'XPC_FLAGS': '0x0', 09:51:02 INFO - 'XPC_SERVICE_NAME': '0', 09:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:02 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:51:02 INFO - Cleaning up... 09:51:02 INFO - Return code: 0 09:51:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:02 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 0x1074c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaebc7a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736cd30>, '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 0x107190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107363b20>, '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.YQUtIUzIbe/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.HIbOW9po78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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:51:02 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:51:02 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:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YQUtIUzIbe/Render', 09:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:02 INFO - 'HOME': '/Users/cltbld', 09:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:02 INFO - 'LOGNAME': 'cltbld', 09:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:02 INFO - 'MOZ_NO_REMOTE': '1', 09:51:02 INFO - 'NO_EM_RESTART': '1', 09:51:02 INFO - 'PAGER': '/bin/cat', 09:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:02 INFO - 'PWD': '/builds/slave/test', 09:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:02 INFO - 'SHELL': '/bin/bash', 09:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HIbOW9po78/Listeners', 09:51:02 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 09:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:02 INFO - 'USER': 'cltbld', 09:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:02 INFO - 'XPC_FLAGS': '0x0', 09:51:02 INFO - 'XPC_SERVICE_NAME': '0', 09:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:02 INFO - Downloading/unpacking psutil>=0.7.1 09:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:05 INFO - Installing collected packages: psutil 09:51:05 INFO - Running setup.py install for psutil 09:51:05 INFO - building 'psutil._psutil_osx' extension 09:51:05 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:51:05 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:51:05 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:51:06 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:51:06 INFO - building 'psutil._psutil_posix' extension 09:51:06 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:51:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:51:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:51:06 INFO - ^ 09:51:06 INFO - 1 warning generated. 09:51:06 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:51:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:06 INFO - Successfully installed psutil 09:51:06 INFO - Cleaning up... 09:51:06 INFO - Return code: 0 09:51:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:06 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 0x1074c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaebc7a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736cd30>, '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 0x107190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107363b20>, '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.YQUtIUzIbe/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.HIbOW9po78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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:51:06 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:51:06 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:51:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YQUtIUzIbe/Render', 09:51:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:06 INFO - 'HOME': '/Users/cltbld', 09:51:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:06 INFO - 'LOGNAME': 'cltbld', 09:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:06 INFO - 'MOZ_NO_REMOTE': '1', 09:51:06 INFO - 'NO_EM_RESTART': '1', 09:51:06 INFO - 'PAGER': '/bin/cat', 09:51:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:06 INFO - 'PWD': '/builds/slave/test', 09:51:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:06 INFO - 'SHELL': '/bin/bash', 09:51:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HIbOW9po78/Listeners', 09:51:06 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 09:51:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:06 INFO - 'USER': 'cltbld', 09:51:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:06 INFO - 'XPC_FLAGS': '0x0', 09:51:06 INFO - 'XPC_SERVICE_NAME': '0', 09:51:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:51:06 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:51:06 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:51:06 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:51:06 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:51:06 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:51:06 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:51:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:51:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:09 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:51:09 INFO - Installing collected packages: mozsystemmonitor 09:51:09 INFO - Running setup.py install for mozsystemmonitor 09:51:09 INFO - Successfully installed mozsystemmonitor 09:51:09 INFO - Cleaning up... 09:51:09 INFO - Return code: 0 09:51:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51: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:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:09 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 0x1074c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaebc7a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736cd30>, '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 0x107190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107363b20>, '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.YQUtIUzIbe/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.HIbOW9po78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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:51:09 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:51:09 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:51:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YQUtIUzIbe/Render', 09:51:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:09 INFO - 'HOME': '/Users/cltbld', 09:51:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:09 INFO - 'LOGNAME': 'cltbld', 09:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:09 INFO - 'MOZ_NO_REMOTE': '1', 09:51:09 INFO - 'NO_EM_RESTART': '1', 09:51:09 INFO - 'PAGER': '/bin/cat', 09:51:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:09 INFO - 'PWD': '/builds/slave/test', 09:51:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:09 INFO - 'SHELL': '/bin/bash', 09:51:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HIbOW9po78/Listeners', 09:51:09 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 09:51:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:09 INFO - 'USER': 'cltbld', 09:51:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:09 INFO - 'XPC_FLAGS': '0x0', 09:51:09 INFO - 'XPC_SERVICE_NAME': '0', 09:51:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:09 INFO - Downloading/unpacking blobuploader==1.2.4 09:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:11 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - Downloading docopt-0.6.1.tar.gz 09:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:13 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:13 INFO - Running setup.py install for blobuploader 09:51:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:13 INFO - Running setup.py install for requests 09:51:13 INFO - Running setup.py install for docopt 09:51:13 INFO - Successfully installed blobuploader requests docopt 09:51:13 INFO - Cleaning up... 09:51:13 INFO - Return code: 0 09:51:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:13 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:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 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:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 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 0x1074c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaebc7a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736cd30>, '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 0x107190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107363b20>, '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.YQUtIUzIbe/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.HIbOW9po78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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:51:13 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:51:13 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:51:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YQUtIUzIbe/Render', 09:51:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:13 INFO - 'HOME': '/Users/cltbld', 09:51:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:13 INFO - 'LOGNAME': 'cltbld', 09:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:13 INFO - 'MOZ_NO_REMOTE': '1', 09:51:13 INFO - 'NO_EM_RESTART': '1', 09:51:13 INFO - 'PAGER': '/bin/cat', 09:51:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:13 INFO - 'PWD': '/builds/slave/test', 09:51:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:13 INFO - 'SHELL': '/bin/bash', 09:51:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HIbOW9po78/Listeners', 09:51:13 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 09:51:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:13 INFO - 'USER': 'cltbld', 09:51:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:13 INFO - 'XPC_FLAGS': '0x0', 09:51:13 INFO - 'XPC_SERVICE_NAME': '0', 09:51:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:14 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-zhCpWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:14 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-8Ty6KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:14 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-ti242g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:14 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-7_Yae4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:14 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-ee65qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:14 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-8wahBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:14 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-lb7AX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:14 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-KHO0Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:15 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-DgikFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:15 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-j6OSJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:15 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-2uUH3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:15 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-V9RMJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:15 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-StljEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:15 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-xQIHEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:15 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-qUBa0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:15 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-2xTJGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:15 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-024vop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:15 INFO - Running setup.py install for manifestparser 09:51:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:16 INFO - Running setup.py install for mozcrash 09:51:16 INFO - Running setup.py install for mozdebug 09:51:16 INFO - Running setup.py install for mozdevice 09:51:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:16 INFO - Running setup.py install for mozfile 09:51:16 INFO - Running setup.py install for mozhttpd 09:51:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:16 INFO - Running setup.py install for mozinfo 09:51:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:17 INFO - Running setup.py install for mozInstall 09:51:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:17 INFO - Running setup.py install for mozleak 09:51:17 INFO - Running setup.py install for mozlog 09:51:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:17 INFO - Running setup.py install for moznetwork 09:51:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:17 INFO - Running setup.py install for mozprocess 09:51:17 INFO - Running setup.py install for mozprofile 09:51:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:17 INFO - Running setup.py install for mozrunner 09:51:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:18 INFO - Running setup.py install for mozscreenshot 09:51:18 INFO - Running setup.py install for moztest 09:51:18 INFO - Running setup.py install for mozversion 09:51:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:18 INFO - Cleaning up... 09:51:18 INFO - Return code: 0 09:51:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51: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:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51: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:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:18 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 0x1074c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaebc7a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736cd30>, '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 0x107190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107363b20>, '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.YQUtIUzIbe/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.HIbOW9po78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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:51:18 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:51:18 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:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YQUtIUzIbe/Render', 09:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:18 INFO - 'HOME': '/Users/cltbld', 09:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:18 INFO - 'LOGNAME': 'cltbld', 09:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:18 INFO - 'MOZ_NO_REMOTE': '1', 09:51:18 INFO - 'NO_EM_RESTART': '1', 09:51:18 INFO - 'PAGER': '/bin/cat', 09:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:18 INFO - 'PWD': '/builds/slave/test', 09:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:18 INFO - 'SHELL': '/bin/bash', 09:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HIbOW9po78/Listeners', 09:51:18 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 09:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:18 INFO - 'USER': 'cltbld', 09:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:18 INFO - 'XPC_FLAGS': '0x0', 09:51:18 INFO - 'XPC_SERVICE_NAME': '0', 09:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:19 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-6Bo3jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:19 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:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:19 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-waMd7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:19 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-xk_k58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:19 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:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:19 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-HCrQ_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:19 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:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:19 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-0eOTao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:19 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:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:19 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-8qcR4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:19 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:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:19 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-WX6XxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:19 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:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:19 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-pDster-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:20 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:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-kMN3do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:20 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:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-42CS5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:20 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:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-9uIDaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:20 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:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-7uFdja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:20 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:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-uHdfx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:20 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:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-xkChAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:20 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:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-qnqJ8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:20 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:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-AzceN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:20 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:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-cHENFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:21 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:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:51:21 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:51:21 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:51:21 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:51:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:23 INFO - Downloading blessings-1.6.tar.gz 09:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:23 INFO - Installing collected packages: blessings 09:51:23 INFO - Running setup.py install for blessings 09:51:23 INFO - Successfully installed blessings 09:51:23 INFO - Cleaning up... 09:51:24 INFO - Return code: 0 09:51:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:24 INFO - Reading from file tmpfile_stdout 09:51:24 INFO - Current package versions: 09:51:24 INFO - blessings == 1.6 09:51:24 INFO - blobuploader == 1.2.4 09:51:24 INFO - docopt == 0.6.1 09:51:24 INFO - manifestparser == 1.1 09:51:24 INFO - mozInstall == 1.12 09:51:24 INFO - mozcrash == 0.16 09:51:24 INFO - mozdebug == 0.1 09:51:24 INFO - mozdevice == 0.48 09:51:24 INFO - mozfile == 1.2 09:51:24 INFO - mozhttpd == 0.7 09:51:24 INFO - mozinfo == 0.9 09:51:24 INFO - mozleak == 0.1 09:51:24 INFO - mozlog == 3.1 09:51:24 INFO - moznetwork == 0.27 09:51:24 INFO - mozprocess == 0.22 09:51:24 INFO - mozprofile == 0.28 09:51:24 INFO - mozrunner == 6.11 09:51:24 INFO - mozscreenshot == 0.1 09:51:24 INFO - mozsystemmonitor == 0.0 09:51:24 INFO - moztest == 0.7 09:51:24 INFO - mozversion == 1.4 09:51:24 INFO - psutil == 3.1.1 09:51:24 INFO - requests == 1.2.3 09:51:24 INFO - wsgiref == 0.1.2 09:51:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 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 0x1074c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaebc7a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736cd30>, '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 0x107190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107363b20>, '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.YQUtIUzIbe/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.HIbOW9po78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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:51:24 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:51:24 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:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YQUtIUzIbe/Render', 09:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:24 INFO - 'HOME': '/Users/cltbld', 09:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:24 INFO - 'LOGNAME': 'cltbld', 09:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:24 INFO - 'MOZ_NO_REMOTE': '1', 09:51:24 INFO - 'NO_EM_RESTART': '1', 09:51:24 INFO - 'PAGER': '/bin/cat', 09:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:24 INFO - 'PWD': '/builds/slave/test', 09:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:24 INFO - 'SHELL': '/bin/bash', 09:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HIbOW9po78/Listeners', 09:51:24 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 09:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:24 INFO - 'USER': 'cltbld', 09:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:24 INFO - 'XPC_FLAGS': '0x0', 09:51:24 INFO - 'XPC_SERVICE_NAME': '0', 09:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:24 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:51:24 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:51:24 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:51:24 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:51:24 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:51:24 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:51:24 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:51:24 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:51:24 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:51:24 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:51:24 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:51:24 INFO - Cleaning up... 09:51:24 INFO - Return code: 0 09:51:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:24 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 0x1074c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaebc7a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736cd30>, '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 0x107190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107363b20>, '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.YQUtIUzIbe/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.HIbOW9po78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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:51:24 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:51:24 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:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YQUtIUzIbe/Render', 09:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:24 INFO - 'HOME': '/Users/cltbld', 09:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:24 INFO - 'LOGNAME': 'cltbld', 09:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:24 INFO - 'MOZ_NO_REMOTE': '1', 09:51:24 INFO - 'NO_EM_RESTART': '1', 09:51:24 INFO - 'PAGER': '/bin/cat', 09:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:24 INFO - 'PWD': '/builds/slave/test', 09:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:24 INFO - 'SHELL': '/bin/bash', 09:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HIbOW9po78/Listeners', 09:51:24 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 09:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:24 INFO - 'USER': 'cltbld', 09:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:24 INFO - 'XPC_FLAGS': '0x0', 09:51:24 INFO - 'XPC_SERVICE_NAME': '0', 09:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:24 INFO - Downloading/unpacking jsonschema 09:51:24 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:51:24 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:51:24 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:51:24 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:51:24 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:51:24 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:51:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:51:27 INFO - Downloading/unpacking functools32 (from jsonschema) 09:51:27 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:51:27 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:51:27 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:51:27 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:51:27 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:51:27 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:51:27 INFO - Downloading functools32-3.2.3-2.tar.gz 09:51:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:27 INFO - warning: no files found matching '*.txt' 09:51:27 INFO - no previously-included directories found matching 'build' 09:51:27 INFO - no previously-included directories found matching 'dist' 09:51:27 INFO - no previously-included directories found matching '.git*' 09:51:27 INFO - Installing collected packages: jsonschema, functools32 09:51:27 INFO - Running setup.py install for functools32 09:51:27 INFO - warning: no files found matching '*.txt' 09:51:27 INFO - no previously-included directories found matching 'build' 09:51:27 INFO - no previously-included directories found matching 'dist' 09:51:27 INFO - no previously-included directories found matching '.git*' 09:51:27 INFO - Successfully installed jsonschema functools32 09:51:27 INFO - Cleaning up... 09:51:28 INFO - Return code: 0 09:51:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:28 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 0x1074c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1074d04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdaebc7a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10736cd30>, '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 0x107190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107363b20>, '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.YQUtIUzIbe/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.HIbOW9po78/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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:51:28 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:51:28 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:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YQUtIUzIbe/Render', 09:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:28 INFO - 'HOME': '/Users/cltbld', 09:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:28 INFO - 'LOGNAME': 'cltbld', 09:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:28 INFO - 'MOZ_NO_REMOTE': '1', 09:51:28 INFO - 'NO_EM_RESTART': '1', 09:51:28 INFO - 'PAGER': '/bin/cat', 09:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:28 INFO - 'PWD': '/builds/slave/test', 09:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:28 INFO - 'SHELL': '/bin/bash', 09:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HIbOW9po78/Listeners', 09:51:28 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 09:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:28 INFO - 'USER': 'cltbld', 09:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:28 INFO - 'XPC_FLAGS': '0x0', 09:51:28 INFO - 'XPC_SERVICE_NAME': '0', 09:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:28 INFO - Downloading/unpacking flake8 09:51: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:51: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:51: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:51: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:51: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:51: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:51:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:51:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:51:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:51:31 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:51:31 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:51:31 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:51:31 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:51:31 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:51:31 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:51:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:51:31 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:51:31 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:51:31 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:51:31 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:51:31 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:51:31 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:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:51:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:51:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:51:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:51:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:51:31 INFO - no previously-included directories found matching 'docs/_build' 09:51:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:51:32 INFO - Running setup.py install for pep8 09:51:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:51:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:51:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:51:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:51:32 INFO - no previously-included directories found matching 'docs/_build' 09:51:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:51:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:51:32 INFO - Cleaning up... 09:51:32 INFO - Return code: 0 09:51:32 INFO - Running post-action listener: _resource_record_post_action 09:51:32 INFO - Running post-action listener: _start_resource_monitoring 09:51:32 INFO - Starting resource monitoring. 09:51:32 INFO - ##### 09:51:32 INFO - ##### Running install step. 09:51:32 INFO - ##### 09:51:32 INFO - Running pre-action listener: _resource_record_pre_action 09:51:32 INFO - Running main action method: install 09:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:32 INFO - Reading from file tmpfile_stdout 09:51:32 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:32 INFO - Reading from file tmpfile_stdout 09:51:32 INFO - Output received: 09:51:32 INFO - Usage: mozinstall [options] installer 09:51:32 INFO - Options: 09:51:32 INFO - -h, --help show this help message and exit 09:51:32 INFO - -d DEST, --destination=DEST 09:51:32 INFO - Directory to install application into. [default: 09:51:32 INFO - "/builds/slave/test"] 09:51:32 INFO - --app=APP Application being installed. [default: firefox] 09:51:32 INFO - mkdir: /builds/slave/test/build/application 09:51:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:52:07 INFO - Reading from file tmpfile_stdout 09:52:07 INFO - Output received: 09:52:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:52:07 INFO - Running post-action listener: _resource_record_post_action 09:52:07 INFO - ##### 09:52:07 INFO - ##### Running run-tests step. 09:52:07 INFO - ##### 09:52:07 INFO - Running pre-action listener: _resource_record_pre_action 09:52:07 INFO - Running main action method: run_tests 09:52:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:52:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:52:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:52:07 INFO - 2016-03-02 09:52:07.216 screenresolution[1963:18740] starting screenresolution argv=screenresolution get 09:52:07 INFO - 2016-03-02 09:52:07.219 screenresolution[1963:18740] Display 0: 1600x1200x32@60 09:52:07 INFO - 2016-03-02 09:52:07.225 screenresolution[1964:18742] starting screenresolution argv=screenresolution list 09:52:07 INFO - Available Modes on Display 0 09:52:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:52:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:52:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:52:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:52:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:52:07 INFO - Intel Iris: 09:52:07 INFO - Chipset Model: Intel Iris 09:52:07 INFO - Type: GPU 09:52:07 INFO - Bus: Built-In 09:52:07 INFO - VRAM (Dynamic, Max): 1536 MB 09:52:07 INFO - Vendor: Intel (0x8086) 09:52:07 INFO - Device ID: 0x0a2e 09:52:07 INFO - Revision ID: 0x0009 09:52:07 INFO - Displays: 09:52:07 INFO - Display: 09:52:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:52:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:52:07 INFO - Display Serial Number: 1600x1200 60 09:52:07 INFO - Main Display: Yes 09:52:07 INFO - Mirror: Off 09:52:07 INFO - Online: Yes 09:52:07 INFO - Rotation: Supported 09:52:07 INFO - Return code: 0 09:52:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:52:07 INFO - Python 2.7.3 09:52:07 INFO - Return code: 0 09:52:07 INFO - grabbing minidump binary from tooltool 09:52:07 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:52:07 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 0x10736cd30>, '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 0x107190db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107363b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:52:07 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:52:07 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:52:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:52:07 INFO - Return code: 0 09:52:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:52:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:52:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:52:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:52:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:52:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:52:08 INFO - Return code: 0 09:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:52:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YQUtIUzIbe/Render', 09:52:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:08 INFO - 'HOME': '/Users/cltbld', 09:52:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:08 INFO - 'LOGNAME': 'cltbld', 09:52:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:52:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:08 INFO - 'MOZ_NO_REMOTE': '1', 09:52:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:52:08 INFO - 'NO_EM_RESTART': '1', 09:52:08 INFO - 'PAGER': '/bin/cat', 09:52:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:08 INFO - 'PWD': '/builds/slave/test', 09:52:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:52:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:08 INFO - 'SHELL': '/bin/bash', 09:52:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HIbOW9po78/Listeners', 09:52:08 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 09:52:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:08 INFO - 'USER': 'cltbld', 09:52:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:08 INFO - 'XPC_FLAGS': '0x0', 09:52:08 INFO - 'XPC_SERVICE_NAME': '0', 09:52:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:52:09 INFO - mozversion application_buildid: 20160302081822 09:52:09 INFO - mozversion application_changeset: f7149b0bcf7491e23edacbffce6fa418b05e776e 09:52:09 INFO - mozversion application_display_name: Nightly 09:52:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:52:09 INFO - mozversion application_name: Firefox 09:52:09 INFO - mozversion application_remotingname: firefox 09:52:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:52:09 INFO - mozversion application_vendor: Mozilla 09:52:09 INFO - mozversion application_version: 47.0a1 09:52:09 INFO - mozversion platform_buildid: 20160302081822 09:52:09 INFO - mozversion platform_changeset: f7149b0bcf7491e23edacbffce6fa418b05e776e 09:52:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:52:09 INFO - mozversion platform_version: 47.0a1 09:52:09 INFO - using testdate: 1456941129 09:52:09 INFO - actual date: 1456941129 09:52:09 INFO - starting webserver on 'localhost:57327' 09:52:09 INFO - SUITE-START | Running 2 tests 09:52:09 INFO - TEST-START | dromaeo_css 09:52:09 INFO - operating with platform_type : mac_ 09:52:09 INFO - Initialising browser for dromaeo_css test... 09:52:09 INFO - TEST-INFO | started process 1982 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpOHBFSX/profile http://localhost:57327/getInfo.html) 09:52:11 INFO - PROCESS | 1982 | __metrics Screen width/height:1600/1200 09:52:11 INFO - PROCESS | 1982 | colorDepth:24 09:52:11 INFO - PROCESS | 1982 | Browser inner width/height: 1024/689 09:52:11 INFO - PROCESS | 1982 | __metrics 09:52:11 INFO - PROCESS | 1982 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:52:11 INFO - PROCESS | 1982 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:11 INFO - TEST-INFO | 1982: exit 0 09:52:11 INFO - Browser initialized. 09:52:11 INFO - Running cycle 1/1 for dromaeo_css test... 09:52:11 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpOHBFSX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:24 INFO - PROCESS | 1985 | RSS: Main: 243572736 09:52:24 INFO - PROCESS | 1985 | 09:53:14 INFO - PROCESS | 1985 | 1456941194945 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:55:24 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:57327/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57327/tests/dromaeo/cssquery-ext.html) 09:55:26 INFO - PROCESS | 1985 | RSS: Main: 472432640 09:55:26 INFO - PROCESS | 1985 | 09:58:29 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:57327/tests/dromaeo/cssquery-ext.html (next: http://localhost:57327/tests/dromaeo/cssquery-jquery.html) 09:58:30 INFO - PROCESS | 1985 | RSS: Main: 381415424 09:58:30 INFO - PROCESS | 1985 | 10:01:32 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:57327/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57327/tests/dromaeo/cssquery-mootools.html) 10:01:32 INFO - PROCESS | 1985 | RSS: Main: 377081856 10:01:32 INFO - PROCESS | 1985 | 10:04:34 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:57327/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57327/tests/dromaeo/cssquery-prototype.html) 10:04:35 INFO - PROCESS | 1985 | RSS: Main: 338104320 10:04:35 INFO - PROCESS | 1985 | 10:07:38 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:57327/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57327/tests/dromaeo/cssquery-yui.html) 10:07:39 INFO - PROCESS | 1985 | RSS: Main: 339968000 10:07:39 INFO - PROCESS | 1985 | 10:10:41 INFO - PROCESS | 1985 | Cycle 1(1): loaded http://localhost:57327/tests/dromaeo/cssquery-yui.html (next: http://localhost:57327/tests/dromaeo/cssquery-dojo.html) 10:10:42 INFO - PROCESS | 1985 | RSS: Main: 400687104 10:10:42 INFO - PROCESS | 1985 | 10:10:42 INFO - PROCESS | 1985 | __start_tp_report 10:10:42 INFO - PROCESS | 1985 | _x_x_mozilla_page_load 10:10:42 INFO - PROCESS | 1985 | _x_x_mozilla_page_load_details 10:10:42 INFO - PROCESS | 1985 | |i|pagename|runs| 10:10:42 INFO - PROCESS | 1985 | |0;dojo.html;3390.966090339097;3406.7104296134826;3436.106612280808;3436.329915666446;3480.9477857832135;5545.556355491561;5575.2473416088815;5606.103023516233;5630.915536266959;5634.070378387566;5638.520725738307;5642.322921249445;5685.204071429993;5779.82660520184;5810.506106980901;5068.5438310552045;5113.233015047745;5135.075686376451;5144.3826740791155;5207.088759467097;4062.512498500184;5203.505666961632;5214.921776173361;5221.216817477371;5277.920831187535;5071.1886098224295;5096.439391666913;5150.587952963754;5160.071187186324;5167;5167.069927413064;5178.197379406198;5178.715170665612;5179.015986962465;5191.870203244911;5134.2812006319145;5139.331886854685;5151.356080489939;5175.327207463043;5197.324347834795;5450.100733378988;5492.148716948879;5564.165375193753;5585.329760428734;5617.466340697627;6153.784617538365;6169.413905678954;6187.102870083858;6206.813795586139;6207.596506227081;6198.411150940653;6255.562110652256;6270.749170033238;6281.120643109968;6292.716827742763;5605.187247849039;5702.885942281173;5704.8859022819315;5782;5806;6294.181756371734;6306.779262725874;6306.905396419057;6312.463440607508;6325.936740632535;6030.7889223876955;6035.39646035393;6089.939100608937;6094.847628809227;6108.205933228652;6086;6141.455323060903;6187.257529096447;6230.06549017651;6261.436470717657;6125.846853828601;6130.356312587203;6132.877342453126;6134.079888016744;6140.969295153495;6135;6160.537959653044;6171.753129874754;6173.259208894961;6174.38256174379;4768.594669453066;4778.593819525379;4821.541953514481;4823.758812059383;4847.175980083394;4306.5262821089655;4378.408914796461;4384.583464570925;4399.36209249657;4399.934000989988;5474.945250547444;5548.5838562108;5566.888662226814;5576.470235327637;5600.075987462104;6198.81403557885;6210.844728881814;6220.409061139185;6238.438540531374;6240.095186197976;4622.560856718606;5445.700486473203;5532.612717109763;5540.972295138579;5547.057000309957;4673.065386922561;5173.974130129325;5278.604104692164;5323.574114070865;5374.677519348774;6208.286047104641;6256.843578910563;6258;6260.373962603703;6268.059791031382;6091.451769340781;6150;6179.660118693515;6239.688015599111;6245.250569931637;5562.471565201299;6057.666828324484;6178.62928224308;6259.499240060693;6286.8428289291305;6099.451049405575;6143.573288551087;6162.537809664203;6167.383261673796;6174.506039516738;6168.1056246844855;6170.228721409824;6243.157173781663;6244.157038799885;6247.2815626201755;5873.295204575478;5947.553933454921;5968.731407086605;6064.090386442069;6071.939280607314;4853.781579828846;5736.139579063174;5915;5929.970350148222;5932.525397968066;5768.826935191951;5772.797952071657;5772.855678608068;5777.480026797609;5793.391693872083;5905.763769449174;5907.261592300963;5923.49650279731;5940.61386009908;6032.939670603238;5929.140274660064;5939;5989.880202396015;5994.970025150021;6012.488938440281 10:10:42 INFO - PROCESS | 1985 | |1;ext.html;438.4147163536678;470.47776967565994;560.0982418306526;570.8554348531194;584.6871923520918;30260.546091808614;31041.84479077607;38184.61815381849;38487.037824054416;38712;41924.161516769644;42217.36673949893;42386.78806605963;42410.36384454236;42540.36189457161;9474.526273686306;9701.90298097017;9704.41773493589;9707.61169553217;9709.563069661846;9509.286803489766;9548.331616786827;9633.27750418718;9647.276454265922;9665.806683866318;9774.071463210983;9839.55721992512;9842.311038227326;9848.852267215962;9850.359726617782;9698.51507424626;9747.805043899118;9751.561179746928;9766.414015159113;9767.16979056781;9670.75823104421;9770.658026969093;9801.215902727765;9806.705798825975;9815.950920245425;40596.188076238606;41107;41193.97015074647;41221;41280.1743965119;3120;3320.684534969174;3337.8998630041137;3338.4992251162275;3561.5370001899587;24755;25313.62029569558;27073.917043318244;30227.848860755556;30284;2707.945841083187;2820.0552814807065;2847.5586284125993;2851.8431486268246;2853.843038632874;472126;472885;473564;475669;475944;61998.69000654968;62350;62725;62814.37185628177;62823.6858815703;68357.31642683609;68771.65614171997;69009;69062.65468672726;69115.65442172857;13867.514636987657;17103.57241068983;17113.828861711474;17124.315027398763;17144.057076860892;13039.869601303866;13077.738445231042;13078.346082695827;13093.148945318524;13106.80339794904;19866.304679336154;20288.087036083412;20306.59386812285;20325.18699252013;20336.69494957577;6865.656717164222;8275.420720549504;8399.95800020996;8414.579271036424;8485.787855303543;927.3045216087934;931.1293940165966;1015.1422048369117;1023.7747695506977;1045.749020235138;23001;28849.990250341136;29664.703352966626;29669.406611867642;29843.552346714816;879.7536689726886;964.8745663063897;1033.7105610429091;1090.487470888681;1092.5083712329483;13239;14308.356123974447;14351.712965740626;14645;14720.969532132647;369848;377330;381883;382757;383184;57750.4224957745;58975.705121474115;59073;59141.112883306785;59207;1170.39724541861;1186.3593659423987;1274.3564499927663;1290.6386211860695;1399.5801259622276;23659.053637854293;26597.601035984088;28124.29689257703;28363.149105526867;28985.7101428983;45520.77239613781;45775.77112114418;45824.39614613473;45883.770581146884;45976.540234598564;304329;314490;314688;315386;315616;22813.657795132753;32492.675073248964;32628;32793.50809737904;33605.495917560766;41094;41534.79232603818;41551.58448415477;42301.36547951722;42943;32655.510167347984;33830.815921442634;36040;36405.45391819072;36843.63156368509;33839.49240761341;35716.28567428689;35909.46135807913;36242.456363154044;36783.81608091942;35243.82378088093;35746.10634734049;35791;36242.10731551207;36692.81653591822;30965.69034309628;31614;31814.840925795223;31867.681323186473;31928.6807131935;23924.476333988478;24131.396715082265;24132.56404155759;24283.27150185497;24382.26853194407 10:10:42 INFO - PROCESS | 1985 | |2;jquery.html;347.6263017256449;351.83287938229336;352.58395093789335;354.48245561480235;360.74026700775465;19201.61596768064;19496;20875.060622271998;21354.572908541857;21363.893180534076;19258.22967081315;20272.8986355068;20368.592628147428;20384.184632614713;21033.47416314593;6456;6623.072769812206;6691.397774200321;6693.464522838186;6697.8995315070315;4548.603669386388;5544.6118771686;6608.834779130512;7600.847983040336;7605.80985475362;7503.324700776929;7513.962430187841;7583.9241607584045;7584.886226706604;7601.543907365576;7315.926840731578;7491.850162996737;7510.849783004364;7518.924810751932;7527.849443011164;4452.220861349251;6870.244273129952;7174.92825071753;7190.388816950565;7193;20324.79675203244;26370.86814565934;26497.73502264972;27737.44525109507;27787.444251115066;2045.7442819647545;2183.6724491326268;2213.833962452806;2391.6651668766385;2458.704955405345;15325;15596.908216424854;15606;15679.529614111594;16189.433369831999;1819.8635102367375;1915.7126431035317;1915.7605299337583;1952.0532541717255;1968.6161198566285;98539;105881;109190.27024324455;112756.30865536942;115580.42209788981;18148.455546333633;18704;18927.485801135877;18936.810631893506;18984.525386865163;27793.861030695123;27831.16506504808;27848.582271265946;27855.543113101805;27893.302667433072;10105.595776168871;10504.579816807394;10511.84232236517;10633.627823026158;10644.733881652866;9030.232430243503;9037.819243615091;9055.547222638974;9058.230050445654;9172.312076594282;8254.092049874509;8351.457155284887;8396.118407567239;8400.957995209985;8431.662733490592;2797.888084476639;3306.239564900038;3318.2699806042633;3327;3445.707114895212;847.4025811802665;874.6719980007497;895.2703546609492;935.3031991166624;1051.5846240734868;18139.45581632553;18480.168392422373;18680;18746;19132.043397830053;864.2006144316482;886.255545341903;898.2275243290765;928.6424726480219;933.3326671429825;9744.853827192597;10289.97100289965;10365.118964887919;10425.843612345821;10456.738581535523;502519;505992;508146;550641;589943;124360.37819811024;125000;130072;130852;134276;961.274237950343;993.60752502761;1006.3659894266565;1009.2733232072895;1036.409246729357;17463.650726985645;17611.03139327298;17844.375446859296;18071.186796593924;18174.636507269515;50440.74779626078;50800.491995079574;51539;51721;52425.47574524206;73402.26597734168;73901.6304918472;76108.61945690236;77409;78529.21470785448;7696.422768292288;7855.018122734658;7868.449208555575;7989.960050199712;8214.507129572006;9247.352685311964;9772.462514561767;12942.352882356034;13219.66950826237;13249.271290079138;10991.175661825235;11304.604338848101;11305.26515776472;11342.659720208407;11385.203035787416;10778.514966826668;11198.38408887519;11214.943925280322;11318.547258109584;11424.371659558805;11234.382108984084;11479.36863472517;11791.115666324888;12016.699582510508;12034;7827.295543401121;7840.01116015818;7929.5242285460745;7999.200079991954;8025.9598702006115;11217;11408.201425900108;11616.303021818718;11726.530938762355;11740.178187526792 10:10:42 INFO - PROCESS | 1985 | |3;mootools.html;1298.2023738842793;1363.8772510474068;1565.9608509787258;1737.331127515906;1923.8268555829964;6506.609603423798;8445;8485.91514084859;8581.442206256588;8603.354748393873;8311.293540049102;8535.231829135377;8543.91456085439;8546.188112129337;8550.52972086535;2403.7716416940407;2435.0990133650575;2435.2694191742494;2436.744141865105;2438.317271164068;2398.1126983016306;2414.5774489464275;2443.144899285254;2452.3869032741813;2452.6075827867544;2417.4802417480237;2443.633454981758;2445.4742230420457;2448.0574978633267;2449.3876530867283;2401.9639705404434;2432.525657496789;2442.474867903409;2444.5966415541416;2446.425090103824;2392.0670938334065;2435.5250726108416;2444.792192663626;2447.816413768957;2448.424620214248;8610.397272190949;8666.176713212235;8678;8696.434731742416;8706.738797836075;5301.231321458367;5456.890862182734;5461.18082287656;5468.425815289417;5476.479734425223;3540.8406621702084;3601.567811862567;3671.81640917953;3674.8530058797614;3682.447632855093;988.7132731507854;1056.915446764257;1059.7244716373798;1062.7502536903821;1070.5717712914818;11724.237924534878;11739.530418783239;11742.530298788039;11751.764964700658;11765.11761617882;3856.382978723391;4742.715437073786;4784.784684689197;4785.665003449725;4799.616030717534;8424.368172387096;9976.60327554143;10036.096751292418;10051.195904327782;10052.64815731446;5297.231901374279;5325.627206095536;5341.278927344759;5347.0909945309395;5351.464853514695;4367.737935723867;4535.659825513099;4735.715857048588;4845.442774080955;4889.608831293488;3489.4242449995468;3610.627961374661;3869.4582758413844;3875.6124387561017;3925.156091440354;1250.4310538704867;1252.3800718644147;1260.3194275091348;1262.4823822233025;1264.9241045537296;963.4460185393427;989.4508547756064;1152.7809716153904;1189.149757923089;1305.2038256663427;7952.602369881482;8058.879116813252;8080.757577272691;8088.029436467662;8123.878141827878;877.6621000914566;1157.8842115788354;1183.4910988274953;1202.374765122149;1212.563477148226;6129.785457508966;6280.591761535577;6335.049742538564;6350.872982540323;6368.14030105939;10314.226433017553;10771.138308935266;10772.515236814363;10780.78438431227;10798.082163016075;10331.01855323743;10468.842967355497;10542;10634.149268058536;10664.520096595672;8160.67357305713;8289.253967142866;8291.419600627898;8293.917060829435;8331.6667333306;7611.162772094955;7845.411594130349;7851.097123830604;7860.3318717909615;7861.724839630586;9324.207442367204;9389.953050234704;9605.37565058269;9706.611735530782;9720.562574684298;9697.32118751709;9943.950280248553;10128.088472037552;10141.391516509033;10179.236557258087;7151.177614574391;7460.477766556506;7465.589392583242;7468.7593721884305;7472.551646900986;8172.060213075572;8175.754727358189;8253.13342099095;8270.421070525246;8280;6291.339409361951;7287.27127287267;7314.926850731425;7372.594507301936;7410.4442166836625;6027.397260274113;7239.239879812754;7241.239669834592;7259.637018148966;7306.41548676094;7649.617519124133;7711.190325016017;7719.768406947801;7723.150453450228;7723.575203363869;6577.309382514958;6912.758053468105;6983.9650801745665;6991.755288564876;6994.985727069445;6959.0257363970095;6991.9300806993315;7008.509404341851;7033.402160816388;7040.225575186623 10:10:42 INFO - PROCESS | 1985 | |4;prototype.html;309.4646261966797;314.9794665284479;318.4029943855272;323.1968558133039;324.68829923273654;6495.123158373618;6570.277269500357;6624.436922861551;6640.369164929336;6654.833629159273;6530.771423000196;6577.473802095833;6579.94720844665;6587.8023659290175;6602;4673.088747694201;4774.618030557547;4792.520747925215;4898.216285394329;4924.433690125627;4856.814433504919;4888.535589119028;4890.584300334476;4913.8771530711665;4922.80308787648;4852.563269305761;4854.854354369357;4858.101251268509;4858.368412106439;4898.314236006961;4624.699394539361;4698.154332220199;4855.053264613366;4874.268859671042;4882.41411030675;4177.707560470768;4198.181354635847;4199.349100889367;4205.222033923734;4206.957930420718;6324.968375158141;6339.95390760524;6357.459615932651;6357.713902874381;6368.77709280173;5711.742971566289;5719.227904232958;5721.9427805721825;5724.570657200685;5725.427457254283;6979.616121113337;6981.301869813029;6993.47548933832;7001.229864714877;7006.824829379255;4326.199653064194;4480.910381792379;4486.439195100613;4504.8873778155485;4518.932216016762;7202.847544392925;7269.89095163573;7362.190159082496;7416.369608583277;7418.925810741932;3850.5186851643543;4540.069285796404;4541.455025396974;4541.6593755468475;4544.386507821468;4581.473130589959;4587.678862479661;4595.172868883633;4598.287265473857;4618.884527886829;5518.310211223597;5528.474794894479;5530.170474428868;5530.55755539564;5533.806316778893;6748.696308666122;6982.47631427645;7011.4741394394605;7019.052427922165;7037.718491260394;1323.9602811915659;1481.3704924583087;1589.3721979817908;1604.0696396090239;1605.590574403543;926.3700683535261;957.5355952363099;1017.1747573779872;1033.813913495563;1036.2435422141727;6288.182536270256;6384.138141350858;6490.286068532458;6554.4101030906495;6579.934200657932;7322.926770732331;7327.926720732831;7329.780106596811;7333.376662983599;7337.339639432476;6525.184351956005;6538.607683539003;6539.836504087436;6545.410913017851;6548.443382312462;3594.263176048904;3808.3716186829415;3847.5575308839284;3848.13416981177;3854.6338097880657;7320.67056982437;7651;7652.196519365387;7693.615319234016;7697.153313135551;7514.9624251878395;7556.433267504959;7559.1684914659345;7569.5079819811535;7574.810629734301;5692.715364231854;6116.999999999911;7647.464677472635;7651.540907545454;7658.502197357154;6296.622202667854;6842.46044639952;6996.545224560387;7251.347378735939;7269.273072692688;7199.964000179965;7217.422606191387;7247.528910620793;7255.854882902207;7274.4907856449545;7623.352015078781;7635.885461717968;7649.426293028157;7659.387249020177;7673.736247806799;4571.542845715402;4582.175208462509;4582.931256031229;4585.380973568659;4601.723896566216;7036.9296307036275;7284.125904891447;7304.086989126359;7309.086364204474;7335.523190992569;7043.647817608997;7060.576365418091;7061.71753129869;7076.787696369117;7086.893696594659;5728.684922329312;6976;7024.367806897404;7032.261612530815;7050;6841.965790171017;6853.246142924374;6855.058341453784;6855.5543889647015;7008.159020917318;6790.253072162157;7022.578645281299;7039.718411263492;7062.187848397294;7072.752453664097;6716.597004179765;6811.455083593201;6875.346842050198;6922.203946546211;6932.850816246778 10:10:42 INFO - PROCESS | 1985 | |5;yui.html;626.5958456795366;719.0616245799232;723;740.8370158565117;758.4425447296236;14767.852321476783;14867.107973521597;14929.477468288613;14955.925220373883;14998.700025999473;13641.18152910826;13863.584092477242;13863.792043119336;13871.098378605384;13880.236586987712;726.956382617042;727.9708811647528;842.540815255684;859.6131740716671;881.7310720230328;872.5462759365126;880.6917578847416;881.0792721605937;881.3566096749377;882.2765332427412;928.5450129436562;931.1991687149047;932.1191474057019;932.1517419148577;932.3520153493325;746.3805041815308;752.3191511681937;753.6872198037807;891.2513488669484;905.5653286422521;678.3623394009616;679.9830004249884;680.5406350713298;681.5399605266475;683.2723149845399;14800.111993280438;14863.479778207819;14885.106893586419;14904.850951490454;14908.850911490854;12608.676089010705;12711.046671499582;12829.486820527261;13005.284709340982;13102.737945241137;9904.547110217378;10014.49927503622;10088.848667269996;10115.039071288216;10401.739956501073;3475.565554305712;3518.1556426457464;3539.557555305587;3552.573691157052;3605.4231322988194;81848;82011.5899420499;83567.16432835655;83764;84119.5794021026;7816.726414575576;9469.952650236704;9475.384100033614;9766.804663906823;9794.069563391466;21821.890890545445;22000.229991950204;22197.445063873532;22263;22370.55258894813;7362.042934418491;7449.217832127657;7497.775066748006;7498.362639175732;7688.807779805437;3932.4297976793205;3991.9002024949027;3996.320625493673;4045.6358927696647;4271.060366719316;3492.842822073013;3541.6281290464644;3566.661167189113;3575.9284814304087;3579.534660494119;616.9136320915076;632.1844820182006;633.8478765096344;634.3783092569216;641.425923798198;525.5296509623942;568.2868000659229;572.481903876992;581.0499832773446;587.6943989125716;8143.552104634302;8184.959075204586;8185.386096042821;8301.46040507365;8341.499510029418;558.1683291895047;580.9941900581025;590.8138936235158;598.8622616798161;604.921360223177;3690.2435000824767;3823.6749876260274;3856.5564960029956;3910.569837317893;3951.7233793634746;54736;90764;95017.524912375;95182.04817951871;95432;79785;79869.40261194743;80477.59761201157;81541.77687334694;83895.58052209699;69380.6530967352;70023;71161;71193.6440317795;75382.24617753862;7246.384057355184;8204.876926845982;8446.535440550582;8506.489610623383;8663.870041949502;38009;48185.75907120442;48593.5140648589;48804.85158761545;49413.25880111873;69071;69397.65301173461;71200.28799711936;73845;74898;9719.9028009719;10884.292520986111;10977.890221097687;11147.146310647713;11532.88467115318;11731;11993.280403175837;12004.279743215435;12390.876091239334;12737.55418560346;9696.75758106053;11168.66494005181;11207.935246151603;11516.42417879086;12398.00815934705;11294.378809165575;11359.54561817518;11492.36791976416;11501.597444089417;11541.192116551762;11249.268797528135;11307.43462826839;11321.490532925873;11568.768624627628;11575.305481671126;9379.437233765995;9587.712368628674;9712.805743884941;9794.020597940149;9989.750256243362;8837.91162088371;9151.3136514763;9233.117511497794;9681.661141860282;9842.311038227255 10:10:42 INFO - PROCESS | 1985 | __end_tp_report 10:10:42 INFO - PROCESS | 1985 | __start_cc_report 10:10:42 INFO - PROCESS | 1985 | _x_x_mozilla_cycle_collect,2323 10:10:42 INFO - PROCESS | 1985 | __end_cc_report 10:10:42 INFO - PROCESS | 1985 | __startTimestamp1456942242102__endTimestamp 10:10:42 INFO - PROCESS | 1985 | 10:10:42 INFO - PROCESS | 1985 | ------- Summary: start ------- 10:10:42 INFO - PROCESS | 1985 | Number of tests: 6 10:10:42 INFO - PROCESS | 1985 | 10:10:42 INFO - PROCESS | 1985 | [#0] dojo.html Cycles:165 Average:5653.84 Median:5810.51 stddev:649.61 (11.2%) stddev-sans-first:626.88 10:10:42 INFO - PROCESS | 1985 | Values: 3391.0 3406.7 3436.1 3436.3 3480.9 5545.6 5575.2 5606.1 5630.9 5634.1 5638.5 5642.3 5685.2 5779.8 5810.5 5068.5 5113.2 5135.1 5144.4 5207.1 4062.5 5203.5 5214.9 5221.2 5277.9 5071.2 5096.4 5150.6 5160.1 5167.0 5167.1 5178.2 5178.7 5179.0 5191.9 5134.3 5139.3 5151.4 5175.3 5197.3 5450.1 5492.1 5564.2 5585.3 5617.5 6153.8 6169.4 6187.1 6206.8 6207.6 6198.4 6255.6 6270.7 6281.1 6292.7 5605.2 5702.9 5704.9 5782.0 5806.0 6294.2 6306.8 6306.9 6312.5 6325.9 6030.8 6035.4 6089.9 6094.8 6108.2 6086.0 6141.5 6187.3 6230.1 6261.4 6125.8 6130.4 6132.9 6134.1 6141.0 6135.0 6160.5 6171.8 6173.3 6174.4 4768.6 4778.6 4821.5 4823.8 4847.2 4306.5 4378.4 4384.6 4399.4 4399.9 5474.9 5548.6 5566.9 5576.5 5600.1 6198.8 6210.8 6220.4 6238.4 6240.1 4622.6 5445.7 5532.6 5541.0 5547.1 4673.1 5174.0 5278.6 5323.6 5374.7 6208.3 6256.8 6258.0 6260.4 6268.1 6091.5 6150.0 6179.7 6239.7 6245.3 5562.5 6057.7 6178.6 6259.5 6286.8 6099.5 6143.6 6162.5 6167.4 6174.5 6168.1 6170.2 6243.2 6244.2 6247.3 5873.3 5947.6 5968.7 6064.1 6071.9 4853.8 5736.1 5915.0 5930.0 5932.5 5768.8 5772.8 5772.9 5777.5 5793.4 5905.8 5907.3 5923.5 5940.6 6032.9 5929.1 5939.0 5989.9 5995.0 6012.5 10:10:42 INFO - PROCESS | 1985 | 10:10:42 INFO - PROCESS | 1985 | [#1] ext.html Cycles:180 Average:54710.89 Median:36738.32 stddev:104312.15 (283.9%) stddev-sans-first:104525.18 10:10:42 INFO - PROCESS | 1985 | Values: 438.4 470.5 560.1 570.9 584.7 30260.5 31041.8 38184.6 38487.0 38712.0 41924.2 42217.4 42386.8 42410.4 42540.4 9474.5 9701.9 9704.4 9707.6 9709.6 9509.3 9548.3 9633.3 9647.3 9665.8 9774.1 9839.6 9842.3 9848.9 9850.4 9698.5 9747.8 9751.6 9766.4 9767.2 9670.8 9770.7 9801.2 9806.7 9816.0 40596.2 41107.0 41194.0 41221.0 41280.2 3120.0 3320.7 3337.9 3338.5 3561.5 24755.0 25313.6 27073.9 30227.8 30284.0 2707.9 2820.1 2847.6 2851.8 2853.8 472126.0 472885.0 473564.0 475669.0 475944.0 61998.7 62350.0 62725.0 62814.4 62823.7 68357.3 68771.7 69009.0 69062.7 69115.7 13867.5 17103.6 17113.8 17124.3 17144.1 13039.9 13077.7 13078.3 13093.1 13106.8 19866.3 20288.1 20306.6 20325.2 20336.7 6865.7 8275.4 8400.0 8414.6 8485.8 927.3 931.1 1015.1 1023.8 1045.7 23001.0 28850.0 29664.7 29669.4 29843.6 879.8 964.9 1033.7 1090.5 1092.5 13239.0 14308.4 14351.7 14645.0 14721.0 369848.0 377330.0 381883.0 382757.0 383184.0 57750.4 58975.7 59073.0 59141.1 59207.0 1170.4 1186.4 1274.4 1290.6 1399.6 23659.1 26597.6 28124.3 28363.1 28985.7 45520.8 45775.8 45824.4 45883.8 45976.5 304329.0 314490.0 314688.0 315386.0 315616.0 22813.7 32492.7 32628.0 32793.5 33605.5 41094.0 41534.8 41551.6 42301.4 42943.0 32655.5 33830.8 36040.0 36405.5 36843.6 33839.5 35716.3 35909.5 36242.5 36783.8 35243.8 35746.1 35791.0 36242.1 36692.8 30965.7 31614.0 31814.8 31867.7 31928.7 23924.5 24131.4 24132.6 24283.3 24382.3 10:10:42 INFO - PROCESS | 1985 | 10:10:42 INFO - PROCESS | 1985 | [#2] jquery.html Cycles:180 Average:33828.59 Median:27812.51 stddev:89095.36 (320.3%) stddev-sans-first:89309.83 10:10:42 INFO - PROCESS | 1985 | Values: 347.6 351.8 352.6 354.5 360.7 19201.6 19496.0 20875.1 21354.6 21363.9 19258.2 20272.9 20368.6 20384.2 21033.5 6456.0 6623.1 6691.4 6693.5 6697.9 4548.6 5544.6 6608.8 7600.8 7605.8 7503.3 7514.0 7583.9 7584.9 7601.5 7315.9 7491.9 7510.8 7518.9 7527.8 4452.2 6870.2 7174.9 7190.4 7193.0 20324.8 26370.9 26497.7 27737.4 27787.4 2045.7 2183.7 2213.8 2391.7 2458.7 15325.0 15596.9 15606.0 15679.5 16189.4 1819.9 1915.7 1915.8 1952.1 1968.6 98539.0 105881.0 109190.3 112756.3 115580.4 18148.5 18704.0 18927.5 18936.8 18984.5 27793.9 27831.2 27848.6 27855.5 27893.3 10105.6 10504.6 10511.8 10633.6 10644.7 9030.2 9037.8 9055.5 9058.2 9172.3 8254.1 8351.5 8396.1 8401.0 8431.7 2797.9 3306.2 3318.3 3327.0 3445.7 847.4 874.7 895.3 935.3 1051.6 18139.5 18480.2 18680.0 18746.0 19132.0 864.2 886.3 898.2 928.6 933.3 9744.9 10290.0 10365.1 10425.8 10456.7 502519.0 505992.0 508146.0 550641.0 589943.0 124360.4 125000.0 130072.0 130852.0 134276.0 961.3 993.6 1006.4 1009.3 1036.4 17463.7 17611.0 17844.4 18071.2 18174.6 50440.7 50800.5 51539.0 51721.0 52425.5 73402.3 73901.6 76108.6 77409.0 78529.2 7696.4 7855.0 7868.4 7990.0 8214.5 9247.4 9772.5 12942.4 13219.7 13249.3 10991.2 11304.6 11305.3 11342.7 11385.2 10778.5 11198.4 11214.9 11318.5 11424.4 11234.4 11479.4 11791.1 12016.7 12034.0 7827.3 7840.0 7929.5 7999.2 8026.0 11217.0 11408.2 11616.3 11726.5 11740.2 10:10:42 INFO - PROCESS | 1985 | 10:10:42 INFO - PROCESS | 1985 | [#3] mootools.html Cycles:180 Average:5974.26 Median:5344.18 stddev:3159.67 (59.1%) stddev-sans-first:3148.98 10:10:42 INFO - PROCESS | 1985 | Values: 1298.2 1363.9 1566.0 1737.3 1923.8 6506.6 8445.0 8485.9 8581.4 8603.4 8311.3 8535.2 8543.9 8546.2 8550.5 2403.8 2435.1 2435.3 2436.7 2438.3 2398.1 2414.6 2443.1 2452.4 2452.6 2417.5 2443.6 2445.5 2448.1 2449.4 2402.0 2432.5 2442.5 2444.6 2446.4 2392.1 2435.5 2444.8 2447.8 2448.4 8610.4 8666.2 8678.0 8696.4 8706.7 5301.2 5456.9 5461.2 5468.4 5476.5 3540.8 3601.6 3671.8 3674.9 3682.4 988.7 1056.9 1059.7 1062.8 1070.6 11724.2 11739.5 11742.5 11751.8 11765.1 3856.4 4742.7 4784.8 4785.7 4799.6 8424.4 9976.6 10036.1 10051.2 10052.6 5297.2 5325.6 5341.3 5347.1 5351.5 4367.7 4535.7 4735.7 4845.4 4889.6 3489.4 3610.6 3869.5 3875.6 3925.2 1250.4 1252.4 1260.3 1262.5 1264.9 963.4 989.5 1152.8 1189.1 1305.2 7952.6 8058.9 8080.8 8088.0 8123.9 877.7 1157.9 1183.5 1202.4 1212.6 6129.8 6280.6 6335.0 6350.9 6368.1 10314.2 10771.1 10772.5 10780.8 10798.1 10331.0 10468.8 10542.0 10634.1 10664.5 8160.7 8289.3 8291.4 8293.9 8331.7 7611.2 7845.4 7851.1 7860.3 7861.7 9324.2 9390.0 9605.4 9706.6 9720.6 9697.3 9944.0 10128.1 10141.4 10179.2 7151.2 7460.5 7465.6 7468.8 7472.6 8172.1 8175.8 8253.1 8270.4 8280.0 6291.3 7287.3 7314.9 7372.6 7410.4 6027.4 7239.2 7241.2 7259.6 7306.4 7649.6 7711.2 7719.8 7723.2 7723.6 6577.3 6912.8 6984.0 6991.8 6995.0 6959.0 6991.9 7008.5 7033.4 7040.2 10:10:42 INFO - PROCESS | 1985 | 10:10:42 INFO - PROCESS | 1985 | [#4] prototype.html Cycles:180 Average:5732.19 Median:6546.93 stddev:1849.53 (28.3%) stddev-sans-first:1809.38 10:10:42 INFO - PROCESS | 1985 | Values: 309.5 315.0 318.4 323.2 324.7 6495.1 6570.3 6624.4 6640.4 6654.8 6530.8 6577.5 6579.9 6587.8 6602.0 4673.1 4774.6 4792.5 4898.2 4924.4 4856.8 4888.5 4890.6 4913.9 4922.8 4852.6 4854.9 4858.1 4858.4 4898.3 4624.7 4698.2 4855.1 4874.3 4882.4 4177.7 4198.2 4199.3 4205.2 4207.0 6325.0 6340.0 6357.5 6357.7 6368.8 5711.7 5719.2 5721.9 5724.6 5725.4 6979.6 6981.3 6993.5 7001.2 7006.8 4326.2 4480.9 4486.4 4504.9 4518.9 7202.8 7269.9 7362.2 7416.4 7418.9 3850.5 4540.1 4541.5 4541.7 4544.4 4581.5 4587.7 4595.2 4598.3 4618.9 5518.3 5528.5 5530.2 5530.6 5533.8 6748.7 6982.5 7011.5 7019.1 7037.7 1324.0 1481.4 1589.4 1604.1 1605.6 926.4 957.5 1017.2 1033.8 1036.2 6288.2 6384.1 6490.3 6554.4 6579.9 7322.9 7327.9 7329.8 7333.4 7337.3 6525.2 6538.6 6539.8 6545.4 6548.4 3594.3 3808.4 3847.6 3848.1 3854.6 7320.7 7651.0 7652.2 7693.6 7697.2 7515.0 7556.4 7559.2 7569.5 7574.8 5692.7 6117.0 7647.5 7651.5 7658.5 6296.6 6842.5 6996.5 7251.3 7269.3 7200.0 7217.4 7247.5 7255.9 7274.5 7623.4 7635.9 7649.4 7659.4 7673.7 4571.5 4582.2 4582.9 4585.4 4601.7 7036.9 7284.1 7304.1 7309.1 7335.5 7043.6 7060.6 7061.7 7076.8 7086.9 5728.7 6976.0 7024.4 7032.3 7050.0 6842.0 6853.2 6855.1 6855.6 7008.2 6790.3 7022.6 7039.7 7062.2 7072.8 6716.6 6811.5 6875.3 6922.2 6932.9 10:10:42 INFO - PROCESS | 1985 | 10:10:42 INFO - PROCESS | 1985 | [#5] yui.html Cycles:180 Average:18325.21 Median:633.02 stddev:25937.75 (4097.5%) stddev-sans-first:25976.47 10:10:42 INFO - PROCESS | 1985 | Values: 626.6 719.1 723.0 740.8 758.4 14767.9 14867.1 14929.5 14955.9 14998.7 13641.2 13863.6 13863.8 13871.1 13880.2 727.0 728.0 842.5 859.6 881.7 872.5 880.7 881.1 881.4 882.3 928.5 931.2 932.1 932.2 932.4 746.4 752.3 753.7 891.3 905.6 678.4 680.0 680.5 681.5 683.3 14800.1 14863.5 14885.1 14904.9 14908.9 12608.7 12711.0 12829.5 13005.3 13102.7 9904.5 10014.5 10088.8 10115.0 10401.7 3475.6 3518.2 3539.6 3552.6 3605.4 81848.0 82011.6 83567.2 83764.0 84119.6 7816.7 9470.0 9475.4 9766.8 9794.1 21821.9 22000.2 22197.4 22263.0 22370.6 7362.0 7449.2 7497.8 7498.4 7688.8 3932.4 3991.9 3996.3 4045.6 4271.1 3492.8 3541.6 3566.7 3575.9 3579.5 616.9 632.2 633.8 634.4 641.4 525.5 568.3 572.5 581.0 587.7 8143.6 8185.0 8185.4 8301.5 8341.5 558.2 581.0 590.8 598.9 604.9 3690.2 3823.7 3856.6 3910.6 3951.7 54736.0 90764.0 95017.5 95182.0 95432.0 79785.0 79869.4 80477.6 81541.8 83895.6 69380.7 70023.0 71161.0 71193.6 75382.2 7246.4 8204.9 8446.5 8506.5 8663.9 38009.0 48185.8 48593.5 48804.9 49413.3 69071.0 69397.7 71200.3 73845.0 74898.0 9719.9 10884.3 10977.9 11147.1 11532.9 11731.0 11993.3 12004.3 12390.9 12737.6 9696.8 11168.7 11207.9 11516.4 12398.0 11294.4 11359.5 11492.4 11501.6 11541.2 11249.3 11307.4 11321.5 11568.8 11575.3 9379.4 9587.7 9712.8 9794.0 9989.8 8837.9 9151.3 9233.1 9681.7 9842.3 10:10:42 INFO - PROCESS | 1985 | -------- Summary: end -------- 10:10:42 INFO - PROCESS | 1985 | 10:10:42 INFO - TEST-INFO | 1985: exit 0 10:10:42 INFO - TEST-OK | dromaeo_css | took 1113636ms 10:10:42 INFO - TEST-START | kraken 10:10:42 INFO - operating with platform_type : mac_ 10:10:42 INFO - Initialising browser for kraken test... 10:10:42 INFO - TEST-INFO | started process 1989 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpAf0Sce/profile http://localhost:57327/getInfo.html) 10:10:44 INFO - PROCESS | 1989 | __metrics Screen width/height:1600/1200 10:10:44 INFO - PROCESS | 1989 | colorDepth:24 10:10:44 INFO - PROCESS | 1989 | Browser inner width/height: 1024/689 10:10:44 INFO - PROCESS | 1989 | __metrics 10:10:44 INFO - PROCESS | 1989 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:10:44 INFO - PROCESS | 1989 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:45 INFO - TEST-INFO | 1989: exit 0 10:10:45 INFO - Browser initialized. 10:10:45 INFO - Running cycle 1/1 for kraken test... 10:10:45 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpAf0Sce/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:57 INFO - PROCESS | 1991 | RSS: Main: 242790400 10:10:57 INFO - PROCESS | 1991 | 10:11:00 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57327/tests/kraken/driver.html?testName=audio-beat-detection) 10:11:01 INFO - PROCESS | 1991 | RSS: Main: 288403456 10:11:01 INFO - PROCESS | 1991 | 10:11:03 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57327/tests/kraken/driver.html?testName=audio-dft) 10:11:04 INFO - PROCESS | 1991 | RSS: Main: 299061248 10:11:04 INFO - PROCESS | 1991 | 10:11:07 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57327/tests/kraken/driver.html?testName=audio-fft) 10:11:08 INFO - PROCESS | 1991 | RSS: Main: 286564352 10:11:08 INFO - PROCESS | 1991 | 10:11:10 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57327/tests/kraken/driver.html?testName=audio-oscillator) 10:11:10 INFO - PROCESS | 1991 | RSS: Main: 289325056 10:11:10 INFO - PROCESS | 1991 | 10:11:12 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57327/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:11:13 INFO - PROCESS | 1991 | RSS: Main: 290418688 10:11:13 INFO - PROCESS | 1991 | 10:11:16 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57327/tests/kraken/driver.html?testName=imaging-darkroom) 10:11:16 INFO - PROCESS | 1991 | RSS: Main: 290623488 10:11:16 INFO - PROCESS | 1991 | 10:11:19 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57327/tests/kraken/driver.html?testName=imaging-desaturate) 10:11:20 INFO - PROCESS | 1991 | RSS: Main: 288927744 10:11:20 INFO - PROCESS | 1991 | 10:11:22 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57327/tests/kraken/driver.html?testName=json-parse-financial) 10:11:23 INFO - PROCESS | 1991 | RSS: Main: 291098624 10:11:23 INFO - PROCESS | 1991 | 10:11:24 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57327/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:25 INFO - PROCESS | 1991 | RSS: Main: 323977216 10:11:25 INFO - PROCESS | 1991 | 10:11:27 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57327/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:27 INFO - PROCESS | 1991 | RSS: Main: 323391488 10:11:27 INFO - PROCESS | 1991 | 10:11:29 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57327/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:30 INFO - PROCESS | 1991 | RSS: Main: 330346496 10:11:30 INFO - PROCESS | 1991 | 10:11:33 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:33 INFO - PROCESS | 1991 | RSS: Main: 332136448 10:11:33 INFO - PROCESS | 1991 | 10:11:36 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:36 INFO - PROCESS | 1991 | RSS: Main: 332619776 10:11:36 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | Cycle 1(1): loaded http://localhost:57327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57327/tests/kraken/driver.html?testName=ai-astar) 10:11:38 INFO - PROCESS | 1991 | RSS: Main: 393109504 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | __start_tp_report 10:11:38 INFO - PROCESS | 1991 | _x_x_mozilla_page_load 10:11:38 INFO - PROCESS | 1991 | _x_x_mozilla_page_load_details 10:11:38 INFO - PROCESS | 1991 | |i|pagename|runs| 10:11:38 INFO - PROCESS | 1991 | |0;ai-astar;109;109;110;111;112;110;115;112;111;112 10:11:38 INFO - PROCESS | 1991 | |1;audio-beat-detection;156;121;145;156;118;141;139;117;158;117 10:11:38 INFO - PROCESS | 1991 | |2;audio-dft;185;185;186;186;184;184;184;183;191;181 10:11:38 INFO - PROCESS | 1991 | |3;audio-fft;74;102;118;105;55;58;57;81;77;62 10:11:38 INFO - PROCESS | 1991 | |4;audio-oscillator;93;95;128;80;76;79;117;76;78;116 10:11:38 INFO - PROCESS | 1991 | |5;imaging-gaussian-blur;91;86;90;88;90;87;91;87;90;86 10:11:38 INFO - PROCESS | 1991 | |6;imaging-darkroom;94;94;95;95;95;94;96;94;90;133 10:11:38 INFO - PROCESS | 1991 | |7;imaging-desaturate;85;86;86;87;85;87;84;85;85;84 10:11:38 INFO - PROCESS | 1991 | |8;json-parse-financial;52;54;54;54;52;54;53;62;54;51 10:11:38 INFO - PROCESS | 1991 | |9;json-stringify-tinderbox;64;71;65;74;72;70;68;69;70;69 10:11:38 INFO - PROCESS | 1991 | |10;stanford-crypto-aes;81;82;82;82;83;84;81;85;83;82 10:11:38 INFO - PROCESS | 1991 | |11;stanford-crypto-ccm;124;132;127;116;118;120;112;117;120;146 10:11:38 INFO - PROCESS | 1991 | |12;stanford-crypto-pbkdf2;139;141;131;140;134;126;139;137;139;137 10:11:38 INFO - PROCESS | 1991 | |13;stanford-crypto-sha256-iterative;67;67;66;67;67;65;66;66;67;66 10:11:38 INFO - PROCESS | 1991 | __end_tp_report 10:11:38 INFO - PROCESS | 1991 | __start_cc_report 10:11:38 INFO - PROCESS | 1991 | _x_x_mozilla_cycle_collect,1245 10:11:38 INFO - PROCESS | 1991 | __end_cc_report 10:11:38 INFO - PROCESS | 1991 | __startTimestamp1456942298726__endTimestamp 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | ------- Summary: start ------- 10:11:38 INFO - PROCESS | 1991 | Number of tests: 14 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:1.79 (1.6%) stddev-sans-first:1.73 10:11:38 INFO - PROCESS | 1991 | Values: 109.0 109.0 110.0 111.0 112.0 110.0 115.0 112.0 111.0 112.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:143.00 stddev:17.20 (12.0%) stddev-sans-first:16.79 10:11:38 INFO - PROCESS | 1991 | Values: 156.0 121.0 145.0 156.0 118.0 141.0 139.0 117.0 158.0 117.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:2.60 (1.4%) stddev-sans-first:2.76 10:11:38 INFO - PROCESS | 1991 | Values: 185.0 185.0 186.0 186.0 184.0 184.0 184.0 183.0 191.0 181.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#3] audio-fft Cycles:10 Average:78.90 Median:60.00 stddev:22.48 (37.5%) stddev-sans-first:23.78 10:11:38 INFO - PROCESS | 1991 | Values: 74.0 102.0 118.0 105.0 55.0 58.0 57.0 81.0 77.0 62.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:78.50 stddev:19.71 (25.1%) stddev-sans-first:20.90 10:11:38 INFO - PROCESS | 1991 | Values: 93.0 95.0 128.0 80.0 76.0 79.0 117.0 76.0 78.0 116.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:90.00 stddev:2.01 (2.2%) stddev-sans-first:1.94 10:11:38 INFO - PROCESS | 1991 | Values: 91.0 86.0 90.0 88.0 90.0 87.0 91.0 87.0 90.0 86.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#6] imaging-darkroom Cycles:10 Average:98.00 Median:94.50 stddev:12.40 (13.1%) stddev-sans-first:13.07 10:11:38 INFO - PROCESS | 1991 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 96.0 94.0 90.0 133.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:1.07 (1.3%) stddev-sans-first:1.13 10:11:38 INFO - PROCESS | 1991 | Values: 85.0 86.0 86.0 87.0 85.0 87.0 84.0 85.0 85.0 84.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:3.02 (5.6%) stddev-sans-first:3.11 10:11:38 INFO - PROCESS | 1991 | Values: 52.0 54.0 54.0 54.0 52.0 54.0 53.0 62.0 54.0 51.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:70.00 stddev:3.01 (4.3%) stddev-sans-first:2.54 10:11:38 INFO - PROCESS | 1991 | Values: 64.0 71.0 65.0 74.0 72.0 70.0 68.0 69.0 70.0 69.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:1.27 (1.5%) stddev-sans-first:1.22 10:11:38 INFO - PROCESS | 1991 | Values: 81.0 82.0 82.0 82.0 83.0 84.0 81.0 85.0 83.0 82.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:122.00 stddev:9.86 (8.1%) stddev-sans-first:10.46 10:11:38 INFO - PROCESS | 1991 | Values: 124.0 132.0 127.0 116.0 118.0 120.0 112.0 117.0 120.0 146.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.30 Median:139.00 stddev:4.69 (3.4%) stddev-sans-first:4.87 10:11:38 INFO - PROCESS | 1991 | Values: 139.0 141.0 131.0 140.0 134.0 126.0 139.0 137.0 139.0 137.0 10:11:38 INFO - PROCESS | 1991 | 10:11:38 INFO - PROCESS | 1991 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 10:11:38 INFO - PROCESS | 1991 | Values: 67.0 67.0 66.0 67.0 67.0 65.0 66.0 66.0 67.0 66.0 10:11:38 INFO - PROCESS | 1991 | -------- Summary: end -------- 10:11:38 INFO - PROCESS | 1991 | 10:11:39 INFO - TEST-INFO | 1991: exit 0 10:11:39 INFO - TEST-OK | kraken | took 56794ms 10:11:39 INFO - SUITE-END | took 1170s 10:11:39 INFO - Completed test suite (00:19:30) 10:11:39 INFO - Working with test: dromaeo_css 10:11:39 INFO - Generating results file: dromaeo_css 10:11:39 INFO - Working with test: kraken 10:11:39 INFO - Generating results file: kraken 10:11:39 INFO - javascript benchmark 10:11:39 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:11:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 10:11:40 INFO - process_Request line: dromaeo_css 7575.51 graph.html#tests=[[72,64,59]] 10:11:40 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:11:40 INFO - process_Request line: kraken 1409.10 graph.html#tests=[[232,64,59]] 10:11:40 INFO - RETURN: dromaeo_css: 7575.51 10:11:40 INFO - RETURN: kraken: 1409.10 10:11:40 INFO - javascript benchmark 10:11:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3390.966090339097, 3406.7104296134826, 3436.106612280808, 3436.329915666446, 3480.9477857832135, 5545.556355491561, 5575.2473416088815, 5606.103023516233, 5630.915536266959, 5634.070378387566, 5638.520725738307, 5642.322921249445, 5685.204071429993, 5779.82660520184, 5810.506106980901, 5068.5438310552045, 5113.233015047745, 5135.075686376451, 5144.3826740791155, 5207.088759467097, 4062.512498500184, 5203.505666961632, 5214.921776173361, 5221.216817477371, 5277.920831187535, 5071.1886098224295, 5096.439391666913, 5150.587952963754, 5160.071187186324, 5167.0, 5167.069927413064, 5178.197379406198, 5178.715170665612, 5179.015986962465, 5191.870203244911, 5134.2812006319145, 5139.331886854685, 5151.356080489939, 5175.327207463043, 5197.324347834795, 5450.100733378988, 5492.148716948879, 5564.165375193753, 5585.329760428734, 5617.466340697627, 6153.784617538365, 6169.413905678954, 6187.102870083858, 6206.813795586139, 6207.596506227081, 6198.411150940653, 6255.562110652256, 6270.749170033238, 6281.120643109968, 6292.716827742763, 5605.187247849039, 5702.885942281173, 5704.8859022819315, 5782.0, 5806.0, 6294.181756371734, 6306.779262725874, 6306.905396419057, 6312.463440607508, 6325.936740632535, 6030.7889223876955, 6035.39646035393, 6089.939100608937, 6094.847628809227, 6108.205933228652, 6086.0, 6141.455323060903, 6187.257529096447, 6230.06549017651, 6261.436470717657, 6125.846853828601, 6130.356312587203, 6132.877342453126, 6134.079888016744, 6140.969295153495, 6135.0, 6160.537959653044, 6171.753129874754, 6173.259208894961, 6174.38256174379, 4768.594669453066, 4778.593819525379, 4821.541953514481, 4823.758812059383, 4847.175980083394, 4306.5262821089655, 4378.408914796461, 4384.583464570925, 4399.36209249657, 4399.934000989988, 5474.945250547444, 5548.5838562108, 5566.888662226814, 5576.470235327637, 5600.075987462104, 6198.81403557885, 6210.844728881814, 6220.409061139185, 6238.438540531374, 6240.095186197976, 4622.560856718606, 5445.700486473203, 5532.612717109763, 5540.972295138579, 5547.057000309957, 4673.065386922561, 5173.974130129325, 5278.604104692164, 5323.574114070865, 5374.677519348774, 6208.286047104641, 6256.843578910563, 6258.0, 6260.373962603703, 6268.059791031382, 6091.451769340781, 6150.0, 6179.660118693515, 6239.688015599111, 6245.250569931637, 5562.471565201299, 6057.666828324484, 6178.62928224308, 6259.499240060693, 6286.8428289291305, 6099.451049405575, 6143.573288551087, 6162.537809664203, 6167.383261673796, 6174.506039516738, 6168.1056246844855, 6170.228721409824, 6243.157173781663, 6244.157038799885, 6247.2815626201755, 5873.295204575478, 5947.553933454921, 5968.731407086605, 6064.090386442069, 6071.939280607314, 4853.781579828846, 5736.139579063174, 5915.0, 5929.970350148222, 5932.525397968066, 5768.826935191951, 5772.797952071657, 5772.855678608068, 5777.480026797609, 5793.391693872083, 5905.763769449174, 5907.261592300963, 5923.49650279731, 5940.61386009908, 6032.939670603238, 5929.140274660064, 5939.0, 5989.880202396015, 5994.970025150021, 6012.488938440281], "unit": "score", "name": "dojo.html", "value": 5613.089504081553}, {"lowerIsBetter": false, "replicates": [438.4147163536678, 470.47776967565994, 560.0982418306526, 570.8554348531194, 584.6871923520918, 30260.546091808614, 31041.84479077607, 38184.61815381849, 38487.037824054416, 38712.0, 41924.161516769644, 42217.36673949893, 42386.78806605963, 42410.36384454236, 42540.36189457161, 9474.526273686306, 9701.90298097017, 9704.41773493589, 9707.61169553217, 9709.563069661846, 9509.286803489766, 9548.331616786827, 9633.27750418718, 9647.276454265922, 9665.806683866318, 9774.071463210983, 9839.55721992512, 9842.311038227326, 9848.852267215962, 9850.359726617782, 9698.51507424626, 9747.805043899118, 9751.561179746928, 9766.414015159113, 9767.16979056781, 9670.75823104421, 9770.658026969093, 9801.215902727765, 9806.705798825975, 9815.950920245425, 40596.188076238606, 41107.0, 41193.97015074647, 41221.0, 41280.1743965119, 3120.0, 3320.684534969174, 3337.8998630041137, 3338.4992251162275, 3561.5370001899587, 24755.0, 25313.62029569558, 27073.917043318244, 30227.848860755556, 30284.0, 2707.945841083187, 2820.0552814807065, 2847.5586284125993, 2851.8431486268246, 2853.843038632874, 472126.0, 472885.0, 473564.0, 475669.0, 475944.0, 61998.69000654968, 62350.0, 62725.0, 62814.37185628177, 62823.6858815703, 68357.31642683609, 68771.65614171997, 69009.0, 69062.65468672726, 69115.65442172857, 13867.514636987657, 17103.57241068983, 17113.828861711474, 17124.315027398763, 17144.057076860892, 13039.869601303866, 13077.738445231042, 13078.346082695827, 13093.148945318524, 13106.80339794904, 19866.304679336154, 20288.087036083412, 20306.59386812285, 20325.18699252013, 20336.69494957577, 6865.656717164222, 8275.420720549504, 8399.95800020996, 8414.579271036424, 8485.787855303543, 927.3045216087934, 931.1293940165966, 1015.1422048369117, 1023.7747695506977, 1045.749020235138, 23001.0, 28849.990250341136, 29664.703352966626, 29669.406611867642, 29843.552346714816, 879.7536689726886, 964.8745663063897, 1033.7105610429091, 1090.487470888681, 1092.5083712329483, 13239.0, 14308.356123974447, 14351.712965740626, 14645.0, 14720.969532132647, 369848.0, 377330.0, 381883.0, 382757.0, 383184.0, 57750.4224957745, 58975.705121474115, 59073.0, 59141.112883306785, 59207.0, 1170.39724541861, 1186.3593659423987, 1274.3564499927663, 1290.6386211860695, 1399.5801259622276, 23659.053637854293, 26597.601035984088, 28124.29689257703, 28363.149105526867, 28985.7101428983, 45520.77239613781, 45775.77112114418, 45824.39614613473, 45883.770581146884, 45976.540234598564, 304329.0, 314490.0, 314688.0, 315386.0, 315616.0, 22813.657795132753, 32492.675073248964, 32628.0, 32793.50809737904, 33605.495917560766, 41094.0, 41534.79232603818, 41551.58448415477, 42301.36547951722, 42943.0, 32655.510167347984, 33830.815921442634, 36040.0, 36405.45391819072, 36843.63156368509, 33839.49240761341, 35716.28567428689, 35909.46135807913, 36242.456363154044, 36783.81608091942, 35243.82378088093, 35746.10634734049, 35791.0, 36242.10731551207, 36692.81653591822, 30965.69034309628, 31614.0, 31814.840925795223, 31867.681323186473, 31928.6807131935, 23924.476333988478, 24131.396715082265, 24132.56404155759, 24283.27150185497, 24382.26853194407], "unit": "score", "name": "ext.html", "value": 18972.68551936862}, {"lowerIsBetter": false, "replicates": [347.6263017256449, 351.83287938229336, 352.58395093789335, 354.48245561480235, 360.74026700775465, 19201.61596768064, 19496.0, 20875.060622271998, 21354.572908541857, 21363.893180534076, 19258.22967081315, 20272.8986355068, 20368.592628147428, 20384.184632614713, 21033.47416314593, 6456.0, 6623.072769812206, 6691.397774200321, 6693.464522838186, 6697.8995315070315, 4548.603669386388, 5544.6118771686, 6608.834779130512, 7600.847983040336, 7605.80985475362, 7503.324700776929, 7513.962430187841, 7583.9241607584045, 7584.886226706604, 7601.543907365576, 7315.926840731578, 7491.850162996737, 7510.849783004364, 7518.924810751932, 7527.849443011164, 4452.220861349251, 6870.244273129952, 7174.92825071753, 7190.388816950565, 7193.0, 20324.79675203244, 26370.86814565934, 26497.73502264972, 27737.44525109507, 27787.444251115066, 2045.7442819647545, 2183.6724491326268, 2213.833962452806, 2391.6651668766385, 2458.704955405345, 15325.0, 15596.908216424854, 15606.0, 15679.529614111594, 16189.433369831999, 1819.8635102367375, 1915.7126431035317, 1915.7605299337583, 1952.0532541717255, 1968.6161198566285, 98539.0, 105881.0, 109190.27024324455, 112756.30865536942, 115580.42209788981, 18148.455546333633, 18704.0, 18927.485801135877, 18936.810631893506, 18984.525386865163, 27793.861030695123, 27831.16506504808, 27848.582271265946, 27855.543113101805, 27893.302667433072, 10105.595776168871, 10504.579816807394, 10511.84232236517, 10633.627823026158, 10644.733881652866, 9030.232430243503, 9037.819243615091, 9055.547222638974, 9058.230050445654, 9172.312076594282, 8254.092049874509, 8351.457155284887, 8396.118407567239, 8400.957995209985, 8431.662733490592, 2797.888084476639, 3306.239564900038, 3318.2699806042633, 3327.0, 3445.707114895212, 847.4025811802665, 874.6719980007497, 895.2703546609492, 935.3031991166624, 1051.5846240734868, 18139.45581632553, 18480.168392422373, 18680.0, 18746.0, 19132.043397830053, 864.2006144316482, 886.255545341903, 898.2275243290765, 928.6424726480219, 933.3326671429825, 9744.853827192597, 10289.97100289965, 10365.118964887919, 10425.843612345821, 10456.738581535523, 502519.0, 505992.0, 508146.0, 550641.0, 589943.0, 124360.37819811024, 125000.0, 130072.0, 130852.0, 134276.0, 961.274237950343, 993.60752502761, 1006.3659894266565, 1009.2733232072895, 1036.409246729357, 17463.650726985645, 17611.03139327298, 17844.375446859296, 18071.186796593924, 18174.636507269515, 50440.74779626078, 50800.491995079574, 51539.0, 51721.0, 52425.47574524206, 73402.26597734168, 73901.6304918472, 76108.61945690236, 77409.0, 78529.21470785448, 7696.422768292288, 7855.018122734658, 7868.449208555575, 7989.960050199712, 8214.507129572006, 9247.352685311964, 9772.462514561767, 12942.352882356034, 13219.66950826237, 13249.271290079138, 10991.175661825235, 11304.604338848101, 11305.26515776472, 11342.659720208407, 11385.203035787416, 10778.514966826668, 11198.38408887519, 11214.943925280322, 11318.547258109584, 11424.371659558805, 11234.382108984084, 11479.36863472517, 11791.115666324888, 12016.699582510508, 12034.0, 7827.295543401121, 7840.01116015818, 7929.5242285460745, 7999.200079991954, 8025.9598702006115, 11217.0, 11408.201425900108, 11616.303021818718, 11726.530938762355, 11740.178187526792], "unit": "score", "name": "jquery.html", "value": 10489.174177021172}, {"lowerIsBetter": false, "replicates": [1298.2023738842793, 1363.8772510474068, 1565.9608509787258, 1737.331127515906, 1923.8268555829964, 6506.609603423798, 8445.0, 8485.91514084859, 8581.442206256588, 8603.354748393873, 8311.293540049102, 8535.231829135377, 8543.91456085439, 8546.188112129337, 8550.52972086535, 2403.7716416940407, 2435.0990133650575, 2435.2694191742494, 2436.744141865105, 2438.317271164068, 2398.1126983016306, 2414.5774489464275, 2443.144899285254, 2452.3869032741813, 2452.6075827867544, 2417.4802417480237, 2443.633454981758, 2445.4742230420457, 2448.0574978633267, 2449.3876530867283, 2401.9639705404434, 2432.525657496789, 2442.474867903409, 2444.5966415541416, 2446.425090103824, 2392.0670938334065, 2435.5250726108416, 2444.792192663626, 2447.816413768957, 2448.424620214248, 8610.397272190949, 8666.176713212235, 8678.0, 8696.434731742416, 8706.738797836075, 5301.231321458367, 5456.890862182734, 5461.18082287656, 5468.425815289417, 5476.479734425223, 3540.8406621702084, 3601.567811862567, 3671.81640917953, 3674.8530058797614, 3682.447632855093, 988.7132731507854, 1056.915446764257, 1059.7244716373798, 1062.7502536903821, 1070.5717712914818, 11724.237924534878, 11739.530418783239, 11742.530298788039, 11751.764964700658, 11765.11761617882, 3856.382978723391, 4742.715437073786, 4784.784684689197, 4785.665003449725, 4799.616030717534, 8424.368172387096, 9976.60327554143, 10036.096751292418, 10051.195904327782, 10052.64815731446, 5297.231901374279, 5325.627206095536, 5341.278927344759, 5347.0909945309395, 5351.464853514695, 4367.737935723867, 4535.659825513099, 4735.715857048588, 4845.442774080955, 4889.608831293488, 3489.4242449995468, 3610.627961374661, 3869.4582758413844, 3875.6124387561017, 3925.156091440354, 1250.4310538704867, 1252.3800718644147, 1260.3194275091348, 1262.4823822233025, 1264.9241045537296, 963.4460185393427, 989.4508547756064, 1152.7809716153904, 1189.149757923089, 1305.2038256663427, 7952.602369881482, 8058.879116813252, 8080.757577272691, 8088.029436467662, 8123.878141827878, 877.6621000914566, 1157.8842115788354, 1183.4910988274953, 1202.374765122149, 1212.563477148226, 6129.785457508966, 6280.591761535577, 6335.049742538564, 6350.872982540323, 6368.14030105939, 10314.226433017553, 10771.138308935266, 10772.515236814363, 10780.78438431227, 10798.082163016075, 10331.01855323743, 10468.842967355497, 10542.0, 10634.149268058536, 10664.520096595672, 8160.67357305713, 8289.253967142866, 8291.419600627898, 8293.917060829435, 8331.6667333306, 7611.162772094955, 7845.411594130349, 7851.097123830604, 7860.3318717909615, 7861.724839630586, 9324.207442367204, 9389.953050234704, 9605.37565058269, 9706.611735530782, 9720.562574684298, 9697.32118751709, 9943.950280248553, 10128.088472037552, 10141.391516509033, 10179.236557258087, 7151.177614574391, 7460.477766556506, 7465.589392583242, 7468.7593721884305, 7472.551646900986, 8172.060213075572, 8175.754727358189, 8253.13342099095, 8270.421070525246, 8280.0, 6291.339409361951, 7287.27127287267, 7314.926850731425, 7372.594507301936, 7410.4442166836625, 6027.397260274113, 7239.239879812754, 7241.239669834592, 7259.637018148966, 7306.41548676094, 7649.617519124133, 7711.190325016017, 7719.768406947801, 7723.150453450228, 7723.575203363869, 6577.309382514958, 6912.758053468105, 6983.9650801745665, 6991.755288564876, 6994.985727069445, 6959.0257363970095, 6991.9300806993315, 7008.509404341851, 7033.402160816388, 7040.225575186623], "unit": "score", "name": "mootools.html", "value": 4859.4354796183825}, {"lowerIsBetter": false, "replicates": [309.4646261966797, 314.9794665284479, 318.4029943855272, 323.1968558133039, 324.68829923273654, 6495.123158373618, 6570.277269500357, 6624.436922861551, 6640.369164929336, 6654.833629159273, 6530.771423000196, 6577.473802095833, 6579.94720844665, 6587.8023659290175, 6602.0, 4673.088747694201, 4774.618030557547, 4792.520747925215, 4898.216285394329, 4924.433690125627, 4856.814433504919, 4888.535589119028, 4890.584300334476, 4913.8771530711665, 4922.80308787648, 4852.563269305761, 4854.854354369357, 4858.101251268509, 4858.368412106439, 4898.314236006961, 4624.699394539361, 4698.154332220199, 4855.053264613366, 4874.268859671042, 4882.41411030675, 4177.707560470768, 4198.181354635847, 4199.349100889367, 4205.222033923734, 4206.957930420718, 6324.968375158141, 6339.95390760524, 6357.459615932651, 6357.713902874381, 6368.77709280173, 5711.742971566289, 5719.227904232958, 5721.9427805721825, 5724.570657200685, 5725.427457254283, 6979.616121113337, 6981.301869813029, 6993.47548933832, 7001.229864714877, 7006.824829379255, 4326.199653064194, 4480.910381792379, 4486.439195100613, 4504.8873778155485, 4518.932216016762, 7202.847544392925, 7269.89095163573, 7362.190159082496, 7416.369608583277, 7418.925810741932, 3850.5186851643543, 4540.069285796404, 4541.455025396974, 4541.6593755468475, 4544.386507821468, 4581.473130589959, 4587.678862479661, 4595.172868883633, 4598.287265473857, 4618.884527886829, 5518.310211223597, 5528.474794894479, 5530.170474428868, 5530.55755539564, 5533.806316778893, 6748.696308666122, 6982.47631427645, 7011.4741394394605, 7019.052427922165, 7037.718491260394, 1323.9602811915659, 1481.3704924583087, 1589.3721979817908, 1604.0696396090239, 1605.590574403543, 926.3700683535261, 957.5355952363099, 1017.1747573779872, 1033.813913495563, 1036.2435422141727, 6288.182536270256, 6384.138141350858, 6490.286068532458, 6554.4101030906495, 6579.934200657932, 7322.926770732331, 7327.926720732831, 7329.780106596811, 7333.376662983599, 7337.339639432476, 6525.184351956005, 6538.607683539003, 6539.836504087436, 6545.410913017851, 6548.443382312462, 3594.263176048904, 3808.3716186829415, 3847.5575308839284, 3848.13416981177, 3854.6338097880657, 7320.67056982437, 7651.0, 7652.196519365387, 7693.615319234016, 7697.153313135551, 7514.9624251878395, 7556.433267504959, 7559.1684914659345, 7569.5079819811535, 7574.810629734301, 5692.715364231854, 6116.999999999911, 7647.464677472635, 7651.540907545454, 7658.502197357154, 6296.622202667854, 6842.46044639952, 6996.545224560387, 7251.347378735939, 7269.273072692688, 7199.964000179965, 7217.422606191387, 7247.528910620793, 7255.854882902207, 7274.4907856449545, 7623.352015078781, 7635.885461717968, 7649.426293028157, 7659.387249020177, 7673.736247806799, 4571.542845715402, 4582.175208462509, 4582.931256031229, 4585.380973568659, 4601.723896566216, 7036.9296307036275, 7284.125904891447, 7304.086989126359, 7309.086364204474, 7335.523190992569, 7043.647817608997, 7060.576365418091, 7061.71753129869, 7076.787696369117, 7086.893696594659, 5728.684922329312, 6976.0, 7024.367806897404, 7032.261612530815, 7050.0, 6841.965790171017, 6853.246142924374, 6855.058341453784, 6855.5543889647015, 7008.159020917318, 6790.253072162157, 7022.578645281299, 7039.718411263492, 7062.187848397294, 7072.752453664097, 6716.597004179765, 6811.455083593201, 6875.346842050198, 6922.203946546211, 6932.850816246778], "unit": "score", "name": "prototype.html", "value": 5098.865311012119}, {"lowerIsBetter": false, "replicates": [626.5958456795366, 719.0616245799232, 723.0, 740.8370158565117, 758.4425447296236, 14767.852321476783, 14867.107973521597, 14929.477468288613, 14955.925220373883, 14998.700025999473, 13641.18152910826, 13863.584092477242, 13863.792043119336, 13871.098378605384, 13880.236586987712, 726.956382617042, 727.9708811647528, 842.540815255684, 859.6131740716671, 881.7310720230328, 872.5462759365126, 880.6917578847416, 881.0792721605937, 881.3566096749377, 882.2765332427412, 928.5450129436562, 931.1991687149047, 932.1191474057019, 932.1517419148577, 932.3520153493325, 746.3805041815308, 752.3191511681937, 753.6872198037807, 891.2513488669484, 905.5653286422521, 678.3623394009616, 679.9830004249884, 680.5406350713298, 681.5399605266475, 683.2723149845399, 14800.111993280438, 14863.479778207819, 14885.106893586419, 14904.850951490454, 14908.850911490854, 12608.676089010705, 12711.046671499582, 12829.486820527261, 13005.284709340982, 13102.737945241137, 9904.547110217378, 10014.49927503622, 10088.848667269996, 10115.039071288216, 10401.739956501073, 3475.565554305712, 3518.1556426457464, 3539.557555305587, 3552.573691157052, 3605.4231322988194, 81848.0, 82011.5899420499, 83567.16432835655, 83764.0, 84119.5794021026, 7816.726414575576, 9469.952650236704, 9475.384100033614, 9766.804663906823, 9794.069563391466, 21821.890890545445, 22000.229991950204, 22197.445063873532, 22263.0, 22370.55258894813, 7362.042934418491, 7449.217832127657, 7497.775066748006, 7498.362639175732, 7688.807779805437, 3932.4297976793205, 3991.9002024949027, 3996.320625493673, 4045.6358927696647, 4271.060366719316, 3492.842822073013, 3541.6281290464644, 3566.661167189113, 3575.9284814304087, 3579.534660494119, 616.9136320915076, 632.1844820182006, 633.8478765096344, 634.3783092569216, 641.425923798198, 525.5296509623942, 568.2868000659229, 572.481903876992, 581.0499832773446, 587.6943989125716, 8143.552104634302, 8184.959075204586, 8185.386096042821, 8301.46040507365, 8341.499510029418, 558.1683291895047, 580.9941900581025, 590.8138936235158, 598.8622616798161, 604.921360223177, 3690.2435000824767, 3823.6749876260274, 3856.5564960029956, 3910.569837317893, 3951.7233793634746, 54736.0, 90764.0, 95017.524912375, 95182.04817951871, 95432.0, 79785.0, 79869.40261194743, 80477.59761201157, 81541.77687334694, 83895.58052209699, 69380.6530967352, 70023.0, 71161.0, 71193.6440317795, 75382.24617753862, 7246.384057355184, 8204.876926845982, 8446.535440550582, 8506.489610623383, 8663.870041949502, 38009.0, 48185.75907120442, 48593.5140648589, 48804.85158761545, 49413.25880111873, 69071.0, 69397.65301173461, 71200.28799711936, 73845.0, 74898.0, 9719.9028009719, 10884.292520986111, 10977.890221097687, 11147.146310647713, 11532.88467115318, 11731.0, 11993.280403175837, 12004.279743215435, 12390.876091239334, 12737.55418560346, 9696.75758106053, 11168.66494005181, 11207.935246151603, 11516.42417879086, 12398.00815934705, 11294.378809165575, 11359.54561817518, 11492.36791976416, 11501.597444089417, 11541.192116551762, 11249.268797528135, 11307.43462826839, 11321.490532925873, 11568.768624627628, 11575.305481671126, 9379.437233765995, 9587.712368628674, 9712.805743884941, 9794.020597940149, 9989.750256243362, 8837.91162088371, 9151.3136514763, 9233.117511497794, 9681.661141860282, 9842.311038227255], "unit": "score", "name": "yui.html", "value": 6828.166278025461}], "name": "dromaeo_css", "value": 7575.510292936191}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 111.0, 112.0, 110.0, 115.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [156.0, 121.0, 145.0, 156.0, 118.0, 141.0, 139.0, 117.0, 158.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 136.8}, {"lowerIsBetter": true, "replicates": [185.0, 185.0, 186.0, 186.0, 184.0, 184.0, 184.0, 183.0, 191.0, 181.0], "unit": "score", "name": "audio-dft", "value": 184.9}, {"lowerIsBetter": true, "replicates": [74.0, 102.0, 118.0, 105.0, 55.0, 58.0, 57.0, 81.0, 77.0, 62.0], "unit": "score", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 128.0, 80.0, 76.0, 79.0, 117.0, 76.0, 78.0, 116.0], "unit": "score", "name": "audio-oscillator", "value": 93.8}, {"lowerIsBetter": true, "replicates": [91.0, 86.0, 90.0, 88.0, 90.0, 87.0, 91.0, 87.0, 90.0, 86.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.6}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 96.0, 94.0, 90.0, 133.0], "unit": "score", "name": "imaging-darkroom", "value": 98.0}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 87.0, 85.0, 87.0, 84.0, 85.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.4}, {"lowerIsBetter": true, "replicates": [52.0, 54.0, 54.0, 54.0, 52.0, 54.0, 53.0, 62.0, 54.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 54.0}, {"lowerIsBetter": true, "replicates": [64.0, 71.0, 65.0, 74.0, 72.0, 70.0, 68.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 82.0, 83.0, 84.0, 81.0, 85.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [124.0, 132.0, 127.0, 116.0, 118.0, 120.0, 112.0, 117.0, 120.0, 146.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [139.0, 141.0, 131.0, 140.0, 134.0, 126.0, 139.0, 137.0, 139.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 65.0, 66.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1409.1000000000001}]} 10:11:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1409.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7575.51"}}} 10:11:40 INFO - Return code: 0 10:11:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:11:40 INFO - # TBPL SUCCESS # 10:11:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:11:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:11:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:11:40 INFO - 2016-03-02 10:11:40.439 screenresolution[1995:20869] starting screenresolution argv=screenresolution get 10:11:40 INFO - 2016-03-02 10:11:40.442 screenresolution[1995:20869] Display 0: 1600x1200x32@60 10:11:40 INFO - 2016-03-02 10:11:40.448 screenresolution[1996:20872] starting screenresolution argv=screenresolution list 10:11:40 INFO - Available Modes on Display 0 10:11:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:11:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:11:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:11:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:11:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:11:40 INFO - Intel Iris: 10:11:40 INFO - Chipset Model: Intel Iris 10:11:40 INFO - Type: GPU 10:11:40 INFO - Bus: Built-In 10:11:40 INFO - VRAM (Dynamic, Max): 1536 MB 10:11:40 INFO - Vendor: Intel (0x8086) 10:11:40 INFO - Device ID: 0x0a2e 10:11:40 INFO - Revision ID: 0x0009 10:11:40 INFO - Displays: 10:11:40 INFO - Display: 10:11:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:11:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:11:40 INFO - Display Serial Number: 1600x1200 60 10:11:40 INFO - Main Display: Yes 10:11:40 INFO - Mirror: Off 10:11:40 INFO - Online: Yes 10:11:40 INFO - Rotation: Supported 10:11:40 INFO - Return code: 0 10:11:40 INFO - Running post-action listener: _resource_record_post_action 10:11:40 INFO - Running post-run listener: _resource_record_post_run 10:11:41 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 106496; Write bytes: 707840512; Read time: 5; Write time: 2119 10:11:41 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 383904256; Write bytes: 379929600; Read time: 29756; Write time: 759 10:11:41 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 106496; Write bytes: 301207552; Read time: 5; Write time: 1315 10:11:41 INFO - Running post-run listener: _upload_blobber_files 10:11:41 INFO - Blob upload gear active. 10:11:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:41 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 10:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:11:42 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:11:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:11:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:42 INFO - (blobuploader) - INFO - Done attempting. 10:11:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:11:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:11:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:44 INFO - (blobuploader) - INFO - Done attempting. 10:11:44 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:44 INFO - Return code: 0 10:11:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b367781ad4d7b5077b32337bb3da17dfedde3efa5496e1446c0aa7c2ab6410badea5cb62a0df796e042f08b9829887144844e6d7aa6a0ce954b4495f46051cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/615060f14285cfc54a7b0e0da0a2fac981794420a25300da44712ff525256fc9388f954fc76577b5433750e83d051a79bd5410e45e8d3f1ffae77cc4a2bb6687"} 10:11:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:44 INFO - Contents: 10:11:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b367781ad4d7b5077b32337bb3da17dfedde3efa5496e1446c0aa7c2ab6410badea5cb62a0df796e042f08b9829887144844e6d7aa6a0ce954b4495f46051cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/615060f14285cfc54a7b0e0da0a2fac981794420a25300da44712ff525256fc9388f954fc76577b5433750e83d051a79bd5410e45e8d3f1ffae77cc4a2bb6687"} 10:11:44 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:44 INFO - Copying logs to upload dir... 10:11:44 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.990626 ========= master_lag: 0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-02 10:11:44.449639) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:44.455572) ========= 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.YQUtIUzIbe/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.HIbOW9po78/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b367781ad4d7b5077b32337bb3da17dfedde3efa5496e1446c0aa7c2ab6410badea5cb62a0df796e042f08b9829887144844e6d7aa6a0ce954b4495f46051cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/615060f14285cfc54a7b0e0da0a2fac981794420a25300da44712ff525256fc9388f954fc76577b5433750e83d051a79bd5410e45e8d3f1ffae77cc4a2bb6687"} build_url:https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010963 build_url: 'https://queue.taskcluster.net/v1/task/c43-PgsoTkaDfaoamuIpzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b367781ad4d7b5077b32337bb3da17dfedde3efa5496e1446c0aa7c2ab6410badea5cb62a0df796e042f08b9829887144844e6d7aa6a0ce954b4495f46051cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/615060f14285cfc54a7b0e0da0a2fac981794420a25300da44712ff525256fc9388f954fc76577b5433750e83d051a79bd5410e45e8d3f1ffae77cc4a2bb6687"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:44.487124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:44.487495) ========= 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.YQUtIUzIbe/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.HIbOW9po78/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.005184 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 10:11:44.535907) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 10:11:44.536228) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 10:11:44.536620) ========= ========= Total master_lag: 5.94 =========