builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0031 starttime: 1456183583.06 results: success (0) buildid: 20160222142848 builduid: 9d91b02336de41ff822fa811416d915e revision: 061710a98fa4a8353f63076c34aa318565e59ec8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.057038) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.057476) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.057781) ========= 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.jjTEeaSebS/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.4h6N3gYqEV/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.005585 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.081633) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.081948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.099208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.099581) ========= 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.jjTEeaSebS/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.4h6N3gYqEV/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.005565 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.147513) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.147842) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.148213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.148486) ========= 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.jjTEeaSebS/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.4h6N3gYqEV/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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-22 15:26:23-- 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% 48.4M=0s 2016-02-22 15:26:23 (48.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.105488 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.269700) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.270045) ========= 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.jjTEeaSebS/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.4h6N3gYqEV/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.023117 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:23.318501) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 15:26:23.318866) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 061710a98fa4a8353f63076c34aa318565e59ec8 --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 061710a98fa4a8353f63076c34aa318565e59ec8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jjTEeaSebS/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.4h6N3gYqEV/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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-22 15:26:23,389 truncating revision to first 12 chars 2016-02-22 15:26:23,389 Setting DEBUG logging. 2016-02-22 15:26:23,389 attempt 1/10 2016-02-22 15:26:23,389 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/061710a98fa4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 15:26:24,367 unpacking tar archive at: fx-team-061710a98fa4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.221238 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 15:26:24.629080) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:24.629453) ========= echo 061710a98fa4a8353f63076c34aa318565e59ec8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'061710a98fa4a8353f63076c34aa318565e59ec8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jjTEeaSebS/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.4h6N3gYqEV/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 061710a98fa4a8353f63076c34aa318565e59ec8 program finished with exit code 0 elapsedTime=0.006531 script_repo_revision: '061710a98fa4a8353f63076c34aa318565e59ec8' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:24.652852) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:24.653145) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 15:26:24.675832) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-22 15:26:24.676252) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jjTEeaSebS/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.4h6N3gYqEV/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 15:26:24 INFO - MultiFileLogger online at 20160222 15:26:24 in /builds/slave/test 15:26:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:26:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:26:24 INFO - {'append_to_log': False, 15:26:24 INFO - 'base_work_dir': '/builds/slave/test', 15:26:24 INFO - 'blob_upload_branch': 'Fx-Team', 15:26:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:26:24 INFO - 'branch': 'Fx-Team', 15:26:24 INFO - 'buildbot_json_path': 'buildprops.json', 15:26:24 INFO - 'config_files': ('talos/mac_config.py',), 15:26:24 INFO - 'default_actions': ('clobber', 15:26:24 INFO - 'read-buildbot-config', 15:26:24 INFO - 'download-and-extract', 15:26:24 INFO - 'populate-webroot', 15:26:24 INFO - 'create-virtualenv', 15:26:24 INFO - 'install', 15:26:24 INFO - 'run-tests'), 15:26:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:26:24 INFO - 'download_minidump_stackwalk': True, 15:26:24 INFO - 'download_symbols': 'ondemand', 15:26:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:26:24 INFO - 'tooltool.py': '/tools/tooltool.py', 15:26:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:26:24 INFO - '/tools/misc-python/virtualenv.py')}, 15:26:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:26:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:26:24 INFO - 'installer_path': 'installer.exe', 15:26:24 INFO - 'log_level': 'info', 15:26:24 INFO - 'log_name': 'talos', 15:26:24 INFO - 'log_to_console': True, 15:26:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:26:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:26:24 INFO - 'opt_config_files': (), 15:26:24 INFO - 'pip_index': False, 15:26:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:26:24 INFO - 'cmd': ('bash', 15:26:24 INFO - '-c', 15:26:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:26:24 INFO - 'enabled': True, 15:26:24 INFO - 'halt_on_failure': False, 15:26:24 INFO - 'name': 'check_screen_resolution'},), 15:26:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:26:24 INFO - 'cmd': ('bash', 15:26:24 INFO - '-c', 15:26:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:26:24 INFO - 'enabled': True, 15:26:24 INFO - 'halt_on_failure': False, 15:26:24 INFO - 'name': 'check_screen_resolution'},), 15:26:24 INFO - 'run_cmd_checks_enabled': True, 15:26:24 INFO - 'sps_profile': False, 15:26:24 INFO - 'sps_profile_interval': 0, 15:26:24 INFO - 'suite': 'dromaeojs', 15:26:24 INFO - 'system_bits': '32', 15:26:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:26:24 INFO - 'title': 't-yosemite-r7-0031', 15:26:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:26:24 INFO - 'use_talos_json': True, 15:26:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:26:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:26:24 INFO - 'work_dir': 'build'} 15:26:24 INFO - ##### 15:26:24 INFO - ##### Running clobber step. 15:26:24 INFO - ##### 15:26:24 INFO - Running pre-action listener: _resource_record_pre_action 15:26:24 INFO - Running main action method: clobber 15:26:24 INFO - rmtree: /builds/slave/test/build 15:26:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:26:26 INFO - Running post-action listener: _resource_record_post_action 15:26:26 INFO - ##### 15:26:26 INFO - ##### Running read-buildbot-config step. 15:26:26 INFO - ##### 15:26:26 INFO - Running pre-action listener: _resource_record_pre_action 15:26:26 INFO - Running main action method: read_buildbot_config 15:26:26 INFO - Using buildbot properties: 15:26:26 INFO - { 15:26:26 INFO - "project": "", 15:26:26 INFO - "product": "firefox", 15:26:26 INFO - "script_repo_revision": "production", 15:26:26 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:26:26 INFO - "repository": "", 15:26:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:26:26 INFO - "buildid": "20160222142848", 15:26:26 INFO - "pgo_build": "False", 15:26:26 INFO - "basedir": "/builds/slave/test", 15:26:26 INFO - "buildnumber": 481, 15:26:26 INFO - "slavename": "t-yosemite-r7-0031", 15:26:26 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:26:26 INFO - "platform": "yosemite_r7", 15:26:26 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:26:26 INFO - "branch": "fx-team", 15:26:26 INFO - "repo_path": "integration/fx-team", 15:26:26 INFO - "revision": "061710a98fa4a8353f63076c34aa318565e59ec8", 15:26:26 INFO - "stage_platform": "macosx64", 15:26:26 INFO - "builduid": "9d91b02336de41ff822fa811416d915e", 15:26:26 INFO - "slavebuilddir": "test" 15:26:26 INFO - } 15:26:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 15:26:26 INFO - Running post-action listener: _resource_record_post_action 15:26:26 INFO - ##### 15:26:26 INFO - ##### Running download-and-extract step. 15:26:26 INFO - ##### 15:26:26 INFO - Running pre-action listener: _resource_record_pre_action 15:26:26 INFO - Running main action method: download_and_extract 15:26:26 INFO - mkdir: /builds/slave/test/build/tests 15:26:26 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')]} 15:26:26 INFO - https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:26:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/test_packages.json 15:26:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/test_packages.json 15:26:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:26:28 INFO - Downloaded 1277 bytes. 15:26:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:26:28 INFO - Using the following test package requirements: 15:26:28 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:26:28 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:28 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 15:26:28 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:28 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 15:26:28 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:28 INFO - u'jsshell-mac.zip'], 15:26:28 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:28 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 15:26:28 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:26:28 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:28 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 15:26:28 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:28 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 15:26:28 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:28 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 15:26:28 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 15:26:28 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 15:26:28 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 15:26:28 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:26:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:28 INFO - https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:26:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:26:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:26:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:29 INFO - Downloaded 17825424 bytes. 15:26:29 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'] 15:26:29 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 15:26:32 INFO - Return code: 0 15:26:32 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 15:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:32 INFO - https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:26:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:26:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 15:26:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:34 INFO - Downloaded 17825424 bytes. 15:26: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'] 15:26: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 15:26:37 INFO - Return code: 0 15:26: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')]} 15:26:37 INFO - https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:26:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:26:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 15:26:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:39 INFO - Downloaded 10707015 bytes. 15:26:39 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'] 15:26:39 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 15:26:39 INFO - Return code: 0 15:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:39 INFO - https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:26:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:26:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:26:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 15:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WZfT5HNtQpGICZeWm2oDaA/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 15:26:42 INFO - Downloaded 111277349 bytes. 15:26:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:26:42 INFO - mkdir: /builds/slave/test/properties 15:26:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:26:42 INFO - Writing to file /builds/slave/test/properties/build_url 15:26:42 INFO - Contents: 15:26:42 INFO - build_url:https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 15:26:43 INFO - Running post-action listener: _resource_record_post_action 15:26:43 INFO - Running post-action listener: set_extra_try_arguments 15:26:43 INFO - ##### 15:26:43 INFO - ##### Running populate-webroot step. 15:26:43 INFO - ##### 15:26:43 INFO - Running pre-action listener: _resource_record_pre_action 15:26:43 INFO - Running main action method: populate_webroot 15:26:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:26:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:26:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:26:43 INFO - '--tppagecycles', 15:26:43 INFO - '7'], 15:26:43 INFO - 'tests': ['tsvgm']}}, 15:26:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:26:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:26:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:26:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:26:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:26:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:26:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'talos_options': ['--e10s'], 15:26:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:26:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'tests': ['damp', 'tps']}, 15:26:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'talos_options': ['--e10s'], 15:26:43 INFO - 'tests': ['damp', 'tps']}, 15:26:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:26:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:26:43 INFO - 'other': {'tests': ['a11yr', 15:26:43 INFO - 'ts_paint', 15:26:43 INFO - 'tpaint', 15:26:43 INFO - 'sessionrestore', 15:26:43 INFO - 'sessionrestore_no_auto_restore']}, 15:26:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:26:43 INFO - 'tests': ['a11yr', 15:26:43 INFO - 'ts_paint', 15:26:43 INFO - 'tpaint', 15:26:43 INFO - 'sessionrestore', 15:26:43 INFO - 'sessionrestore_no_auto_restore']}, 15:26:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:26:43 INFO - 'tests': ['a11yr', 15:26:43 INFO - 'ts_paint', 15:26:43 INFO - 'tpaint', 15:26:43 INFO - 'sessionrestore', 15:26:43 INFO - 'sessionrestore_no_auto_restore']}, 15:26:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:26:43 INFO - 'tests': ['a11yr', 15:26:43 INFO - 'ts_paint', 15:26:43 INFO - 'tpaint', 15:26:43 INFO - 'sessionrestore', 15:26:43 INFO - 'sessionrestore_no_auto_restore']}, 15:26:43 INFO - 'other_l64': {'tests': ['a11yr', 15:26:43 INFO - 'ts_paint', 15:26:43 INFO - 'tpaint', 15:26:43 INFO - 'sessionrestore', 15:26:43 INFO - 'sessionrestore_no_auto_restore']}, 15:26:43 INFO - 'other_nol64': {'tests': ['a11yr', 15:26:43 INFO - 'ts_paint', 15:26:43 INFO - 'tpaint', 15:26:43 INFO - 'sessionrestore', 15:26:43 INFO - 'sessionrestore_no_auto_restore']}, 15:26:43 INFO - 'svgr': {'tests': ['tsvgx', 15:26:43 INFO - 'tsvgr_opacity', 15:26:43 INFO - 'tart', 15:26:43 INFO - 'tscrollx', 15:26:43 INFO - 'cart']}, 15:26:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:26:43 INFO - 'tests': ['tsvgx', 15:26:43 INFO - 'tsvgr_opacity', 15:26:43 INFO - 'tart', 15:26:43 INFO - 'tscrollx', 15:26:43 INFO - 'cart']}, 15:26:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'tests': ['tp5o']}, 15:26:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'talos_options': ['--e10s'], 15:26:43 INFO - 'tests': ['tp5o']}, 15:26:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'talos_options': ['--xperf_path', 15:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:43 INFO - 'tests': ['tp5n']}, 15:26:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:26:43 INFO - 'talos_options': ['--e10s', 15:26:43 INFO - '--xperf_path', 15:26:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:26:43 INFO - 'tests': ['tp5n']}}, 15:26:43 INFO - 'talos.zip': {'path': '', 15:26:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:26:43 INFO - Running post-action listener: _resource_record_post_action 15:26:43 INFO - ##### 15:26:43 INFO - ##### Running create-virtualenv step. 15:26:43 INFO - ##### 15:26:43 INFO - Running pre-action listener: _resource_record_pre_action 15:26:43 INFO - Running main action method: create_virtualenv 15:26:43 INFO - Creating virtualenv /builds/slave/test/build/venv 15:26:43 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 15:26:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:26:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:26:43 INFO - Using real prefix '/tools/python27' 15:26:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:26:44 INFO - Installing distribute.............................................................................................................................................................................................done. 15:26:47 INFO - Installing pip.................done. 15:26:47 INFO - Return code: 0 15:26:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:26:47 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')]} 15:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:47 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')]} 15:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:47 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 0x1035b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98349dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345cd30>, '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 0x103280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103453b20>, '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.jjTEeaSebS/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.4h6N3gYqEV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 15:26:47 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 15:26:47 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 15:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjTEeaSebS/Render', 15:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:47 INFO - 'HOME': '/Users/cltbld', 15:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:47 INFO - 'LOGNAME': 'cltbld', 15:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:47 INFO - 'MOZ_NO_REMOTE': '1', 15:26:47 INFO - 'NO_EM_RESTART': '1', 15:26:47 INFO - 'PAGER': '/bin/cat', 15:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:47 INFO - 'PWD': '/builds/slave/test', 15:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:47 INFO - 'SHELL': '/bin/bash', 15:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4h6N3gYqEV/Listeners', 15:26:47 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 15:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:47 INFO - 'USER': 'cltbld', 15:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:47 INFO - 'XPC_FLAGS': '0x0', 15:26:47 INFO - 'XPC_SERVICE_NAME': '0', 15:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:47 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 15:26:47 INFO - Cleaning up... 15:26:47 INFO - Return code: 0 15:26:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:26:47 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')]} 15:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:47 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')]} 15:26:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:47 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 0x1035b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98349dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345cd30>, '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 0x103280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103453b20>, '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.jjTEeaSebS/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.4h6N3gYqEV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 15:26:47 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 15:26:47 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 15:26:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjTEeaSebS/Render', 15:26:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:47 INFO - 'HOME': '/Users/cltbld', 15:26:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:47 INFO - 'LOGNAME': 'cltbld', 15:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:47 INFO - 'MOZ_NO_REMOTE': '1', 15:26:47 INFO - 'NO_EM_RESTART': '1', 15:26:47 INFO - 'PAGER': '/bin/cat', 15:26:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:47 INFO - 'PWD': '/builds/slave/test', 15:26:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:47 INFO - 'SHELL': '/bin/bash', 15:26:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4h6N3gYqEV/Listeners', 15:26:47 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 15:26:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:47 INFO - 'USER': 'cltbld', 15:26:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:47 INFO - 'XPC_FLAGS': '0x0', 15:26:47 INFO - 'XPC_SERVICE_NAME': '0', 15:26:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:47 INFO - Downloading/unpacking psutil>=0.7.1 15:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:26:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:50 INFO - Installing collected packages: psutil 15:26:50 INFO - Running setup.py install for psutil 15:26:50 INFO - building 'psutil._psutil_osx' extension 15:26:50 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 15:26:50 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 15:26:50 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 15:26:50 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 15:26:51 INFO - building 'psutil._psutil_posix' extension 15:26:51 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 15:26:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:26:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:26:51 INFO - ^ 15:26:51 INFO - 1 warning generated. 15:26:51 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 15:26:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:26:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:26:51 INFO - Successfully installed psutil 15:26:51 INFO - Cleaning up... 15:26:51 INFO - Return code: 0 15:26:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:26: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')]} 15:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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')]} 15:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26: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', '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 0x1035b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98349dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345cd30>, '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 0x103280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103453b20>, '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.jjTEeaSebS/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.4h6N3gYqEV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 15:26: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:26: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 mozsystemmonitor==0.0.0 15:26:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjTEeaSebS/Render', 15:26:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:51 INFO - 'HOME': '/Users/cltbld', 15:26:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:51 INFO - 'LOGNAME': 'cltbld', 15:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:51 INFO - 'MOZ_NO_REMOTE': '1', 15:26:51 INFO - 'NO_EM_RESTART': '1', 15:26:51 INFO - 'PAGER': '/bin/cat', 15:26:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:51 INFO - 'PWD': '/builds/slave/test', 15:26:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:51 INFO - 'SHELL': '/bin/bash', 15:26:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4h6N3gYqEV/Listeners', 15:26:51 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 15:26:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:51 INFO - 'USER': 'cltbld', 15:26:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:51 INFO - 'XPC_FLAGS': '0x0', 15:26:51 INFO - 'XPC_SERVICE_NAME': '0', 15:26:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26: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 15:26:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:26:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:26:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:26:54 INFO - Installing collected packages: mozsystemmonitor 15:26:54 INFO - Running setup.py install for mozsystemmonitor 15:26:54 INFO - Successfully installed mozsystemmonitor 15:26:54 INFO - Cleaning up... 15:26:54 INFO - Return code: 0 15:26:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1035b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98349dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345cd30>, '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 0x103280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103453b20>, '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.jjTEeaSebS/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.4h6N3gYqEV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 15:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjTEeaSebS/Render', 15:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:54 INFO - 'HOME': '/Users/cltbld', 15:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:54 INFO - 'LOGNAME': 'cltbld', 15:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:54 INFO - 'MOZ_NO_REMOTE': '1', 15:26:54 INFO - 'NO_EM_RESTART': '1', 15:26:54 INFO - 'PAGER': '/bin/cat', 15:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:54 INFO - 'PWD': '/builds/slave/test', 15:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:54 INFO - 'SHELL': '/bin/bash', 15:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4h6N3gYqEV/Listeners', 15:26:54 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 15:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:54 INFO - 'USER': 'cltbld', 15:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:54 INFO - 'XPC_FLAGS': '0x0', 15:26:54 INFO - 'XPC_SERVICE_NAME': '0', 15:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:54 INFO - Downloading/unpacking blobuploader==1.2.4 15:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:56 INFO - Downloading blobuploader-1.2.4.tar.gz 15:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:26:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:26:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:26:58 INFO - Downloading docopt-0.6.1.tar.gz 15:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:26:58 INFO - Installing collected packages: blobuploader, requests, docopt 15:26:58 INFO - Running setup.py install for blobuploader 15:26:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:26:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:26:58 INFO - Running setup.py install for requests 15:26:58 INFO - Running setup.py install for docopt 15:26:58 INFO - Successfully installed blobuploader requests docopt 15:26:58 INFO - Cleaning up... 15:26:59 INFO - Return code: 0 15:26:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:26:59 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')]} 15:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:59 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')]} 15:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:26:59 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 0x1035b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98349dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345cd30>, '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 0x103280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103453b20>, '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.jjTEeaSebS/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.4h6N3gYqEV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 15:26:59 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 15:26:59 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 15:26:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjTEeaSebS/Render', 15:26:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:26:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:26:59 INFO - 'HOME': '/Users/cltbld', 15:26:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:26:59 INFO - 'LOGNAME': 'cltbld', 15:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:26:59 INFO - 'MOZ_NO_REMOTE': '1', 15:26:59 INFO - 'NO_EM_RESTART': '1', 15:26:59 INFO - 'PAGER': '/bin/cat', 15:26:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:26:59 INFO - 'PWD': '/builds/slave/test', 15:26:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:26:59 INFO - 'SHELL': '/bin/bash', 15:26:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4h6N3gYqEV/Listeners', 15:26:59 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 15:26:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:26:59 INFO - 'USER': 'cltbld', 15:26:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:26:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:26:59 INFO - 'XPC_FLAGS': '0x0', 15:26:59 INFO - 'XPC_SERVICE_NAME': '0', 15:26:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:26:59 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-lsWoNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:26:59 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-ezxSq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:26:59 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-nB3Wi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:26:59 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-AduoZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:26:59 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-0zMj3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:26:59 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-t4_KoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:26:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:26:59 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-1TyV9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-0rangL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-q9557R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-GeizBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-JxVBhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-kAjQqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-6ABPlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-xXmbHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-UBWNyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:00 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-ANxltX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:01 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-S9PTlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:27:01 INFO - Running setup.py install for manifestparser 15:27:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:27:01 INFO - Running setup.py install for mozcrash 15:27:01 INFO - Running setup.py install for mozdebug 15:27:01 INFO - Running setup.py install for mozdevice 15:27:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:27:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:27:01 INFO - Running setup.py install for mozfile 15:27:01 INFO - Running setup.py install for mozhttpd 15:27:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozinfo 15:27:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozInstall 15:27:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozleak 15:27:02 INFO - Running setup.py install for mozlog 15:27:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for moznetwork 15:27:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:27:02 INFO - Running setup.py install for mozprocess 15:27:02 INFO - Running setup.py install for mozprofile 15:27:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Running setup.py install for mozrunner 15:27:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Running setup.py install for mozscreenshot 15:27:03 INFO - Running setup.py install for moztest 15:27:03 INFO - Running setup.py install for mozversion 15:27:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:27:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:27:03 INFO - Cleaning up... 15:27:03 INFO - Return code: 0 15:27:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:03 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')]} 15:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:03 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')]} 15:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:03 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 0x1035b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98349dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345cd30>, '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 0x103280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103453b20>, '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.jjTEeaSebS/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.4h6N3gYqEV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 15:27:03 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 15:27:03 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 15:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjTEeaSebS/Render', 15:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:03 INFO - 'HOME': '/Users/cltbld', 15:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:03 INFO - 'LOGNAME': 'cltbld', 15:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:03 INFO - 'MOZ_NO_REMOTE': '1', 15:27:03 INFO - 'NO_EM_RESTART': '1', 15:27:03 INFO - 'PAGER': '/bin/cat', 15:27:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:03 INFO - 'PWD': '/builds/slave/test', 15:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:03 INFO - 'SHELL': '/bin/bash', 15:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4h6N3gYqEV/Listeners', 15:27:03 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 15:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:03 INFO - 'USER': 'cltbld', 15:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:03 INFO - 'XPC_FLAGS': '0x0', 15:27:03 INFO - 'XPC_SERVICE_NAME': '0', 15:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:27:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-YPN7qV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:27:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-q3DkRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:27:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-1jjl35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:27:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-GWCF_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:27:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-WAbduK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:27:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-HK5Fo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:27:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-C6zSrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:27:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-QYb3Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:27:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-rpO_ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:27:04 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)) 15:27:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:27:04 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-F8iPMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:27:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-jXFbw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:27:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Gbk3EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:27:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Hw1voJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:27:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-VeXiyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-SnUpxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:27:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-Uu0Fzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:27:05 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)) 15:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:27:05 INFO - Running setup.py (path:/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/pip-8HE2s7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:27:05 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)) 15:27:05 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)) 15:27:05 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)) 15:27:05 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)) 15:27:05 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)) 15:27:05 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)) 15:27:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:27:05 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 15:27:05 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 15:27:05 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 15:27:05 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 15:27:05 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 15:27:05 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 15:27:08 INFO - Downloading blessings-1.6.tar.gz 15:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:27:08 INFO - Installing collected packages: blessings 15:27:08 INFO - Running setup.py install for blessings 15:27:08 INFO - Successfully installed blessings 15:27:08 INFO - Cleaning up... 15:27:08 INFO - Return code: 0 15:27:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:08 INFO - Reading from file tmpfile_stdout 15:27:08 INFO - Current package versions: 15:27:08 INFO - blessings == 1.6 15:27:08 INFO - blobuploader == 1.2.4 15:27:08 INFO - docopt == 0.6.1 15:27:08 INFO - manifestparser == 1.1 15:27:08 INFO - mozInstall == 1.12 15:27:08 INFO - mozcrash == 0.16 15:27:08 INFO - mozdebug == 0.1 15:27:08 INFO - mozdevice == 0.48 15:27:08 INFO - mozfile == 1.2 15:27:08 INFO - mozhttpd == 0.7 15:27:08 INFO - mozinfo == 0.9 15:27:08 INFO - mozleak == 0.1 15:27:08 INFO - mozlog == 3.1 15:27:08 INFO - moznetwork == 0.27 15:27:08 INFO - mozprocess == 0.22 15:27:08 INFO - mozprofile == 0.28 15:27:08 INFO - mozrunner == 6.11 15:27:08 INFO - mozscreenshot == 0.1 15:27:08 INFO - mozsystemmonitor == 0.0 15:27:08 INFO - moztest == 0.7 15:27:08 INFO - mozversion == 1.4 15:27:08 INFO - psutil == 3.1.1 15:27:08 INFO - requests == 1.2.3 15:27:08 INFO - wsgiref == 0.1.2 15:27:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:08 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 0x1035b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98349dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345cd30>, '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 0x103280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103453b20>, '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.jjTEeaSebS/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.4h6N3gYqEV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 15:27:08 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 15:27:08 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 15:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjTEeaSebS/Render', 15:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:08 INFO - 'HOME': '/Users/cltbld', 15:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:08 INFO - 'LOGNAME': 'cltbld', 15:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:08 INFO - 'MOZ_NO_REMOTE': '1', 15:27:08 INFO - 'NO_EM_RESTART': '1', 15:27:08 INFO - 'PAGER': '/bin/cat', 15:27:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:08 INFO - 'PWD': '/builds/slave/test', 15:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:08 INFO - 'SHELL': '/bin/bash', 15:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4h6N3gYqEV/Listeners', 15:27:08 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 15:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:08 INFO - 'USER': 'cltbld', 15:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:08 INFO - 'XPC_FLAGS': '0x0', 15:27:08 INFO - 'XPC_SERVICE_NAME': '0', 15:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:09 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)) 15:27:09 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)) 15:27:09 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)) 15:27:09 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)) 15:27:09 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)) 15:27:09 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)) 15:27:09 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)) 15:27:09 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)) 15:27:09 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)) 15:27:09 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)) 15:27:09 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)) 15:27:09 INFO - Cleaning up... 15:27:09 INFO - Return code: 0 15:27:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98349dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345cd30>, '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 0x103280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103453b20>, '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.jjTEeaSebS/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.4h6N3gYqEV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 15:27:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:27:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjTEeaSebS/Render', 15:27:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:09 INFO - 'HOME': '/Users/cltbld', 15:27:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:09 INFO - 'LOGNAME': 'cltbld', 15:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:09 INFO - 'MOZ_NO_REMOTE': '1', 15:27:09 INFO - 'NO_EM_RESTART': '1', 15:27:09 INFO - 'PAGER': '/bin/cat', 15:27:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:09 INFO - 'PWD': '/builds/slave/test', 15:27:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:09 INFO - 'SHELL': '/bin/bash', 15:27:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4h6N3gYqEV/Listeners', 15:27:09 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 15:27:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:09 INFO - 'USER': 'cltbld', 15:27:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:09 INFO - 'XPC_FLAGS': '0x0', 15:27:09 INFO - 'XPC_SERVICE_NAME': '0', 15:27:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:09 INFO - Downloading/unpacking jsonschema 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:27:11 INFO - Downloading/unpacking functools32 (from jsonschema) 15:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:11 INFO - Downloading functools32-3.2.3-2.tar.gz 15:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:27:12 INFO - warning: no files found matching '*.txt' 15:27:12 INFO - no previously-included directories found matching 'build' 15:27:12 INFO - no previously-included directories found matching 'dist' 15:27:12 INFO - no previously-included directories found matching '.git*' 15:27:12 INFO - Installing collected packages: jsonschema, functools32 15:27:12 INFO - Running setup.py install for functools32 15:27:12 INFO - warning: no files found matching '*.txt' 15:27:12 INFO - no previously-included directories found matching 'build' 15:27:12 INFO - no previously-included directories found matching 'dist' 15:27:12 INFO - no previously-included directories found matching '.git*' 15:27:12 INFO - Successfully installed jsonschema functools32 15:27:12 INFO - Cleaning up... 15:27:12 INFO - Return code: 0 15:27:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:27: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')]} 15:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:27:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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')]} 15:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:27:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:27: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1035b8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035c04c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe98349dbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10345cd30>, '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 0x103280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103453b20>, '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.jjTEeaSebS/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.4h6N3gYqEV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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 15:27: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', 'flake8'] in /builds/slave/test/build 15:27: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 flake8 15:27:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjTEeaSebS/Render', 15:27:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:12 INFO - 'HOME': '/Users/cltbld', 15:27:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:12 INFO - 'LOGNAME': 'cltbld', 15:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:12 INFO - 'MOZ_NO_REMOTE': '1', 15:27:12 INFO - 'NO_EM_RESTART': '1', 15:27:12 INFO - 'PAGER': '/bin/cat', 15:27:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:12 INFO - 'PWD': '/builds/slave/test', 15:27:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:12 INFO - 'SHELL': '/bin/bash', 15:27:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4h6N3gYqEV/Listeners', 15:27:12 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 15:27:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:12 INFO - 'USER': 'cltbld', 15:27:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:12 INFO - 'XPC_FLAGS': '0x0', 15:27:12 INFO - 'XPC_SERVICE_NAME': '0', 15:27:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:27:12 INFO - Downloading/unpacking flake8 15:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:27:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:27:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:27:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27: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 15:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:16 INFO - no previously-included directories found matching 'docs/_build' 15:27:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:27:16 INFO - Running setup.py install for pep8 15:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:27:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:27:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:27:16 INFO - no previously-included directories found matching 'docs/_build' 15:27:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:27:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:27:16 INFO - Cleaning up... 15:27:16 INFO - Return code: 0 15:27:16 INFO - Running post-action listener: _resource_record_post_action 15:27:16 INFO - Running post-action listener: _start_resource_monitoring 15:27:16 INFO - Starting resource monitoring. 15:27:16 INFO - ##### 15:27:16 INFO - ##### Running install step. 15:27:16 INFO - ##### 15:27:16 INFO - Running pre-action listener: _resource_record_pre_action 15:27:16 INFO - Running main action method: install 15:27:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:27:16 INFO - Reading from file tmpfile_stdout 15:27:16 INFO - Detecting whether we're running mozinstall >=1.0... 15:27:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:27:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:27:16 INFO - Reading from file tmpfile_stdout 15:27:16 INFO - Output received: 15:27:16 INFO - Usage: mozinstall [options] installer 15:27:16 INFO - Options: 15:27:16 INFO - -h, --help show this help message and exit 15:27:16 INFO - -d DEST, --destination=DEST 15:27:16 INFO - Directory to install application into. [default: 15:27:16 INFO - "/builds/slave/test"] 15:27:16 INFO - --app=APP Application being installed. [default: firefox] 15:27:16 INFO - mkdir: /builds/slave/test/build/application 15:27:16 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'] 15:27:16 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 15:27:50 INFO - Reading from file tmpfile_stdout 15:27:50 INFO - Output received: 15:27:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:27:50 INFO - Running post-action listener: _resource_record_post_action 15:27:50 INFO - ##### 15:27:50 INFO - ##### Running run-tests step. 15:27:50 INFO - ##### 15:27:50 INFO - Running pre-action listener: _resource_record_pre_action 15:27:50 INFO - Running main action method: run_tests 15:27:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:27:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:27:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:27:50 INFO - 2016-02-22 15:27:50.932 screenresolution[1651:7648] starting screenresolution argv=screenresolution get 15:27:50 INFO - 2016-02-22 15:27:50.935 screenresolution[1651:7648] Display 0: 1600x1200x32@60 15:27:50 INFO - 2016-02-22 15:27:50.941 screenresolution[1652:7651] starting screenresolution argv=screenresolution list 15:27:50 INFO - Available Modes on Display 0 15:27:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:27:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:27:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:27:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:27:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:27:51 INFO - Intel Iris: 15:27:51 INFO - Chipset Model: Intel Iris 15:27:51 INFO - Type: GPU 15:27:51 INFO - Bus: Built-In 15:27:51 INFO - VRAM (Dynamic, Max): 1536 MB 15:27:51 INFO - Vendor: Intel (0x8086) 15:27:51 INFO - Device ID: 0x0a2e 15:27:51 INFO - Revision ID: 0x0009 15:27:51 INFO - Displays: 15:27:51 INFO - Display: 15:27:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:27:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:27:51 INFO - Display Serial Number: 1600x1200 60 15:27:51 INFO - Main Display: Yes 15:27:51 INFO - Mirror: Off 15:27:51 INFO - Online: Yes 15:27:51 INFO - Rotation: Supported 15:27:51 INFO - Return code: 0 15:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:27:51 INFO - Python 2.7.3 15:27:51 INFO - Return code: 0 15:27:51 INFO - grabbing minidump binary from tooltool 15:27: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')]} 15:27:51 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 0x10345cd30>, '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 0x103280db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103453b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:27:51 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 15:27:51 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 15:27:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:27:51 INFO - Return code: 0 15:27:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:27:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:27:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:27:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:27:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:27:52 INFO - Return code: 0 15:27:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:27:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jjTEeaSebS/Render', 15:27:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:27:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:27:52 INFO - 'HOME': '/Users/cltbld', 15:27:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:27:52 INFO - 'LOGNAME': 'cltbld', 15:27:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:27:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:27:52 INFO - 'MOZ_NO_REMOTE': '1', 15:27:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:27:52 INFO - 'NO_EM_RESTART': '1', 15:27:52 INFO - 'PAGER': '/bin/cat', 15:27:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:27:52 INFO - 'PWD': '/builds/slave/test', 15:27:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:27:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:27:52 INFO - 'SHELL': '/bin/bash', 15:27:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4h6N3gYqEV/Listeners', 15:27:52 INFO - 'TMPDIR': '/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/', 15:27:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:27:52 INFO - 'USER': 'cltbld', 15:27:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:27:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:27:52 INFO - 'XPC_FLAGS': '0x0', 15:27:52 INFO - 'XPC_SERVICE_NAME': '0', 15:27:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:27:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:27:52 INFO - mozversion application_buildid: 20160222142848 15:27:52 INFO - mozversion application_changeset: 061710a98fa4a8353f63076c34aa318565e59ec8 15:27:52 INFO - mozversion application_display_name: Nightly 15:27:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:27:52 INFO - mozversion application_name: Firefox 15:27:52 INFO - mozversion application_remotingname: firefox 15:27:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:27:52 INFO - mozversion application_vendor: Mozilla 15:27:52 INFO - mozversion application_version: 47.0a1 15:27:52 INFO - mozversion platform_buildid: 20160222142848 15:27:52 INFO - mozversion platform_changeset: 061710a98fa4a8353f63076c34aa318565e59ec8 15:27:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:27:52 INFO - mozversion platform_version: 47.0a1 15:27:52 INFO - using testdate: 1456183672 15:27:52 INFO - actual date: 1456183672 15:27:53 INFO - starting webserver on 'localhost:49282' 15:27:53 INFO - SUITE-START | Running 2 tests 15:27:53 INFO - TEST-START | dromaeo_css 15:27:53 INFO - operating with platform_type : mac_ 15:27:53 INFO - Initialising browser for dromaeo_css test... 15:27:53 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpOE4a1i/profile http://localhost:49282/getInfo.html) 15:27:55 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 15:27:55 INFO - PROCESS | 1670 | colorDepth:24 15:27:55 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 15:27:55 INFO - PROCESS | 1670 | __metrics 15:27:55 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:27:55 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:27:55 INFO - TEST-INFO | 1670: exit 0 15:27:55 INFO - Browser initialized. 15:27:55 INFO - Running cycle 1/1 for dromaeo_css test... 15:27:55 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmpOE4a1i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:28:07 INFO - PROCESS | 1673 | RSS: Main: 242806784 15:28:07 INFO - PROCESS | 1673 | 15:28:59 INFO - PROCESS | 1673 | 1456183739030 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] 15:31:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49282/tests/dromaeo/cssquery-ext.html) 15:31:11 INFO - PROCESS | 1673 | RSS: Main: 384192512 15:31:11 INFO - PROCESS | 1673 | 15:34:14 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-ext.html (next: http://localhost:49282/tests/dromaeo/cssquery-jquery.html) 15:34:15 INFO - PROCESS | 1673 | RSS: Main: 383700992 15:34:15 INFO - PROCESS | 1673 | 15:37:17 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49282/tests/dromaeo/cssquery-mootools.html) 15:37:17 INFO - PROCESS | 1673 | RSS: Main: 379539456 15:37:17 INFO - PROCESS | 1673 | 15:40:20 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49282/tests/dromaeo/cssquery-prototype.html) 15:40:20 INFO - PROCESS | 1673 | RSS: Main: 337317888 15:40:20 INFO - PROCESS | 1673 | 15:43:23 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49282/tests/dromaeo/cssquery-yui.html) 15:43:24 INFO - PROCESS | 1673 | RSS: Main: 342056960 15:43:24 INFO - PROCESS | 1673 | 15:46:27 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-yui.html (next: http://localhost:49282/tests/dromaeo/cssquery-dojo.html) 15:46:27 INFO - PROCESS | 1673 | RSS: Main: 437764096 15:46:27 INFO - PROCESS | 1673 | 15:46:27 INFO - PROCESS | 1673 | __start_tp_report 15:46:27 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 15:46:27 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 15:46:27 INFO - PROCESS | 1673 | |i|pagename|runs| 15:46:27 INFO - PROCESS | 1673 | |0;dojo.html;3407.1993081625815;3470.4100302948495;3501.03721476594;3505.5968563615193;3541.769784963977;5632.183333416652;5653.6607803531715;5669.71651417429;5683.2895888014;5686.573506986972;5716.28546431696;5783;5801.738921748521;5824.534037277018;5886.676232807194;5072.137736584771;5131.4098878629065;5140.049090918183;5148.485151484859;5176.301199338079;4541.704789188709;5033.471485494026;5037.647364684473;5180.041692286939;5271.314729085233;5039.546440820343;5182.507661772125;5186;5208.609354298424;5246.632735708502;5100.872478188038;5110.897782044375;5114.488551144893;5115.360579927509;5119.283300337956;5044.54599086084;5085.110105731482;5100.5409513143995;5107.055194788939;5114.156164232897;5395.379531353866;5523.392426833045;5556.277683901108;5556.527695145917;5559.805406810742;5999.13012613173;6095.769242301587;6122.8775424491705;6240.812775616739;6248.78129265478;6244.687765611747;6275.780347687854;6283.685815709242;6296.842578935518;6325.304216536178;5558.6942718150085;5723.799667011718;5762.711864406763;5766.942330576682;5771.8557036074435;5291.417944026154;6219.595726277777;6329.968350158219;6331.588446750947;6336.398042185985;6082.939170608237;6119.541034422347;6124.785632502841;6126.754929802847;6174.351693072163;6137.96931015351;6276.843078922972;6280.717367718464;6296;6316.9368306317265;6125.908111378333;6139.693015349215;6142.771445710786;6207.34822843604;6209.6895155242055;5232.790688372423;6119;6164.753409863645;6220.533459990428;6224.875502489925;4784.545468180518;4849.975750121227;4857.271409288564;4860.538248866352;4868.172410690191;4322.178786030707;4325.7188282762145;4349.717268377609;4371.519132895379;4404.515503294635;5574.191742197439;5601.271834661468;5626.352969408488;5632.7746890123935;5659.801906933238;6067.544934129958;6177.413145751147;6258.812235632939;6264.59280146789;6286.968565157236;5573.832785016456;5581.748821303051;5599.0761524348845;5603.551715862721;5604.075327570987;5288.259643649815;5290.285811415487;5293.57651387888;5294.285271488377;5295.020421222086;5320.255164277004;6266.749330026839;6296.0555916612875;6316;6344.080108384351;6261.592996455216;6275.02737075754;6288.6855657217875;6295.3389894060465;6303.747850085945;6267.9373206267355;6313.747450101944;6323.083152942706;6323.114763932961;6352.237731472253;6113.938860611337;6149.2313460817395;6153.72308246139;6162.476189523941;6163.84590385244;6243.125962365181;6295;6299.4645455135;6302.684865756785;6306.306306306395;5514.172874068921;5851.473367396955;6013.879722405615;6021.066734656135;6078.6048906820915;6060.181875446935;6061.878762424815;6065.3934606539;6088.51291896656;6091.543134264859;5874.206982057368;5882.794102206402;5893.764249429974;5898.439648233411;5903.822885313448;5854.970725146347;6034.849128771816;6052.848678783065;6125.784909797561;6129.754809807736;5929.932612129858;5930.318013428511;5932.1694962706115;5951.970240148771;5959.28488581373 15:46:27 INFO - PROCESS | 1673 | |1;ext.html;461.4762244852092;479.30740080583524;503.5769953239279;525.4272842601564;575.5223164773236;28783.856080719594;36464.08839779007;37456.81271593645;37480.81259593698;37665;39594.604053959454;40075.799621001854;40123.59876401235;40167.59832401675;40369.79815100921;9300.813983720338;9532.38039527432;9540.713778586654;9561.80876382472;9575.042495750404;9278.582463789146;9428.151466368026;9447.90552094477;9454.81090378192;9547.952260238724;9483.90516094837;9548.28387870909;9572.712818615419;9574.186194173504;9598.232141428669;9456.196223321025;9532.14210721035;9535.284853636005;9542.42745435276;9556.23550115996;9390;9535.046495350478;9539.809203815954;9542.856857147148;9561.043895610454;38659.8067009666;39005.804970975245;39112.21775564501;39147.60852391497;39168;3101.550275210082;3173.01636492688;3523.4010218262956;3724.9068773280615;3745.606711295329;25631.102911398197;25840.483190336276;28149.718502814914;28300.009499667412;29122.563161552593;2692.7172646872186;2748.2030211238716;2770.5290100682732;2787.5957986091903;2902.3179552805072;501902;505614;505633;506352;507187.464062681;42781.57218427776;43480;43583.34624980628;43614.34578481325;43792.088068111036;43196.3520547192;43935.78032109819;43970.78014609907;43984.12031759411;44062.67811965646;15078.623034424008;15307;15311.387544498319;15311.540653780405;15343.923280383528;12202.694932626579;12362.320072395925;12367.752644947052;12550.497980080694;12580.622581322576;12826.871731282754;13235.073544851768;14237.715245695028;14259.78610320846;14342.85657143436;6151.907721384183;6201.658908759971;6233.3143354231;6253;6258.186435763413;909.8908131024187;963.3882484622176;965.6861520006026;1012.7822518158631;1111.5053801058452;28690.426191476054;29223.853880730887;29258.853705731333;29301;29349;945.7966537194399;1047.8323468245044;1074.1084899533369;1079.5465904320204;1175.518037604595;13542.59372218835;13731.45074197041;13863.861361386458;13922.512712055232;13945.442182312796;471377.64311178226;485543.5722821363;533819;717304;717720;53319.466805332224;54920.72539637276;55658.44341556533;55662.44337556654;55779.721101394236;1352.7429788340185;1421.665908511499;1445.125698952119;1454.70178613384;1456.8543145685346;24978.50042999166;28234.71765282321;28979.98570050038;29014.56478152787;29041.419171616028;43437.565624343355;43478.56521434745;43827;43838;43876;310931;315768;316202;316586;316697;25255;29962.850185748932;30040.19758814478;31712.524312134876;32040.03879883607;42974.785126074166;42980.57019429766;43153.948410030614;43226.91932701707;43957.12085758331;35948.64051359453;36023.09942251465;36887.077823054635;36910.27890676949;37106.8144659275;31083.844580776953;35470.30169548693;36313.37695510639;36702.63297366992;36741;35033.29933401369;35133;35975.64024359723;35998.64001359953;36070.8196459016;30514.389712206077;32422.027339179862;32535.349293014482;32652.673473265913;32737.854175103756;23946.28161155168;24503.50992980166;25626.974921003697;25674.486510269315;25730.485390292462 15:46:27 INFO - PROCESS | 1673 | |2;jquery.html;363.8308186693188;367.3882984830258;369.9352613292673;372.3762697481718;375.79331367747733;15741.449049283277;16408.09755463449;19639.214431422726;20412.183512659496;21889.781102188954;19350.709739353922;19546.413607591796;20029.399118026446;20109.29617463389;20346.389608311736;5158.509941555565;5673.26247587813;5892.322382925954;5897.646141231518;5904.3800400957925;5836.387179346171;5845.473907348338;5880.852978675524;5884.529237660977;5896;5686.260786097822;5717.656940583557;5794.826155215329;5879.470847623713;5892.204552385416;5819.82540523785;5849.883002339972;5887.1463637772285;5898.8230353089475;5906.527477801766;5133.153029750087;5143.794248230066;5838.970805145989;7291.4895957283015;7310.232425595343;26252.21243362702;26330.341741456425;26789.732102678918;27153.728462715317;27378.589321160198;2274.80664143548;2340.6957095577636;2397.7602239776056;2505.7619526145168;2696.9865150674123;15081.019733717274;15353.769693454607;15765.290561924627;15809.525714228592;16169.948953317997;1845.363349644384;1855.7587513623278;1857.4891904726173;1868.2807119259182;1924.0572119661265;92079;98877.50561247148;104780.95219047788;108969.45515272452;116658.41670791677;19393.612127757366;19728.210871565265;19805.30681426172;19828.306009289896;19857.60284794296;24266;25286.74713252844;27271.727282727315;29404.11787646374;29408;10475.371477711362;10611.522481488197;10615.52230149645;10620.20348473852;10693.251472396858;9037.277017838556;9043.050479699668;9051.230645395215;9119.316051296179;9151.405158664798;8689.17452841979;8737.344699147588;8767.956160219159;8789.033206347296;8793.252573531194;3319.68462996015;3432.8626854926024;3449.5170676105367;3546.769459985093;3607.2965771674794;787.5314188058096;897.3359713811863;921.8340698674169;932.4871320773548;1013.002192840052;20169.39491815248;20806.479838004172;20827.791722082584;20987.475313117295;21381.03785329664;888.4536010353586;935.209747763139;949.5964215208509;969.8351280282369;997.0229175408141;7958.960205198937;10972.890271097347;11273.661790146309;11275.548978040786;11280.943595281971;516087;525264;526668;676927;684671;95506.52246738721;111805;115482.4225878882;137376;137406;998.3560603410759;1018.5772904244656;1054.9525271362807;1097.1113398147527;1099.5326986030905;18915.86504809716;19154;19250.518737031685;19254.422367329003;19357.322493712654;51617.879786205885;52434.689132771986;53011.73494132505;53695.7315213437;54493.45506545043;76574.61712691624;76688.46623067619;76980.46039079298;77894.83157752526;78389;10650.360978341325;11285.548578056785;11857.822132667845;11920.821187682364;11940.462679179283;13799.79300310476;14151.858481415466;14208.218547979961;14379.496717614833;14423.711525769635;8192.877106843283;8211.71259005932;8343.165683431609;8346.749597512084;8507.319414446953;6858.897116543156;7260.019897314006;7797.259260370256;8199.71301004462;8371.41400101987;8342.582870856555;8409.789755255923;8466.111058338785;8502.192291732275;8633.30933525329;11933.940330298294;11987.100967427303;12205.69485762863;12207.45066471993;12208.267503949792;9924.553395097382;12050.51797928073;12230.388480575757;12249.510019599116;12281.38593070325 15:46:27 INFO - PROCESS | 1673 | |3;mootools.html;1227.582621908551;1430.9697018146933;1533.8772898168147;1763.7530745695606;1951.1317463728647;7923.247291507312;8569.314454843614;8728.912710872904;8756.387052906299;8779.2537634301;8368.497890126597;8605.225529702326;8616.26761725254;8641.740747777576;8642.524661143634;1826.6072794349213;2203.889805509726;2205.2061257947125;2446.5106978604263;2486.689163854518;2421.87890605469;2504.6618706474574;2504.6743923289946;2509;2510.535550923076;2405.7746584409438;2438.17102185257;2491.2401717476164;2501.5997440409537;2508.122157244968;2163.610550100981;2392.808575313971;2462.679851619278;2472.332470233036;2491.177911289279;2436.9878150609134;2447.3269850791;2479.1694782247787;2482.2305085423395;2489.788367988723;8617.138286171396;8651.221390074923;8654.269146170791;8656.350773691998;8663;5342.118550439173;5479.863003424946;5496.642718223303;5504.4495550445035;5511.0080185566585;3552.502649629054;3610.7291953103622;3671.94492082619;3683.834227459771;3685.6130106338983;913.9223166030895;1008.8638033865408;1021.341234903483;1046.6912260883057;1053.9894601053968;11391.829122563167;11544.480498377594;11563.710907227303;11575.942120289345;11582.420878956103;3798.867039653599;4638.721676699409;4649.325847752057;4689.554492323224;4734.810607575727;9190.40262382943;9204.125608067223;9205.171534561921;9213.98646148923;9225.953870230605;5319.441458646864;5337.893242135136;5348.786048558092;5355.3841308249275;5367.275417818622;4428.003699167726;4600.516945720651;4821.855344339676;4929.679570827885;5034.219695947061;3218.3080637663015;3778.3199024175365;3783.39465685489;3816.7900765458166;3845.0964023454467;1176.5529098942347;1190.6844686158174;1196.234409977615;1200.7418405042959;1201.3152503073338;1107.335598640825;1141.1042331769686;1144.0961640304233;1302.47900839663;1385.2035079829138;8059.355251579859;8166.673333066729;8192.221738934792;8200.302974247137;8239.340852731768;428.9185054839633;519.2963534410819;519.4364114935262;524.9133892907704;525.3302039899082;6212.502999760009;6221.720022598994;6325.620462772248;6335.651539165298;6336.556441049082;10431.11335536488;10780.946095269474;10846.457677116112;10915.39965301916;10942.781144377068;10570.418626975435;10702.143828493701;10717.142628589694;10748.946255268673;10753.247272690836;8288.958555207306;8364.330853531703;8388.328933685412;8434.620442079999;8463.322934165251;7717.729879454192;7863.606819658879;7881.172476889844;7924.960375198087;7929.801754956172;9390.107939745712;9609.56756945953;9633.421994680342;9679.66121185755;9790.314677972758;9743.317967742474;10025.398476091457;10103;10125.443100629536;10160.74598135023;6363.331850155852;6384.712687929147;6384.9042264367;6970.721171153097;7046.859062818818;8119.83760324802;8138.674453021813;8189.50862948225;8191.590420478833;8198.303144232568;7267.963660181666;7348.301911318416;7352.080989876265;7505.324520793155;7522.623868806647;7131.928680713127;7190.352868241884;7226.566406015656;7306.4520160989205;7335;7581.6209189541405;7726.227377262228;7738.303552680286;7740.148583655906;7757.806054848448;6793.66031698423;6994.790156295319;7051.400630946222;7056.223815380406;7060.505764596634;7009.264027277062;7090.326418990187;7091.326323999212;7094.929050709633;7099 15:46:27 INFO - PROCESS | 1673 | |4;prototype.html;320.04307121706097;328.6483462694916;330.756893683143;332.17951659401285;335.9009092317766;6559.311272316398;6572.178477690289;6573;6583.868322633551;6600.900986485207;6500.41496265336;6503.804885853432;6508.2515510716285;6516.6090034597955;6531.640759758223;4785.545373189541;4836.951630483685;4846.369971903665;4851.490593487686;4862.100511405383;4846.854594362175;4850.514948505156;4851.514848515156;4864.1974074277705;4874.780634871439;4311.28863737483;4547.749873756942;4757.976210118944;4775.832845850396;4786.210275304588;4665.5567721066445;4728.929066064012;4733.5503127202865;4734.763261836894;4744.359511465942;4108.383742438628;4117.547069822317;4121.216968775953;4121.29937910556;4136.503619565671;6036.185115009462;6138.294096178952;6216;6304.117423560705;6343.968280158616;5683.54531637468;5694.77220911163;5704.458076482728;5706.743196556165;5715.628484148517;6971.372576468142;6978.232394436608;7006.229314775371;7026.473014523931;7027.754028608974;4667.6265898728025;4667.766611669403;4670.136024835382;4676.251799712029;4676.462206846222;5626.2967129108865;7112.679929403138;7146.428285737128;7318.341349278538;7319.926800731978;4753.738544380092;4758.357621721093;4764.118638051971;4765.404324459442;4775.546323099369;4791;4841.346418233564;4845.63657725672;4853.6602437829715;4866.78099485524;5742.28221472316;5742.684152371659;5743.368229494836;5744.684042377709;5751.22358481608;7026.402755765715;7029.472789540805;7034.964825175944;7052.823679407953;7059.505834591632;1541.391150495548;1613.2256516871967;1613.9273732681822;1621.2947367895003;1645.9506214813575;1022.9232807539464;1038.0864838941684;1049.1606714628267;1051.51104736298;1052.494802494807;5249.527542521191;5898.174255604219;6069.666168360783;6577.506686998494;6580.078788969548;6456.54804163704;6777.593344399352;7277.563346199245;7279.015603602497;7314.670839812221;6501.122348482894;6511.804645860631;6515.4787616990525;6520.9347906520325;6535.215774107138;3834.309824231609;3834.9233015339537;3849.672777813917;3855.151866589346;3857.2285542890972;5822.7962021329895;7466.104067511933;7537.321641052332;7556.811079723051;7579.014728085313;7434.033575635132;7495.8500829983095;7506.3244308012545;7507.286807753255;7512.511686740344;6078.3617720138745;6588.242352129567;7092.751753688596;7532.43506736986;7544.811379715551;6791.083203767428;7192.604406757679;7203.2076471589135;7240.275972402928;7248.456365772483;6802.965985170043;7088;7108.964455177691;7112.679929403293;7122.216556178712;7489.775306740807;7554.697812087455;7561.848763024599;7578.355839753683;7579.810504737426;4346.804393802349;4472.262076757299;4506.932396014128;4595;4630.120277147331;5864.67744274052;7157.391621712213;7167.8566428672175;7183.712651494091;7184.281571842774;6892.414144797548;6901.102856628606;6902.378785909293;6903.99892015665;6914;6881.208661004049;6927.164301460017;6931.826704332432;6935.89596156048;6936.826579335557;6515.967420163059;6690.83272918181;6743.15710536183;6747.156605424322;6761.391474767294;6843.213030501357;6875.106236189264;6920.619365934922;6922.965385173042;6927.861442771217;6780.38976492118;6784.76253331131;6787.049813026081;6793.93206067933;6794.694238759169 15:46:27 INFO - PROCESS | 1673 | |5;yui.html;662.6653539962324;664.2527156948433;722.9240929702379;743.8809790433531;779.9181085985975;14022.649433764162;14216.431342746278;14217.71564568708;14218.360173792178;14221.288935553206;14347.852171826255;15269.541913742605;15784.44754433595;15789.28948197331;15795.921020394882;706.6043015911106;715.2204097533687;792.6353877216487;873.2053831013778;880.9207171354577;863.6027427383411;880.053942012336;880.5289170293894;881.3081730841259;884.849575572151;923.5336155241594;926.018420474296;926.3839546701469;926.5135803703076;926.8053708721143;733.2960358056272;901.7430032440789;917.6329468212701;919.3564504846634;920.1258804136031;680.8400025993888;682.5120039171966;683.111954459206;684.0799125176629;684.384054351083;14720.852791472162;14783;14785.482508112273;14810.185439800807;14827.629309267246;12197.08521860864;12379.566715165016;12676.176048556814;12736.917362024238;12890.226586404846;10099.343542669703;10169.54237059334;10334.22493312997;10946.890531094747;11255.493502792395;3541.3448512025357;3556.3065202285566;3582.176099497104;3620.076880395509;3644.653757892996;86824.56587717084;87878.5606071972;87946;87983;88204.55897720535;9172.35793494449;9227.400218985744;9234.630614775333;9240.412684448365;9281.30390220736;20790.480237994172;20900.163993440092;20980.160793568088;21105;21190.576188476454;7365.81585460357;7368.226336234726;7368.557886526825;7463.216362281991;7552.622368881534;4096.631303182728;4105.34314509677;4162.4796900387455;4173.728707633994;4184;3521.559805024372;3537.46937959303;3561.928761424757;3565.4651802229873;3570.5179800727087;638.9041643753474;648.3257412291258;649.7498463091649;650.8958566629411;654.4796886475264;506.5921932844096;602.5691630484225;603.8943184942617;618.1870839845589;639.7579401178706;8410.201030902055;8697.217250447364;8815.206631403205;8928.196462318423;9082.000979892207;522.8562145410043;529.3462573721451;576.7289373994216;622.7726879688881;626.295417655138;3674.2835147146584;4031.173609410064;4065.308897487434;4066.959330406658;4142.2751018572235;92474.61288080685;92736.07263927274;97576;98553;99443.50834737485;81773;81857.59071204606;82976;83369.45773445084;84184.31631367462;74179.62910185523;74823;74834.62582687051;75084.62457687786;75861.24138758541;8462.323014158976;8472.949738094405;8692.478451292942;8709.651613935372;8785.736427907173;46331.76834115808;49701.50298496969;50157;50475.49524504708;50759.22342717987;70839.64580177066;72145;72294.63852680703;72717.6364118176;72875;10794.622188223375;10920.563177472812;11210.943945280222;11236.775264494829;11285.322880627189;10655.840162397726;11934.462949167482;12064.396780160781;12197.146199765932;12725.490980360682;11501.942490287494;11515.596954106566;11631.127665424958;12126.27558632233;12443.688907777378;11061.94469027682;11320.150988676047;11353;11636.825447618123;11998.820017699567;10890.891091088988;11054;11060.115190784558;11090.279131856403;12018;7379.520331178456;9151.313651476034;9158.954205229198;9163.541822908961;9680.4675742832;8660.857635661429;9220.723378298662;9554.808903822024;9565.569549370433;9789.657361992297 15:46:27 INFO - PROCESS | 1673 | __end_tp_report 15:46:27 INFO - PROCESS | 1673 | __start_cc_report 15:46:27 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1384 15:46:27 INFO - PROCESS | 1673 | __end_cc_report 15:46:27 INFO - PROCESS | 1673 | __startTimestamp1456184787287__endTimestamp 15:46:27 INFO - PROCESS | 1673 | 15:46:27 INFO - PROCESS | 1673 | ------- Summary: start ------- 15:46:27 INFO - PROCESS | 1673 | Number of tests: 6 15:46:27 INFO - PROCESS | 1673 | 15:46:27 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5687.40 Median:5886.68 stddev:645.74 (11.0%) stddev-sans-first:622.45 15:46:27 INFO - PROCESS | 1673 | Values: 3407.2 3470.4 3501.0 3505.6 3541.8 5632.2 5653.7 5669.7 5683.3 5686.6 5716.3 5783.0 5801.7 5824.5 5886.7 5072.1 5131.4 5140.0 5148.5 5176.3 4541.7 5033.5 5037.6 5180.0 5271.3 5039.5 5182.5 5186.0 5208.6 5246.6 5100.9 5110.9 5114.5 5115.4 5119.3 5044.5 5085.1 5100.5 5107.1 5114.2 5395.4 5523.4 5556.3 5556.5 5559.8 5999.1 6095.8 6122.9 6240.8 6248.8 6244.7 6275.8 6283.7 6296.8 6325.3 5558.7 5723.8 5762.7 5766.9 5771.9 5291.4 6219.6 6330.0 6331.6 6336.4 6082.9 6119.5 6124.8 6126.8 6174.4 6138.0 6276.8 6280.7 6296.0 6316.9 6125.9 6139.7 6142.8 6207.3 6209.7 5232.8 6119.0 6164.8 6220.5 6224.9 4784.5 4850.0 4857.3 4860.5 4868.2 4322.2 4325.7 4349.7 4371.5 4404.5 5574.2 5601.3 5626.4 5632.8 5659.8 6067.5 6177.4 6258.8 6264.6 6287.0 5573.8 5581.7 5599.1 5603.6 5604.1 5288.3 5290.3 5293.6 5294.3 5295.0 5320.3 6266.7 6296.1 6316.0 6344.1 6261.6 6275.0 6288.7 6295.3 6303.7 6267.9 6313.7 6323.1 6323.1 6352.2 6113.9 6149.2 6153.7 6162.5 6163.8 6243.1 6295.0 6299.5 6302.7 6306.3 5514.2 5851.5 6013.9 6021.1 6078.6 6060.2 6061.9 6065.4 6088.5 6091.5 5874.2 5882.8 5893.8 5898.4 5903.8 5855.0 6034.8 6052.8 6125.8 6129.8 5929.9 5930.3 5932.2 5952.0 5959.3 15:46:27 INFO - PROCESS | 1673 | 15:46:27 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:59669.25 Median:20415.86 stddev:130127.31 (637.4%) stddev-sans-first:130416.42 15:46:27 INFO - PROCESS | 1673 | Values: 461.5 479.3 503.6 525.4 575.5 28783.9 36464.1 37456.8 37480.8 37665.0 39594.6 40075.8 40123.6 40167.6 40369.8 9300.8 9532.4 9540.7 9561.8 9575.0 9278.6 9428.2 9447.9 9454.8 9548.0 9483.9 9548.3 9572.7 9574.2 9598.2 9456.2 9532.1 9535.3 9542.4 9556.2 9390.0 9535.0 9539.8 9542.9 9561.0 38659.8 39005.8 39112.2 39147.6 39168.0 3101.6 3173.0 3523.4 3724.9 3745.6 25631.1 25840.5 28149.7 28300.0 29122.6 2692.7 2748.2 2770.5 2787.6 2902.3 501902.0 505614.0 505633.0 506352.0 507187.5 42781.6 43480.0 43583.3 43614.3 43792.1 43196.4 43935.8 43970.8 43984.1 44062.7 15078.6 15307.0 15311.4 15311.5 15343.9 12202.7 12362.3 12367.8 12550.5 12580.6 12826.9 13235.1 14237.7 14259.8 14342.9 6151.9 6201.7 6233.3 6253.0 6258.2 909.9 963.4 965.7 1012.8 1111.5 28690.4 29223.9 29258.9 29301.0 29349.0 945.8 1047.8 1074.1 1079.5 1175.5 13542.6 13731.5 13863.9 13922.5 13945.4 471377.6 485543.6 533819.0 717304.0 717720.0 53319.5 54920.7 55658.4 55662.4 55779.7 1352.7 1421.7 1445.1 1454.7 1456.9 24978.5 28234.7 28980.0 29014.6 29041.4 43437.6 43478.6 43827.0 43838.0 43876.0 310931.0 315768.0 316202.0 316586.0 316697.0 25255.0 29962.9 30040.2 31712.5 32040.0 42974.8 42980.6 43153.9 43226.9 43957.1 35948.6 36023.1 36887.1 36910.3 37106.8 31083.8 35470.3 36313.4 36702.6 36741.0 35033.3 35133.0 35975.6 35998.6 36070.8 30514.4 32422.0 32535.3 32652.7 32737.9 23946.3 24503.5 25627.0 25674.5 25730.5 15:46:27 INFO - PROCESS | 1673 | 15:46:27 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:35043.33 Median:3376.27 stddev:98088.88 (2905.2%) stddev-sans-first:98329.48 15:46:27 INFO - PROCESS | 1673 | Values: 363.8 367.4 369.9 372.4 375.8 15741.4 16408.1 19639.2 20412.2 21889.8 19350.7 19546.4 20029.4 20109.3 20346.4 5158.5 5673.3 5892.3 5897.6 5904.4 5836.4 5845.5 5880.9 5884.5 5896.0 5686.3 5717.7 5794.8 5879.5 5892.2 5819.8 5849.9 5887.1 5898.8 5906.5 5133.2 5143.8 5839.0 7291.5 7310.2 26252.2 26330.3 26789.7 27153.7 27378.6 2274.8 2340.7 2397.8 2505.8 2697.0 15081.0 15353.8 15765.3 15809.5 16169.9 1845.4 1855.8 1857.5 1868.3 1924.1 92079.0 98877.5 104781.0 108969.5 116658.4 19393.6 19728.2 19805.3 19828.3 19857.6 24266.0 25286.7 27271.7 29404.1 29408.0 10475.4 10611.5 10615.5 10620.2 10693.3 9037.3 9043.1 9051.2 9119.3 9151.4 8689.2 8737.3 8768.0 8789.0 8793.3 3319.7 3432.9 3449.5 3546.8 3607.3 787.5 897.3 921.8 932.5 1013.0 20169.4 20806.5 20827.8 20987.5 21381.0 888.5 935.2 949.6 969.8 997.0 7959.0 10972.9 11273.7 11275.5 11280.9 516087.0 525264.0 526668.0 676927.0 684671.0 95506.5 111805.0 115482.4 137376.0 137406.0 998.4 1018.6 1055.0 1097.1 1099.5 18915.9 19154.0 19250.5 19254.4 19357.3 51617.9 52434.7 53011.7 53695.7 54493.5 76574.6 76688.5 76980.5 77894.8 78389.0 10650.4 11285.5 11857.8 11920.8 11940.5 13799.8 14151.9 14208.2 14379.5 14423.7 8192.9 8211.7 8343.2 8346.7 8507.3 6858.9 7260.0 7797.3 8199.7 8371.4 8342.6 8409.8 8466.1 8502.2 8633.3 11933.9 11987.1 12205.7 12207.5 12208.3 9924.6 12050.5 12230.4 12249.5 12281.4 15:46:27 INFO - PROCESS | 1673 | 15:46:27 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:5959.34 Median:5345.45 stddev:3189.22 (59.7%) stddev-sans-first:3178.33 15:46:27 INFO - PROCESS | 1673 | Values: 1227.6 1431.0 1533.9 1763.8 1951.1 7923.2 8569.3 8728.9 8756.4 8779.3 8368.5 8605.2 8616.3 8641.7 8642.5 1826.6 2203.9 2205.2 2446.5 2486.7 2421.9 2504.7 2504.7 2509.0 2510.5 2405.8 2438.2 2491.2 2501.6 2508.1 2163.6 2392.8 2462.7 2472.3 2491.2 2437.0 2447.3 2479.2 2482.2 2489.8 8617.1 8651.2 8654.3 8656.4 8663.0 5342.1 5479.9 5496.6 5504.4 5511.0 3552.5 3610.7 3671.9 3683.8 3685.6 913.9 1008.9 1021.3 1046.7 1054.0 11391.8 11544.5 11563.7 11575.9 11582.4 3798.9 4638.7 4649.3 4689.6 4734.8 9190.4 9204.1 9205.2 9214.0 9226.0 5319.4 5337.9 5348.8 5355.4 5367.3 4428.0 4600.5 4821.9 4929.7 5034.2 3218.3 3778.3 3783.4 3816.8 3845.1 1176.6 1190.7 1196.2 1200.7 1201.3 1107.3 1141.1 1144.1 1302.5 1385.2 8059.4 8166.7 8192.2 8200.3 8239.3 428.9 519.3 519.4 524.9 525.3 6212.5 6221.7 6325.6 6335.7 6336.6 10431.1 10780.9 10846.5 10915.4 10942.8 10570.4 10702.1 10717.1 10748.9 10753.2 8289.0 8364.3 8388.3 8434.6 8463.3 7717.7 7863.6 7881.2 7925.0 7929.8 9390.1 9609.6 9633.4 9679.7 9790.3 9743.3 10025.4 10103.0 10125.4 10160.7 6363.3 6384.7 6384.9 6970.7 7046.9 8119.8 8138.7 8189.5 8191.6 8198.3 7268.0 7348.3 7352.1 7505.3 7522.6 7131.9 7190.4 7226.6 7306.5 7335.0 7581.6 7726.2 7738.3 7740.1 7757.8 6793.7 6994.8 7051.4 7056.2 7060.5 7009.3 7090.3 7091.3 7094.9 7099.0 15:46:27 INFO - PROCESS | 1673 | 15:46:27 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:5682.99 Median:6506.03 stddev:1787.20 (27.5%) stddev-sans-first:1746.30 15:46:27 INFO - PROCESS | 1673 | Values: 320.0 328.6 330.8 332.2 335.9 6559.3 6572.2 6573.0 6583.9 6600.9 6500.4 6503.8 6508.3 6516.6 6531.6 4785.5 4837.0 4846.4 4851.5 4862.1 4846.9 4850.5 4851.5 4864.2 4874.8 4311.3 4547.7 4758.0 4775.8 4786.2 4665.6 4728.9 4733.6 4734.8 4744.4 4108.4 4117.5 4121.2 4121.3 4136.5 6036.2 6138.3 6216.0 6304.1 6344.0 5683.5 5694.8 5704.5 5706.7 5715.6 6971.4 6978.2 7006.2 7026.5 7027.8 4667.6 4667.8 4670.1 4676.3 4676.5 5626.3 7112.7 7146.4 7318.3 7319.9 4753.7 4758.4 4764.1 4765.4 4775.5 4791.0 4841.3 4845.6 4853.7 4866.8 5742.3 5742.7 5743.4 5744.7 5751.2 7026.4 7029.5 7035.0 7052.8 7059.5 1541.4 1613.2 1613.9 1621.3 1646.0 1022.9 1038.1 1049.2 1051.5 1052.5 5249.5 5898.2 6069.7 6577.5 6580.1 6456.5 6777.6 7277.6 7279.0 7314.7 6501.1 6511.8 6515.5 6520.9 6535.2 3834.3 3834.9 3849.7 3855.2 3857.2 5822.8 7466.1 7537.3 7556.8 7579.0 7434.0 7495.9 7506.3 7507.3 7512.5 6078.4 6588.2 7092.8 7532.4 7544.8 6791.1 7192.6 7203.2 7240.3 7248.5 6803.0 7088.0 7109.0 7112.7 7122.2 7489.8 7554.7 7561.8 7578.4 7579.8 4346.8 4472.3 4506.9 4595.0 4630.1 5864.7 7157.4 7167.9 7183.7 7184.3 6892.4 6901.1 6902.4 6904.0 6914.0 6881.2 6927.2 6931.8 6935.9 6936.8 6516.0 6690.8 6743.2 6747.2 6761.4 6843.2 6875.1 6920.6 6923.0 6927.9 6780.4 6784.8 6787.0 6793.9 6794.7 15:46:27 INFO - PROCESS | 1673 | 15:46:27 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:18992.06 Median:644.04 stddev:27294.11 (4237.9%) stddev-sans-first:27335.98 15:46:27 INFO - PROCESS | 1673 | Values: 662.7 664.3 722.9 743.9 779.9 14022.6 14216.4 14217.7 14218.4 14221.3 14347.9 15269.5 15784.4 15789.3 15795.9 706.6 715.2 792.6 873.2 880.9 863.6 880.1 880.5 881.3 884.8 923.5 926.0 926.4 926.5 926.8 733.3 901.7 917.6 919.4 920.1 680.8 682.5 683.1 684.1 684.4 14720.9 14783.0 14785.5 14810.2 14827.6 12197.1 12379.6 12676.2 12736.9 12890.2 10099.3 10169.5 10334.2 10946.9 11255.5 3541.3 3556.3 3582.2 3620.1 3644.7 86824.6 87878.6 87946.0 87983.0 88204.6 9172.4 9227.4 9234.6 9240.4 9281.3 20790.5 20900.2 20980.2 21105.0 21190.6 7365.8 7368.2 7368.6 7463.2 7552.6 4096.6 4105.3 4162.5 4173.7 4184.0 3521.6 3537.5 3561.9 3565.5 3570.5 638.9 648.3 649.7 650.9 654.5 506.6 602.6 603.9 618.2 639.8 8410.2 8697.2 8815.2 8928.2 9082.0 522.9 529.3 576.7 622.8 626.3 3674.3 4031.2 4065.3 4067.0 4142.3 92474.6 92736.1 97576.0 98553.0 99443.5 81773.0 81857.6 82976.0 83369.5 84184.3 74179.6 74823.0 74834.6 75084.6 75861.2 8462.3 8472.9 8692.5 8709.7 8785.7 46331.8 49701.5 50157.0 50475.5 50759.2 70839.6 72145.0 72294.6 72717.6 72875.0 10794.6 10920.6 11210.9 11236.8 11285.3 10655.8 11934.5 12064.4 12197.1 12725.5 11501.9 11515.6 11631.1 12126.3 12443.7 11061.9 11320.2 11353.0 11636.8 11998.8 10890.9 11054.0 11060.1 11090.3 12018.0 7379.5 9151.3 9159.0 9163.5 9680.5 8660.9 9220.7 9554.8 9565.6 9789.7 15:46:27 INFO - PROCESS | 1673 | -------- Summary: end -------- 15:46:27 INFO - PROCESS | 1673 | 15:46:27 INFO - TEST-INFO | 1673: exit 0 15:46:27 INFO - TEST-OK | dromaeo_css | took 1114740ms 15:46:27 INFO - TEST-START | kraken 15:46:27 INFO - operating with platform_type : mac_ 15:46:27 INFO - Initialising browser for kraken test... 15:46:27 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmphUUMg9/profile http://localhost:49282/getInfo.html) 15:46:29 INFO - PROCESS | 1683 | __metrics Screen width/height:1600/1200 15:46:29 INFO - PROCESS | 1683 | colorDepth:24 15:46:29 INFO - PROCESS | 1683 | Browser inner width/height: 1024/689 15:46:29 INFO - PROCESS | 1683 | __metrics 15:46:29 INFO - PROCESS | 1683 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:46:29 INFO - PROCESS | 1683 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:46:30 INFO - TEST-INFO | 1683: exit 0 15:46:30 INFO - Browser initialized. 15:46:30 INFO - Running cycle 1/1 for kraken test... 15:46:30 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/tmphUUMg9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:42 INFO - PROCESS | 1685 | RSS: Main: 242601984 15:46:42 INFO - PROCESS | 1685 | 15:46:44 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection) 15:46:45 INFO - PROCESS | 1685 | RSS: Main: 291606528 15:46:45 INFO - PROCESS | 1685 | 15:46:48 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-dft) 15:46:48 INFO - PROCESS | 1685 | RSS: Main: 300748800 15:46:48 INFO - PROCESS | 1685 | 15:46:51 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-fft) 15:46:52 INFO - PROCESS | 1685 | RSS: Main: 284225536 15:46:52 INFO - PROCESS | 1685 | 15:46:54 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator) 15:46:55 INFO - PROCESS | 1685 | RSS: Main: 287440896 15:46:55 INFO - PROCESS | 1685 | 15:46:57 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:46:57 INFO - PROCESS | 1685 | RSS: Main: 289857536 15:46:57 INFO - PROCESS | 1685 | 15:47:00 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom) 15:47:01 INFO - PROCESS | 1685 | RSS: Main: 290209792 15:47:01 INFO - PROCESS | 1685 | 15:47:04 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate) 15:47:04 INFO - PROCESS | 1685 | RSS: Main: 288370688 15:47:04 INFO - PROCESS | 1685 | 15:47:07 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial) 15:47:08 INFO - PROCESS | 1685 | RSS: Main: 289562624 15:47:08 INFO - PROCESS | 1685 | 15:47:09 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:47:10 INFO - PROCESS | 1685 | RSS: Main: 324722688 15:47:10 INFO - PROCESS | 1685 | 15:47:11 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:47:12 INFO - PROCESS | 1685 | RSS: Main: 325632000 15:47:12 INFO - PROCESS | 1685 | 15:47:14 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:47:15 INFO - PROCESS | 1685 | RSS: Main: 332161024 15:47:15 INFO - PROCESS | 1685 | 15:47:17 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:47:18 INFO - PROCESS | 1685 | RSS: Main: 333627392 15:47:18 INFO - PROCESS | 1685 | 15:47:20 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:47:21 INFO - PROCESS | 1685 | RSS: Main: 332279808 15:47:21 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49282/tests/kraken/driver.html?testName=ai-astar) 15:47:23 INFO - PROCESS | 1685 | RSS: Main: 393650176 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | __start_tp_report 15:47:23 INFO - PROCESS | 1685 | _x_x_mozilla_page_load 15:47:23 INFO - PROCESS | 1685 | _x_x_mozilla_page_load_details 15:47:23 INFO - PROCESS | 1685 | |i|pagename|runs| 15:47:23 INFO - PROCESS | 1685 | |0;ai-astar;109;107;112;111;111;110;115;112;111;110 15:47:23 INFO - PROCESS | 1685 | |1;audio-beat-detection;158;122;145;153;119;144;144;122;158;119 15:47:23 INFO - PROCESS | 1685 | |2;audio-dft;191;185;184;181;186;185;184;182;182;182 15:47:23 INFO - PROCESS | 1685 | |3;audio-fft;74;76;82;77;58;56;57;80;78;55 15:47:23 INFO - PROCESS | 1685 | |4;audio-oscillator;93;94;129;80;80;84;109;78;79;109 15:47:23 INFO - PROCESS | 1685 | |5;imaging-gaussian-blur;83;90;88;139;85;95;129;138;85;91 15:47:23 INFO - PROCESS | 1685 | |6;imaging-darkroom;94;93;93;93;94;93;94;93;100;139 15:47:23 INFO - PROCESS | 1685 | |7;imaging-desaturate;85;85;85;85;85;85;84;86;86;99 15:47:23 INFO - PROCESS | 1685 | |8;json-parse-financial;57;56;55;53;53;54;54;66;53;53 15:47:23 INFO - PROCESS | 1685 | |9;json-stringify-tinderbox;62;71;69;72;71;66;64;67;70;67 15:47:23 INFO - PROCESS | 1685 | |10;stanford-crypto-aes;87;84;81;77;82;82;83;83;83;84 15:47:23 INFO - PROCESS | 1685 | |11;stanford-crypto-ccm;123;128;129;127;123;124;133;124;125;128 15:47:23 INFO - PROCESS | 1685 | |12;stanford-crypto-pbkdf2;133;158;139;138;132;128;141;137;170;149 15:47:23 INFO - PROCESS | 1685 | |13;stanford-crypto-sha256-iterative;68;67;66;68;67;68;66;67;66;66 15:47:23 INFO - PROCESS | 1685 | __end_tp_report 15:47:23 INFO - PROCESS | 1685 | __start_cc_report 15:47:23 INFO - PROCESS | 1685 | _x_x_mozilla_cycle_collect,1139 15:47:23 INFO - PROCESS | 1685 | __end_cc_report 15:47:23 INFO - PROCESS | 1685 | __startTimestamp1456184843520__endTimestamp 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | ------- Summary: start ------- 15:47:23 INFO - PROCESS | 1685 | Number of tests: 14 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.10 (1.9%) stddev-sans-first:2.12 15:47:23 INFO - PROCESS | 1685 | Values: 109.0 107.0 112.0 111.0 111.0 110.0 115.0 112.0 111.0 110.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:144.50 stddev:16.26 (11.3%) stddev-sans-first:15.62 15:47:23 INFO - PROCESS | 1685 | Values: 158.0 122.0 145.0 153.0 119.0 144.0 144.0 122.0 158.0 119.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.50 stddev:2.90 (1.6%) stddev-sans-first:1.74 15:47:23 INFO - PROCESS | 1685 | Values: 191.0 185.0 184.0 181.0 186.0 185.0 184.0 182.0 182.0 182.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#3] audio-fft Cycles:10 Average:69.30 Median:76.50 stddev:11.25 (14.7%) stddev-sans-first:11.80 15:47:23 INFO - PROCESS | 1685 | Values: 74.0 76.0 82.0 77.0 58.0 56.0 57.0 80.0 78.0 55.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:80.00 stddev:17.15 (21.4%) stddev-sans-first:18.19 15:47:23 INFO - PROCESS | 1685 | Values: 93.0 94.0 129.0 80.0 80.0 84.0 109.0 78.0 79.0 109.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#5] imaging-gaussian-blur Cycles:10 Average:102.30 Median:86.50 stddev:23.20 (26.8%) stddev-sans-first:23.53 15:47:23 INFO - PROCESS | 1685 | Values: 83.0 90.0 88.0 139.0 85.0 95.0 129.0 138.0 85.0 91.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#6] imaging-darkroom Cycles:10 Average:98.60 Median:93.00 stddev:14.35 (15.4%) stddev-sans-first:15.13 15:47:23 INFO - PROCESS | 1685 | Values: 94.0 93.0 93.0 93.0 94.0 93.0 94.0 93.0 100.0 139.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:85.00 stddev:4.43 (5.2%) stddev-sans-first:4.66 15:47:23 INFO - PROCESS | 1685 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 84.0 86.0 86.0 99.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.50 stddev:3.98 (7.3%) stddev-sans-first:4.18 15:47:23 INFO - PROCESS | 1685 | Values: 57.0 56.0 55.0 53.0 53.0 54.0 54.0 66.0 53.0 53.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:69.50 stddev:3.28 (4.7%) stddev-sans-first:2.70 15:47:23 INFO - PROCESS | 1685 | Values: 62.0 71.0 69.0 72.0 71.0 66.0 64.0 67.0 70.0 67.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:2.55 (3.1%) stddev-sans-first:2.15 15:47:23 INFO - PROCESS | 1685 | Values: 87.0 84.0 81.0 77.0 82.0 82.0 83.0 83.0 83.0 84.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:127.50 stddev:3.20 (2.5%) stddev-sans-first:3.15 15:47:23 INFO - PROCESS | 1685 | Values: 123.0 128.0 129.0 127.0 123.0 124.0 133.0 124.0 125.0 128.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.50 Median:140.00 stddev:12.97 (9.3%) stddev-sans-first:13.30 15:47:23 INFO - PROCESS | 1685 | Values: 133.0 158.0 139.0 138.0 132.0 128.0 141.0 137.0 170.0 149.0 15:47:23 INFO - PROCESS | 1685 | 15:47:23 INFO - PROCESS | 1685 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 15:47:23 INFO - PROCESS | 1685 | Values: 68.0 67.0 66.0 68.0 67.0 68.0 66.0 67.0 66.0 66.0 15:47:23 INFO - PROCESS | 1685 | -------- Summary: end -------- 15:47:23 INFO - PROCESS | 1685 | 15:47:24 INFO - TEST-INFO | 1685: exit 0 15:47:24 INFO - TEST-OK | kraken | took 56433ms 15:47:24 INFO - SUITE-END | took 1171s 15:47:24 INFO - Completed test suite (00:19:31) 15:47:24 INFO - Working with test: dromaeo_css 15:47:24 INFO - Generating results file: dromaeo_css 15:47:24 INFO - Working with test: kraken 15:47:24 INFO - Generating results file: kraken 15:47:24 INFO - javascript benchmark 15:47:24 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:47:24 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 15:47:24 INFO - process_Request line: dromaeo_css 7520.65 graph.html#tests=[[72,64,59]] 15:47:24 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:47:24 INFO - process_Request line: kraken 1425.30 graph.html#tests=[[232,64,59]] 15:47:24 INFO - RETURN: dromaeo_css: 7520.65 15:47:24 INFO - RETURN: kraken: 1425.30 15:47:24 INFO - javascript benchmark 15:47:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3407.1993081625815, 3470.4100302948495, 3501.03721476594, 3505.5968563615193, 3541.769784963977, 5632.183333416652, 5653.6607803531715, 5669.71651417429, 5683.2895888014, 5686.573506986972, 5716.28546431696, 5783.0, 5801.738921748521, 5824.534037277018, 5886.676232807194, 5072.137736584771, 5131.4098878629065, 5140.049090918183, 5148.485151484859, 5176.301199338079, 4541.704789188709, 5033.471485494026, 5037.647364684473, 5180.041692286939, 5271.314729085233, 5039.546440820343, 5182.507661772125, 5186.0, 5208.609354298424, 5246.632735708502, 5100.872478188038, 5110.897782044375, 5114.488551144893, 5115.360579927509, 5119.283300337956, 5044.54599086084, 5085.110105731482, 5100.5409513143995, 5107.055194788939, 5114.156164232897, 5395.379531353866, 5523.392426833045, 5556.277683901108, 5556.527695145917, 5559.805406810742, 5999.13012613173, 6095.769242301587, 6122.8775424491705, 6240.812775616739, 6248.78129265478, 6244.687765611747, 6275.780347687854, 6283.685815709242, 6296.842578935518, 6325.304216536178, 5558.6942718150085, 5723.799667011718, 5762.711864406763, 5766.942330576682, 5771.8557036074435, 5291.417944026154, 6219.595726277777, 6329.968350158219, 6331.588446750947, 6336.398042185985, 6082.939170608237, 6119.541034422347, 6124.785632502841, 6126.754929802847, 6174.351693072163, 6137.96931015351, 6276.843078922972, 6280.717367718464, 6296.0, 6316.9368306317265, 6125.908111378333, 6139.693015349215, 6142.771445710786, 6207.34822843604, 6209.6895155242055, 5232.790688372423, 6119.0, 6164.753409863645, 6220.533459990428, 6224.875502489925, 4784.545468180518, 4849.975750121227, 4857.271409288564, 4860.538248866352, 4868.172410690191, 4322.178786030707, 4325.7188282762145, 4349.717268377609, 4371.519132895379, 4404.515503294635, 5574.191742197439, 5601.271834661468, 5626.352969408488, 5632.7746890123935, 5659.801906933238, 6067.544934129958, 6177.413145751147, 6258.812235632939, 6264.59280146789, 6286.968565157236, 5573.832785016456, 5581.748821303051, 5599.0761524348845, 5603.551715862721, 5604.075327570987, 5288.259643649815, 5290.285811415487, 5293.57651387888, 5294.285271488377, 5295.020421222086, 5320.255164277004, 6266.749330026839, 6296.0555916612875, 6316.0, 6344.080108384351, 6261.592996455216, 6275.02737075754, 6288.6855657217875, 6295.3389894060465, 6303.747850085945, 6267.9373206267355, 6313.747450101944, 6323.083152942706, 6323.114763932961, 6352.237731472253, 6113.938860611337, 6149.2313460817395, 6153.72308246139, 6162.476189523941, 6163.84590385244, 6243.125962365181, 6295.0, 6299.4645455135, 6302.684865756785, 6306.306306306395, 5514.172874068921, 5851.473367396955, 6013.879722405615, 6021.066734656135, 6078.6048906820915, 6060.181875446935, 6061.878762424815, 6065.3934606539, 6088.51291896656, 6091.543134264859, 5874.206982057368, 5882.794102206402, 5893.764249429974, 5898.439648233411, 5903.822885313448, 5854.970725146347, 6034.849128771816, 6052.848678783065, 6125.784909797561, 6129.754809807736, 5929.932612129858, 5930.318013428511, 5932.1694962706115, 5951.970240148771, 5959.28488581373], "unit": "score", "name": "dojo.html", "value": 5647.13705614374}, {"lowerIsBetter": false, "replicates": [461.4762244852092, 479.30740080583524, 503.5769953239279, 525.4272842601564, 575.5223164773236, 28783.856080719594, 36464.08839779007, 37456.81271593645, 37480.81259593698, 37665.0, 39594.604053959454, 40075.799621001854, 40123.59876401235, 40167.59832401675, 40369.79815100921, 9300.813983720338, 9532.38039527432, 9540.713778586654, 9561.80876382472, 9575.042495750404, 9278.582463789146, 9428.151466368026, 9447.90552094477, 9454.81090378192, 9547.952260238724, 9483.90516094837, 9548.28387870909, 9572.712818615419, 9574.186194173504, 9598.232141428669, 9456.196223321025, 9532.14210721035, 9535.284853636005, 9542.42745435276, 9556.23550115996, 9390.0, 9535.046495350478, 9539.809203815954, 9542.856857147148, 9561.043895610454, 38659.8067009666, 39005.804970975245, 39112.21775564501, 39147.60852391497, 39168.0, 3101.550275210082, 3173.01636492688, 3523.4010218262956, 3724.9068773280615, 3745.606711295329, 25631.102911398197, 25840.483190336276, 28149.718502814914, 28300.009499667412, 29122.563161552593, 2692.7172646872186, 2748.2030211238716, 2770.5290100682732, 2787.5957986091903, 2902.3179552805072, 501902.0, 505614.0, 505633.0, 506352.0, 507187.464062681, 42781.57218427776, 43480.0, 43583.34624980628, 43614.34578481325, 43792.088068111036, 43196.3520547192, 43935.78032109819, 43970.78014609907, 43984.12031759411, 44062.67811965646, 15078.623034424008, 15307.0, 15311.387544498319, 15311.540653780405, 15343.923280383528, 12202.694932626579, 12362.320072395925, 12367.752644947052, 12550.497980080694, 12580.622581322576, 12826.871731282754, 13235.073544851768, 14237.715245695028, 14259.78610320846, 14342.85657143436, 6151.907721384183, 6201.658908759971, 6233.3143354231, 6253.0, 6258.186435763413, 909.8908131024187, 963.3882484622176, 965.6861520006026, 1012.7822518158631, 1111.5053801058452, 28690.426191476054, 29223.853880730887, 29258.853705731333, 29301.0, 29349.0, 945.7966537194399, 1047.8323468245044, 1074.1084899533369, 1079.5465904320204, 1175.518037604595, 13542.59372218835, 13731.45074197041, 13863.861361386458, 13922.512712055232, 13945.442182312796, 471377.64311178226, 485543.5722821363, 533819.0, 717304.0, 717720.0, 53319.466805332224, 54920.72539637276, 55658.44341556533, 55662.44337556654, 55779.721101394236, 1352.7429788340185, 1421.665908511499, 1445.125698952119, 1454.70178613384, 1456.8543145685346, 24978.50042999166, 28234.71765282321, 28979.98570050038, 29014.56478152787, 29041.419171616028, 43437.565624343355, 43478.56521434745, 43827.0, 43838.0, 43876.0, 310931.0, 315768.0, 316202.0, 316586.0, 316697.0, 25255.0, 29962.850185748932, 30040.19758814478, 31712.524312134876, 32040.03879883607, 42974.785126074166, 42980.57019429766, 43153.948410030614, 43226.91932701707, 43957.12085758331, 35948.64051359453, 36023.09942251465, 36887.077823054635, 36910.27890676949, 37106.8144659275, 31083.844580776953, 35470.30169548693, 36313.37695510639, 36702.63297366992, 36741.0, 35033.29933401369, 35133.0, 35975.64024359723, 35998.64001359953, 36070.8196459016, 30514.389712206077, 32422.027339179862, 32535.349293014482, 32652.673473265913, 32737.854175103756, 23946.28161155168, 24503.50992980166, 25626.974921003697, 25674.486510269315, 25730.485390292462], "unit": "score", "name": "ext.html", "value": 18379.619575187648}, {"lowerIsBetter": false, "replicates": [363.8308186693188, 367.3882984830258, 369.9352613292673, 372.3762697481718, 375.79331367747733, 15741.449049283277, 16408.09755463449, 19639.214431422726, 20412.183512659496, 21889.781102188954, 19350.709739353922, 19546.413607591796, 20029.399118026446, 20109.29617463389, 20346.389608311736, 5158.509941555565, 5673.26247587813, 5892.322382925954, 5897.646141231518, 5904.3800400957925, 5836.387179346171, 5845.473907348338, 5880.852978675524, 5884.529237660977, 5896.0, 5686.260786097822, 5717.656940583557, 5794.826155215329, 5879.470847623713, 5892.204552385416, 5819.82540523785, 5849.883002339972, 5887.1463637772285, 5898.8230353089475, 5906.527477801766, 5133.153029750087, 5143.794248230066, 5838.970805145989, 7291.4895957283015, 7310.232425595343, 26252.21243362702, 26330.341741456425, 26789.732102678918, 27153.728462715317, 27378.589321160198, 2274.80664143548, 2340.6957095577636, 2397.7602239776056, 2505.7619526145168, 2696.9865150674123, 15081.019733717274, 15353.769693454607, 15765.290561924627, 15809.525714228592, 16169.948953317997, 1845.363349644384, 1855.7587513623278, 1857.4891904726173, 1868.2807119259182, 1924.0572119661265, 92079.0, 98877.50561247148, 104780.95219047788, 108969.45515272452, 116658.41670791677, 19393.612127757366, 19728.210871565265, 19805.30681426172, 19828.306009289896, 19857.60284794296, 24266.0, 25286.74713252844, 27271.727282727315, 29404.11787646374, 29408.0, 10475.371477711362, 10611.522481488197, 10615.52230149645, 10620.20348473852, 10693.251472396858, 9037.277017838556, 9043.050479699668, 9051.230645395215, 9119.316051296179, 9151.405158664798, 8689.17452841979, 8737.344699147588, 8767.956160219159, 8789.033206347296, 8793.252573531194, 3319.68462996015, 3432.8626854926024, 3449.5170676105367, 3546.769459985093, 3607.2965771674794, 787.5314188058096, 897.3359713811863, 921.8340698674169, 932.4871320773548, 1013.002192840052, 20169.39491815248, 20806.479838004172, 20827.791722082584, 20987.475313117295, 21381.03785329664, 888.4536010353586, 935.209747763139, 949.5964215208509, 969.8351280282369, 997.0229175408141, 7958.960205198937, 10972.890271097347, 11273.661790146309, 11275.548978040786, 11280.943595281971, 516087.0, 525264.0, 526668.0, 676927.0, 684671.0, 95506.52246738721, 111805.0, 115482.4225878882, 137376.0, 137406.0, 998.3560603410759, 1018.5772904244656, 1054.9525271362807, 1097.1113398147527, 1099.5326986030905, 18915.86504809716, 19154.0, 19250.518737031685, 19254.422367329003, 19357.322493712654, 51617.879786205885, 52434.689132771986, 53011.73494132505, 53695.7315213437, 54493.45506545043, 76574.61712691624, 76688.46623067619, 76980.46039079298, 77894.83157752526, 78389.0, 10650.360978341325, 11285.548578056785, 11857.822132667845, 11920.821187682364, 11940.462679179283, 13799.79300310476, 14151.858481415466, 14208.218547979961, 14379.496717614833, 14423.711525769635, 8192.877106843283, 8211.71259005932, 8343.165683431609, 8346.749597512084, 8507.319414446953, 6858.897116543156, 7260.019897314006, 7797.259260370256, 8199.71301004462, 8371.41400101987, 8342.582870856555, 8409.789755255923, 8466.111058338785, 8502.192291732275, 8633.30933525329, 11933.940330298294, 11987.100967427303, 12205.69485762863, 12207.45066471993, 12208.267503949792, 9924.553395097382, 12050.51797928073, 12230.388480575757, 12249.510019599116, 12281.38593070325], "unit": "score", "name": "jquery.html", "value": 10408.967216595829}, {"lowerIsBetter": false, "replicates": [1227.582621908551, 1430.9697018146933, 1533.8772898168147, 1763.7530745695606, 1951.1317463728647, 7923.247291507312, 8569.314454843614, 8728.912710872904, 8756.387052906299, 8779.2537634301, 8368.497890126597, 8605.225529702326, 8616.26761725254, 8641.740747777576, 8642.524661143634, 1826.6072794349213, 2203.889805509726, 2205.2061257947125, 2446.5106978604263, 2486.689163854518, 2421.87890605469, 2504.6618706474574, 2504.6743923289946, 2509.0, 2510.535550923076, 2405.7746584409438, 2438.17102185257, 2491.2401717476164, 2501.5997440409537, 2508.122157244968, 2163.610550100981, 2392.808575313971, 2462.679851619278, 2472.332470233036, 2491.177911289279, 2436.9878150609134, 2447.3269850791, 2479.1694782247787, 2482.2305085423395, 2489.788367988723, 8617.138286171396, 8651.221390074923, 8654.269146170791, 8656.350773691998, 8663.0, 5342.118550439173, 5479.863003424946, 5496.642718223303, 5504.4495550445035, 5511.0080185566585, 3552.502649629054, 3610.7291953103622, 3671.94492082619, 3683.834227459771, 3685.6130106338983, 913.9223166030895, 1008.8638033865408, 1021.341234903483, 1046.6912260883057, 1053.9894601053968, 11391.829122563167, 11544.480498377594, 11563.710907227303, 11575.942120289345, 11582.420878956103, 3798.867039653599, 4638.721676699409, 4649.325847752057, 4689.554492323224, 4734.810607575727, 9190.40262382943, 9204.125608067223, 9205.171534561921, 9213.98646148923, 9225.953870230605, 5319.441458646864, 5337.893242135136, 5348.786048558092, 5355.3841308249275, 5367.275417818622, 4428.003699167726, 4600.516945720651, 4821.855344339676, 4929.679570827885, 5034.219695947061, 3218.3080637663015, 3778.3199024175365, 3783.39465685489, 3816.7900765458166, 3845.0964023454467, 1176.5529098942347, 1190.6844686158174, 1196.234409977615, 1200.7418405042959, 1201.3152503073338, 1107.335598640825, 1141.1042331769686, 1144.0961640304233, 1302.47900839663, 1385.2035079829138, 8059.355251579859, 8166.673333066729, 8192.221738934792, 8200.302974247137, 8239.340852731768, 428.9185054839633, 519.2963534410819, 519.4364114935262, 524.9133892907704, 525.3302039899082, 6212.502999760009, 6221.720022598994, 6325.620462772248, 6335.651539165298, 6336.556441049082, 10431.11335536488, 10780.946095269474, 10846.457677116112, 10915.39965301916, 10942.781144377068, 10570.418626975435, 10702.143828493701, 10717.142628589694, 10748.946255268673, 10753.247272690836, 8288.958555207306, 8364.330853531703, 8388.328933685412, 8434.620442079999, 8463.322934165251, 7717.729879454192, 7863.606819658879, 7881.172476889844, 7924.960375198087, 7929.801754956172, 9390.107939745712, 9609.56756945953, 9633.421994680342, 9679.66121185755, 9790.314677972758, 9743.317967742474, 10025.398476091457, 10103.0, 10125.443100629536, 10160.74598135023, 6363.331850155852, 6384.712687929147, 6384.9042264367, 6970.721171153097, 7046.859062818818, 8119.83760324802, 8138.674453021813, 8189.50862948225, 8191.590420478833, 8198.303144232568, 7267.963660181666, 7348.301911318416, 7352.080989876265, 7505.324520793155, 7522.623868806647, 7131.928680713127, 7190.352868241884, 7226.566406015656, 7306.4520160989205, 7335.0, 7581.6209189541405, 7726.227377262228, 7738.303552680286, 7740.148583655906, 7757.806054848448, 6793.66031698423, 6994.790156295319, 7051.400630946222, 7056.223815380406, 7060.505764596634, 7009.264027277062, 7090.326418990187, 7091.326323999212, 7094.929050709633, 7099.0], "unit": "score", "name": "mootools.html", "value": 4747.1227187387685}, {"lowerIsBetter": false, "replicates": [320.04307121706097, 328.6483462694916, 330.756893683143, 332.17951659401285, 335.9009092317766, 6559.311272316398, 6572.178477690289, 6573.0, 6583.868322633551, 6600.900986485207, 6500.41496265336, 6503.804885853432, 6508.2515510716285, 6516.6090034597955, 6531.640759758223, 4785.545373189541, 4836.951630483685, 4846.369971903665, 4851.490593487686, 4862.100511405383, 4846.854594362175, 4850.514948505156, 4851.514848515156, 4864.1974074277705, 4874.780634871439, 4311.28863737483, 4547.749873756942, 4757.976210118944, 4775.832845850396, 4786.210275304588, 4665.5567721066445, 4728.929066064012, 4733.5503127202865, 4734.763261836894, 4744.359511465942, 4108.383742438628, 4117.547069822317, 4121.216968775953, 4121.29937910556, 4136.503619565671, 6036.185115009462, 6138.294096178952, 6216.0, 6304.117423560705, 6343.968280158616, 5683.54531637468, 5694.77220911163, 5704.458076482728, 5706.743196556165, 5715.628484148517, 6971.372576468142, 6978.232394436608, 7006.229314775371, 7026.473014523931, 7027.754028608974, 4667.6265898728025, 4667.766611669403, 4670.136024835382, 4676.251799712029, 4676.462206846222, 5626.2967129108865, 7112.679929403138, 7146.428285737128, 7318.341349278538, 7319.926800731978, 4753.738544380092, 4758.357621721093, 4764.118638051971, 4765.404324459442, 4775.546323099369, 4791.0, 4841.346418233564, 4845.63657725672, 4853.6602437829715, 4866.78099485524, 5742.28221472316, 5742.684152371659, 5743.368229494836, 5744.684042377709, 5751.22358481608, 7026.402755765715, 7029.472789540805, 7034.964825175944, 7052.823679407953, 7059.505834591632, 1541.391150495548, 1613.2256516871967, 1613.9273732681822, 1621.2947367895003, 1645.9506214813575, 1022.9232807539464, 1038.0864838941684, 1049.1606714628267, 1051.51104736298, 1052.494802494807, 5249.527542521191, 5898.174255604219, 6069.666168360783, 6577.506686998494, 6580.078788969548, 6456.54804163704, 6777.593344399352, 7277.563346199245, 7279.015603602497, 7314.670839812221, 6501.122348482894, 6511.804645860631, 6515.4787616990525, 6520.9347906520325, 6535.215774107138, 3834.309824231609, 3834.9233015339537, 3849.672777813917, 3855.151866589346, 3857.2285542890972, 5822.7962021329895, 7466.104067511933, 7537.321641052332, 7556.811079723051, 7579.014728085313, 7434.033575635132, 7495.8500829983095, 7506.3244308012545, 7507.286807753255, 7512.511686740344, 6078.3617720138745, 6588.242352129567, 7092.751753688596, 7532.43506736986, 7544.811379715551, 6791.083203767428, 7192.604406757679, 7203.2076471589135, 7240.275972402928, 7248.456365772483, 6802.965985170043, 7088.0, 7108.964455177691, 7112.679929403293, 7122.216556178712, 7489.775306740807, 7554.697812087455, 7561.848763024599, 7578.355839753683, 7579.810504737426, 4346.804393802349, 4472.262076757299, 4506.932396014128, 4595.0, 4630.120277147331, 5864.67744274052, 7157.391621712213, 7167.8566428672175, 7183.712651494091, 7184.281571842774, 6892.414144797548, 6901.102856628606, 6902.378785909293, 6903.99892015665, 6914.0, 6881.208661004049, 6927.164301460017, 6931.826704332432, 6935.89596156048, 6936.826579335557, 6515.967420163059, 6690.83272918181, 6743.15710536183, 6747.156605424322, 6761.391474767294, 6843.213030501357, 6875.106236189264, 6920.619365934922, 6922.965385173042, 6927.861442771217, 6780.38976492118, 6784.76253331131, 6787.049813026081, 6793.93206067933, 6794.694238759169], "unit": "score", "name": "prototype.html", "value": 5084.822081534858}, {"lowerIsBetter": false, "replicates": [662.6653539962324, 664.2527156948433, 722.9240929702379, 743.8809790433531, 779.9181085985975, 14022.649433764162, 14216.431342746278, 14217.71564568708, 14218.360173792178, 14221.288935553206, 14347.852171826255, 15269.541913742605, 15784.44754433595, 15789.28948197331, 15795.921020394882, 706.6043015911106, 715.2204097533687, 792.6353877216487, 873.2053831013778, 880.9207171354577, 863.6027427383411, 880.053942012336, 880.5289170293894, 881.3081730841259, 884.849575572151, 923.5336155241594, 926.018420474296, 926.3839546701469, 926.5135803703076, 926.8053708721143, 733.2960358056272, 901.7430032440789, 917.6329468212701, 919.3564504846634, 920.1258804136031, 680.8400025993888, 682.5120039171966, 683.111954459206, 684.0799125176629, 684.384054351083, 14720.852791472162, 14783.0, 14785.482508112273, 14810.185439800807, 14827.629309267246, 12197.08521860864, 12379.566715165016, 12676.176048556814, 12736.917362024238, 12890.226586404846, 10099.343542669703, 10169.54237059334, 10334.22493312997, 10946.890531094747, 11255.493502792395, 3541.3448512025357, 3556.3065202285566, 3582.176099497104, 3620.076880395509, 3644.653757892996, 86824.56587717084, 87878.5606071972, 87946.0, 87983.0, 88204.55897720535, 9172.35793494449, 9227.400218985744, 9234.630614775333, 9240.412684448365, 9281.30390220736, 20790.480237994172, 20900.163993440092, 20980.160793568088, 21105.0, 21190.576188476454, 7365.81585460357, 7368.226336234726, 7368.557886526825, 7463.216362281991, 7552.622368881534, 4096.631303182728, 4105.34314509677, 4162.4796900387455, 4173.728707633994, 4184.0, 3521.559805024372, 3537.46937959303, 3561.928761424757, 3565.4651802229873, 3570.5179800727087, 638.9041643753474, 648.3257412291258, 649.7498463091649, 650.8958566629411, 654.4796886475264, 506.5921932844096, 602.5691630484225, 603.8943184942617, 618.1870839845589, 639.7579401178706, 8410.201030902055, 8697.217250447364, 8815.206631403205, 8928.196462318423, 9082.000979892207, 522.8562145410043, 529.3462573721451, 576.7289373994216, 622.7726879688881, 626.295417655138, 3674.2835147146584, 4031.173609410064, 4065.308897487434, 4066.959330406658, 4142.2751018572235, 92474.61288080685, 92736.07263927274, 97576.0, 98553.0, 99443.50834737485, 81773.0, 81857.59071204606, 82976.0, 83369.45773445084, 84184.31631367462, 74179.62910185523, 74823.0, 74834.62582687051, 75084.62457687786, 75861.24138758541, 8462.323014158976, 8472.949738094405, 8692.478451292942, 8709.651613935372, 8785.736427907173, 46331.76834115808, 49701.50298496969, 50157.0, 50475.49524504708, 50759.22342717987, 70839.64580177066, 72145.0, 72294.63852680703, 72717.6364118176, 72875.0, 10794.622188223375, 10920.563177472812, 11210.943945280222, 11236.775264494829, 11285.322880627189, 10655.840162397726, 11934.462949167482, 12064.396780160781, 12197.146199765932, 12725.490980360682, 11501.942490287494, 11515.596954106566, 11631.127665424958, 12126.27558632233, 12443.688907777378, 11061.94469027682, 11320.150988676047, 11353.0, 11636.825447618123, 11998.820017699567, 10890.891091088988, 11054.0, 11060.115190784558, 11090.279131856403, 12018.0, 7379.520331178456, 9151.313651476034, 9158.954205229198, 9163.541822908961, 9680.4675742832, 8660.857635661429, 9220.723378298662, 9554.808903822024, 9565.569549370433, 9789.657361992297], "unit": "score", "name": "yui.html", "value": 6937.735425767864}], "name": "dromaeo_css", "value": 7520.648373147608}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 107.0, 112.0, 111.0, 111.0, 110.0, 115.0, 112.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [158.0, 122.0, 145.0, 153.0, 119.0, 144.0, 144.0, 122.0, 158.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 138.4}, {"lowerIsBetter": true, "replicates": [191.0, 185.0, 184.0, 181.0, 186.0, 185.0, 184.0, 182.0, 182.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.2}, {"lowerIsBetter": true, "replicates": [74.0, 76.0, 82.0, 77.0, 58.0, 56.0, 57.0, 80.0, 78.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.3}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 129.0, 80.0, 80.0, 84.0, 109.0, 78.0, 79.0, 109.0], "unit": "score", "name": "audio-oscillator", "value": 93.5}, {"lowerIsBetter": true, "replicates": [83.0, 90.0, 88.0, 139.0, 85.0, 95.0, 129.0, 138.0, 85.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 102.3}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 93.0, 93.0, 94.0, 93.0, 94.0, 93.0, 100.0, 139.0], "unit": "score", "name": "imaging-darkroom", "value": 98.6}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 86.0, 86.0, 99.0], "unit": "score", "name": "imaging-desaturate", "value": 86.5}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 55.0, 53.0, 53.0, 54.0, 54.0, 66.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [62.0, 71.0, 69.0, 72.0, 71.0, 66.0, 64.0, 67.0, 70.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 81.0, 77.0, 82.0, 82.0, 83.0, 83.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [123.0, 128.0, 129.0, 127.0, 123.0, 124.0, 133.0, 124.0, 125.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.4}, {"lowerIsBetter": true, "replicates": [133.0, 158.0, 139.0, 138.0, 132.0, 128.0, 141.0, 137.0, 170.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.5}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 66.0, 68.0, 67.0, 68.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1425.3000000000002}]} 15:47:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1425.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7520.65"}}} 15:47:24 INFO - Return code: 0 15:47:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:47:24 INFO - # TBPL SUCCESS # 15:47:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:47:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:47:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:47:24 INFO - 2016-02-22 15:47:24.898 screenresolution[1689:10018] starting screenresolution argv=screenresolution get 15:47:24 INFO - 2016-02-22 15:47:24.900 screenresolution[1689:10018] Display 0: 1600x1200x32@60 15:47:24 INFO - 2016-02-22 15:47:24.906 screenresolution[1690:10021] starting screenresolution argv=screenresolution list 15:47:24 INFO - Available Modes on Display 0 15:47:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:47:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:47:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:47:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:47:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:47:25 INFO - Intel Iris: 15:47:25 INFO - Chipset Model: Intel Iris 15:47:25 INFO - Type: GPU 15:47:25 INFO - Bus: Built-In 15:47:25 INFO - VRAM (Dynamic, Max): 1536 MB 15:47:25 INFO - Vendor: Intel (0x8086) 15:47:25 INFO - Device ID: 0x0a2e 15:47:25 INFO - Revision ID: 0x0009 15:47:25 INFO - Displays: 15:47:25 INFO - Display: 15:47:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:47:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:47:25 INFO - Display Serial Number: 1600x1200 60 15:47:25 INFO - Main Display: Yes 15:47:25 INFO - Mirror: Off 15:47:25 INFO - Online: Yes 15:47:25 INFO - Rotation: Supported 15:47:25 INFO - Return code: 0 15:47:25 INFO - Running post-action listener: _resource_record_post_action 15:47:25 INFO - Running post-run listener: _resource_record_post_run 15:47:26 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 39507456; Write bytes: 706574336; Read time: 424; Write time: 1882 15:47:26 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399505920; Write bytes: 393189376; Read time: 29736; Write time: 692 15:47:26 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 37692928; Write bytes: 299728896; Read time: 402; Write time: 1152 15:47:26 INFO - Running post-run listener: _upload_blobber_files 15:47:26 INFO - Blob upload gear active. 15:47:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:47:26 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 15:47:26 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'] 15:47:26 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 15:47:26 INFO - (blobuploader) - INFO - Open directory for files ... 15:47:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:47:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:47:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:27 INFO - (blobuploader) - INFO - Done attempting. 15:47:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:47:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:47:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:47:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:47:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:47:28 INFO - (blobuploader) - INFO - Done attempting. 15:47:28 INFO - (blobuploader) - INFO - Iteration through files over. 15:47:28 INFO - Return code: 0 15:47:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:47:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:47:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3d45c530736b10f86c77bec825f8c3161a583ef0446824c820cb2e20e8ca6aa39ea76fb0bdb40b9c7badc35f270bb26518e5ba33008d5d07d96ec225fd25345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/711b2d25f2bbbd4495f58ddda681cf9125579c50117d12a42adf342193a0b32225ccb989eff757a61c0b4a17ad53b123cef53ebd3595db3847292b25740c9df1"} 15:47:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:47:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:47:28 INFO - Contents: 15:47:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3d45c530736b10f86c77bec825f8c3161a583ef0446824c820cb2e20e8ca6aa39ea76fb0bdb40b9c7badc35f270bb26518e5ba33008d5d07d96ec225fd25345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/711b2d25f2bbbd4495f58ddda681cf9125579c50117d12a42adf342193a0b32225ccb989eff757a61c0b4a17ad53b123cef53ebd3595db3847292b25740c9df1"} 15:47:28 INFO - Running post-run listener: copy_logs_to_upload_dir 15:47:28 INFO - Copying logs to upload dir... 15:47:28 INFO - mkdir: /builds/slave/test/build/upload/logs 15:47:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.945236 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-22 15:47:28.650540) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 15:47:28.653944) ========= 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.jjTEeaSebS/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.4h6N3gYqEV/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3d45c530736b10f86c77bec825f8c3161a583ef0446824c820cb2e20e8ca6aa39ea76fb0bdb40b9c7badc35f270bb26518e5ba33008d5d07d96ec225fd25345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/711b2d25f2bbbd4495f58ddda681cf9125579c50117d12a42adf342193a0b32225ccb989eff757a61c0b4a17ad53b123cef53ebd3595db3847292b25740c9df1"} build_url:https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011120 build_url: 'https://queue.taskcluster.net/v1/task/WZfT5HNtQpGICZeWm2oDaA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3d45c530736b10f86c77bec825f8c3161a583ef0446824c820cb2e20e8ca6aa39ea76fb0bdb40b9c7badc35f270bb26518e5ba33008d5d07d96ec225fd25345", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/711b2d25f2bbbd4495f58ddda681cf9125579c50117d12a42adf342193a0b32225ccb989eff757a61c0b4a17ad53b123cef53ebd3595db3847292b25740c9df1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 15:47:28.684925) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:47:28.685214) ========= 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.jjTEeaSebS/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.4h6N3gYqEV/Listeners TMPDIR=/var/folders/30/cty5_80j7yx3964y35jzqrp000000w/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.005352 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 15:47:28.761630) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 15:47:28.761909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 15:47:29.150872) ========= ========= Total master_lag: 0.33 =========