builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0134 starttime: 1455022769.24 results: success (0) buildid: 20160209035955 builduid: 8898ca4e253f4f3d8915b4fe0b04b629 revision: 7a0ebe3fccacc655c38e7f32948626af4d3d3269 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.235447) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.235868) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.236154) ========= 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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005505 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.258097) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.258402) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.273314) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.273620) ========= 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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005388 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.388621) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.388941) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.389301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.389573) ========= 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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-09 04:59:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.38M=0.001s 2016-02-09 04:59:29 (8.38 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181387 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.676341) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.676686) ========= 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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.019789 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:29.710748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 04:59:29.711138) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7a0ebe3fccacc655c38e7f32948626af4d3d3269 --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 7a0ebe3fccacc655c38e7f32948626af4d3d3269 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b4UxRMwXuc/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.QvEJVnnOPr/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-09 04:59:29,786 truncating revision to first 12 chars 2016-02-09 04:59:29,786 Setting DEBUG logging. 2016-02-09 04:59:29,786 attempt 1/10 2016-02-09 04:59:29,786 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7a0ebe3fccac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-09 04:59:30,690 unpacking tar archive at: fx-team-7a0ebe3fccac/testing/mozharness/ program finished with exit code 0 elapsedTime=1.151621 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-09 04:59:30.878359) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:30.878710) ========= echo 7a0ebe3fccacc655c38e7f32948626af4d3d3269 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7a0ebe3fccacc655c38e7f32948626af4d3d3269'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b4UxRMwXuc/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.QvEJVnnOPr/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 7a0ebe3fccacc655c38e7f32948626af4d3d3269 program finished with exit code 0 elapsedTime=0.005136 script_repo_revision: '7a0ebe3fccacc655c38e7f32948626af4d3d3269' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:30.928315) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:30.928602) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-09 04:59:30.939561) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-09 04:59:30.939842) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b4UxRMwXuc/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.QvEJVnnOPr/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:59:31 INFO - MultiFileLogger online at 20160209 04:59:31 in /builds/slave/test 04:59:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:59:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:59:31 INFO - {'append_to_log': False, 04:59:31 INFO - 'base_work_dir': '/builds/slave/test', 04:59:31 INFO - 'blob_upload_branch': 'Fx-Team', 04:59:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:59:31 INFO - 'branch': 'Fx-Team', 04:59:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:59:31 INFO - 'config_files': ('talos/mac_config.py',), 04:59:31 INFO - 'default_actions': ('clobber', 04:59:31 INFO - 'read-buildbot-config', 04:59:31 INFO - 'download-and-extract', 04:59:31 INFO - 'populate-webroot', 04:59:31 INFO - 'create-virtualenv', 04:59:31 INFO - 'install', 04:59:31 INFO - 'run-tests'), 04:59:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:59:31 INFO - 'download_minidump_stackwalk': True, 04:59:31 INFO - 'download_symbols': 'ondemand', 04:59:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:59:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:59:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:59:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:59:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:59:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:59:31 INFO - 'installer_path': 'installer.exe', 04:59:31 INFO - 'log_level': 'info', 04:59:31 INFO - 'log_name': 'talos', 04:59:31 INFO - 'log_to_console': True, 04:59:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:59:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:59:31 INFO - 'opt_config_files': (), 04:59:31 INFO - 'pip_index': False, 04:59:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:59:31 INFO - 'cmd': ('bash', 04:59:31 INFO - '-c', 04:59:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:59:31 INFO - 'enabled': True, 04:59:31 INFO - 'halt_on_failure': False, 04:59:31 INFO - 'name': 'check_screen_resolution'},), 04:59:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:59:31 INFO - 'cmd': ('bash', 04:59:31 INFO - '-c', 04:59:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:59:31 INFO - 'enabled': True, 04:59:31 INFO - 'halt_on_failure': False, 04:59:31 INFO - 'name': 'check_screen_resolution'},), 04:59:31 INFO - 'run_cmd_checks_enabled': True, 04:59:31 INFO - 'sps_profile': False, 04:59:31 INFO - 'sps_profile_interval': 0, 04:59:31 INFO - 'suite': 'dromaeojs-e10s', 04:59:31 INFO - 'system_bits': '32', 04:59:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:59:31 INFO - 'title': 't-yosemite-r7-0134', 04:59:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:59:31 INFO - 'use_talos_json': True, 04:59:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:59:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:59:31 INFO - 'work_dir': 'build'} 04:59:31 INFO - ##### 04:59:31 INFO - ##### Running clobber step. 04:59:31 INFO - ##### 04:59:31 INFO - Running pre-action listener: _resource_record_pre_action 04:59:31 INFO - Running main action method: clobber 04:59:31 INFO - rmtree: /builds/slave/test/build 04:59:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:59:31 INFO - Running post-action listener: _resource_record_post_action 04:59:31 INFO - ##### 04:59:31 INFO - ##### Running read-buildbot-config step. 04:59:31 INFO - ##### 04:59:31 INFO - Running pre-action listener: _resource_record_pre_action 04:59:31 INFO - Running main action method: read_buildbot_config 04:59:31 INFO - Using buildbot properties: 04:59:31 INFO - { 04:59:31 INFO - "project": "", 04:59:31 INFO - "product": "firefox", 04:59:31 INFO - "script_repo_revision": "production", 04:59:31 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:59:31 INFO - "repository": "", 04:59:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:59:31 INFO - "buildid": "20160209035955", 04:59:31 INFO - "pgo_build": "False", 04:59:31 INFO - "basedir": "/builds/slave/test", 04:59:31 INFO - "buildnumber": 349, 04:59:31 INFO - "slavename": "t-yosemite-r7-0134", 04:59:31 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:59:31 INFO - "platform": "yosemite_r7", 04:59:31 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:59:31 INFO - "branch": "fx-team", 04:59:31 INFO - "repo_path": "integration/fx-team", 04:59:31 INFO - "revision": "7a0ebe3fccacc655c38e7f32948626af4d3d3269", 04:59:31 INFO - "stage_platform": "macosx64", 04:59:31 INFO - "builduid": "8898ca4e253f4f3d8915b4fe0b04b629", 04:59:31 INFO - "slavebuilddir": "test" 04:59:31 INFO - } 04:59:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:59:31 INFO - Running post-action listener: _resource_record_post_action 04:59:31 INFO - ##### 04:59:31 INFO - ##### Running download-and-extract step. 04:59:31 INFO - ##### 04:59:31 INFO - Running pre-action listener: _resource_record_pre_action 04:59:31 INFO - Running main action method: download_and_extract 04:59:31 INFO - mkdir: /builds/slave/test/build/tests 04:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:31 INFO - https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:59:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/test_packages.json 04:59:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/test_packages.json 04:59:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:59:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:59:33 INFO - Downloaded 1277 bytes. 04:59:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:59:33 INFO - Using the following test package requirements: 04:59:33 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:59:33 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:59:33 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:59:33 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:59:33 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:59:33 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:59:33 INFO - u'jsshell-mac.zip'], 04:59:33 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:59:33 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:59:33 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:59:33 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:59:33 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:59:33 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:59:33 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:59:33 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:59:33 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:59:33 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:59:33 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:59:33 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:59:33 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:33 INFO - https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:59:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:59:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:59:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/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 04:59:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/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 04:59:34 INFO - Downloaded 17753854 bytes. 04:59:34 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'] 04:59:34 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 04:59:37 INFO - Return code: 0 04:59:37 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 04:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:37 INFO - https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/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 04:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/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 04:59:38 INFO - Downloaded 17753854 bytes. 04:59:38 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'] 04:59:38 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 04:59:42 INFO - Return code: 0 04:59:42 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')]} 04:59:42 INFO - https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/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 04:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/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 04:59:43 INFO - Downloaded 10706547 bytes. 04:59:43 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'] 04:59:43 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 04:59:43 INFO - Return code: 0 04:59: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')]} 04:59:43 INFO - https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:59:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:59:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:59:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:59:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MbSExAXcTWyPO8B7SuHF7A/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 04:59:46 INFO - Downloaded 111838973 bytes. 04:59:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:59:46 INFO - mkdir: /builds/slave/test/properties 04:59:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:59:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:59:46 INFO - Contents: 04:59:46 INFO - build_url:https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:59:47 INFO - Running post-action listener: _resource_record_post_action 04:59:47 INFO - Running post-action listener: set_extra_try_arguments 04:59:47 INFO - ##### 04:59:47 INFO - ##### Running populate-webroot step. 04:59:47 INFO - ##### 04:59:47 INFO - Running pre-action listener: _resource_record_pre_action 04:59:47 INFO - Running main action method: populate_webroot 04:59:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:59:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:59:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:59:47 INFO - '--tppagecycles', 04:59:47 INFO - '7'], 04:59:47 INFO - 'tests': ['tsvgm']}}, 04:59:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:59:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:59:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:59:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:59:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:59:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:59:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:47 INFO - 'talos_options': ['--e10s'], 04:59:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:59:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:47 INFO - 'tests': ['damp', 'tps']}, 04:59:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:47 INFO - 'talos_options': ['--e10s'], 04:59:47 INFO - 'tests': ['damp', 'tps']}, 04:59:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:59:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:59:47 INFO - 'other': {'tests': ['a11yr', 04:59:47 INFO - 'ts_paint', 04:59:47 INFO - 'tpaint', 04:59:47 INFO - 'sessionrestore', 04:59:47 INFO - 'sessionrestore_no_auto_restore']}, 04:59:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:59:47 INFO - 'tests': ['a11yr', 04:59:47 INFO - 'ts_paint', 04:59:47 INFO - 'tpaint', 04:59:47 INFO - 'sessionrestore', 04:59:47 INFO - 'sessionrestore_no_auto_restore']}, 04:59:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:59:47 INFO - 'tests': ['a11yr', 04:59:47 INFO - 'ts_paint', 04:59:47 INFO - 'tpaint', 04:59:47 INFO - 'sessionrestore', 04:59:47 INFO - 'sessionrestore_no_auto_restore']}, 04:59:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:59:47 INFO - 'tests': ['a11yr', 04:59:47 INFO - 'ts_paint', 04:59:47 INFO - 'tpaint', 04:59:47 INFO - 'sessionrestore', 04:59:47 INFO - 'sessionrestore_no_auto_restore']}, 04:59:47 INFO - 'other_l64': {'tests': ['a11yr', 04:59:47 INFO - 'ts_paint', 04:59:47 INFO - 'tpaint', 04:59:47 INFO - 'sessionrestore', 04:59:47 INFO - 'sessionrestore_no_auto_restore']}, 04:59:47 INFO - 'other_nol64': {'tests': ['a11yr', 04:59:47 INFO - 'ts_paint', 04:59:47 INFO - 'tpaint', 04:59:47 INFO - 'sessionrestore', 04:59:47 INFO - 'sessionrestore_no_auto_restore']}, 04:59:47 INFO - 'svgr': {'tests': ['tsvgx', 04:59:47 INFO - 'tsvgr_opacity', 04:59:47 INFO - 'tart', 04:59:47 INFO - 'tscrollx', 04:59:47 INFO - 'cart']}, 04:59:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:59:47 INFO - 'tests': ['tsvgx', 04:59:47 INFO - 'tsvgr_opacity', 04:59:47 INFO - 'tart', 04:59:47 INFO - 'tscrollx', 04:59:47 INFO - 'cart']}, 04:59:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:47 INFO - 'tests': ['tp5o']}, 04:59:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:47 INFO - 'talos_options': ['--e10s'], 04:59:47 INFO - 'tests': ['tp5o']}, 04:59:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:47 INFO - 'talos_options': ['--xperf_path', 04:59:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:47 INFO - 'tests': ['tp5n']}, 04:59:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:59:47 INFO - 'talos_options': ['--e10s', 04:59:47 INFO - '--xperf_path', 04:59:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:59:47 INFO - 'tests': ['tp5n']}}, 04:59:47 INFO - 'talos.zip': {'path': '', 04:59:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:59:47 INFO - Running post-action listener: _resource_record_post_action 04:59:47 INFO - ##### 04:59:47 INFO - ##### Running create-virtualenv step. 04:59:47 INFO - ##### 04:59:47 INFO - Running pre-action listener: _resource_record_pre_action 04:59:47 INFO - Running main action method: create_virtualenv 04:59:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:59:47 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 04:59:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:59:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:59:47 INFO - Using real prefix '/tools/python27' 04:59:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:59:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:59:51 INFO - Installing pip.................done. 04:59:51 INFO - Return code: 0 04:59:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:51 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 0x102f02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0b5759f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da6d30>, '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 0x102bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d9db20>, '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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:59:51 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 04:59:51 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 04:59:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4UxRMwXuc/Render', 04:59:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:51 INFO - 'HOME': '/Users/cltbld', 04:59:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:51 INFO - 'LOGNAME': 'cltbld', 04:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:51 INFO - 'MOZ_NO_REMOTE': '1', 04:59:51 INFO - 'NO_EM_RESTART': '1', 04:59:51 INFO - 'PAGER': '/bin/cat', 04:59:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:51 INFO - 'PWD': '/builds/slave/test', 04:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:51 INFO - 'SHELL': '/bin/bash', 04:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvEJVnnOPr/Listeners', 04:59:51 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:51 INFO - 'USER': 'cltbld', 04:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:51 INFO - 'XPC_FLAGS': '0x0', 04:59:51 INFO - 'XPC_SERVICE_NAME': '0', 04:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:51 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 04:59:51 INFO - Cleaning up... 04:59:51 INFO - Return code: 0 04:59:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:51 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 0x102f02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0b5759f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da6d30>, '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 0x102bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d9db20>, '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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:59:51 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 04:59:51 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 04:59:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4UxRMwXuc/Render', 04:59:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:51 INFO - 'HOME': '/Users/cltbld', 04:59:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:51 INFO - 'LOGNAME': 'cltbld', 04:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:51 INFO - 'MOZ_NO_REMOTE': '1', 04:59:51 INFO - 'NO_EM_RESTART': '1', 04:59:51 INFO - 'PAGER': '/bin/cat', 04:59:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:51 INFO - 'PWD': '/builds/slave/test', 04:59:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:51 INFO - 'SHELL': '/bin/bash', 04:59:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvEJVnnOPr/Listeners', 04:59:51 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:59:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:51 INFO - 'USER': 'cltbld', 04:59:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:51 INFO - 'XPC_FLAGS': '0x0', 04:59:51 INFO - 'XPC_SERVICE_NAME': '0', 04:59:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:51 INFO - Downloading/unpacking psutil>=0.7.1 04:59:51 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 04:59:51 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 04:59:51 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 04:59:51 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 04:59:51 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 04:59:51 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 04:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:59:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:54 INFO - Installing collected packages: psutil 04:59:54 INFO - Running setup.py install for psutil 04:59:54 INFO - building 'psutil._psutil_osx' extension 04:59:54 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 04:59:54 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 04:59:55 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 04:59:55 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 04:59:55 INFO - building 'psutil._psutil_posix' extension 04:59:55 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 04:59:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:59:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:59:55 INFO - ^ 04:59:55 INFO - 1 warning generated. 04:59:55 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 04:59:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:59:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:59:55 INFO - Successfully installed psutil 04:59:55 INFO - Cleaning up... 04:59:55 INFO - Return code: 0 04:59:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:55 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 0x102f02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0b5759f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da6d30>, '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 0x102bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d9db20>, '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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:59:55 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 04:59:55 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 04:59:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4UxRMwXuc/Render', 04:59:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:55 INFO - 'HOME': '/Users/cltbld', 04:59:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:55 INFO - 'LOGNAME': 'cltbld', 04:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:55 INFO - 'MOZ_NO_REMOTE': '1', 04:59:55 INFO - 'NO_EM_RESTART': '1', 04:59:55 INFO - 'PAGER': '/bin/cat', 04:59:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:55 INFO - 'PWD': '/builds/slave/test', 04:59:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:55 INFO - 'SHELL': '/bin/bash', 04:59:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvEJVnnOPr/Listeners', 04:59:55 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:59:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:55 INFO - 'USER': 'cltbld', 04:59:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:55 INFO - 'XPC_FLAGS': '0x0', 04:59:55 INFO - 'XPC_SERVICE_NAME': '0', 04:59:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:59:55 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 04:59:55 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 04:59:55 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 04:59:55 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 04:59:55 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 04:59:55 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 04:59:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:59:58 INFO - Installing collected packages: mozsystemmonitor 04:59:58 INFO - Running setup.py install for mozsystemmonitor 04:59:58 INFO - Successfully installed mozsystemmonitor 04:59:58 INFO - Cleaning up... 04:59:58 INFO - Return code: 0 04:59:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:59:58 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')]} 04:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:58 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')]} 04:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:59:58 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 0x102f02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0b5759f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da6d30>, '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 0x102bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d9db20>, '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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 04:59:58 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 04:59:58 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 04:59:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4UxRMwXuc/Render', 04:59:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:58 INFO - 'HOME': '/Users/cltbld', 04:59:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:58 INFO - 'LOGNAME': 'cltbld', 04:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:58 INFO - 'MOZ_NO_REMOTE': '1', 04:59:58 INFO - 'NO_EM_RESTART': '1', 04:59:58 INFO - 'PAGER': '/bin/cat', 04:59:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:58 INFO - 'PWD': '/builds/slave/test', 04:59:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:58 INFO - 'SHELL': '/bin/bash', 04:59:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvEJVnnOPr/Listeners', 04:59:58 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 04:59:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:58 INFO - 'USER': 'cltbld', 04:59:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:58 INFO - 'XPC_FLAGS': '0x0', 04:59:58 INFO - 'XPC_SERVICE_NAME': '0', 04:59:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:59:58 INFO - Downloading/unpacking blobuploader==1.2.4 04:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:59:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:59:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:00:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:00:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:01 INFO - Downloading docopt-0.6.1.tar.gz 05:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:00:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:00:02 INFO - Running setup.py install for blobuploader 05:00:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:00:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:00:02 INFO - Running setup.py install for requests 05:00:02 INFO - Running setup.py install for docopt 05:00:02 INFO - Successfully installed blobuploader requests docopt 05:00:02 INFO - Cleaning up... 05:00:02 INFO - Return code: 0 05:00:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00: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')]} 05:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:02 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 0x102f02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0b5759f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da6d30>, '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 0x102bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d9db20>, '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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 05:00:02 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 05:00:02 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 05:00:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4UxRMwXuc/Render', 05:00:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:02 INFO - 'HOME': '/Users/cltbld', 05:00:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:02 INFO - 'LOGNAME': 'cltbld', 05:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:02 INFO - 'MOZ_NO_REMOTE': '1', 05:00:02 INFO - 'NO_EM_RESTART': '1', 05:00:02 INFO - 'PAGER': '/bin/cat', 05:00:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:02 INFO - 'PWD': '/builds/slave/test', 05:00:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:02 INFO - 'SHELL': '/bin/bash', 05:00:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvEJVnnOPr/Listeners', 05:00:02 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 05:00:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:02 INFO - 'USER': 'cltbld', 05:00:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:02 INFO - 'XPC_FLAGS': '0x0', 05:00:02 INFO - 'XPC_SERVICE_NAME': '0', 05:00:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:00:03 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-WeUEoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:00:03 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Bz6N9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:00:03 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-O9NRXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:00:03 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-hHl616-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:00:03 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-c68O_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:00:03 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-DKicO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:00:03 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-osWSt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:00:03 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-FytYO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:00:04 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-S_gqMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:00:04 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-34eL9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:00:04 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-YnkQ4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:00:04 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-nPMX35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:00:04 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-kJh0Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:00:04 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-VOO7Yn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:04 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-VfaL8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:00:04 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-sb_uVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:00:04 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-sIbC3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:00:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:00:04 INFO - Running setup.py install for manifestparser 05:00:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:00:05 INFO - Running setup.py install for mozcrash 05:00:05 INFO - Running setup.py install for mozdebug 05:00:05 INFO - Running setup.py install for mozdevice 05:00:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:00:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:00:05 INFO - Running setup.py install for mozfile 05:00:05 INFO - Running setup.py install for mozhttpd 05:00:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:00:05 INFO - Running setup.py install for mozinfo 05:00:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:00:05 INFO - Running setup.py install for mozInstall 05:00:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:00:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:00:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:00:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:00:06 INFO - Running setup.py install for mozleak 05:00:06 INFO - Running setup.py install for mozlog 05:00:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:00:06 INFO - Running setup.py install for moznetwork 05:00:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:00:06 INFO - Running setup.py install for mozprocess 05:00:06 INFO - Running setup.py install for mozprofile 05:00:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:00:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:00:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:00:06 INFO - Running setup.py install for mozrunner 05:00:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:00:07 INFO - Running setup.py install for mozscreenshot 05:00:07 INFO - Running setup.py install for moztest 05:00:07 INFO - Running setup.py install for mozversion 05:00:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:00:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:00:07 INFO - Cleaning up... 05:00:07 INFO - Return code: 0 05:00:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00: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')]} 05:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:07 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 0x102f02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0b5759f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da6d30>, '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 0x102bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d9db20>, '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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 05:00:07 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 05:00:07 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 05:00:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4UxRMwXuc/Render', 05:00:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:07 INFO - 'HOME': '/Users/cltbld', 05:00:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:07 INFO - 'LOGNAME': 'cltbld', 05:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:07 INFO - 'MOZ_NO_REMOTE': '1', 05:00:07 INFO - 'NO_EM_RESTART': '1', 05:00:07 INFO - 'PAGER': '/bin/cat', 05:00:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:07 INFO - 'PWD': '/builds/slave/test', 05:00:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:07 INFO - 'SHELL': '/bin/bash', 05:00:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvEJVnnOPr/Listeners', 05:00:07 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 05:00:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:07 INFO - 'USER': 'cltbld', 05:00:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:07 INFO - 'XPC_FLAGS': '0x0', 05:00:07 INFO - 'XPC_SERVICE_NAME': '0', 05:00:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:00:07 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-V5IUFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:00:07 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)) 05:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:00:07 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-IAf_ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:00:08 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)) 05:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:00:08 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-r55mvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:00:08 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)) 05:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:00:08 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-FN8s_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:00:08 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)) 05:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:00:08 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ZCQDBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:00:08 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)) 05:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:00:08 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ajN375-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:00:08 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)) 05:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:00:08 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-NR2olG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:00:08 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)) 05:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:00:08 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-3rBjdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:00:08 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)) 05:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:00:08 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-TaZcfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:00:08 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)) 05:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:00:08 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-FH_S2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:00:08 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)) 05:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:00:08 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-35KNks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:00:08 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)) 05:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:00:08 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-PNYrXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:00:09 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)) 05:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:00:09 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-xC35F3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:00:09 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)) 05:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:00:09 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Vx7jtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:00:09 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)) 05:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:09 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-YlQC7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:00:09 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)) 05:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:00:09 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-og_iLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:00:09 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)) 05:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:00:09 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Jek48Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:00:09 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)) 05:00:09 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)) 05:00:09 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)) 05:00:09 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)) 05:00:09 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)) 05:00:09 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)) 05:00:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00:11 INFO - Downloading blessings-1.6.tar.gz 05:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:00:12 INFO - Installing collected packages: blessings 05:00:12 INFO - Running setup.py install for blessings 05:00:12 INFO - Successfully installed blessings 05:00:12 INFO - Cleaning up... 05:00:12 INFO - Return code: 0 05:00:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:00:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:00:12 INFO - Reading from file tmpfile_stdout 05:00:12 INFO - Current package versions: 05:00:12 INFO - blessings == 1.6 05:00:12 INFO - blobuploader == 1.2.4 05:00:12 INFO - docopt == 0.6.1 05:00:12 INFO - manifestparser == 1.1 05:00:12 INFO - mozInstall == 1.12 05:00:12 INFO - mozcrash == 0.16 05:00:12 INFO - mozdebug == 0.1 05:00:12 INFO - mozdevice == 0.48 05:00:12 INFO - mozfile == 1.2 05:00:12 INFO - mozhttpd == 0.7 05:00:12 INFO - mozinfo == 0.9 05:00:12 INFO - mozleak == 0.1 05:00:12 INFO - mozlog == 3.1 05:00:12 INFO - moznetwork == 0.27 05:00:12 INFO - mozprocess == 0.22 05:00:12 INFO - mozprofile == 0.28 05:00:12 INFO - mozrunner == 6.11 05:00:12 INFO - mozscreenshot == 0.1 05:00:12 INFO - mozsystemmonitor == 0.0 05:00:12 INFO - moztest == 0.7 05:00:12 INFO - mozversion == 1.4 05:00:12 INFO - psutil == 3.1.1 05:00:12 INFO - requests == 1.2.3 05:00:12 INFO - wsgiref == 0.1.2 05:00:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:12 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 0x102f02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0b5759f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da6d30>, '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 0x102bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d9db20>, '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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 05:00:12 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 05:00:12 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 05:00:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4UxRMwXuc/Render', 05:00:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:12 INFO - 'HOME': '/Users/cltbld', 05:00:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:12 INFO - 'LOGNAME': 'cltbld', 05:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:12 INFO - 'MOZ_NO_REMOTE': '1', 05:00:12 INFO - 'NO_EM_RESTART': '1', 05:00:12 INFO - 'PAGER': '/bin/cat', 05:00:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:12 INFO - 'PWD': '/builds/slave/test', 05:00:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:12 INFO - 'SHELL': '/bin/bash', 05:00:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvEJVnnOPr/Listeners', 05:00:12 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 05:00:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:12 INFO - 'USER': 'cltbld', 05:00:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:12 INFO - 'XPC_FLAGS': '0x0', 05:00:12 INFO - 'XPC_SERVICE_NAME': '0', 05:00:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:12 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)) 05:00:12 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)) 05:00:12 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)) 05:00:12 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)) 05:00:12 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)) 05:00:12 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)) 05:00:12 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)) 05:00:12 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)) 05:00:12 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)) 05:00:12 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)) 05:00:12 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)) 05:00:12 INFO - Cleaning up... 05:00:12 INFO - Return code: 0 05:00:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0b5759f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da6d30>, '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 0x102bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d9db20>, '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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 05:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:00:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4UxRMwXuc/Render', 05:00:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:12 INFO - 'HOME': '/Users/cltbld', 05:00:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:12 INFO - 'LOGNAME': 'cltbld', 05:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:12 INFO - 'MOZ_NO_REMOTE': '1', 05:00:12 INFO - 'NO_EM_RESTART': '1', 05:00:12 INFO - 'PAGER': '/bin/cat', 05:00:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:12 INFO - 'PWD': '/builds/slave/test', 05:00:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:12 INFO - 'SHELL': '/bin/bash', 05:00:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvEJVnnOPr/Listeners', 05:00:12 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 05:00:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:12 INFO - 'USER': 'cltbld', 05:00:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:12 INFO - 'XPC_FLAGS': '0x0', 05:00:12 INFO - 'XPC_SERVICE_NAME': '0', 05:00:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:13 INFO - Downloading/unpacking jsonschema 05:00:13 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 05:00:13 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 05:00:13 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 05:00:13 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 05:00:13 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 05:00:13 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 05:00:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:00:15 INFO - Downloading/unpacking functools32 (from jsonschema) 05:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:00:15 INFO - warning: no files found matching '*.txt' 05:00:15 INFO - no previously-included directories found matching 'build' 05:00:15 INFO - no previously-included directories found matching 'dist' 05:00:15 INFO - no previously-included directories found matching '.git*' 05:00:15 INFO - Installing collected packages: jsonschema, functools32 05:00:15 INFO - Running setup.py install for functools32 05:00:15 INFO - warning: no files found matching '*.txt' 05:00:15 INFO - no previously-included directories found matching 'build' 05:00:15 INFO - no previously-included directories found matching 'dist' 05:00:15 INFO - no previously-included directories found matching '.git*' 05:00:16 INFO - Successfully installed jsonschema functools32 05:00:16 INFO - Cleaning up... 05:00:16 INFO - Return code: 0 05:00:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102f02a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102f094c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc0b5759f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102da6d30>, '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 0x102bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d9db20>, '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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 05:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:00:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4UxRMwXuc/Render', 05:00:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:16 INFO - 'HOME': '/Users/cltbld', 05:00:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:16 INFO - 'LOGNAME': 'cltbld', 05:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:16 INFO - 'MOZ_NO_REMOTE': '1', 05:00:16 INFO - 'NO_EM_RESTART': '1', 05:00:16 INFO - 'PAGER': '/bin/cat', 05:00:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:16 INFO - 'PWD': '/builds/slave/test', 05:00:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:16 INFO - 'SHELL': '/bin/bash', 05:00:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvEJVnnOPr/Listeners', 05:00:16 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 05:00:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:16 INFO - 'USER': 'cltbld', 05:00:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:16 INFO - 'XPC_FLAGS': '0x0', 05:00:16 INFO - 'XPC_SERVICE_NAME': '0', 05:00:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:16 INFO - Downloading/unpacking flake8 05:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:00:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:00:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:00:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:19 INFO - no previously-included directories found matching 'docs/_build' 05:00:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:00:19 INFO - Running setup.py install for pep8 05:00:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:00:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:00:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:00:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:00:20 INFO - no previously-included directories found matching 'docs/_build' 05:00:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:00:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:00:20 INFO - Cleaning up... 05:00:20 INFO - Return code: 0 05:00:20 INFO - Running post-action listener: _resource_record_post_action 05:00:20 INFO - Running post-action listener: _start_resource_monitoring 05:00:20 INFO - Starting resource monitoring. 05:00:20 INFO - ##### 05:00:20 INFO - ##### Running install step. 05:00:20 INFO - ##### 05:00:20 INFO - Running pre-action listener: _resource_record_pre_action 05:00:20 INFO - Running main action method: install 05:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:00:20 INFO - Reading from file tmpfile_stdout 05:00:20 INFO - Detecting whether we're running mozinstall >=1.0... 05:00:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:00:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:00:20 INFO - Reading from file tmpfile_stdout 05:00:20 INFO - Output received: 05:00:20 INFO - Usage: mozinstall [options] installer 05:00:20 INFO - Options: 05:00:20 INFO - -h, --help show this help message and exit 05:00:20 INFO - -d DEST, --destination=DEST 05:00:20 INFO - Directory to install application into. [default: 05:00:20 INFO - "/builds/slave/test"] 05:00:20 INFO - --app=APP Application being installed. [default: firefox] 05:00:20 INFO - mkdir: /builds/slave/test/build/application 05:00:20 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'] 05:00:20 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 05:00:55 INFO - Reading from file tmpfile_stdout 05:00:55 INFO - Output received: 05:00:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:00:55 INFO - Running post-action listener: _resource_record_post_action 05:00:55 INFO - ##### 05:00:55 INFO - ##### Running run-tests step. 05:00:55 INFO - ##### 05:00:55 INFO - Running pre-action listener: _resource_record_pre_action 05:00:55 INFO - Running main action method: run_tests 05:00:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:00:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:00:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:00:55 INFO - 2016-02-09 05:00:55.369 screenresolution[6120:100940] starting screenresolution argv=screenresolution get 05:00:55 INFO - 2016-02-09 05:00:55.371 screenresolution[6120:100940] Display 0: 1600x1200x32@60 05:00:55 INFO - 2016-02-09 05:00:55.377 screenresolution[6121:100942] starting screenresolution argv=screenresolution list 05:00:55 INFO - Available Modes on Display 0 05:00:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:00:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:00:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:00:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:00:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:00:55 INFO - Intel Iris: 05:00:55 INFO - Chipset Model: Intel Iris 05:00:55 INFO - Type: GPU 05:00:55 INFO - Bus: Built-In 05:00:55 INFO - VRAM (Dynamic, Max): 1536 MB 05:00:55 INFO - Vendor: Intel (0x8086) 05:00:55 INFO - Device ID: 0x0a2e 05:00:55 INFO - Revision ID: 0x0009 05:00:55 INFO - Displays: 05:00:55 INFO - Display: 05:00:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:00:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:00:55 INFO - Display Serial Number: 1600x1200 60 05:00:55 INFO - Main Display: Yes 05:00:55 INFO - Mirror: Off 05:00:55 INFO - Online: Yes 05:00:55 INFO - Rotation: Supported 05:00:55 INFO - Return code: 0 05:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:00:55 INFO - Python 2.7.3 05:00:55 INFO - Return code: 0 05:00:55 INFO - grabbing minidump binary from tooltool 05:00:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:55 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 0x102da6d30>, '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 0x102bcadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102d9db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:00:55 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 05:00:55 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 05:00:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:00:55 INFO - Return code: 0 05:00:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:00:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:00:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:00:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:00:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:00:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:00:56 INFO - Return code: 0 05:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0134 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:00:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4UxRMwXuc/Render', 05:00:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:56 INFO - 'HOME': '/Users/cltbld', 05:00:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:56 INFO - 'LOGNAME': 'cltbld', 05:00:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:00:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:56 INFO - 'MOZ_NO_REMOTE': '1', 05:00:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:00:56 INFO - 'NO_EM_RESTART': '1', 05:00:56 INFO - 'PAGER': '/bin/cat', 05:00:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:56 INFO - 'PWD': '/builds/slave/test', 05:00:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:00:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:56 INFO - 'SHELL': '/bin/bash', 05:00:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QvEJVnnOPr/Listeners', 05:00:56 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 05:00:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:56 INFO - 'USER': 'cltbld', 05:00:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:56 INFO - 'XPC_FLAGS': '0x0', 05:00:56 INFO - 'XPC_SERVICE_NAME': '0', 05:00:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:00:57 INFO - mozversion application_buildid: 20160209035955 05:00:57 INFO - mozversion application_changeset: 7a0ebe3fccacc655c38e7f32948626af4d3d3269 05:00:57 INFO - mozversion application_display_name: Nightly 05:00:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:00:57 INFO - mozversion application_name: Firefox 05:00:57 INFO - mozversion application_remotingname: firefox 05:00:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:00:57 INFO - mozversion application_vendor: Mozilla 05:00:57 INFO - mozversion application_version: 47.0a1 05:00:57 INFO - mozversion platform_buildid: 20160209035955 05:00:57 INFO - mozversion platform_changeset: 7a0ebe3fccacc655c38e7f32948626af4d3d3269 05:00:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:00:57 INFO - mozversion platform_version: 47.0a1 05:00:57 INFO - using testdate: 1455022857 05:00:57 INFO - actual date: 1455022857 05:00:57 INFO - starting webserver on 'localhost:56214' 05:00:57 INFO - SUITE-START | Running 2 tests 05:00:57 INFO - TEST-START | dromaeo_css 05:00:57 INFO - operating with platform_type : mac_ 05:00:57 INFO - Initialising browser for dromaeo_css test... 05:00:57 INFO - TEST-INFO | started process 6139 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmprNcUp3/profile http://localhost:56214/getInfo.html) 05:01:00 INFO - PROCESS | 6139 | __metrics Screen width/height:1600/1200 05:01:00 INFO - PROCESS | 6139 | colorDepth:24 05:01:00 INFO - PROCESS | 6139 | Browser inner width/height: 1024/689 05:01:00 INFO - PROCESS | 6139 | __metrics 05:01:00 INFO - PROCESS | 6139 | 05:01:00 INFO - PROCESS | 6139 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 05:01:00 INFO - PROCESS | 6139 | 05:01:01 INFO - TEST-INFO | 6139: exit 0 05:01:01 INFO - Browser initialized. 05:01:01 INFO - Running cycle 1/1 for dromaeo_css test... 05:01:01 INFO - TEST-INFO | started process 6144 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmprNcUp3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:13 INFO - PROCESS | 6144 | RSS: Main: 259207168 05:01:13 INFO - PROCESS | 6144 | 05:02:02 INFO - PROCESS | 6144 | 1455022922854 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] 05:04:13 INFO - PROCESS | 6144 | Cycle 1(1): loaded http://localhost:56214/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56214/tests/dromaeo/cssquery-ext.html) 05:04:14 INFO - PROCESS | 6144 | RSS: Main: 270819328 05:04:14 INFO - PROCESS | 6144 | 05:07:16 INFO - PROCESS | 6144 | Cycle 1(1): loaded http://localhost:56214/tests/dromaeo/cssquery-ext.html (next: http://localhost:56214/tests/dromaeo/cssquery-jquery.html) 05:07:17 INFO - PROCESS | 6144 | RSS: Main: 283631616 05:07:17 INFO - PROCESS | 6144 | 05:10:19 INFO - PROCESS | 6144 | Cycle 1(1): loaded http://localhost:56214/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56214/tests/dromaeo/cssquery-mootools.html) 05:10:19 INFO - PROCESS | 6144 | RSS: Main: 284987392 05:10:19 INFO - PROCESS | 6144 | 05:13:21 INFO - PROCESS | 6144 | Cycle 1(1): loaded http://localhost:56214/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56214/tests/dromaeo/cssquery-prototype.html) 05:13:22 INFO - PROCESS | 6144 | RSS: Main: 286883840 05:13:22 INFO - PROCESS | 6144 | 05:16:24 INFO - PROCESS | 6144 | Cycle 1(1): loaded http://localhost:56214/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56214/tests/dromaeo/cssquery-yui.html) 05:16:25 INFO - PROCESS | 6144 | RSS: Main: 290021376 05:16:25 INFO - PROCESS | 6144 | 05:19:27 INFO - PROCESS | 6144 | Cycle 1(1): loaded http://localhost:56214/tests/dromaeo/cssquery-yui.html (next: http://localhost:56214/tests/dromaeo/cssquery-dojo.html) 05:19:28 INFO - PROCESS | 6144 | RSS: Main: 291602432 05:19:28 INFO - PROCESS | 6144 | 05:19:28 INFO - PROCESS | 6144 | __start_tp_report 05:19:28 INFO - PROCESS | 6144 | _x_x_mozilla_page_load 05:19:28 INFO - PROCESS | 6144 | _x_x_mozilla_page_load_details 05:19:28 INFO - PROCESS | 6144 | |i|pagename|runs| 05:19:28 INFO - PROCESS | 6144 | |0;dojo.html;3482.5472688550485;3487.9302413951737;3493.1965647900997;3535.999999999999;3536.3988122019255;5694.487496125348;5726.7422965966525;5750.424957504248;5774.538036957044;5791.102379131231;4844.975775121119;5637.295338082739;5684.971575142129;5912.763489460427;5985.281766188053;3988.7207895447186;4101.364288535282;5112.130937740584;5257.106291930362;5321.414644389114;5157.8452646420665;5261.158214685651;5327.2808170897015;5375.408705042461;5394.109971854639;3956.3472027115636;4039.434479172918;4083.4079058536345;5148.639595228336;5404.91892621609;4323.308270676676;5173.275741396207;5179.378474583074;5186.273921650972;5210.713410762407;5140.1518749406305;5168.8449346519665;5198.870028249286;5213.244079608474;5255.816046438356;5521.944780552223;5538.390777014525;5758.222639943638;5792.102224155263;5796.42035796417;6125.142480052797;6130.754769809202;6172.1667574877265;6188.133661287423;6202.81391558254;5754.482096611283;6145.508359331243;6158.414950579688;6220.377962203788;6232.563720539564;5864.208331875185;5888.381719919433;5901.321348044987;5910.024845900378;5928.081147422156;6273.12176295319;6274.2784579773;6291.685415729286;6292.307846136921;6309.842253943688;5339.305890234323;6079.483243924316;6141.516692814182;6180.412860778219;6190.845228869224;6196.504279657616;6214.720337584729;6221.377862213742;6225.595336303126;6247.562670613104;6102.206713127265;6209.9379006210265;6230.470410015108;6232.3144454110015;6250.343713910065;6114.723190878713;6209.192804935329;6216.720247588869;6227.875442491125;6234.937650623527;4844.563989240985;4864.270359446112;4897.363342765418;4903.9946810903675;4922.507749225048;4358.825646974085;4366.039471316305;4384.69307148503;4432.556744325606;4441.911161776747;5688.431156884361;5728.369879313273;5744.770209191669;5753.539716822645;5767.423257674283;5521.2270282160525;6019.729112189962;6200.472959798468;6206.782762603287;6225.439710425992;5661.660300381908;5714.942850571524;5734.254546908958;5772.047612144033;5852.531797456193;5354.973225133849;5387.595930305243;5395.21769343443;5403.162509810985;5403.594730395236;5171.689698618095;6206.596571222856;6340.270868850049;6375.203099612549;6403.647799370986;6168.074788781719;6189.845253868509;6207.81376558704;6215.81352559424;6219.315875253628;6333.746650133943;6354.364563543609;6356.650384228912;6357.396047375492;6389.105525226565;6046.12331211963;6108.85814249354;6153.923063463786;6202.596831206138;6220.03589443637;5329.680219186861;6068.575199735976;6178.907316390168;6212.316645168938;6223.875522489616;5944.791932282349;6096;6134.601250918676;6149.815505534841;6179.227596550431;5907.911381329198;6066.575339726353;6160.568760186744;6165.969170154121;6190.133381326528;5340.893182136413;5935.317438494629;5937.406259374028;6005.789797357072;6054.515638748801;5582.385937546947;6084.543659225487;6117.113018612187;6142.775043102407;6170.413810687977;5887.704704964901;5989.490893273946;6025.758969641165;6051.878962420815;6070 05:19:28 INFO - PROCESS | 6144 | |1;ext.html;464.2293792304775;471.5614478534963;495.5341978540173;566.6147020026382;599.6012651586695;33633.327333453315;37189.88430347087;37281;37701.245975080485;37961.43057854131;36724.81637591815;40292.79853600735;40319;40397.596024039754;40608;9347.252219822432;9498.002709715483;9565.139137477625;9569.80860382792;9577.856332155023;8287.58562071897;9432.434053956751;9553.61785528578;9566.091221333962;9578.377405468656;9549.949505554383;9582.856257156114;9583.66457173999;9588.952055239713;9621.326507144502;9502.619895204183;9529.094736000068;9559.761005974837;9580.808383832284;9589.952050239774;9364.859527107099;9435.339526233167;9499.667511637059;9507.24116038535;9529.714108576754;28507.714922850715;36251.09372265688;37748.62251377506;37843.810780946194;38242.80878595617;2668.679758429001;2783.248522898806;3250.0574833298315;3329.267561136546;3354.0943945134923;27243.318917027034;27285;27301.86349068262;27413.45173096547;27640.447191056068;2743.231895069384;2768.764655004327;2823.7035111313426;2839.2617919340914;2952.808067475607;504777.47611261706;508009;508361.45819271036;509764;510900;56393.436065638816;65325.34674653288;66598.66700666466;67010.66494667593;67717;67192.32807671861;67737;67795.66102169457;67928.96213113515;68015.31984680188;12864;14935.626609334853;16200.75698864518;16725.829191956447;16776.580585485215;12528.498860045678;12531.561395351118;12700.80948785769;12803.359832008362;12908.741825163444;18218.817811821977;21058.47353816136;21224;21393;21464.78535214628;9053.411528250643;9274.211692006254;9333.486658233727;9358.064193580587;9365;776.751439539342;965.3725078698761;990.8315586350337;1042.718466014172;1080.7514271717548;22790.65814012791;28070.43859122806;28404.43191136207;28716.569251461246;28720.563971801326;938.9812203756023;1035.2080658296409;1078.9892101078888;1093.8632670916136;1133.6485689436302;11834.644960651194;13746.65633359154;14621.90335724825;14765;14820.925895370454;576769;581253.0937345286;587010;588405;589228;58206.417935820944;58288;58537.4146258532;58662.70668646715;58746;1312.1274352555633;1324.4702119152223;1371.403439503799;1416.6812467195005;1431.205680847119;28382.43235135327;28487;28875.42249155047;29009.564856526747;29083.41833163367;53447.732761335945;54500.18249726178;54714.45285547093;54805.62985925384;54833.1775023367;500565;504412;509675;510096;510576;42936;44430;44808.77595612001;45642.85892852705;45916;38996.83009509719;42324.153516930106;44432.33351499795;45064.54935450604;45307.32039019351;29072.854635726686;35704.82147589245;36355.500755707835;37131;37396.6260337404;32065.19837004;35174.82412588023;35252;36060.639393606776;36249.81875090607;35608.643913561566;36237.63762362343;37222.44166337453;38228;38399.232015360096;30802.383952321277;33365.16587085342;33402.997910061764;33439;33653.663463365054;24982.875085624455;25238.369040774127;25344.98620055177;25743;25798.484030319665 05:19:28 INFO - PROCESS | 6144 | |2;jquery.html;351.5096440465549;359.955005624297;360.43411843405846;363.53467561521256;363.83809204903827;15493.147876866768;18874.923758386583;19495.70756438651;19800.30698925538;20749.066292016876;9426.245900327975;11928.522859085626;11950.880491195085;12003.519859205644;19725.210991560358;4855.927161092595;5090.643654944155;5776.335721392052;5796.942030579682;5803.100519419497;4976.776045077962;5664.801731939383;5672.9221447924965;5697.658140511562;5720.456556627114;3878.7672739635573;5156.381234251895;5158.303629010074;5161.071007218699;5616.354119276274;4884.3406140171155;5903.645781253139;5931.555133365015;5935.376785437532;5943.286805583336;4813.542713442217;5590.776368945238;5629.746661400206;5669.971650141723;5697.77208911643;13352.666183345495;13369.866301336959;13418.261995590336;13418.396172172275;23131.33472185636;2200.7689192634703;2239.540894116702;2242.8766417847014;2250.1561914282142;2775.639166908309;9734.756631084208;10185.745356366077;10308.175345972379;10500.632477863315;14695.853041469662;1438.4318194313291;1460.3866376121948;1714.125795844116;1759.6480703859152;1813.8367546920708;97629;100441;101073.48389774085;101139.9886001138;102138.48930755373;11170.385628790333;11322.830157547643;11358.829617555743;11413.60052398162;11468.13988950832;13569.932150339382;13632.045756797128;13647.931760341135;13684.657883552793;13695.931520342334;8545.060043395222;8590.098039705741;8626.482411055356;8656.69701560455;8671.306295496344;8374;8473.406861519634;8491.278241349431;8519.446235994641;8582.527960962083;3737.8878633641034;3834.1373191031794;4427.667924905645;4442.400275962768;4481.708688935274;1852.19429548147;1910.980890191108;1940.9126589303514;1956.735840661521;1959.4121763470903;402.9556748757634;404.09885954322027;418.080223508283;422.9323308270662;429.3345314762106;11536.711582210344;11957.940210298893;11981.341026243466;12032.759344813056;12056.457459414347;897.7665806890125;926.4117285523741;987.1757082835912;998.3311181508407;1031.200819364983;9900.65347712841;10207.285490015627;10209;10217.284790064625;10227.94886025565;724220;726432;739219;753528;766969;99462;109266;109653.45173274082;116080;119884;1032.143321043532;1117.8546788917552;1152.948117334722;1190.7678002789373;1211.5759484180467;14594.273209191024;18217;18280.72578911291;18317.450476485727;18550.44348669542;50139.74930125326;51532.74233628808;52025;52143.73928130335;52231.21653175281;74806.50386992338;75244;75330.62334688292;75344.62327688545;76373;7456.701731930879;7708.49894756839;7718.729844455417;7742.65158067877;7823.765287041398;10037.397756134655;10350.085234231692;11041.723956901142;12107.394630268627;12224.449899754354;10157.84763228567;10279.640212592523;10362.067413932782;10468.63359782404;10714.517846697074;9847.950760246153;10225.539850706884;10298.794024119625;10324.845127323246;10724;10427.791444171226;10840.292145474614;10924.453777310944;11037.006669399792;11168.553257869595;5968.910466342922;7411.370033547209;7653.502522336031;7723.613819309125;7730.420218483524;10315.845262320921;10590;10592.470376480991;10630.202734794766;10737.946310268399 05:19:28 INFO - PROCESS | 6144 | |3;mootools.html;1532.8390518995504;1543.1898253416955;1677.1698009485306;1758.1472985601981;1763.382816014396;7945.92054079459;8573.399862009663;8605.354598405122;8827.47035177889;8845.557722113892;8615.741527754177;8687.391882568223;8797.340199485032;8799.252063574604;8799.428037177595;2480.900763969439;2505.5865782145925;2508.097085049381;2508.8620125893067;2519.1308998395525;2403.627437747143;2473.0973194783865;2531.0382054819233;2532.202356257773;2533.7466253374605;2213.7896899794496;2464.4331803685163;2475.752424757528;2509.8494090354548;2518.659980902573;2454.8527088374753;2461.9261422157365;2486.477839653675;2487.6517287579754;2497.7377375375504;2431.8297719159664;2439.0609615298063;2470.505898820243;2472.938176545583;2473.208573256559;8661.480311181349;8697.69558065471;8730.86903696445;8740.038595754462;8823.205911467998;5382.4886635769935;5564.10974244119;5583.637063590853;5583.776648934037;5587.636803607753;3063.5251536011956;3120.578721872541;3690.464882592036;3765.811709414518;3767.8869633911027;905.3979103895902;1040.422565476168;1060.8249638809586;1086.684861390196;1098.2257508456519;9652.517374131265;11417.80113088122;11623.244489108265;11808.232464889841;11875.703107422298;4494.505604383515;4743.146233677971;4829.372181616367;4833.613310935117;4844.660873738804;9275.721728348026;9282.211012063915;9324.25405967521;9324.813503730024;9324.8601270981;5331.70675612845;5369.48989845964;5389.784408623611;5411.9729401353525;5425.484578964992;4961.652684312064;4981.277714731344;5016.1723315653235;5030.748462576857;5069.847904562869;3774.150816066418;3784.0918179636687;3793.2982398256413;3817.2938006468894;3858.9807050964564;1034.9482525873675;1133.1444759206747;1192.099964526794;1197.808350663907;1211.2248161176854;1053.167997282154;1111.7387413957713;1127.1658972360558;1154.359330571524;1306.9869301306865;7991;8061.556614386265;8066.717664881701;8156.265936065783;8177.386695997824;1024.3555836260932;1182.1665725663386;1183.2722875431548;1197.8442802435627;1202.897753690946;5618.016847051749;5913.379095195029;6157.045657922939;6168.9691551541955;6258.718357673915;10374.17006639467;11007.504662290215;11078.501467433985;11088.501017454233;11133.721656958642;10396.792064158826;10688.198385121146;10747.570097196181;10881.347119172875;10944;8384.455010424303;8484.066752657203;8525.19010693983;8526.806247125407;8526.914730852735;7920.683172673029;7990.360771138411;8016.038075430985;8062.072861620754;8078.23256790604;8917;9657.71026869195;9760.023997600183;9855.014498550088;9913.65302214448;9645.228381729585;9786.902130978884;9945.801083978135;9959.850602241117;10113.64602238918;7565.2812982766545;7642.197569255148;7656.349210316963;7688.46180767341;7694.230576942261;6983.9650801745665;7073.646317684198;8293.58532073406;8350.832983340179;8444.197801208875;7294.197638259893;7781.844363112593;7816.84366312682;7869.645865935932;8032.718854840053;7516.736914207976;7535.773926782205;7549.2828181324885;7637.389008879165;7683.769486915178;7726.3432608226685;7750.302472777477;7750.883736743841;7758.681024226008;7783.9880815493625;6923.134608173978;6985.1967023790885;7006.509544331848;7014.333638304353;7027.4378049756915;5938.792142275172;7058.11773528309;7179.317964793545;7191.2449192834;7209.531380460253 05:19:28 INFO - PROCESS | 6144 | |4;prototype.html;248.99875500622494;323.2661857583286;328.2041050452653;335.5285823418098;337.18737841801266;4890.853274401765;6202.658853763041;6806.251312355637;6891.1041564596535;7088.716451341947;5246.845693947335;6861.210960739517;6890.517663763539;6898.37914587687;6933.098697169361;4250.511191213003;5007.574356179729;5009;5026.271190677349;5036.093503169428;5018.5232402921665;5025.698458092508;5027.622928280375;5033.597312215033;5044;3595.280943811235;4721.362616046824;4769.4515130760055;4809.725422762971;4917.852464426073;4881.560659540658;4890.462049174588;4893.388326459192;4894.461609222983;4944.87637809054;3993.800309984518;4086.7547947123267;4145.316022856225;4161.500619925598;4181.665466762652;6447.516436267252;6477.708503117371;6510.16807688657;6511.804645860631;6540;5844.386339434341;5902.173695682608;5920.970395147997;5927.555433342516;5931.288245410536;7117.679704413314;7340.559566425978;7363.410927125817;7375.11498620169;7380.225076367012;3878.379459286529;4002.779847108408;4741.146593613148;4749.216379297412;4750.002499475115;7045.89431158533;7139.535930164523;7753.340966017895;7823.100343460575;7871.094824095245;4586.633069354443;4777.116233496814;4780.976095119502;4781.95218047822;4788.928166077511;4870.172070747911;4870.586000190024;4889.266610008527;4889.951100489021;4896.143174944371;4938.728369939688;5760.251167348218;5859.091840764689;5891.675957822361;5907.527397808165;7390.704371825174;7398.630068496554;7419.591922444318;7423;7437.702491900372;1624.8375162483658;1665.616908111117;1694.669539439822;1695.169367010156;1701.4725435115154;1059.6238335390826;1063.7553362726617;1071.4053700196466;1078.9190810689229;1079.578964203961;6747.628880411527;6775.254721980578;6778.152730908637;6812.978053292046;6830.624315662686;7637.19809420014;7653.464257501922;7657.770266892002;7669.923300767033;7671.846563068707;6600.80197594073;6767.323267673291;6784;6788.49086318528;6843.657817109125;3780.5066998535426;3960.7029472789654;4038.0712436139265;4087.5299340576216;4099.631033207026;7017.4386049116965;8059.314958228499;8067.410002548927;8116.715914943066;8137.75586732399;6700.994850772326;7500.624968751541;7914.089879663798;7980.3615710743;7988.520688758693;6536.692661467726;7153.213146553875;7327.890081648886;7339.926600733925;8150.796230094295;6240.375962403905;7746.92253077462;7761.805954851174;7807.18024607408;7808.219178082373;6216.595921265103;7428.517146385468;7649.732259370895;7658.387329013777;7661.233876612294;8138.9186108138165;8147.63335649909;8151;8164;8165.346772258086;3956.8812935611977;4108.342665173558;4968.478309777566;5022.096022715946;5051.494850514919;7373.041504604582;7637.236276372319;7640.218092044473;7654.846903062019;7707.190744971697;5962;7318.012068370702;7329.596872172082;7335.889961650473;7349.6692648832;7310.707571697285;7322.450816188701;7337.706491740484;7409.444291678254;7423.257674232534;5956.404359564009;6961.7215311389;7224.963875180591;7260.983462315386;7263.6005019724425;7389.815254618463;7394.371478424394;7419.035525381882;7420.962895185706;7427.702891884264;6978.47661425385;7218.963905180441;7236.167840698387;7249.746258880914;7290.635468226674 05:19:28 INFO - PROCESS | 6144 | |5;yui.html;659.861429099889;666.2904007232297;689.5449003657587;717.1609217215857;726.8182954261434;14691.926540367296;14865.108093514396;14978.925105374472;15063.171525566104;15069.773953390708;13662.316884155802;13702.451901923936;13723.245221512812;13728.862711372883;13731.794023089637;654.1006116589689;810.6068556749972;813.9226773456512;823.6828820903966;836.1178956201205;820.36421773126;820.3765138494728;823.0411570520337;828.3828547731918;829.6639860856363;872.8821609082756;874.4884242718017;879.7536689726854;880.5993273060774;884.2483888694622;862.8403745307138;865.16079402979;874.6982291109557;876.202655583416;877.473515890467;646.176125440063;648.1994736500418;649.9252585952629;652.7486917536735;653.5359894474929;14893.32980015902;14942.925285373612;15024.248787560688;15024.924875375662;15055.54833355001;12789.232646041268;12798.744025119446;12890.548830790878;13110.344482775918;13310.93512518996;9987.650432234837;10186.08325250731;10197.49012549377;10210.540525676362;10331.48342582868;3496.126507467454;3544.769589976669;3612.819359032038;3622.967454275545;3689.8339574719203;84410.73383899247;85394;85401;86876.56561717213;87095;9472.100150485692;9571.425714457155;9749.853752193723;9897.307188496736;10360.896391035993;19958;20435.182592696125;20602.484937876674;20624;20642;7327.303906128909;7458.142313633893;7487.66305516253;7708.152103268636;7757.961210193913;3968.226195891831;4074.144429669743;4077.225327187825;4104;4123.731957422758;3609.7112231021456;3630.419132938717;3645.799481028516;3659.14010207601;3660.524131862894;640.3468462168562;648.2059477140465;652.4780175859294;656.4518626946553;661.5468404143178;457.9771011449414;491.87457198414177;549.8982688202695;596.9283685957625;607.0469363099979;8564.914350856536;9191.678291259774;9218.631254749735;9356.719298421058;9361.672341468153;506.57194670503367;533.4105813076573;568.8606291458619;600.4025994135776;652.6606164794375;3468.7571869969365;3623.456481527739;3889.3582558878034;3936.7441116327345;4085.8978525536504;96174;97239;97598.51200744094;98995;100857.49571252096;77503.61248193723;78585;79331;79613.20386796174;79673.02452316099;68134;69066.65466672635;71407.2859271411;71712;72074.55850882953;8311.39095592449;8333.583320833814;8451.619677114422;8529.273864509301;8575.185357391038;39259;44172;48188;50110.96602503303;50752;66375.33624663691;66754;67978.66010669916;70959;71398.64300678464;8289.544075075928;9970.102690757867;10175;10305.484725763532;10720.889083282173;11193.104551636012;11292.096632269235;11326.603568875049;11397.145214109141;11442.199046066695;9252.167304942588;10443.843342349719;10575.153987680813;10793.19051071157;10839.349639021684;10545.894541054799;10691.786164276826;10806.837897431387;10812.297200681931;10856.728581785519;10217.540210690388;10236.232282578687;10643.148548116287;10703.357798532114;10717.785644286914;8669.869951950599;8756.14238344461;9529.285303602119;9572.808543829224;9575.941172647914;9909;10024.749381265527;10064.44645544502;10085.647002354883;10192.082712555906 05:19:28 INFO - PROCESS | 6144 | __end_tp_report 05:19:28 INFO - PROCESS | 6144 | __start_cc_report 05:19:28 INFO - PROCESS | 6144 | _x_x_mozilla_cycle_collect,371 05:19:28 INFO - PROCESS | 6144 | __end_cc_report 05:19:28 INFO - PROCESS | 6144 | __startTimestamp1455023968026__endTimestamp 05:19:28 INFO - PROCESS | 6144 | 05:19:28 INFO - PROCESS | 6144 | ------- Summary: start ------- 05:19:28 INFO - PROCESS | 6144 | Number of tests: 6 05:19:28 INFO - PROCESS | 6144 | 05:19:28 INFO - PROCESS | 6144 | [#0] dojo.html Cycles:165 Average:5681.41 Median:5928.08 stddev:688.80 (11.6%) stddev-sans-first:668.97 05:19:28 INFO - PROCESS | 6144 | Values: 3482.5 3487.9 3493.2 3536.0 3536.4 5694.5 5726.7 5750.4 5774.5 5791.1 4845.0 5637.3 5685.0 5912.8 5985.3 3988.7 4101.4 5112.1 5257.1 5321.4 5157.8 5261.2 5327.3 5375.4 5394.1 3956.3 4039.4 4083.4 5148.6 5404.9 4323.3 5173.3 5179.4 5186.3 5210.7 5140.2 5168.8 5198.9 5213.2 5255.8 5521.9 5538.4 5758.2 5792.1 5796.4 6125.1 6130.8 6172.2 6188.1 6202.8 5754.5 6145.5 6158.4 6220.4 6232.6 5864.2 5888.4 5901.3 5910.0 5928.1 6273.1 6274.3 6291.7 6292.3 6309.8 5339.3 6079.5 6141.5 6180.4 6190.8 6196.5 6214.7 6221.4 6225.6 6247.6 6102.2 6209.9 6230.5 6232.3 6250.3 6114.7 6209.2 6216.7 6227.9 6234.9 4844.6 4864.3 4897.4 4904.0 4922.5 4358.8 4366.0 4384.7 4432.6 4441.9 5688.4 5728.4 5744.8 5753.5 5767.4 5521.2 6019.7 6200.5 6206.8 6225.4 5661.7 5714.9 5734.3 5772.0 5852.5 5355.0 5387.6 5395.2 5403.2 5403.6 5171.7 6206.6 6340.3 6375.2 6403.6 6168.1 6189.8 6207.8 6215.8 6219.3 6333.7 6354.4 6356.7 6357.4 6389.1 6046.1 6108.9 6153.9 6202.6 6220.0 5329.7 6068.6 6178.9 6212.3 6223.9 5944.8 6096.0 6134.6 6149.8 6179.2 5907.9 6066.6 6160.6 6166.0 6190.1 5340.9 5935.3 5937.4 6005.8 6054.5 5582.4 6084.5 6117.1 6142.8 6170.4 5887.7 5989.5 6025.8 6051.9 6070.0 05:19:28 INFO - PROCESS | 6144 | 05:19:28 INFO - PROCESS | 6144 | [#1] ext.html Cycles:180 Average:67326.60 Median:38321.02 stddev:142488.32 (371.8%) stddev-sans-first:142799.61 05:19:28 INFO - PROCESS | 6144 | Values: 464.2 471.6 495.5 566.6 599.6 33633.3 37189.9 37281.0 37701.2 37961.4 36724.8 40292.8 40319.0 40397.6 40608.0 9347.3 9498.0 9565.1 9569.8 9577.9 8287.6 9432.4 9553.6 9566.1 9578.4 9549.9 9582.9 9583.7 9589.0 9621.3 9502.6 9529.1 9559.8 9580.8 9590.0 9364.9 9435.3 9499.7 9507.2 9529.7 28507.7 36251.1 37748.6 37843.8 38242.8 2668.7 2783.2 3250.1 3329.3 3354.1 27243.3 27285.0 27301.9 27413.5 27640.4 2743.2 2768.8 2823.7 2839.3 2952.8 504777.5 508009.0 508361.5 509764.0 510900.0 56393.4 65325.3 66598.7 67010.7 67717.0 67192.3 67737.0 67795.7 67929.0 68015.3 12864.0 14935.6 16200.8 16725.8 16776.6 12528.5 12531.6 12700.8 12803.4 12908.7 18218.8 21058.5 21224.0 21393.0 21464.8 9053.4 9274.2 9333.5 9358.1 9365.0 776.8 965.4 990.8 1042.7 1080.8 22790.7 28070.4 28404.4 28716.6 28720.6 939.0 1035.2 1079.0 1093.9 1133.6 11834.6 13746.7 14621.9 14765.0 14820.9 576769.0 581253.1 587010.0 588405.0 589228.0 58206.4 58288.0 58537.4 58662.7 58746.0 1312.1 1324.5 1371.4 1416.7 1431.2 28382.4 28487.0 28875.4 29009.6 29083.4 53447.7 54500.2 54714.5 54805.6 54833.2 500565.0 504412.0 509675.0 510096.0 510576.0 42936.0 44430.0 44808.8 45642.9 45916.0 38996.8 42324.2 44432.3 45064.5 45307.3 29072.9 35704.8 36355.5 37131.0 37396.6 32065.2 35174.8 35252.0 36060.6 36249.8 35608.6 36237.6 37222.4 38228.0 38399.2 30802.4 33365.2 33403.0 33439.0 33653.7 24982.9 25238.4 25345.0 25743.0 25798.5 05:19:28 INFO - PROCESS | 6144 | 05:19:28 INFO - PROCESS | 6144 | [#2] jquery.html Cycles:180 Average:36916.16 Median:2241.21 stddev:122299.81 (5456.9%) stddev-sans-first:122612.07 05:19:28 INFO - PROCESS | 6144 | Values: 351.5 360.0 360.4 363.5 363.8 15493.1 18874.9 19495.7 19800.3 20749.1 9426.2 11928.5 11950.9 12003.5 19725.2 4855.9 5090.6 5776.3 5796.9 5803.1 4976.8 5664.8 5672.9 5697.7 5720.5 3878.8 5156.4 5158.3 5161.1 5616.4 4884.3 5903.6 5931.6 5935.4 5943.3 4813.5 5590.8 5629.7 5670.0 5697.8 13352.7 13369.9 13418.3 13418.4 23131.3 2200.8 2239.5 2242.9 2250.2 2775.6 9734.8 10185.7 10308.2 10500.6 14695.9 1438.4 1460.4 1714.1 1759.6 1813.8 97629.0 100441.0 101073.5 101140.0 102138.5 11170.4 11322.8 11358.8 11413.6 11468.1 13569.9 13632.0 13647.9 13684.7 13695.9 8545.1 8590.1 8626.5 8656.7 8671.3 8374.0 8473.4 8491.3 8519.4 8582.5 3737.9 3834.1 4427.7 4442.4 4481.7 1852.2 1911.0 1940.9 1956.7 1959.4 403.0 404.1 418.1 422.9 429.3 11536.7 11957.9 11981.3 12032.8 12056.5 897.8 926.4 987.2 998.3 1031.2 9900.7 10207.3 10209.0 10217.3 10227.9 724220.0 726432.0 739219.0 753528.0 766969.0 99462.0 109266.0 109653.5 116080.0 119884.0 1032.1 1117.9 1152.9 1190.8 1211.6 14594.3 18217.0 18280.7 18317.5 18550.4 50139.7 51532.7 52025.0 52143.7 52231.2 74806.5 75244.0 75330.6 75344.6 76373.0 7456.7 7708.5 7718.7 7742.7 7823.8 10037.4 10350.1 11041.7 12107.4 12224.4 10157.8 10279.6 10362.1 10468.6 10714.5 9848.0 10225.5 10298.8 10324.8 10724.0 10427.8 10840.3 10924.5 11037.0 11168.6 5968.9 7411.4 7653.5 7723.6 7730.4 10315.8 10590.0 10592.5 10630.2 10737.9 05:19:28 INFO - PROCESS | 6144 | 05:19:28 INFO - PROCESS | 6144 | [#3] mootools.html Cycles:180 Average:6038.66 Median:5573.87 stddev:3166.08 (56.8%) stddev-sans-first:3156.85 05:19:28 INFO - PROCESS | 6144 | Values: 1532.8 1543.2 1677.2 1758.1 1763.4 7945.9 8573.4 8605.4 8827.5 8845.6 8615.7 8687.4 8797.3 8799.3 8799.4 2480.9 2505.6 2508.1 2508.9 2519.1 2403.6 2473.1 2531.0 2532.2 2533.7 2213.8 2464.4 2475.8 2509.8 2518.7 2454.9 2461.9 2486.5 2487.7 2497.7 2431.8 2439.1 2470.5 2472.9 2473.2 8661.5 8697.7 8730.9 8740.0 8823.2 5382.5 5564.1 5583.6 5583.8 5587.6 3063.5 3120.6 3690.5 3765.8 3767.9 905.4 1040.4 1060.8 1086.7 1098.2 9652.5 11417.8 11623.2 11808.2 11875.7 4494.5 4743.1 4829.4 4833.6 4844.7 9275.7 9282.2 9324.3 9324.8 9324.9 5331.7 5369.5 5389.8 5412.0 5425.5 4961.7 4981.3 5016.2 5030.7 5069.8 3774.2 3784.1 3793.3 3817.3 3859.0 1034.9 1133.1 1192.1 1197.8 1211.2 1053.2 1111.7 1127.2 1154.4 1307.0 7991.0 8061.6 8066.7 8156.3 8177.4 1024.4 1182.2 1183.3 1197.8 1202.9 5618.0 5913.4 6157.0 6169.0 6258.7 10374.2 11007.5 11078.5 11088.5 11133.7 10396.8 10688.2 10747.6 10881.3 10944.0 8384.5 8484.1 8525.2 8526.8 8526.9 7920.7 7990.4 8016.0 8062.1 8078.2 8917.0 9657.7 9760.0 9855.0 9913.7 9645.2 9786.9 9945.8 9959.9 10113.6 7565.3 7642.2 7656.3 7688.5 7694.2 6984.0 7073.6 8293.6 8350.8 8444.2 7294.2 7781.8 7816.8 7869.6 8032.7 7516.7 7535.8 7549.3 7637.4 7683.8 7726.3 7750.3 7750.9 7758.7 7784.0 6923.1 6985.2 7006.5 7014.3 7027.4 5938.8 7058.1 7179.3 7191.2 7209.5 05:19:28 INFO - PROCESS | 6144 | 05:19:28 INFO - PROCESS | 6144 | [#4] prototype.html Cycles:180 Average:5916.24 Median:6757.48 stddev:1952.64 (28.9%) stddev-sans-first:1911.22 05:19:28 INFO - PROCESS | 6144 | Values: 249.0 323.3 328.2 335.5 337.2 4890.9 6202.7 6806.3 6891.1 7088.7 5246.8 6861.2 6890.5 6898.4 6933.1 4250.5 5007.6 5009.0 5026.3 5036.1 5018.5 5025.7 5027.6 5033.6 5044.0 3595.3 4721.4 4769.5 4809.7 4917.9 4881.6 4890.5 4893.4 4894.5 4944.9 3993.8 4086.8 4145.3 4161.5 4181.7 6447.5 6477.7 6510.2 6511.8 6540.0 5844.4 5902.2 5921.0 5927.6 5931.3 7117.7 7340.6 7363.4 7375.1 7380.2 3878.4 4002.8 4741.1 4749.2 4750.0 7045.9 7139.5 7753.3 7823.1 7871.1 4586.6 4777.1 4781.0 4782.0 4788.9 4870.2 4870.6 4889.3 4890.0 4896.1 4938.7 5760.3 5859.1 5891.7 5907.5 7390.7 7398.6 7419.6 7423.0 7437.7 1624.8 1665.6 1694.7 1695.2 1701.5 1059.6 1063.8 1071.4 1078.9 1079.6 6747.6 6775.3 6778.2 6813.0 6830.6 7637.2 7653.5 7657.8 7669.9 7671.8 6600.8 6767.3 6784.0 6788.5 6843.7 3780.5 3960.7 4038.1 4087.5 4099.6 7017.4 8059.3 8067.4 8116.7 8137.8 6701.0 7500.6 7914.1 7980.4 7988.5 6536.7 7153.2 7327.9 7339.9 8150.8 6240.4 7746.9 7761.8 7807.2 7808.2 6216.6 7428.5 7649.7 7658.4 7661.2 8138.9 8147.6 8151.0 8164.0 8165.3 3956.9 4108.3 4968.5 5022.1 5051.5 7373.0 7637.2 7640.2 7654.8 7707.2 5962.0 7318.0 7329.6 7335.9 7349.7 7310.7 7322.5 7337.7 7409.4 7423.3 5956.4 6961.7 7225.0 7261.0 7263.6 7389.8 7394.4 7419.0 7421.0 7427.7 6978.5 7219.0 7236.2 7249.7 7290.6 05:19:28 INFO - PROCESS | 6144 | 05:19:28 INFO - PROCESS | 6144 | [#5] yui.html Cycles:180 Average:18458.35 Median:623.70 stddev:26580.14 (4261.7%) stddev-sans-first:26621.11 05:19:28 INFO - PROCESS | 6144 | Values: 659.9 666.3 689.5 717.2 726.8 14691.9 14865.1 14978.9 15063.2 15069.8 13662.3 13702.5 13723.2 13728.9 13731.8 654.1 810.6 813.9 823.7 836.1 820.4 820.4 823.0 828.4 829.7 872.9 874.5 879.8 880.6 884.2 862.8 865.2 874.7 876.2 877.5 646.2 648.2 649.9 652.7 653.5 14893.3 14942.9 15024.2 15024.9 15055.5 12789.2 12798.7 12890.5 13110.3 13310.9 9987.7 10186.1 10197.5 10210.5 10331.5 3496.1 3544.8 3612.8 3623.0 3689.8 84410.7 85394.0 85401.0 86876.6 87095.0 9472.1 9571.4 9749.9 9897.3 10360.9 19958.0 20435.2 20602.5 20624.0 20642.0 7327.3 7458.1 7487.7 7708.2 7758.0 3968.2 4074.1 4077.2 4104.0 4123.7 3609.7 3630.4 3645.8 3659.1 3660.5 640.3 648.2 652.5 656.5 661.5 458.0 491.9 549.9 596.9 607.0 8564.9 9191.7 9218.6 9356.7 9361.7 506.6 533.4 568.9 600.4 652.7 3468.8 3623.5 3889.4 3936.7 4085.9 96174.0 97239.0 97598.5 98995.0 100857.5 77503.6 78585.0 79331.0 79613.2 79673.0 68134.0 69066.7 71407.3 71712.0 72074.6 8311.4 8333.6 8451.6 8529.3 8575.2 39259.0 44172.0 48188.0 50111.0 50752.0 66375.3 66754.0 67978.7 70959.0 71398.6 8289.5 9970.1 10175.0 10305.5 10720.9 11193.1 11292.1 11326.6 11397.1 11442.2 9252.2 10443.8 10575.2 10793.2 10839.3 10545.9 10691.8 10806.8 10812.3 10856.7 10217.5 10236.2 10643.1 10703.4 10717.8 8669.9 8756.1 9529.3 9572.8 9575.9 9909.0 10024.7 10064.4 10085.6 10192.1 05:19:28 INFO - PROCESS | 6144 | -------- Summary: end -------- 05:19:28 INFO - PROCESS | 6144 | 05:19:28 INFO - TEST-INFO | 6144: exit 0 05:19:28 INFO - TEST-OK | dromaeo_css | took 1111126ms 05:19:28 INFO - TEST-START | kraken 05:19:28 INFO - operating with platform_type : mac_ 05:19:28 INFO - Initialising browser for kraken test... 05:19:28 INFO - TEST-INFO | started process 6150 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpzEE2YX/profile http://localhost:56214/getInfo.html) 05:19:31 INFO - PROCESS | 6150 | __metrics Screen width/height:1600/1200 05:19:31 INFO - PROCESS | 6150 | colorDepth:24 05:19:31 INFO - PROCESS | 6150 | Browser inner width/height: 1024/689 05:19:31 INFO - PROCESS | 6150 | __metrics 05:19:31 INFO - PROCESS | 6150 | 05:19:31 INFO - PROCESS | 6150 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 05:19:31 INFO - PROCESS | 6150 | 05:19:32 INFO - TEST-INFO | 6150: exit 0 05:19:32 INFO - Browser initialized. 05:19:32 INFO - Running cycle 1/1 for kraken test... 05:19:32 INFO - TEST-INFO | started process 6153 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpzEE2YX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:19:44 INFO - PROCESS | 6153 | RSS: Main: 258228224 05:19:44 INFO - PROCESS | 6153 | 05:19:46 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56214/tests/kraken/driver.html?testName=audio-beat-detection) 05:19:47 INFO - PROCESS | 6153 | RSS: Main: 271138816 05:19:47 INFO - PROCESS | 6153 | 05:19:50 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56214/tests/kraken/driver.html?testName=audio-dft) 05:19:50 INFO - PROCESS | 6153 | RSS: Main: 280449024 05:19:50 INFO - PROCESS | 6153 | 05:19:54 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56214/tests/kraken/driver.html?testName=audio-fft) 05:19:54 INFO - PROCESS | 6153 | RSS: Main: 282914816 05:19:54 INFO - PROCESS | 6153 | 05:19:56 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56214/tests/kraken/driver.html?testName=audio-oscillator) 05:19:57 INFO - PROCESS | 6153 | RSS: Main: 284983296 05:19:57 INFO - PROCESS | 6153 | 05:19:59 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56214/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:20:00 INFO - PROCESS | 6153 | RSS: Main: 284106752 05:20:00 INFO - PROCESS | 6153 | 05:20:02 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56214/tests/kraken/driver.html?testName=imaging-darkroom) 05:20:03 INFO - PROCESS | 6153 | RSS: Main: 285736960 05:20:03 INFO - PROCESS | 6153 | 05:20:06 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56214/tests/kraken/driver.html?testName=imaging-desaturate) 05:20:07 INFO - PROCESS | 6153 | RSS: Main: 285290496 05:20:07 INFO - PROCESS | 6153 | 05:20:09 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56214/tests/kraken/driver.html?testName=json-parse-financial) 05:20:10 INFO - PROCESS | 6153 | RSS: Main: 285700096 05:20:10 INFO - PROCESS | 6153 | 05:20:12 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56214/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:20:12 INFO - PROCESS | 6153 | RSS: Main: 284852224 05:20:12 INFO - PROCESS | 6153 | 05:20:14 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:20:15 INFO - PROCESS | 6153 | RSS: Main: 284557312 05:20:15 INFO - PROCESS | 6153 | 05:20:17 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:20:17 INFO - PROCESS | 6153 | RSS: Main: 286785536 05:20:17 INFO - PROCESS | 6153 | 05:20:20 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:20:20 INFO - PROCESS | 6153 | RSS: Main: 286404608 05:20:20 INFO - PROCESS | 6153 | 05:20:23 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:20:24 INFO - PROCESS | 6153 | RSS: Main: 285437952 05:20:24 INFO - PROCESS | 6153 | 05:20:25 INFO - PROCESS | 6153 | Cycle 1(1): loaded http://localhost:56214/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56214/tests/kraken/driver.html?testName=ai-astar) 05:20:26 INFO - PROCESS | 6153 | RSS: Main: 286552064 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | __start_tp_report 05:20:26 INFO - PROCESS | 6153 | _x_x_mozilla_page_load 05:20:26 INFO - PROCESS | 6153 | _x_x_mozilla_page_load_details 05:20:26 INFO - PROCESS | 6153 | |i|pagename|runs| 05:20:26 INFO - PROCESS | 6153 | |0;ai-astar;115;111;114;115;115;128;115;116;116;118 05:20:26 INFO - PROCESS | 6153 | |1;audio-beat-detection;170;152;180;151;121;144;166;150;152;119 05:20:26 INFO - PROCESS | 6153 | |2;audio-dft;220;201;195;266;273;206;196;201;201;198 05:20:26 INFO - PROCESS | 6153 | |3;audio-fft;82;67;74;114;54;86;82;50;112;88 05:20:26 INFO - PROCESS | 6153 | |4;audio-oscillator;81;86;116;78;98;119;116;81;81;117 05:20:26 INFO - PROCESS | 6153 | |5;imaging-gaussian-blur;89;93;87;94;89;93;104;95;90;94 05:20:26 INFO - PROCESS | 6153 | |6;imaging-darkroom;148;96;97;98;97;96;100;148;97;97 05:20:26 INFO - PROCESS | 6153 | |7;imaging-desaturate;150;142;91;90;91;96;94;126;84;144 05:20:26 INFO - PROCESS | 6153 | |8;json-parse-financial;57;55;56;55;57;55;57;66;55;55 05:20:26 INFO - PROCESS | 6153 | |9;json-stringify-tinderbox;64;65;72;73;81;74;69;67;75;60 05:20:26 INFO - PROCESS | 6153 | |10;stanford-crypto-aes;87;88;84;86;84;85;84;87;84;87 05:20:26 INFO - PROCESS | 6153 | |11;stanford-crypto-ccm;123;127;123;133;128;129;132;123;127;127 05:20:26 INFO - PROCESS | 6153 | |12;stanford-crypto-pbkdf2;141;143;142;139;147;144;149;169;138;131 05:20:26 INFO - PROCESS | 6153 | |13;stanford-crypto-sha256-iterative;59;100;96;59;82;68;63;94;62;94 05:20:26 INFO - PROCESS | 6153 | __end_tp_report 05:20:26 INFO - PROCESS | 6153 | __start_cc_report 05:20:26 INFO - PROCESS | 6153 | _x_x_mozilla_cycle_collect,945 05:20:26 INFO - PROCESS | 6153 | __end_cc_report 05:20:26 INFO - PROCESS | 6153 | __startTimestamp1455024026154__endTimestamp 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | ------- Summary: start ------- 05:20:26 INFO - PROCESS | 6153 | Number of tests: 14 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#0] ai-astar Cycles:10 Average:116.30 Median:115.50 stddev:4.47 (3.9%) stddev-sans-first:4.72 05:20:26 INFO - PROCESS | 6153 | Values: 115.0 111.0 114.0 115.0 115.0 128.0 115.0 116.0 116.0 118.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#1] audio-beat-detection Cycles:10 Average:150.50 Median:152.00 stddev:19.44 (12.8%) stddev-sans-first:19.29 05:20:26 INFO - PROCESS | 6153 | Values: 170.0 152.0 180.0 151.0 121.0 144.0 166.0 150.0 152.0 119.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#2] audio-dft Cycles:10 Average:215.70 Median:203.50 stddev:29.26 (14.4%) stddev-sans-first:30.99 05:20:26 INFO - PROCESS | 6153 | Values: 220.0 201.0 195.0 266.0 273.0 206.0 196.0 201.0 201.0 198.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#3] audio-fft Cycles:10 Average:80.90 Median:78.00 stddev:21.24 (27.2%) stddev-sans-first:22.53 05:20:26 INFO - PROCESS | 6153 | Values: 82.0 67.0 74.0 114.0 54.0 86.0 82.0 50.0 112.0 88.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:81.00 stddev:17.81 (22.0%) stddev-sans-first:17.89 05:20:26 INFO - PROCESS | 6153 | Values: 81.0 86.0 116.0 78.0 98.0 119.0 116.0 81.0 81.0 117.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:93.00 stddev:4.76 (5.1%) stddev-sans-first:4.84 05:20:26 INFO - PROCESS | 6153 | Values: 89.0 93.0 87.0 94.0 89.0 93.0 104.0 95.0 90.0 94.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#6] imaging-darkroom Cycles:10 Average:107.40 Median:97.00 stddev:21.43 (22.1%) stddev-sans-first:16.96 05:20:26 INFO - PROCESS | 6153 | Values: 148.0 96.0 97.0 98.0 97.0 96.0 100.0 148.0 97.0 97.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#7] imaging-desaturate Cycles:10 Average:110.80 Median:90.50 stddev:26.41 (29.2%) stddev-sans-first:23.91 05:20:26 INFO - PROCESS | 6153 | Values: 150.0 142.0 91.0 90.0 91.0 96.0 94.0 126.0 84.0 144.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:3.36 (5.9%) stddev-sans-first:3.56 05:20:26 INFO - PROCESS | 6153 | Values: 57.0 55.0 56.0 55.0 57.0 55.0 57.0 66.0 55.0 55.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#9] json-stringify-tinderbox Cycles:10 Average:70.00 Median:72.50 stddev:6.20 (8.6%) stddev-sans-first:6.18 05:20:26 INFO - PROCESS | 6153 | Values: 64.0 65.0 72.0 73.0 81.0 74.0 69.0 67.0 75.0 60.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:86.50 stddev:1.58 (1.8%) stddev-sans-first:1.59 05:20:26 INFO - PROCESS | 6153 | Values: 87.0 88.0 84.0 86.0 84.0 85.0 84.0 87.0 84.0 87.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:127.50 stddev:3.55 (2.8%) stddev-sans-first:3.43 05:20:26 INFO - PROCESS | 6153 | Values: 123.0 127.0 123.0 133.0 128.0 129.0 132.0 123.0 127.0 127.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:143.50 stddev:10.01 (7.0%) stddev-sans-first:10.55 05:20:26 INFO - PROCESS | 6153 | Values: 141.0 143.0 142.0 139.0 147.0 144.0 149.0 169.0 138.0 131.0 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - PROCESS | 6153 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.70 Median:75.00 stddev:17.12 (22.8%) stddev-sans-first:16.77 05:20:26 INFO - PROCESS | 6153 | Values: 59.0 100.0 96.0 59.0 82.0 68.0 63.0 94.0 62.0 94.0 05:20:26 INFO - PROCESS | 6153 | -------- Summary: end -------- 05:20:26 INFO - PROCESS | 6153 | 05:20:26 INFO - TEST-INFO | 6153: exit 0 05:20:26 INFO - TEST-OK | kraken | took 58252ms 05:20:26 INFO - SUITE-END | took 1169s 05:20:27 INFO - Completed test suite (00:19:29) 05:20:27 INFO - Working with test: dromaeo_css 05:20:27 INFO - Generating results file: dromaeo_css 05:20:27 INFO - Working with test: kraken 05:20:27 INFO - Generating results file: kraken 05:20:27 INFO - javascript benchmark 05:20:27 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:20:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 05:20:27 INFO - process_Request line: dromaeo_css 7437.06 graph.html#tests=[[72,64,61]] 05:20:27 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:20:27 INFO - process_Request line: kraken 1533.30 graph.html#tests=[[232,64,61]] 05:20:27 INFO - RETURN: dromaeo_css: 7437.06 05:20:27 INFO - RETURN: kraken: 1533.30 05:20:27 INFO - javascript benchmark 05:20:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3482.5472688550485, 3487.9302413951737, 3493.1965647900997, 3535.999999999999, 3536.3988122019255, 5694.487496125348, 5726.7422965966525, 5750.424957504248, 5774.538036957044, 5791.102379131231, 4844.975775121119, 5637.295338082739, 5684.971575142129, 5912.763489460427, 5985.281766188053, 3988.7207895447186, 4101.364288535282, 5112.130937740584, 5257.106291930362, 5321.414644389114, 5157.8452646420665, 5261.158214685651, 5327.2808170897015, 5375.408705042461, 5394.109971854639, 3956.3472027115636, 4039.434479172918, 4083.4079058536345, 5148.639595228336, 5404.91892621609, 4323.308270676676, 5173.275741396207, 5179.378474583074, 5186.273921650972, 5210.713410762407, 5140.1518749406305, 5168.8449346519665, 5198.870028249286, 5213.244079608474, 5255.816046438356, 5521.944780552223, 5538.390777014525, 5758.222639943638, 5792.102224155263, 5796.42035796417, 6125.142480052797, 6130.754769809202, 6172.1667574877265, 6188.133661287423, 6202.81391558254, 5754.482096611283, 6145.508359331243, 6158.414950579688, 6220.377962203788, 6232.563720539564, 5864.208331875185, 5888.381719919433, 5901.321348044987, 5910.024845900378, 5928.081147422156, 6273.12176295319, 6274.2784579773, 6291.685415729286, 6292.307846136921, 6309.842253943688, 5339.305890234323, 6079.483243924316, 6141.516692814182, 6180.412860778219, 6190.845228869224, 6196.504279657616, 6214.720337584729, 6221.377862213742, 6225.595336303126, 6247.562670613104, 6102.206713127265, 6209.9379006210265, 6230.470410015108, 6232.3144454110015, 6250.343713910065, 6114.723190878713, 6209.192804935329, 6216.720247588869, 6227.875442491125, 6234.937650623527, 4844.563989240985, 4864.270359446112, 4897.363342765418, 4903.9946810903675, 4922.507749225048, 4358.825646974085, 4366.039471316305, 4384.69307148503, 4432.556744325606, 4441.911161776747, 5688.431156884361, 5728.369879313273, 5744.770209191669, 5753.539716822645, 5767.423257674283, 5521.2270282160525, 6019.729112189962, 6200.472959798468, 6206.782762603287, 6225.439710425992, 5661.660300381908, 5714.942850571524, 5734.254546908958, 5772.047612144033, 5852.531797456193, 5354.973225133849, 5387.595930305243, 5395.21769343443, 5403.162509810985, 5403.594730395236, 5171.689698618095, 6206.596571222856, 6340.270868850049, 6375.203099612549, 6403.647799370986, 6168.074788781719, 6189.845253868509, 6207.81376558704, 6215.81352559424, 6219.315875253628, 6333.746650133943, 6354.364563543609, 6356.650384228912, 6357.396047375492, 6389.105525226565, 6046.12331211963, 6108.85814249354, 6153.923063463786, 6202.596831206138, 6220.03589443637, 5329.680219186861, 6068.575199735976, 6178.907316390168, 6212.316645168938, 6223.875522489616, 5944.791932282349, 6096.0, 6134.601250918676, 6149.815505534841, 6179.227596550431, 5907.911381329198, 6066.575339726353, 6160.568760186744, 6165.969170154121, 6190.133381326528, 5340.893182136413, 5935.317438494629, 5937.406259374028, 6005.789797357072, 6054.515638748801, 5582.385937546947, 6084.543659225487, 6117.113018612187, 6142.775043102407, 6170.413810687977, 5887.704704964901, 5989.490893273946, 6025.758969641165, 6051.878962420815, 6070.0], "unit": "score", "name": "dojo.html", "value": 5638.700754479284}, {"lowerIsBetter": false, "replicates": [464.2293792304775, 471.5614478534963, 495.5341978540173, 566.6147020026382, 599.6012651586695, 33633.327333453315, 37189.88430347087, 37281.0, 37701.245975080485, 37961.43057854131, 36724.81637591815, 40292.79853600735, 40319.0, 40397.596024039754, 40608.0, 9347.252219822432, 9498.002709715483, 9565.139137477625, 9569.80860382792, 9577.856332155023, 8287.58562071897, 9432.434053956751, 9553.61785528578, 9566.091221333962, 9578.377405468656, 9549.949505554383, 9582.856257156114, 9583.66457173999, 9588.952055239713, 9621.326507144502, 9502.619895204183, 9529.094736000068, 9559.761005974837, 9580.808383832284, 9589.952050239774, 9364.859527107099, 9435.339526233167, 9499.667511637059, 9507.24116038535, 9529.714108576754, 28507.714922850715, 36251.09372265688, 37748.62251377506, 37843.810780946194, 38242.80878595617, 2668.679758429001, 2783.248522898806, 3250.0574833298315, 3329.267561136546, 3354.0943945134923, 27243.318917027034, 27285.0, 27301.86349068262, 27413.45173096547, 27640.447191056068, 2743.231895069384, 2768.764655004327, 2823.7035111313426, 2839.2617919340914, 2952.808067475607, 504777.47611261706, 508009.0, 508361.45819271036, 509764.0, 510900.0, 56393.436065638816, 65325.34674653288, 66598.66700666466, 67010.66494667593, 67717.0, 67192.32807671861, 67737.0, 67795.66102169457, 67928.96213113515, 68015.31984680188, 12864.0, 14935.626609334853, 16200.75698864518, 16725.829191956447, 16776.580585485215, 12528.498860045678, 12531.561395351118, 12700.80948785769, 12803.359832008362, 12908.741825163444, 18218.817811821977, 21058.47353816136, 21224.0, 21393.0, 21464.78535214628, 9053.411528250643, 9274.211692006254, 9333.486658233727, 9358.064193580587, 9365.0, 776.751439539342, 965.3725078698761, 990.8315586350337, 1042.718466014172, 1080.7514271717548, 22790.65814012791, 28070.43859122806, 28404.43191136207, 28716.569251461246, 28720.563971801326, 938.9812203756023, 1035.2080658296409, 1078.9892101078888, 1093.8632670916136, 1133.6485689436302, 11834.644960651194, 13746.65633359154, 14621.90335724825, 14765.0, 14820.925895370454, 576769.0, 581253.0937345286, 587010.0, 588405.0, 589228.0, 58206.417935820944, 58288.0, 58537.4146258532, 58662.70668646715, 58746.0, 1312.1274352555633, 1324.4702119152223, 1371.403439503799, 1416.6812467195005, 1431.205680847119, 28382.43235135327, 28487.0, 28875.42249155047, 29009.564856526747, 29083.41833163367, 53447.732761335945, 54500.18249726178, 54714.45285547093, 54805.62985925384, 54833.1775023367, 500565.0, 504412.0, 509675.0, 510096.0, 510576.0, 42936.0, 44430.0, 44808.77595612001, 45642.85892852705, 45916.0, 38996.83009509719, 42324.153516930106, 44432.33351499795, 45064.54935450604, 45307.32039019351, 29072.854635726686, 35704.82147589245, 36355.500755707835, 37131.0, 37396.6260337404, 32065.19837004, 35174.82412588023, 35252.0, 36060.639393606776, 36249.81875090607, 35608.643913561566, 36237.63762362343, 37222.44166337453, 38228.0, 38399.232015360096, 30802.383952321277, 33365.16587085342, 33402.997910061764, 33439.0, 33653.663463365054, 24982.875085624455, 25238.369040774127, 25344.98620055177, 25743.0, 25798.484030319665], "unit": "score", "name": "ext.html", "value": 19763.434943242883}, {"lowerIsBetter": false, "replicates": [351.5096440465549, 359.955005624297, 360.43411843405846, 363.53467561521256, 363.83809204903827, 15493.147876866768, 18874.923758386583, 19495.70756438651, 19800.30698925538, 20749.066292016876, 9426.245900327975, 11928.522859085626, 11950.880491195085, 12003.519859205644, 19725.210991560358, 4855.927161092595, 5090.643654944155, 5776.335721392052, 5796.942030579682, 5803.100519419497, 4976.776045077962, 5664.801731939383, 5672.9221447924965, 5697.658140511562, 5720.456556627114, 3878.7672739635573, 5156.381234251895, 5158.303629010074, 5161.071007218699, 5616.354119276274, 4884.3406140171155, 5903.645781253139, 5931.555133365015, 5935.376785437532, 5943.286805583336, 4813.542713442217, 5590.776368945238, 5629.746661400206, 5669.971650141723, 5697.77208911643, 13352.666183345495, 13369.866301336959, 13418.261995590336, 13418.396172172275, 23131.33472185636, 2200.7689192634703, 2239.540894116702, 2242.8766417847014, 2250.1561914282142, 2775.639166908309, 9734.756631084208, 10185.745356366077, 10308.175345972379, 10500.632477863315, 14695.853041469662, 1438.4318194313291, 1460.3866376121948, 1714.125795844116, 1759.6480703859152, 1813.8367546920708, 97629.0, 100441.0, 101073.48389774085, 101139.9886001138, 102138.48930755373, 11170.385628790333, 11322.830157547643, 11358.829617555743, 11413.60052398162, 11468.13988950832, 13569.932150339382, 13632.045756797128, 13647.931760341135, 13684.657883552793, 13695.931520342334, 8545.060043395222, 8590.098039705741, 8626.482411055356, 8656.69701560455, 8671.306295496344, 8374.0, 8473.406861519634, 8491.278241349431, 8519.446235994641, 8582.527960962083, 3737.8878633641034, 3834.1373191031794, 4427.667924905645, 4442.400275962768, 4481.708688935274, 1852.19429548147, 1910.980890191108, 1940.9126589303514, 1956.735840661521, 1959.4121763470903, 402.9556748757634, 404.09885954322027, 418.080223508283, 422.9323308270662, 429.3345314762106, 11536.711582210344, 11957.940210298893, 11981.341026243466, 12032.759344813056, 12056.457459414347, 897.7665806890125, 926.4117285523741, 987.1757082835912, 998.3311181508407, 1031.200819364983, 9900.65347712841, 10207.285490015627, 10209.0, 10217.284790064625, 10227.94886025565, 724220.0, 726432.0, 739219.0, 753528.0, 766969.0, 99462.0, 109266.0, 109653.45173274082, 116080.0, 119884.0, 1032.143321043532, 1117.8546788917552, 1152.948117334722, 1190.7678002789373, 1211.5759484180467, 14594.273209191024, 18217.0, 18280.72578911291, 18317.450476485727, 18550.44348669542, 50139.74930125326, 51532.74233628808, 52025.0, 52143.73928130335, 52231.21653175281, 74806.50386992338, 75244.0, 75330.62334688292, 75344.62327688545, 76373.0, 7456.701731930879, 7708.49894756839, 7718.729844455417, 7742.65158067877, 7823.765287041398, 10037.397756134655, 10350.085234231692, 11041.723956901142, 12107.394630268627, 12224.449899754354, 10157.84763228567, 10279.640212592523, 10362.067413932782, 10468.63359782404, 10714.517846697074, 9847.950760246153, 10225.539850706884, 10298.794024119625, 10324.845127323246, 10724.0, 10427.791444171226, 10840.292145474614, 10924.453777310944, 11037.006669399792, 11168.553257869595, 5968.910466342922, 7411.370033547209, 7653.502522336031, 7723.613819309125, 7730.420218483524, 10315.845262320921, 10590.0, 10592.470376480991, 10630.202734794766, 10737.946310268399], "unit": "score", "name": "jquery.html", "value": 8678.29127976276}, {"lowerIsBetter": false, "replicates": [1532.8390518995504, 1543.1898253416955, 1677.1698009485306, 1758.1472985601981, 1763.382816014396, 7945.92054079459, 8573.399862009663, 8605.354598405122, 8827.47035177889, 8845.557722113892, 8615.741527754177, 8687.391882568223, 8797.340199485032, 8799.252063574604, 8799.428037177595, 2480.900763969439, 2505.5865782145925, 2508.097085049381, 2508.8620125893067, 2519.1308998395525, 2403.627437747143, 2473.0973194783865, 2531.0382054819233, 2532.202356257773, 2533.7466253374605, 2213.7896899794496, 2464.4331803685163, 2475.752424757528, 2509.8494090354548, 2518.659980902573, 2454.8527088374753, 2461.9261422157365, 2486.477839653675, 2487.6517287579754, 2497.7377375375504, 2431.8297719159664, 2439.0609615298063, 2470.505898820243, 2472.938176545583, 2473.208573256559, 8661.480311181349, 8697.69558065471, 8730.86903696445, 8740.038595754462, 8823.205911467998, 5382.4886635769935, 5564.10974244119, 5583.637063590853, 5583.776648934037, 5587.636803607753, 3063.5251536011956, 3120.578721872541, 3690.464882592036, 3765.811709414518, 3767.8869633911027, 905.3979103895902, 1040.422565476168, 1060.8249638809586, 1086.684861390196, 1098.2257508456519, 9652.517374131265, 11417.80113088122, 11623.244489108265, 11808.232464889841, 11875.703107422298, 4494.505604383515, 4743.146233677971, 4829.372181616367, 4833.613310935117, 4844.660873738804, 9275.721728348026, 9282.211012063915, 9324.25405967521, 9324.813503730024, 9324.8601270981, 5331.70675612845, 5369.48989845964, 5389.784408623611, 5411.9729401353525, 5425.484578964992, 4961.652684312064, 4981.277714731344, 5016.1723315653235, 5030.748462576857, 5069.847904562869, 3774.150816066418, 3784.0918179636687, 3793.2982398256413, 3817.2938006468894, 3858.9807050964564, 1034.9482525873675, 1133.1444759206747, 1192.099964526794, 1197.808350663907, 1211.2248161176854, 1053.167997282154, 1111.7387413957713, 1127.1658972360558, 1154.359330571524, 1306.9869301306865, 7991.0, 8061.556614386265, 8066.717664881701, 8156.265936065783, 8177.386695997824, 1024.3555836260932, 1182.1665725663386, 1183.2722875431548, 1197.8442802435627, 1202.897753690946, 5618.016847051749, 5913.379095195029, 6157.045657922939, 6168.9691551541955, 6258.718357673915, 10374.17006639467, 11007.504662290215, 11078.501467433985, 11088.501017454233, 11133.721656958642, 10396.792064158826, 10688.198385121146, 10747.570097196181, 10881.347119172875, 10944.0, 8384.455010424303, 8484.066752657203, 8525.19010693983, 8526.806247125407, 8526.914730852735, 7920.683172673029, 7990.360771138411, 8016.038075430985, 8062.072861620754, 8078.23256790604, 8917.0, 9657.71026869195, 9760.023997600183, 9855.014498550088, 9913.65302214448, 9645.228381729585, 9786.902130978884, 9945.801083978135, 9959.850602241117, 10113.64602238918, 7565.2812982766545, 7642.197569255148, 7656.349210316963, 7688.46180767341, 7694.230576942261, 6983.9650801745665, 7073.646317684198, 8293.58532073406, 8350.832983340179, 8444.197801208875, 7294.197638259893, 7781.844363112593, 7816.84366312682, 7869.645865935932, 8032.718854840053, 7516.736914207976, 7535.773926782205, 7549.2828181324885, 7637.389008879165, 7683.769486915178, 7726.3432608226685, 7750.302472777477, 7750.883736743841, 7758.681024226008, 7783.9880815493625, 6923.134608173978, 6985.1967023790885, 7006.509544331848, 7014.333638304353, 7027.4378049756915, 5938.792142275172, 7058.11773528309, 7179.317964793545, 7191.2449192834, 7209.531380460253], "unit": "score", "name": "mootools.html", "value": 4913.198864858372}, {"lowerIsBetter": false, "replicates": [248.99875500622494, 323.2661857583286, 328.2041050452653, 335.5285823418098, 337.18737841801266, 4890.853274401765, 6202.658853763041, 6806.251312355637, 6891.1041564596535, 7088.716451341947, 5246.845693947335, 6861.210960739517, 6890.517663763539, 6898.37914587687, 6933.098697169361, 4250.511191213003, 5007.574356179729, 5009.0, 5026.271190677349, 5036.093503169428, 5018.5232402921665, 5025.698458092508, 5027.622928280375, 5033.597312215033, 5044.0, 3595.280943811235, 4721.362616046824, 4769.4515130760055, 4809.725422762971, 4917.852464426073, 4881.560659540658, 4890.462049174588, 4893.388326459192, 4894.461609222983, 4944.87637809054, 3993.800309984518, 4086.7547947123267, 4145.316022856225, 4161.500619925598, 4181.665466762652, 6447.516436267252, 6477.708503117371, 6510.16807688657, 6511.804645860631, 6540.0, 5844.386339434341, 5902.173695682608, 5920.970395147997, 5927.555433342516, 5931.288245410536, 7117.679704413314, 7340.559566425978, 7363.410927125817, 7375.11498620169, 7380.225076367012, 3878.379459286529, 4002.779847108408, 4741.146593613148, 4749.216379297412, 4750.002499475115, 7045.89431158533, 7139.535930164523, 7753.340966017895, 7823.100343460575, 7871.094824095245, 4586.633069354443, 4777.116233496814, 4780.976095119502, 4781.95218047822, 4788.928166077511, 4870.172070747911, 4870.586000190024, 4889.266610008527, 4889.951100489021, 4896.143174944371, 4938.728369939688, 5760.251167348218, 5859.091840764689, 5891.675957822361, 5907.527397808165, 7390.704371825174, 7398.630068496554, 7419.591922444318, 7423.0, 7437.702491900372, 1624.8375162483658, 1665.616908111117, 1694.669539439822, 1695.169367010156, 1701.4725435115154, 1059.6238335390826, 1063.7553362726617, 1071.4053700196466, 1078.9190810689229, 1079.578964203961, 6747.628880411527, 6775.254721980578, 6778.152730908637, 6812.978053292046, 6830.624315662686, 7637.19809420014, 7653.464257501922, 7657.770266892002, 7669.923300767033, 7671.846563068707, 6600.80197594073, 6767.323267673291, 6784.0, 6788.49086318528, 6843.657817109125, 3780.5066998535426, 3960.7029472789654, 4038.0712436139265, 4087.5299340576216, 4099.631033207026, 7017.4386049116965, 8059.314958228499, 8067.410002548927, 8116.715914943066, 8137.75586732399, 6700.994850772326, 7500.624968751541, 7914.089879663798, 7980.3615710743, 7988.520688758693, 6536.692661467726, 7153.213146553875, 7327.890081648886, 7339.926600733925, 8150.796230094295, 6240.375962403905, 7746.92253077462, 7761.805954851174, 7807.18024607408, 7808.219178082373, 6216.595921265103, 7428.517146385468, 7649.732259370895, 7658.387329013777, 7661.233876612294, 8138.9186108138165, 8147.63335649909, 8151.0, 8164.0, 8165.346772258086, 3956.8812935611977, 4108.342665173558, 4968.478309777566, 5022.096022715946, 5051.494850514919, 7373.041504604582, 7637.236276372319, 7640.218092044473, 7654.846903062019, 7707.190744971697, 5962.0, 7318.012068370702, 7329.596872172082, 7335.889961650473, 7349.6692648832, 7310.707571697285, 7322.450816188701, 7337.706491740484, 7409.444291678254, 7423.257674232534, 5956.404359564009, 6961.7215311389, 7224.963875180591, 7260.983462315386, 7263.6005019724425, 7389.815254618463, 7394.371478424394, 7419.035525381882, 7420.962895185706, 7427.702891884264, 6978.47661425385, 7218.963905180441, 7236.167840698387, 7249.746258880914, 7290.635468226674], "unit": "score", "name": "prototype.html", "value": 5259.560356159614}, {"lowerIsBetter": false, "replicates": [659.861429099889, 666.2904007232297, 689.5449003657587, 717.1609217215857, 726.8182954261434, 14691.926540367296, 14865.108093514396, 14978.925105374472, 15063.171525566104, 15069.773953390708, 13662.316884155802, 13702.451901923936, 13723.245221512812, 13728.862711372883, 13731.794023089637, 654.1006116589689, 810.6068556749972, 813.9226773456512, 823.6828820903966, 836.1178956201205, 820.36421773126, 820.3765138494728, 823.0411570520337, 828.3828547731918, 829.6639860856363, 872.8821609082756, 874.4884242718017, 879.7536689726854, 880.5993273060774, 884.2483888694622, 862.8403745307138, 865.16079402979, 874.6982291109557, 876.202655583416, 877.473515890467, 646.176125440063, 648.1994736500418, 649.9252585952629, 652.7486917536735, 653.5359894474929, 14893.32980015902, 14942.925285373612, 15024.248787560688, 15024.924875375662, 15055.54833355001, 12789.232646041268, 12798.744025119446, 12890.548830790878, 13110.344482775918, 13310.93512518996, 9987.650432234837, 10186.08325250731, 10197.49012549377, 10210.540525676362, 10331.48342582868, 3496.126507467454, 3544.769589976669, 3612.819359032038, 3622.967454275545, 3689.8339574719203, 84410.73383899247, 85394.0, 85401.0, 86876.56561717213, 87095.0, 9472.100150485692, 9571.425714457155, 9749.853752193723, 9897.307188496736, 10360.896391035993, 19958.0, 20435.182592696125, 20602.484937876674, 20624.0, 20642.0, 7327.303906128909, 7458.142313633893, 7487.66305516253, 7708.152103268636, 7757.961210193913, 3968.226195891831, 4074.144429669743, 4077.225327187825, 4104.0, 4123.731957422758, 3609.7112231021456, 3630.419132938717, 3645.799481028516, 3659.14010207601, 3660.524131862894, 640.3468462168562, 648.2059477140465, 652.4780175859294, 656.4518626946553, 661.5468404143178, 457.9771011449414, 491.87457198414177, 549.8982688202695, 596.9283685957625, 607.0469363099979, 8564.914350856536, 9191.678291259774, 9218.631254749735, 9356.719298421058, 9361.672341468153, 506.57194670503367, 533.4105813076573, 568.8606291458619, 600.4025994135776, 652.6606164794375, 3468.7571869969365, 3623.456481527739, 3889.3582558878034, 3936.7441116327345, 4085.8978525536504, 96174.0, 97239.0, 97598.51200744094, 98995.0, 100857.49571252096, 77503.61248193723, 78585.0, 79331.0, 79613.20386796174, 79673.02452316099, 68134.0, 69066.65466672635, 71407.2859271411, 71712.0, 72074.55850882953, 8311.39095592449, 8333.583320833814, 8451.619677114422, 8529.273864509301, 8575.185357391038, 39259.0, 44172.0, 48188.0, 50110.96602503303, 50752.0, 66375.33624663691, 66754.0, 67978.66010669916, 70959.0, 71398.64300678464, 8289.544075075928, 9970.102690757867, 10175.0, 10305.484725763532, 10720.889083282173, 11193.104551636012, 11292.096632269235, 11326.603568875049, 11397.145214109141, 11442.199046066695, 9252.167304942588, 10443.843342349719, 10575.153987680813, 10793.19051071157, 10839.349639021684, 10545.894541054799, 10691.786164276826, 10806.837897431387, 10812.297200681931, 10856.728581785519, 10217.540210690388, 10236.232282578687, 10643.148548116287, 10703.357798532114, 10717.785644286914, 8669.869951950599, 8756.14238344461, 9529.285303602119, 9572.808543829224, 9575.941172647914, 9909.0, 10024.749381265527, 10064.44645544502, 10085.647002354883, 10192.082712555906], "unit": "score", "name": "yui.html", "value": 6769.949574673373}], "name": "dromaeo_css", "value": 7437.06279025572}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 114.0, 115.0, 115.0, 128.0, 115.0, 116.0, 116.0, 118.0], "unit": "score", "name": "ai-astar", "value": 116.3}, {"lowerIsBetter": true, "replicates": [170.0, 152.0, 180.0, 151.0, 121.0, 144.0, 166.0, 150.0, 152.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [220.0, 201.0, 195.0, 266.0, 273.0, 206.0, 196.0, 201.0, 201.0, 198.0], "unit": "score", "name": "audio-dft", "value": 215.7}, {"lowerIsBetter": true, "replicates": [82.0, 67.0, 74.0, 114.0, 54.0, 86.0, 82.0, 50.0, 112.0, 88.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [81.0, 86.0, 116.0, 78.0, 98.0, 119.0, 116.0, 81.0, 81.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 97.3}, {"lowerIsBetter": true, "replicates": [89.0, 93.0, 87.0, 94.0, 89.0, 93.0, 104.0, 95.0, 90.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.8}, {"lowerIsBetter": true, "replicates": [148.0, 96.0, 97.0, 98.0, 97.0, 96.0, 100.0, 148.0, 97.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 107.4}, {"lowerIsBetter": true, "replicates": [150.0, 142.0, 91.0, 90.0, 91.0, 96.0, 94.0, 126.0, 84.0, 144.0], "unit": "score", "name": "imaging-desaturate", "value": 110.8}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 56.0, 55.0, 57.0, 55.0, 57.0, 66.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 72.0, 73.0, 81.0, 74.0, 69.0, 67.0, 75.0, 60.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.0}, {"lowerIsBetter": true, "replicates": [87.0, 88.0, 84.0, 86.0, 84.0, 85.0, 84.0, 87.0, 84.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [123.0, 127.0, 123.0, 133.0, 128.0, 129.0, 132.0, 123.0, 127.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.2}, {"lowerIsBetter": true, "replicates": [141.0, 143.0, 142.0, 139.0, 147.0, 144.0, 149.0, 169.0, 138.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [59.0, 100.0, 96.0, 59.0, 82.0, 68.0, 63.0, 94.0, 62.0, 94.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.7}], "name": "kraken", "value": 1533.2999999999997}]} 05:20:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1533.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7437.06"}}} 05:20:27 INFO - Return code: 0 05:20:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:20:27 INFO - # TBPL SUCCESS # 05:20:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:20:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:20:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:20:27 INFO - 2016-02-09 05:20:27.929 screenresolution[6158:103742] starting screenresolution argv=screenresolution get 05:20:27 INFO - 2016-02-09 05:20:27.932 screenresolution[6158:103742] Display 0: 1600x1200x32@60 05:20:27 INFO - 2016-02-09 05:20:27.938 screenresolution[6159:103745] starting screenresolution argv=screenresolution list 05:20:27 INFO - Available Modes on Display 0 05:20:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:20:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:20:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:20:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:20:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:20:28 INFO - Intel Iris: 05:20:28 INFO - Chipset Model: Intel Iris 05:20:28 INFO - Type: GPU 05:20:28 INFO - Bus: Built-In 05:20:28 INFO - VRAM (Dynamic, Max): 1536 MB 05:20:28 INFO - Vendor: Intel (0x8086) 05:20:28 INFO - Device ID: 0x0a2e 05:20:28 INFO - Revision ID: 0x0009 05:20:28 INFO - Displays: 05:20:28 INFO - Display: 05:20:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:20:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:20:28 INFO - Display Serial Number: 1600x1200 60 05:20:28 INFO - Main Display: Yes 05:20:28 INFO - Mirror: Off 05:20:28 INFO - Online: Yes 05:20:28 INFO - Rotation: Supported 05:20:28 INFO - Return code: 0 05:20:28 INFO - Running post-action listener: _resource_record_post_action 05:20:28 INFO - Running post-run listener: _resource_record_post_run 05:20:29 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 22818304; Write bytes: 713007616; Read time: 240; Write time: 2033 05:20:29 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 406743552; Write bytes: 408577536; Read time: 31026; Write time: 821 05:20:29 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 22793728; Write bytes: 302359552; Read time: 239; Write time: 1202 05:20:29 INFO - Running post-run listener: _upload_blobber_files 05:20:29 INFO - Blob upload gear active. 05:20:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:20:29 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 05:20:29 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'] 05:20:29 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 05:20:29 INFO - (blobuploader) - INFO - Open directory for files ... 05:20:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:20:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:20:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:30 INFO - (blobuploader) - INFO - Done attempting. 05:20:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:20:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:20:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:20:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:20:31 INFO - (blobuploader) - INFO - Done attempting. 05:20:31 INFO - (blobuploader) - INFO - Iteration through files over. 05:20:31 INFO - Return code: 0 05:20:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:20:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:20:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcc9f460cea47549324eb12958a41b98bc1184573f0cb0ecc12d9a77b24d634ccf9279a9f9099df3914376e1e01226e6b393e24dd2e8adda7b1b5d02ef0c5b9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f19fbdd4a7ab4ae0e9973ec8f2ff37886adda876fc669812a34239783d93efe3290906a37b2b199021daefcd9ad6ee5167d4d4ec8551260385c6d6c858b0140"} 05:20:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:20:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:20:31 INFO - Contents: 05:20:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcc9f460cea47549324eb12958a41b98bc1184573f0cb0ecc12d9a77b24d634ccf9279a9f9099df3914376e1e01226e6b393e24dd2e8adda7b1b5d02ef0c5b9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f19fbdd4a7ab4ae0e9973ec8f2ff37886adda876fc669812a34239783d93efe3290906a37b2b199021daefcd9ad6ee5167d4d4ec8551260385c6d6c858b0140"} 05:20:31 INFO - Running post-run listener: copy_logs_to_upload_dir 05:20:31 INFO - Copying logs to upload dir... 05:20:31 INFO - mkdir: /builds/slave/test/build/upload/logs 05:20:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.071123 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-09 05:20:32.053295) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 05:20:32.057269) ========= 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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcc9f460cea47549324eb12958a41b98bc1184573f0cb0ecc12d9a77b24d634ccf9279a9f9099df3914376e1e01226e6b393e24dd2e8adda7b1b5d02ef0c5b9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f19fbdd4a7ab4ae0e9973ec8f2ff37886adda876fc669812a34239783d93efe3290906a37b2b199021daefcd9ad6ee5167d4d4ec8551260385c6d6c858b0140"} build_url:https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011028 build_url: 'https://queue.taskcluster.net/v1/task/MbSExAXcTWyPO8B7SuHF7A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bcc9f460cea47549324eb12958a41b98bc1184573f0cb0ecc12d9a77b24d634ccf9279a9f9099df3914376e1e01226e6b393e24dd2e8adda7b1b5d02ef0c5b9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7f19fbdd4a7ab4ae0e9973ec8f2ff37886adda876fc669812a34239783d93efe3290906a37b2b199021daefcd9ad6ee5167d4d4ec8551260385c6d6c858b0140"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-09 05:20:32.087526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:20:32.087852) ========= 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.b4UxRMwXuc/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.QvEJVnnOPr/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005021 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-09 05:20:32.136960) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 05:20:32.137270) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-09 05:20:32.137714) ========= ========= Total master_lag: 0.41 =========