builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0090 starttime: 1455239301.26 results: success (0) buildid: 20160211154628 builduid: bcd7190a53a3480cbc2f2ff02846fae2 revision: c578a05bb9d6f398fccc5580df198a763af21020 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.256094) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.256603) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.256937) ========= 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.8FUVfg54vh/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.dlMymHbDxO/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.005954 basedir: '/builds/slave/test' ========= master_lag: 0.19 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.450846) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.451223) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.487143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.487664) ========= 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.8FUVfg54vh/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.dlMymHbDxO/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.005306 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.538199) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.540756) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.541568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.541912) ========= 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.8FUVfg54vh/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.dlMymHbDxO/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-11 17:08:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-02-11 17:08:21 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102708 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.887503) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.887859) ========= 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.8FUVfg54vh/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.dlMymHbDxO/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.019677 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.926877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:21.927643) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c578a05bb9d6f398fccc5580df198a763af21020 --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 c578a05bb9d6f398fccc5580df198a763af21020 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8FUVfg54vh/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.dlMymHbDxO/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-11 17:08:22,004 truncating revision to first 12 chars 2016-02-11 17:08:22,004 Setting DEBUG logging. 2016-02-11 17:08:22,004 attempt 1/10 2016-02-11 17:08:22,004 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c578a05bb9d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 17:08:22,273 unpacking tar archive at: fx-team-c578a05bb9d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516551 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:22.465213) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:22.465615) ========= echo c578a05bb9d6f398fccc5580df198a763af21020 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c578a05bb9d6f398fccc5580df198a763af21020'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8FUVfg54vh/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.dlMymHbDxO/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 c578a05bb9d6f398fccc5580df198a763af21020 program finished with exit code 0 elapsedTime=0.005057 script_repo_revision: 'c578a05bb9d6f398fccc5580df198a763af21020' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:22.519648) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:22.520002) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 17:08:22.539881) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-02-11 17:08:22.540243) ========= /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.8FUVfg54vh/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.dlMymHbDxO/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:08:22 INFO - MultiFileLogger online at 20160211 17:08:22 in /builds/slave/test 17:08:22 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 17:08:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:08:22 INFO - {'append_to_log': False, 17:08:22 INFO - 'base_work_dir': '/builds/slave/test', 17:08:22 INFO - 'blob_upload_branch': 'Fx-Team', 17:08:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:08:22 INFO - 'branch': 'Fx-Team', 17:08:22 INFO - 'buildbot_json_path': 'buildprops.json', 17:08:22 INFO - 'config_files': ('talos/mac_config.py',), 17:08:22 INFO - 'default_actions': ('clobber', 17:08:22 INFO - 'read-buildbot-config', 17:08:22 INFO - 'download-and-extract', 17:08:22 INFO - 'populate-webroot', 17:08:22 INFO - 'create-virtualenv', 17:08:22 INFO - 'install', 17:08:22 INFO - 'run-tests'), 17:08:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:08:22 INFO - 'download_minidump_stackwalk': True, 17:08:22 INFO - 'download_symbols': 'ondemand', 17:08:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:08:22 INFO - 'tooltool.py': '/tools/tooltool.py', 17:08:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:08:22 INFO - '/tools/misc-python/virtualenv.py')}, 17:08:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:08:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:08:22 INFO - 'installer_path': 'installer.exe', 17:08:22 INFO - 'log_level': 'info', 17:08:22 INFO - 'log_name': 'talos', 17:08:22 INFO - 'log_to_console': True, 17:08:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:08:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:08:22 INFO - 'opt_config_files': (), 17:08:22 INFO - 'pip_index': False, 17:08:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:08:22 INFO - 'cmd': ('bash', 17:08:22 INFO - '-c', 17:08:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:08:22 INFO - 'enabled': True, 17:08:22 INFO - 'halt_on_failure': False, 17:08:22 INFO - 'name': 'check_screen_resolution'},), 17:08:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:08:22 INFO - 'cmd': ('bash', 17:08:22 INFO - '-c', 17:08:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:08:22 INFO - 'enabled': True, 17:08:22 INFO - 'halt_on_failure': False, 17:08:22 INFO - 'name': 'check_screen_resolution'},), 17:08:22 INFO - 'run_cmd_checks_enabled': True, 17:08:22 INFO - 'sps_profile': False, 17:08:22 INFO - 'sps_profile_interval': 0, 17:08:22 INFO - 'suite': 'dromaeojs', 17:08:22 INFO - 'system_bits': '32', 17:08:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:08:22 INFO - 'title': 't-yosemite-r7-0090', 17:08:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:08:22 INFO - 'use_talos_json': True, 17:08:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:08:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:08:22 INFO - 'work_dir': 'build'} 17:08:22 INFO - ##### 17:08:22 INFO - ##### Running clobber step. 17:08:22 INFO - ##### 17:08:22 INFO - Running pre-action listener: _resource_record_pre_action 17:08:22 INFO - Running main action method: clobber 17:08:22 INFO - rmtree: /builds/slave/test/build 17:08:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:08:23 INFO - Running post-action listener: _resource_record_post_action 17:08:23 INFO - ##### 17:08:23 INFO - ##### Running read-buildbot-config step. 17:08:23 INFO - ##### 17:08:23 INFO - Running pre-action listener: _resource_record_pre_action 17:08:23 INFO - Running main action method: read_buildbot_config 17:08:23 INFO - Using buildbot properties: 17:08:23 INFO - { 17:08:23 INFO - "project": "", 17:08:23 INFO - "product": "firefox", 17:08:23 INFO - "script_repo_revision": "production", 17:08:23 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 17:08:23 INFO - "repository": "", 17:08:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 17:08:23 INFO - "buildid": "20160211154628", 17:08:23 INFO - "pgo_build": "False", 17:08:23 INFO - "basedir": "/builds/slave/test", 17:08:23 INFO - "buildnumber": 426, 17:08:23 INFO - "slavename": "t-yosemite-r7-0090", 17:08:23 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:08:23 INFO - "platform": "yosemite_r7", 17:08:23 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:08:23 INFO - "branch": "fx-team", 17:08:23 INFO - "repo_path": "integration/fx-team", 17:08:23 INFO - "revision": "c578a05bb9d6f398fccc5580df198a763af21020", 17:08:23 INFO - "stage_platform": "macosx64", 17:08:23 INFO - "builduid": "bcd7190a53a3480cbc2f2ff02846fae2", 17:08:23 INFO - "slavebuilddir": "test" 17:08:23 INFO - } 17:08:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 17:08:23 INFO - Running post-action listener: _resource_record_post_action 17:08:23 INFO - ##### 17:08:23 INFO - ##### Running download-and-extract step. 17:08:23 INFO - ##### 17:08:23 INFO - Running pre-action listener: _resource_record_pre_action 17:08:23 INFO - Running main action method: download_and_extract 17:08:23 INFO - mkdir: /builds/slave/test/build/tests 17:08:23 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')]} 17:08:23 INFO - https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:08:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/test_packages.json 17:08:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/test_packages.json 17:08:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:08:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:08:26 INFO - Downloaded 1277 bytes. 17:08:26 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:08:26 INFO - Using the following test package requirements: 17:08:26 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:08:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:08:26 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 17:08:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:08:26 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 17:08:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:08:26 INFO - u'jsshell-mac.zip'], 17:08:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:08:26 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 17:08:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:08:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:08:26 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 17:08:26 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:08:26 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 17:08:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:08:26 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 17:08:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 17:08:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 17:08:26 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 17:08:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:08: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')]} 17:08:26 INFO - https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:08:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:08:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:08:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/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 17:08:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/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 17:08:27 INFO - Downloaded 17754990 bytes. 17:08:27 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'] 17:08:27 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 17:08:30 INFO - Return code: 0 17:08:30 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 17:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:30 INFO - https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 17:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/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 17:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/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 17:08:32 INFO - Downloaded 17754990 bytes. 17:08:32 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'] 17:08:32 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 17:08:36 INFO - Return code: 0 17:08:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:36 INFO - https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:08:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:08:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 17:08:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/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 17:08:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/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 17:08:40 INFO - Downloaded 10706547 bytes. 17:08:40 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'] 17:08:40 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 17:08:40 INFO - Return code: 0 17:08:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:40 INFO - https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:08:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:08:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:08:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 17:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/frtNIz3SRFi04h2eS79wkA/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 17:08:45 INFO - Downloaded 111139522 bytes. 17:08:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:08:45 INFO - mkdir: /builds/slave/test/properties 17:08:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:08:45 INFO - Writing to file /builds/slave/test/properties/build_url 17:08:45 INFO - Contents: 17:08:45 INFO - build_url:https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 17:08:46 INFO - Running post-action listener: _resource_record_post_action 17:08:46 INFO - Running post-action listener: set_extra_try_arguments 17:08:46 INFO - ##### 17:08:46 INFO - ##### Running populate-webroot step. 17:08:46 INFO - ##### 17:08:46 INFO - Running pre-action listener: _resource_record_pre_action 17:08:46 INFO - Running main action method: populate_webroot 17:08:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:08:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:08:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:08:46 INFO - '--tppagecycles', 17:08:46 INFO - '7'], 17:08:46 INFO - 'tests': ['tsvgm']}}, 17:08:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:08:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:08:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:08:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:08:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:08:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:08:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:46 INFO - 'talos_options': ['--e10s'], 17:08:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:08:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:46 INFO - 'tests': ['damp', 'tps']}, 17:08:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:46 INFO - 'talos_options': ['--e10s'], 17:08:46 INFO - 'tests': ['damp', 'tps']}, 17:08:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:08:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:08:46 INFO - 'other': {'tests': ['a11yr', 17:08:46 INFO - 'ts_paint', 17:08:46 INFO - 'tpaint', 17:08:46 INFO - 'sessionrestore', 17:08:46 INFO - 'sessionrestore_no_auto_restore']}, 17:08:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:08:46 INFO - 'tests': ['a11yr', 17:08:46 INFO - 'ts_paint', 17:08:46 INFO - 'tpaint', 17:08:46 INFO - 'sessionrestore', 17:08:46 INFO - 'sessionrestore_no_auto_restore']}, 17:08:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:08:46 INFO - 'tests': ['a11yr', 17:08:46 INFO - 'ts_paint', 17:08:46 INFO - 'tpaint', 17:08:46 INFO - 'sessionrestore', 17:08:46 INFO - 'sessionrestore_no_auto_restore']}, 17:08:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:08:46 INFO - 'tests': ['a11yr', 17:08:46 INFO - 'ts_paint', 17:08:46 INFO - 'tpaint', 17:08:46 INFO - 'sessionrestore', 17:08:46 INFO - 'sessionrestore_no_auto_restore']}, 17:08:46 INFO - 'other_l64': {'tests': ['a11yr', 17:08:46 INFO - 'ts_paint', 17:08:46 INFO - 'tpaint', 17:08:46 INFO - 'sessionrestore', 17:08:46 INFO - 'sessionrestore_no_auto_restore']}, 17:08:46 INFO - 'other_nol64': {'tests': ['a11yr', 17:08:46 INFO - 'ts_paint', 17:08:46 INFO - 'tpaint', 17:08:46 INFO - 'sessionrestore', 17:08:46 INFO - 'sessionrestore_no_auto_restore']}, 17:08:46 INFO - 'svgr': {'tests': ['tsvgx', 17:08:46 INFO - 'tsvgr_opacity', 17:08:46 INFO - 'tart', 17:08:46 INFO - 'tscrollx', 17:08:46 INFO - 'cart']}, 17:08:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:08:46 INFO - 'tests': ['tsvgx', 17:08:46 INFO - 'tsvgr_opacity', 17:08:46 INFO - 'tart', 17:08:46 INFO - 'tscrollx', 17:08:46 INFO - 'cart']}, 17:08:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:46 INFO - 'tests': ['tp5o']}, 17:08:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:46 INFO - 'talos_options': ['--e10s'], 17:08:46 INFO - 'tests': ['tp5o']}, 17:08:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:46 INFO - 'talos_options': ['--xperf_path', 17:08:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:46 INFO - 'tests': ['tp5n']}, 17:08:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:08:46 INFO - 'talos_options': ['--e10s', 17:08:46 INFO - '--xperf_path', 17:08:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:08:46 INFO - 'tests': ['tp5n']}}, 17:08:46 INFO - 'talos.zip': {'path': '', 17:08:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:08:46 INFO - Running post-action listener: _resource_record_post_action 17:08:46 INFO - ##### 17:08:46 INFO - ##### Running create-virtualenv step. 17:08:46 INFO - ##### 17:08:46 INFO - Running pre-action listener: _resource_record_pre_action 17:08:46 INFO - Running main action method: create_virtualenv 17:08:46 INFO - Creating virtualenv /builds/slave/test/build/venv 17:08:46 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 17:08:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:08:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:08:46 INFO - Using real prefix '/tools/python27' 17:08:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:08:47 INFO - Installing distribute.............................................................................................................................................................................................done. 17:08:50 INFO - Installing pip.................done. 17:08:50 INFO - Return code: 0 17:08:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101887a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6985717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10172bd30>, '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 0x10154fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101722b20>, '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.8FUVfg54vh/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.dlMymHbDxO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FUVfg54vh/Render', 17:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:50 INFO - 'HOME': '/Users/cltbld', 17:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:50 INFO - 'LOGNAME': 'cltbld', 17:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:50 INFO - 'MOZ_NO_REMOTE': '1', 17:08:50 INFO - 'NO_EM_RESTART': '1', 17:08:50 INFO - 'PAGER': '/bin/cat', 17:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:50 INFO - 'PWD': '/builds/slave/test', 17:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:50 INFO - 'SHELL': '/bin/bash', 17:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dlMymHbDxO/Listeners', 17:08:50 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:50 INFO - 'USER': 'cltbld', 17:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:50 INFO - 'XPC_FLAGS': '0x0', 17:08:50 INFO - 'XPC_SERVICE_NAME': '0', 17:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:50 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 17:08:50 INFO - Cleaning up... 17:08:50 INFO - Return code: 0 17:08:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101887a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6985717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10172bd30>, '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 0x10154fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101722b20>, '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.8FUVfg54vh/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.dlMymHbDxO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FUVfg54vh/Render', 17:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:50 INFO - 'HOME': '/Users/cltbld', 17:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:50 INFO - 'LOGNAME': 'cltbld', 17:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:50 INFO - 'MOZ_NO_REMOTE': '1', 17:08:50 INFO - 'NO_EM_RESTART': '1', 17:08:50 INFO - 'PAGER': '/bin/cat', 17:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:50 INFO - 'PWD': '/builds/slave/test', 17:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:50 INFO - 'SHELL': '/bin/bash', 17:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dlMymHbDxO/Listeners', 17:08:50 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:50 INFO - 'USER': 'cltbld', 17:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:50 INFO - 'XPC_FLAGS': '0x0', 17:08:50 INFO - 'XPC_SERVICE_NAME': '0', 17:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:50 INFO - Downloading/unpacking psutil>=0.7.1 17:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:08:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:08:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:08:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:53 INFO - Installing collected packages: psutil 17:08:53 INFO - Running setup.py install for psutil 17:08:53 INFO - building 'psutil._psutil_osx' extension 17:08:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 17:08:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 17:08:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 17:08:54 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 17:08:54 INFO - building 'psutil._psutil_posix' extension 17:08:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 17:08:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:08:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:08:54 INFO - ^ 17:08:54 INFO - 1 warning generated. 17:08:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 17:08:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:08:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:08:54 INFO - Successfully installed psutil 17:08:54 INFO - Cleaning up... 17:08:54 INFO - Return code: 0 17:08:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:08: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')]} 17:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08: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')]} 17:08:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101887a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6985717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10172bd30>, '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 0x10154fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101722b20>, '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.8FUVfg54vh/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.dlMymHbDxO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:08:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 17:08:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 17:08:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FUVfg54vh/Render', 17:08:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:54 INFO - 'HOME': '/Users/cltbld', 17:08:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:54 INFO - 'LOGNAME': 'cltbld', 17:08:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:54 INFO - 'MOZ_NO_REMOTE': '1', 17:08:54 INFO - 'NO_EM_RESTART': '1', 17:08:54 INFO - 'PAGER': '/bin/cat', 17:08:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:54 INFO - 'PWD': '/builds/slave/test', 17:08:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:54 INFO - 'SHELL': '/bin/bash', 17:08:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dlMymHbDxO/Listeners', 17:08:54 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:08:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:54 INFO - 'USER': 'cltbld', 17:08:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:54 INFO - 'XPC_FLAGS': '0x0', 17:08:54 INFO - 'XPC_SERVICE_NAME': '0', 17:08:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:08:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:08:57 INFO - Installing collected packages: mozsystemmonitor 17:08:57 INFO - Running setup.py install for mozsystemmonitor 17:08:57 INFO - Successfully installed mozsystemmonitor 17:08:57 INFO - Cleaning up... 17:08:57 INFO - Return code: 0 17:08:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:08:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:08:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:08:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:08:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101887a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6985717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10172bd30>, '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 0x10154fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101722b20>, '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.8FUVfg54vh/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.dlMymHbDxO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:08:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:08:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FUVfg54vh/Render', 17:08:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:08:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:08:57 INFO - 'HOME': '/Users/cltbld', 17:08:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:08:57 INFO - 'LOGNAME': 'cltbld', 17:08:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:08:57 INFO - 'MOZ_NO_REMOTE': '1', 17:08:57 INFO - 'NO_EM_RESTART': '1', 17:08:57 INFO - 'PAGER': '/bin/cat', 17:08:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:08:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:08:57 INFO - 'PWD': '/builds/slave/test', 17:08:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:08:57 INFO - 'SHELL': '/bin/bash', 17:08:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dlMymHbDxO/Listeners', 17:08:57 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:08:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:08:57 INFO - 'USER': 'cltbld', 17:08:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:08:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:08:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:08:57 INFO - 'XPC_FLAGS': '0x0', 17:08:57 INFO - 'XPC_SERVICE_NAME': '0', 17:08:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:08:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:08:57 INFO - Downloading/unpacking blobuploader==1.2.4 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:08: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 17:09:00 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:09:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:01 INFO - Downloading docopt-0.6.1.tar.gz 17:09:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:01 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:01 INFO - Running setup.py install for blobuploader 17:09:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:09:01 INFO - Running setup.py install for requests 17:09:01 INFO - Running setup.py install for docopt 17:09:02 INFO - Successfully installed blobuploader requests docopt 17:09:02 INFO - Cleaning up... 17:09:02 INFO - Return code: 0 17:09:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101887a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6985717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10172bd30>, '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 0x10154fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101722b20>, '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.8FUVfg54vh/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.dlMymHbDxO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:09:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:09:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:09:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FUVfg54vh/Render', 17:09:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:02 INFO - 'HOME': '/Users/cltbld', 17:09:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:02 INFO - 'LOGNAME': 'cltbld', 17:09:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:02 INFO - 'MOZ_NO_REMOTE': '1', 17:09:02 INFO - 'NO_EM_RESTART': '1', 17:09:02 INFO - 'PAGER': '/bin/cat', 17:09:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:02 INFO - 'PWD': '/builds/slave/test', 17:09:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:02 INFO - 'SHELL': '/bin/bash', 17:09:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dlMymHbDxO/Listeners', 17:09:02 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:09:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:02 INFO - 'USER': 'cltbld', 17:09:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:02 INFO - 'XPC_FLAGS': '0x0', 17:09:02 INFO - 'XPC_SERVICE_NAME': '0', 17:09:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:02 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-PQUWiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-8Bp1eE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-RE5vzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-DuNMJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-O2ZJMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-ak789V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-OoFT2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-zHhGrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-iuPQ_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-iBQDGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:03 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-2GOGw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-lsWm3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-J6KqWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Ywuo2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-D5eHHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-Wqm3fM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:04 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-QO65NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:04 INFO - Running setup.py install for manifestparser 17:09:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:09:04 INFO - Running setup.py install for mozcrash 17:09:05 INFO - Running setup.py install for mozdebug 17:09:05 INFO - Running setup.py install for mozdevice 17:09:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:09:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:09:05 INFO - Running setup.py install for mozfile 17:09:05 INFO - Running setup.py install for mozhttpd 17:09:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:09:05 INFO - Running setup.py install for mozinfo 17:09:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:09:05 INFO - Running setup.py install for mozInstall 17:09:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:09:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:09:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:09:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:09:05 INFO - Running setup.py install for mozleak 17:09:06 INFO - Running setup.py install for mozlog 17:09:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:09:06 INFO - Running setup.py install for moznetwork 17:09:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:09:06 INFO - Running setup.py install for mozprocess 17:09:06 INFO - Running setup.py install for mozprofile 17:09:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:09:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:09:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:09:06 INFO - Running setup.py install for mozrunner 17:09:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:09:06 INFO - Running setup.py install for mozscreenshot 17:09:07 INFO - Running setup.py install for moztest 17:09:07 INFO - Running setup.py install for mozversion 17:09:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:09:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:07 INFO - Cleaning up... 17:09:07 INFO - Return code: 0 17:09:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101887a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6985717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10172bd30>, '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 0x10154fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101722b20>, '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.8FUVfg54vh/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.dlMymHbDxO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:09:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:09:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:09:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FUVfg54vh/Render', 17:09:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:07 INFO - 'HOME': '/Users/cltbld', 17:09:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:07 INFO - 'LOGNAME': 'cltbld', 17:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:07 INFO - 'MOZ_NO_REMOTE': '1', 17:09:07 INFO - 'NO_EM_RESTART': '1', 17:09:07 INFO - 'PAGER': '/bin/cat', 17:09:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:07 INFO - 'PWD': '/builds/slave/test', 17:09:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:07 INFO - 'SHELL': '/bin/bash', 17:09:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dlMymHbDxO/Listeners', 17:09:07 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:09:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:07 INFO - 'USER': 'cltbld', 17:09:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:07 INFO - 'XPC_FLAGS': '0x0', 17:09:07 INFO - 'XPC_SERVICE_NAME': '0', 17:09:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:09:07 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-q0xwAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:09:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:09:07 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-kSzarx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:09:07 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)) 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:09:07 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-ypJsCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:09:07 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)) 17:09:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:09:07 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-ldqX5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:09:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-aOIeab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:09:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-d0I9L8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:09:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-dqsoNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:09:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-w73jv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:09:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-6Vpr6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:09:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-55Pp5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:09:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-u6KIFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:09:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:09:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-agu6wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:09:08 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)) 17:09:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:09:08 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-h1PBBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:09:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-RYvb_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-nJJKpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:09:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-M1_jO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:09:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:09:09 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-q_QJXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:11 INFO - Downloading blessings-1.6.tar.gz 17:09:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:11 INFO - Installing collected packages: blessings 17:09:11 INFO - Running setup.py install for blessings 17:09:12 INFO - Successfully installed blessings 17:09:12 INFO - Cleaning up... 17:09:12 INFO - Return code: 0 17:09:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:09:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:12 INFO - Reading from file tmpfile_stdout 17:09:12 INFO - Current package versions: 17:09:12 INFO - blessings == 1.6 17:09:12 INFO - blobuploader == 1.2.4 17:09:12 INFO - docopt == 0.6.1 17:09:12 INFO - manifestparser == 1.1 17:09:12 INFO - mozInstall == 1.12 17:09:12 INFO - mozcrash == 0.16 17:09:12 INFO - mozdebug == 0.1 17:09:12 INFO - mozdevice == 0.48 17:09:12 INFO - mozfile == 1.2 17:09:12 INFO - mozhttpd == 0.7 17:09:12 INFO - mozinfo == 0.9 17:09:12 INFO - mozleak == 0.1 17:09:12 INFO - mozlog == 3.1 17:09:12 INFO - moznetwork == 0.27 17:09:12 INFO - mozprocess == 0.22 17:09:12 INFO - mozprofile == 0.28 17:09:12 INFO - mozrunner == 6.11 17:09:12 INFO - mozscreenshot == 0.1 17:09:12 INFO - mozsystemmonitor == 0.0 17:09:12 INFO - moztest == 0.7 17:09:12 INFO - mozversion == 1.4 17:09:12 INFO - psutil == 3.1.1 17:09:12 INFO - requests == 1.2.3 17:09:12 INFO - wsgiref == 0.1.2 17:09:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101887a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6985717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10172bd30>, '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 0x10154fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101722b20>, '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.8FUVfg54vh/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.dlMymHbDxO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FUVfg54vh/Render', 17:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:12 INFO - 'HOME': '/Users/cltbld', 17:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:12 INFO - 'LOGNAME': 'cltbld', 17:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:12 INFO - 'MOZ_NO_REMOTE': '1', 17:09:12 INFO - 'NO_EM_RESTART': '1', 17:09:12 INFO - 'PAGER': '/bin/cat', 17:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:12 INFO - 'PWD': '/builds/slave/test', 17:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:12 INFO - 'SHELL': '/bin/bash', 17:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dlMymHbDxO/Listeners', 17:09:12 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:12 INFO - 'USER': 'cltbld', 17:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:12 INFO - 'XPC_FLAGS': '0x0', 17:09:12 INFO - 'XPC_SERVICE_NAME': '0', 17:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:09:12 INFO - Cleaning up... 17:09:12 INFO - Return code: 0 17:09:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:09: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')]} 17:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101887a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6985717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10172bd30>, '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 0x10154fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101722b20>, '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.8FUVfg54vh/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.dlMymHbDxO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:09:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FUVfg54vh/Render', 17:09:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:12 INFO - 'HOME': '/Users/cltbld', 17:09:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:12 INFO - 'LOGNAME': 'cltbld', 17:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:12 INFO - 'MOZ_NO_REMOTE': '1', 17:09:12 INFO - 'NO_EM_RESTART': '1', 17:09:12 INFO - 'PAGER': '/bin/cat', 17:09:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:12 INFO - 'PWD': '/builds/slave/test', 17:09:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:12 INFO - 'SHELL': '/bin/bash', 17:09:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dlMymHbDxO/Listeners', 17:09:12 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:09:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:12 INFO - 'USER': 'cltbld', 17:09:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:12 INFO - 'XPC_FLAGS': '0x0', 17:09:12 INFO - 'XPC_SERVICE_NAME': '0', 17:09:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:12 INFO - Downloading/unpacking jsonschema 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:09:15 INFO - Downloading/unpacking functools32 (from jsonschema) 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09: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 17:09:15 INFO - Downloading functools32-3.2.3-2.tar.gz 17:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:09:15 INFO - warning: no files found matching '*.txt' 17:09:15 INFO - no previously-included directories found matching 'build' 17:09:15 INFO - no previously-included directories found matching 'dist' 17:09:15 INFO - no previously-included directories found matching '.git*' 17:09:15 INFO - Installing collected packages: jsonschema, functools32 17:09:15 INFO - Running setup.py install for functools32 17:09:15 INFO - warning: no files found matching '*.txt' 17:09:15 INFO - no previously-included directories found matching 'build' 17:09:15 INFO - no previously-included directories found matching 'dist' 17:09:15 INFO - no previously-included directories found matching '.git*' 17:09:15 INFO - Successfully installed jsonschema functools32 17:09:15 INFO - Cleaning up... 17:09:15 INFO - Return code: 0 17:09:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:09:15 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')]} 17:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:15 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')]} 17:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:15 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 0x101887a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10188f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6985717b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10172bd30>, '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 0x10154fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101722b20>, '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.8FUVfg54vh/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.dlMymHbDxO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 17:09:15 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 17:09:15 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 17:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FUVfg54vh/Render', 17:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:15 INFO - 'HOME': '/Users/cltbld', 17:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:15 INFO - 'LOGNAME': 'cltbld', 17:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:15 INFO - 'MOZ_NO_REMOTE': '1', 17:09:15 INFO - 'NO_EM_RESTART': '1', 17:09:15 INFO - 'PAGER': '/bin/cat', 17:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:15 INFO - 'PWD': '/builds/slave/test', 17:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:15 INFO - 'SHELL': '/bin/bash', 17:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dlMymHbDxO/Listeners', 17:09:15 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:15 INFO - 'USER': 'cltbld', 17:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:15 INFO - 'XPC_FLAGS': '0x0', 17:09:15 INFO - 'XPC_SERVICE_NAME': '0', 17:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:16 INFO - Downloading/unpacking flake8 17:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:18 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:09:18 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:09:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:19 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:09:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:19 INFO - no previously-included directories found matching 'docs/_build' 17:09:19 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:09:19 INFO - Running setup.py install for pep8 17:09:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:09:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:09:19 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:09:19 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:09:19 INFO - no previously-included directories found matching 'docs/_build' 17:09:19 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:09:19 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:09:19 INFO - Cleaning up... 17:09:20 INFO - Return code: 0 17:09:20 INFO - Running post-action listener: _resource_record_post_action 17:09:20 INFO - Running post-action listener: _start_resource_monitoring 17:09:20 INFO - Starting resource monitoring. 17:09:20 INFO - ##### 17:09:20 INFO - ##### Running install step. 17:09:20 INFO - ##### 17:09:20 INFO - Running pre-action listener: _resource_record_pre_action 17:09:20 INFO - Running main action method: install 17:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:09:20 INFO - Reading from file tmpfile_stdout 17:09:20 INFO - Detecting whether we're running mozinstall >=1.0... 17:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:09:20 INFO - Reading from file tmpfile_stdout 17:09:20 INFO - Output received: 17:09:20 INFO - Usage: mozinstall [options] installer 17:09:20 INFO - Options: 17:09:20 INFO - -h, --help show this help message and exit 17:09:20 INFO - -d DEST, --destination=DEST 17:09:20 INFO - Directory to install application into. [default: 17:09:20 INFO - "/builds/slave/test"] 17:09:20 INFO - --app=APP Application being installed. [default: firefox] 17:09:20 INFO - mkdir: /builds/slave/test/build/application 17:09:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:09:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:09:54 INFO - Reading from file tmpfile_stdout 17:09:54 INFO - Output received: 17:09:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:09:54 INFO - Running post-action listener: _resource_record_post_action 17:09:54 INFO - ##### 17:09:54 INFO - ##### Running run-tests step. 17:09:54 INFO - ##### 17:09:54 INFO - Running pre-action listener: _resource_record_pre_action 17:09:54 INFO - Running main action method: run_tests 17:09:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:09:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:09:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:09:54 INFO - 2016-02-11 17:09:54.306 screenresolution[2589:35042] starting screenresolution argv=screenresolution get 17:09:54 INFO - 2016-02-11 17:09:54.308 screenresolution[2589:35042] Display 0: 1600x1200x32@60 17:09:54 INFO - 2016-02-11 17:09:54.314 screenresolution[2590:35044] starting screenresolution argv=screenresolution list 17:09:54 INFO - Available Modes on Display 0 17:09:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:09:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:09:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:09:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:09:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:09:54 INFO - Intel Iris: 17:09:54 INFO - Chipset Model: Intel Iris 17:09:54 INFO - Type: GPU 17:09:54 INFO - Bus: Built-In 17:09:54 INFO - VRAM (Dynamic, Max): 1536 MB 17:09:54 INFO - Vendor: Intel (0x8086) 17:09:54 INFO - Device ID: 0x0a2e 17:09:54 INFO - Revision ID: 0x0009 17:09:54 INFO - Displays: 17:09:54 INFO - Display: 17:09:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:09:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:09:54 INFO - Display Serial Number: 1600x1200 60 17:09:54 INFO - Main Display: Yes 17:09:54 INFO - Mirror: Off 17:09:54 INFO - Online: Yes 17:09:54 INFO - Rotation: Supported 17:09:54 INFO - Return code: 0 17:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:09:54 INFO - Python 2.7.3 17:09:54 INFO - Return code: 0 17:09:54 INFO - grabbing minidump binary from tooltool 17:09: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')]} 17:09:54 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 0x10172bd30>, '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 0x10154fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101722b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:09:54 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 17:09:54 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 17:09:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:09:54 INFO - Return code: 0 17:09:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:09:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:09:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:09:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:09:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:09:55 INFO - Return code: 0 17:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 17:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0090 --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 17:09:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8FUVfg54vh/Render', 17:09:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:09:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:09:55 INFO - 'HOME': '/Users/cltbld', 17:09:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:09:55 INFO - 'LOGNAME': 'cltbld', 17:09:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:09:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:55 INFO - 'MOZ_NO_REMOTE': '1', 17:09:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:09:55 INFO - 'NO_EM_RESTART': '1', 17:09:55 INFO - 'PAGER': '/bin/cat', 17:09:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:09:55 INFO - 'PWD': '/builds/slave/test', 17:09:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:09:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:09:55 INFO - 'SHELL': '/bin/bash', 17:09:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dlMymHbDxO/Listeners', 17:09:55 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 17:09:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:09:55 INFO - 'USER': 'cltbld', 17:09:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:09:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:55 INFO - 'XPC_FLAGS': '0x0', 17:09:55 INFO - 'XPC_SERVICE_NAME': '0', 17:09:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:09:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 17:09:56 INFO - mozversion application_buildid: 20160211154628 17:09:56 INFO - mozversion application_changeset: c578a05bb9d6f398fccc5580df198a763af21020 17:09:56 INFO - mozversion application_display_name: Nightly 17:09:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:09:56 INFO - mozversion application_name: Firefox 17:09:56 INFO - mozversion application_remotingname: firefox 17:09:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:09:56 INFO - mozversion application_vendor: Mozilla 17:09:56 INFO - mozversion application_version: 47.0a1 17:09:56 INFO - mozversion platform_buildid: 20160211154628 17:09:56 INFO - mozversion platform_changeset: c578a05bb9d6f398fccc5580df198a763af21020 17:09:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:09:56 INFO - mozversion platform_version: 47.0a1 17:09:56 INFO - using testdate: 1455239396 17:09:56 INFO - actual date: 1455239396 17:09:56 INFO - starting webserver on 'localhost:50662' 17:09:56 INFO - SUITE-START | Running 2 tests 17:09:56 INFO - TEST-START | dromaeo_css 17:09:56 INFO - operating with platform_type : mac_ 17:09:56 INFO - Initialising browser for dromaeo_css test... 17:09:56 INFO - TEST-INFO | started process 2608 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpqKkBDs/profile http://localhost:50662/getInfo.html) 17:09:58 INFO - PROCESS | 2608 | __metrics Screen width/height:1600/1200 17:09:58 INFO - PROCESS | 2608 | colorDepth:24 17:09:58 INFO - PROCESS | 2608 | Browser inner width/height: 1024/689 17:09:58 INFO - PROCESS | 2608 | __metrics 17:09:58 INFO - PROCESS | 2608 | 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" 17:09:58 INFO - PROCESS | 2608 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:09:59 INFO - TEST-INFO | 2608: exit 0 17:09:59 INFO - Browser initialized. 17:09:59 INFO - Running cycle 1/1 for dromaeo_css test... 17:09:59 INFO - TEST-INFO | started process 2611 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpqKkBDs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:11 INFO - PROCESS | 2611 | RSS: Main: 246431744 17:10:11 INFO - PROCESS | 2611 | 17:11:03 INFO - PROCESS | 2611 | 1455239463015 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] 17:13:12 INFO - PROCESS | 2611 | Cycle 1(1): loaded http://localhost:50662/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50662/tests/dromaeo/cssquery-ext.html) 17:13:13 INFO - PROCESS | 2611 | RSS: Main: 368635904 17:13:13 INFO - PROCESS | 2611 | 17:16:16 INFO - PROCESS | 2611 | Cycle 1(1): loaded http://localhost:50662/tests/dromaeo/cssquery-ext.html (next: http://localhost:50662/tests/dromaeo/cssquery-jquery.html) 17:16:16 INFO - PROCESS | 2611 | RSS: Main: 379351040 17:16:16 INFO - PROCESS | 2611 | 17:19:19 INFO - PROCESS | 2611 | Cycle 1(1): loaded http://localhost:50662/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50662/tests/dromaeo/cssquery-mootools.html) 17:19:19 INFO - PROCESS | 2611 | RSS: Main: 377991168 17:19:19 INFO - PROCESS | 2611 | 17:22:22 INFO - PROCESS | 2611 | Cycle 1(1): loaded http://localhost:50662/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50662/tests/dromaeo/cssquery-prototype.html) 17:22:22 INFO - PROCESS | 2611 | RSS: Main: 377737216 17:22:22 INFO - PROCESS | 2611 | 17:25:25 INFO - PROCESS | 2611 | Cycle 1(1): loaded http://localhost:50662/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50662/tests/dromaeo/cssquery-yui.html) 17:25:26 INFO - PROCESS | 2611 | RSS: Main: 354975744 17:25:26 INFO - PROCESS | 2611 | 17:28:29 INFO - PROCESS | 2611 | Cycle 1(1): loaded http://localhost:50662/tests/dromaeo/cssquery-yui.html (next: http://localhost:50662/tests/dromaeo/cssquery-dojo.html) 17:28:29 INFO - PROCESS | 2611 | RSS: Main: 384581632 17:28:29 INFO - PROCESS | 2611 | 17:28:29 INFO - PROCESS | 2611 | __start_tp_report 17:28:29 INFO - PROCESS | 2611 | _x_x_mozilla_page_load 17:28:29 INFO - PROCESS | 2611 | _x_x_mozilla_page_load_details 17:28:29 INFO - PROCESS | 2611 | |i|pagename|runs| 17:28:29 INFO - PROCESS | 2611 | |0;dojo.html;2845.857707114644;3365.0746044837665;3382.7632065755392;3397.524346591476;3410.3520331137083;5458;5522.5581953443725;5523.2267482552425;5545.3622833374175;5546.556275497961;5530.308711411074;5599.048161812491;5621.550275977922;5658.575606829484;5667.659940403569;4971.502849715036;5015.172496538076;5037.269595908591;5054.469280725526;5196.272521846944;5103.3875934887865;5118.283440318359;5144.331236939192;5144.819931302405;5161.922571161435;4968.652194346397;4986.2769898364895;5055.519725626078;5099.260607211971;5110.080185566597;5070.974645126787;5071.8985620287385;5088.033273677989;5092.719900405476;5138.152204886189;5034.697918124924;5050.065737838511;5065.544101030888;5095.286659867622;5101.183810590325;5411.891762164734;5499.477549632818;5518.061929471999;5524.723763811833;5535.225068490415;6015.4586087252355;6042.456178943872;6056.091586262052;6066.6663333516635;6077.878442431171;5966.433188847052;6071.474957788391;6111.511079113705;6119.938800611982;6122.855605810045;5641.633293835887;5643.209950606918;5650.0959846424375;5701.885962280731;5723.484886360247;6098.573099882966;6101.3092767044445;6162.476189523851;6181.629102253789;6209.161763162006;6006;6006.819795406145;6036.788712395045;6044.335123136451;6050.364711705296;6139.26328840542;6148.262208534915;6151.72317245725;6156.230471191101;6159.168512250879;5931.436513531207;6021.969890150521;6038.245219347582;6105.389461053859;6118.694065296718;6045.304789949212;6092.208012958376;6102.664353460602;6108.3280839107665;6116;4713.2458806590785;4789.161896668069;4801.759912004456;4819.95180048195;4828.758562071883;3680.742348035665;4277.230098582285;4319.200947824663;4327.653787696977;4338.8047537860875;4967.329410529533;5229.294045303835;5498.9826882026955;5563.693996830132;5570.41510641385;6015.157877897098;6129.387061293835;6138.324784273726;6168.383161683796;6198.380161983856;5017.7491125443585;5296.285001524822;5474.233607294982;5518.641288316247;5520.723963801794;5210.6873587584105;5227.555657769132;5260.263563101169;5273.815416460406;5308.840734777886;6117.766507567544;6179.104029915727;6181.5981961174175;6190.350013248544;6192.102145189013;6091.573589848668;6135.1408007826785;6164.3835616438;6168;6208.3791620839365;5477.589180811535;5986.431289027535;6172.969135154295;6190.597611155261;6195.690215489298;6011.939880601138;6061.878762424815;6078.240219972504;6079.513638908965;6094.969525152346;6101.974255744646;6113.908291375544;6120.386183820725;6163.414475624809;6167.84580385494;5973.671448070398;6008.188894499362;6046.90929636047;6072.1498990140535;6101.328853825987;5800.651960882361;5911.645301281937;6064.757409703562;6067.120267561268;6080.270367555921;4936.284238785428;5757.884842303214;5826.766929322949;5841.240638716939;5865.14955331466;5952.553558483044;5954.404559544011;5978.4021597839865;5979.491743201703;6032.90950635732;5728.79949201776;5821.301443826768;5827.300723912988;5837.270341207349;5859.472647461749 17:28:29 INFO - PROCESS | 2611 | |1;ext.html;455.3761346954669;563.0034838336145;585.5491271720774;597.3578403216542;602.3735315272118;29860.552091718615;38080.61919380805;38545.22909541807;38566.61433385669;38826.417603735965;40832.387514187314;41049.17901641966;41255;41282;41321.58678413215;9407.153356197941;9643.710688679352;9645;9648.662296819613;9665.323427360088;9562.091601297865;9695.757606059835;9707.126358627722;9722.805543889119;9819.410835349867;9712.854307185398;9843.704688859345;9844.95077524615;9851.261155413336;9852.359596626233;8346.332293416543;9815.90184098157;9823.263255255813;9823.656172033945;9842.852357214684;8346.70786522475;9699.757506062404;9714.417134971854;9726.659566915125;9732.610695572239;35799.82100089483;36614.08464788375;39298.60701392978;39557.40663890044;39676.60323396758;3251.3822373748912;3291.884784032571;3358.2108204571905;3515.806630635314;3624.4563315502623;28227.576586351017;28332;28445.740479055636;29750.70249297501;30616.234594135323;2737.3430376709643;2804.5232310507263;2817.619621351112;2831.362943337753;2922.4301261254063;407456;414472;414826;415182;415344;56078.719606401704;58546;59712.70143649341;65303.673481632286;71212.64393678102;69377.95933061009;69853;70698;70752.58494830178;70845;16189.190540473164;16368.936019158717;16376;16411.261493232832;16418.917905410395;11632.302061876315;11692.240004399857;12666.49334026647;12781.297028663326;12812.93593532045;21317;21601;21643.891780541;21658.458538536663;21672.674909876365;9491.905080949102;9736;9749;9797.755056123511;9801.705948821547;857.7562534325253;898.1333013641867;1028.9742756431149;1052.1267348101057;1068.636663534402;29295;29680.257993550335;29956.700432995825;30988.84505577458;31977.68022319747;1062.6333914799382;1082.9187810914214;1097.237419993097;1165.2425923149851;1178.2753606531921;14269.858411327068;14653.706925861423;14737.042092263968;15126.470573529874;15159.848401515843;541286;631292;633641;635804;636483;57858.710706446196;58158;58331.5417114567;58335.83328333494;58549.414505854395;1457.9416823326949;1466.2961778346453;1476.0922032949659;1481.8221813382463;1488.3600051977537;29148.854255728587;30093.09720708382;30555.7360741052;30695.539566906067;31246;52201;52867.73566132145;52913;52948.735256323474;53023.73488132535;496811;500357;507899;647906;647977.7601111964;33372;40781.38827917524;41586.37620435756;42138;42249.78875105605;43260.35109473424;43288.78355608202;43320.13359732851;44361.11277774491;44406.3339049921;34921.65078349184;36425.817870910476;36477.81761091178;36746.63253367432;37226.8138659305;29231.85384073066;34724.65275347315;35250.294994100484;36011.819940900124;36347.45478817767;35738.64261357457;35939.28121437504;36344.636553634125;36544;36728.449073264455;30865.8456707715;31484.527732084494;32178.67821321757;32829.50755738618;32853;19567.70648440303;24021.27936161918;24277.66365413418;24343.51312973695;24882.377940551632 17:28:29 INFO - PROCESS | 2611 | |2;jquery.html;328.7912175768386;335.3209750255733;358.81411933559576;361.5516759218569;365.4664190282188;15223.944767456403;18696.252149914006;18775.873447593152;18776.530586735305;19025.714614280798;14165.78751318731;15168.103987001625;15272;18868.43394698158;19268;5566.4990150886415;5608.887822243552;5785.855353616173;5829.766809327622;5833.358330583633;5705.2012718219485;5766.481016708495;5770.307563092435;5774.422557744213;5780.046292361755;3847.153626202231;4015.558288588253;5583.3300003999575;5821.767129314822;5828.154917536955;5556.222128901957;5782.045962416218;5790.507806836424;5793.217915581406;5798.3911689272445;5537.307836520435;5543.944560554383;5548.4174161713245;5553.111502159675;5555.805546805843;19551.706724399144;22620.321390358316;23494;23580.7641923582;23646.29061128169;2301.5742087713825;2380.369202161429;2480.8015358771254;2566.2044766122563;2769.3932239522783;9334.439933604006;9370.437773733598;9412.247020238365;9907.405555666683;9932.304738668296;1715.7254839225664;1780.7863056433182;1799.9820001799944;1802.0989505247376;1847.2703282203454;94139.52930235305;95665.52167239189;96340;96502.81630728752;97180;10866.67399978002;10877.184211184192;10930.070943969693;10950.34297942126;11012.39431831241;13048.217106973612;13164.802527962089;13185.219995300704;13213.405396757169;13237.139585926883;8203.58982050895;8213.753587392388;8223.383246256555;8305.46014509067;8311.127331630212;6858.902575587882;8131.390145739093;8183.79540511492;8220.8355832883;8275.54484503346;3579.552555930509;4244.10873716523;4336.956630433719;4340.457442819647;4365.650747940157;1691.4671878358524;1767.3814165042133;1825.452364290734;1871.9438416847515;1896.1846406045256;394.2548583177796;846.7713717296418;919.4299534288783;969.5491596407563;984.8916619172029;11149.442527873736;11231.55073797039;11254.7186320341;11324.886751132382;11476;377.2662172075342;436.28667129243917;438.45850374787113;453.51926957425235;459.3477262287493;5798.449147330997;5983.880322393527;10256.333338333134;10755.89244107549;10848.891511084947;646747;725843;732766;753613;756344;67672.66163669249;100051;109586.45206773916;116203.09492262761;117916;441.9359192917009;484.8085006422443;501.3182072381631;1143.4111432612212;1179.7817403780327;10825.566977321134;10890.78218435611;10993.670189894316;11081.944590276997;11089.112870970142;47359;48398.75800620974;50590.48228553149;50673.47979560619;50850.23724644059;72583;72994;73644;73996;74766.87849682367;7489.8876516851205;7531.962340188264;7661.502002369828;7687.346575541142;7753.767386978399;8540.829183416421;10855.45722713877;11609.825852612048;11882.881171188177;12030.09774266916;6897.310268973062;7882;9966.651167209113;10186.847197291898;10237.283390162616;8788.209061184523;10173.542190601589;10192.847107293248;10235.7441063974;10257.948710256402;10116;10183.643572474928;10286.537105830404;10339.793204135725;10611;7359.742409015873;7577.0907491101425;7584.582847943416;7595.5822429766895;7600.315971562586;8264.504129752235;10313.22650801178;10438.53026613789;10463.873770409886;10660.413677247516 17:28:29 INFO - PROCESS | 2611 | |3;mootools.html;1382.1016339379407;1506.0511877517165;1541.0291516344705;1766.7614871992278;1924.0283656753347;7919.841603167941;8573.314134869212;8725.47647141172;8735.999999999993;8753.343499237566;8375.706850260227;8666.350023748228;8671.176238257356;8672.089430609789;8678;2106.7261256036772;2158.84888057836;2210.9668354974688;2213.690083388327;2448.289995901191;2215.0475295622878;2245.4723140062074;2407.325948734357;2465.2604218734396;2467.8272520923542;2397.3167647220544;2423.8182136339756;2423.9394015149587;2429.5991161458337;2457.1154384421593;2411.0476361836977;2449.4856080223176;2460.3972026853535;2460.4955984023322;2463.790577800889;2438.1588352018703;2442.2673198040693;2445.7431969643108;2449.5835707929696;2450.48539806639;8770.868436973451;8849.867251991225;8855.778605534848;8858.335624828163;8883.111688831064;5304.549113325372;5431.83704488866;5506.972465137648;5522.254495643077;5534.059209934321;3415.55597772288;3544.5923718772415;3559.5906470755936;3562.768420052714;3573.1960308930543;974.990250097497;983.9754006149832;1004.0762498501323;1013.8631284776608;1040.0587468341164;11673.941630291794;11779.175457717964;11785.528578856836;11787.17489775716;11789.05687545003;4543.227651299287;4673.345731597579;4757.904841903142;4765.332853400527;4773.236282194832;9235.907640923504;9361.391509551857;9370.969193388722;9371.484568348806;9387.812243755086;5360.973195133999;5382.192671099367;5400.540954018952;5407.297051383373;5416.864578385572;4929.75351232437;5003.424606170264;5046.394432668103;5048.823291184791;5050.292958985745;3516.6659167379057;3594.424892017317;3670.8531658733887;3714.7213958953184;3755.1363186467265;1120.1598800899326;1144.7882141803793;1152.9020033297095;1166.4401087478059;1197.4192516629428;1287.4463980488292;1312.9409176587076;1340.3566288181728;1363.6250031241489;1368.493657346788;8110.026796784306;8284.378671599654;8285.58572071394;8286.958565207256;8288.668453261922;1179.151011271883;1185.8636256830575;1189.3468079369684;1197.1619866093595;1208.5890797128843;6234.127222188898;6261.843453913689;6313.305536390993;6314.336994615591;6324.778632747832;10507.211959103099;10920.017198452177;10933.070688991525;10968.17738669587;10982.725431864268;9115.225205857576;10613.946930265454;10697;10812.405317707602;10824.24230303871;8300;8384.455010424303;8394.118617545191;8402.579871006425;8405.621747021276;7809.297163255334;7882.724104656539;7893.921060789318;7907.446478746432;7949.761507154794;9431.528423578931;9696.806063878825;9719.028097190225;9817.165540928816;9862.063104005108;9845.901540984785;9977.950110249692;10221.9488902555;10222.284440089123;10223.386596804216;7000.22997470288;7042.014118023583;7059.788206353817;7097.858042839011;7136.85726285461;8234.958825205835;8295.502269863586;8297.25324720778;8301.916980830114;8305.833883322179;7055.929440705528;7120.679569419285;7713;7839.804004899923;7984.481008734414;7553.282438168365;7627.54234745917;7683.577403242875;7711;7713.074431068308;7457.552546847207;7686.8078298040755;7690.769276921701;7741.845163096594;7745.264199901;6995.265497122932;7014.649267536501;7023.33278338557;7026.543274687129;7028.578285302899;7071.257517960746;7115.359617634438;7169.892451613126;7183.712651494091;7187.245339239514 17:28:29 INFO - PROCESS | 2611 | |4;prototype.html;288.35408684546616;319.5318857873215;326.34893387691557;330.1943258449383;332.8568715452358;6286.182796236489;6368.076628888808;6417.58285711429;6477.546571739968;6518.217813862331;6342.556021078526;6394.936050639492;6410.8076757697345;6421.67891605419;6439.806805795822;4530.139273538017;4675.8363457279;4681.9297710534365;4769.833055843046;4792.952070479303;4493.191225579394;4689.413823272091;4711.269753188244;4797.59220466259;4802.97598512007;4722.338872557844;4733.029728905566;4736.739479328636;4743.739094349809;4747.90504189916;4439.689221754478;4713.293006049103;4732.763361831895;4737.810487580493;4748.548887855665;3635.6909662678704;3945.0926286953872;4030.7380020298588;4050.521559630743;4055.0876052887866;5704.942950570483;6183.165272688175;6198.3801619838105;6201.534884883652;6284.685765711742;5634.549236061105;5638.548916086703;5646.435356464362;5668.461496157858;5671.177679236487;6869.450443964471;6880.277570855038;6886.311368863124;6890.31096890312;6891.241963384024;4595.172868883599;4604.58558729716;4605.907881842378;4609.308603709437;4617.030423611012;6515.902261466082;6632.573996590756;7268.563886166847;7276.381507571809;7299.927000729977;4332.740035597812;4649.5350464953235;4659.068186362673;4664.930026049612;4667.183242932473;4610.95389046112;4646.651501137429;4655.324977878188;4660.813567457264;4661.836835710734;4519.276915693474;4715.83494577695;5477.260569823103;5509.531689806411;5517;6283.685815709287;6947.548409353477;6953.913825852224;6955.93044069563;6970.477214208955;1567.6028739385922;1587.8094628644405;1594.8484893935058;1609.7102521546235;1614.039646410384;1020.5254556631054;1034.5086084110137;1041.984370234432;1050.112654806687;1053.6470282455464;6417.262014868256;6454.515911306671;6459.418652321314;6460.838479037968;6465.1595292611655;7200.495965282485;7204.3155900189395;7204.9639751800905;7205.855882882418;7208.531445456028;6229.221347331583;6418.8716225675225;6419;6421.775237866652;6433.067205255305;3757.1170774867883;3809.4476300936763;3810.1998580297895;3811.066288759216;3816.7709937403843;6622.072909792633;7518.135414427411;7530.623468826537;7537.660805263777;7541.698332066766;5432;7218.67515961783;7453.925460745323;7476.962615186889;7524.398048156135;7289.817754556178;7619.390448764086;7620.618969051525;7624.618769061524;7647.044119485065;7054.611996340045;7148.28517148281;7217.097862767154;7280.089988751406;7301.926980730337;7071.929280707127;7106.076210092655;7116.964415177891;7127.46544009191;7141.785746427616;7319.451041171827;7592.202818703957;7616.619169041636;7623;7630.084389873251;4289.099289149313;4564.109998550251;4610.662907756847;4621.168189725747;4621.376114224537;6454.322296159024;7177.066981292607;7195.244499327495;7205.531640443354;7207.9279207207255;6724.663766811737;6942.166939967236;6977.197622273504;6993.125859267591;6996.160460744743;6939.410150137295;6944.340287672865;6951.44388448933;6964.268751781193;6968.581885086911;6784.948333008391;6786;6794.626295553594;6797.1843378794865;6815.3866152044575;6782.879875257437;6893.0694356261265;6977.988191712275;6984.650767461708;6991.265917078634;6814.93185068143;6825.38571528545;6835.521513494008;6835.624040677811;6871.072405225231 17:28:29 INFO - PROCESS | 2611 | |5;yui.html;678.2776343194497;714.6105372571948;716.226475406561;734.7501849371213;775.8254392761626;15047.94664373493;15165.6966860663;15212.695746085072;15244.542663720093;15279.69440611187;13950.093243939136;14125.78811317831;14139.858601413982;14156;14174.645633859158;704.3484776581668;715.3490323805338;838.3042075077701;853.4623187391934;859.4456575508793;846.5851732651018;856.8157846063095;858.8582883824192;860.8837806896083;862.4480332587149;889.6752685269895;893.4415990006246;893.9150780675825;894.7628878347243;896.0904681747999;724.9057622509066;735.2867718313228;887.1660638999319;908.7500937242245;914.1955079529971;651.9869602607969;656.2977613953072;658.1871388834833;658.8352911772057;659.5086660437956;13938.651533711738;13978;13992.440302387893;13994.510192143227;14051.929740351336;12409.503619855195;12649.494020239179;12694.238345699288;12719.618411447671;12810.039247056415;9690.32167748258;10101.49492525378;10250.436226007567;10258.128059114984;10803.729906752395;3574.60590369756;3618.077390265492;3635.9472927027145;3721.38597131473;3755.680767134797;78965.99999999943;79064;79252.62242132745;79575.60212198959;79685.60157199176;9525;9599.520023998772;9630.711078667651;9694.951525242328;10368.688939331832;21815.890920545615;22011.009504572332;22024.779752202594;22170.88914555417;22230.333090007327;7389.778306650809;7405.370543503755;7528.962355188299;7649.732259370895;7688.884666730003;3966.6033396660105;4008.1983603278877;4011.277969965376;4032.6773858091283;4036.374361973899;3397.235621985083;3433.639467855889;3434.1414646338417;3441.8451169697423;3448.810315432625;606.8937935861206;614.6926536731634;620.9875802483925;638.7476946606065;639.0733436517069;555.4362322242927;578.7829563913532;603.0050416812295;624.7219987105785;638.6966191059303;7113.502054856214;7513.586752728653;8066.637001334954;8502.234798868132;8750.86873696895;522.26621596656;593.77139801176;601.9548533859978;611.3855575146949;620.2928661326092;3736.7757934524016;3967.563568007517;4080.8775736727944;4124.628783409447;4255.340422234559;85175;85548;92968.53515732514;93805.53097234607;94180;76253.23746762572;77260;78194.21805781983;78206;78742.60628696934;70318;70428;70735;70858;71007;8784.165504277084;8807.867881981647;8888.066752990842;8901.499068389801;8985.146411091197;47740.090396383755;47759.52240477551;48778;49250.50749492459;50214.74463138451;62536.687316563126;66553.66723166354;66871.33128668845;67641.66179169073;67705.32294677188;10770.407627580558;10820.67537973862;11223.326600404002;11290.604828830952;11568.668231472497;11605.361705106301;11918.582849600569;11930.642080737593;11963.880361196276;11972;9543.76140596463;10111.494425278559;11429.885701142883;11731.88268117308;12038.06944886894;11397.258634702313;11543.653690389301;11558.94220528892;11569.132315076571;11602.47788849487;11278.266912650652;11291.661250162508;11296.943515282372;11316.6039188628;11366.772664546828;9374.718758437259;9784.51077446139;9796.951015245164;9823.754406139904;9854.852177217204;9835.803283934425;10030.799384012425;10035.34770239932;10039;10051.296409251283 17:28:29 INFO - PROCESS | 2611 | __end_tp_report 17:28:29 INFO - PROCESS | 2611 | __start_cc_report 17:28:29 INFO - PROCESS | 2611 | _x_x_mozilla_cycle_collect,1001 17:28:29 INFO - PROCESS | 2611 | __end_cc_report 17:28:29 INFO - PROCESS | 2611 | __startTimestamp1455240509263__endTimestamp 17:28:29 INFO - PROCESS | 2611 | 17:28:29 INFO - PROCESS | 2611 | ------- Summary: start ------- 17:28:29 INFO - PROCESS | 2611 | Number of tests: 6 17:28:29 INFO - PROCESS | 2611 | 17:28:29 INFO - PROCESS | 2611 | [#0] dojo.html Cycles:165 Average:5596.00 Median:5827.30 stddev:650.52 (11.2%) stddev-sans-first:615.71 17:28:29 INFO - PROCESS | 2611 | Values: 2845.9 3365.1 3382.8 3397.5 3410.4 5458.0 5522.6 5523.2 5545.4 5546.6 5530.3 5599.0 5621.6 5658.6 5667.7 4971.5 5015.2 5037.3 5054.5 5196.3 5103.4 5118.3 5144.3 5144.8 5161.9 4968.7 4986.3 5055.5 5099.3 5110.1 5071.0 5071.9 5088.0 5092.7 5138.2 5034.7 5050.1 5065.5 5095.3 5101.2 5411.9 5499.5 5518.1 5524.7 5535.2 6015.5 6042.5 6056.1 6066.7 6077.9 5966.4 6071.5 6111.5 6119.9 6122.9 5641.6 5643.2 5650.1 5701.9 5723.5 6098.6 6101.3 6162.5 6181.6 6209.2 6006.0 6006.8 6036.8 6044.3 6050.4 6139.3 6148.3 6151.7 6156.2 6159.2 5931.4 6022.0 6038.2 6105.4 6118.7 6045.3 6092.2 6102.7 6108.3 6116.0 4713.2 4789.2 4801.8 4820.0 4828.8 3680.7 4277.2 4319.2 4327.7 4338.8 4967.3 5229.3 5499.0 5563.7 5570.4 6015.2 6129.4 6138.3 6168.4 6198.4 5017.7 5296.3 5474.2 5518.6 5520.7 5210.7 5227.6 5260.3 5273.8 5308.8 6117.8 6179.1 6181.6 6190.4 6192.1 6091.6 6135.1 6164.4 6168.0 6208.4 5477.6 5986.4 6173.0 6190.6 6195.7 6011.9 6061.9 6078.2 6079.5 6095.0 6102.0 6113.9 6120.4 6163.4 6167.8 5973.7 6008.2 6046.9 6072.1 6101.3 5800.7 5911.6 6064.8 6067.1 6080.3 4936.3 5757.9 5826.8 5841.2 5865.1 5952.6 5954.4 5978.4 5979.5 6032.9 5728.8 5821.3 5827.3 5837.3 5859.5 17:28:29 INFO - PROCESS | 2611 | 17:28:29 INFO - PROCESS | 2611 | [#1] ext.html Cycles:180 Average:67170.50 Median:39062.51 stddev:143850.05 (368.3%) stddev-sans-first:144166.37 17:28:29 INFO - PROCESS | 2611 | Values: 455.4 563.0 585.5 597.4 602.4 29860.6 38080.6 38545.2 38566.6 38826.4 40832.4 41049.2 41255.0 41282.0 41321.6 9407.2 9643.7 9645.0 9648.7 9665.3 9562.1 9695.8 9707.1 9722.8 9819.4 9712.9 9843.7 9845.0 9851.3 9852.4 8346.3 9815.9 9823.3 9823.7 9842.9 8346.7 9699.8 9714.4 9726.7 9732.6 35799.8 36614.1 39298.6 39557.4 39676.6 3251.4 3291.9 3358.2 3515.8 3624.5 28227.6 28332.0 28445.7 29750.7 30616.2 2737.3 2804.5 2817.6 2831.4 2922.4 407456.0 414472.0 414826.0 415182.0 415344.0 56078.7 58546.0 59712.7 65303.7 71212.6 69378.0 69853.0 70698.0 70752.6 70845.0 16189.2 16368.9 16376.0 16411.3 16418.9 11632.3 11692.2 12666.5 12781.3 12812.9 21317.0 21601.0 21643.9 21658.5 21672.7 9491.9 9736.0 9749.0 9797.8 9801.7 857.8 898.1 1029.0 1052.1 1068.6 29295.0 29680.3 29956.7 30988.8 31977.7 1062.6 1082.9 1097.2 1165.2 1178.3 14269.9 14653.7 14737.0 15126.5 15159.8 541286.0 631292.0 633641.0 635804.0 636483.0 57858.7 58158.0 58331.5 58335.8 58549.4 1457.9 1466.3 1476.1 1481.8 1488.4 29148.9 30093.1 30555.7 30695.5 31246.0 52201.0 52867.7 52913.0 52948.7 53023.7 496811.0 500357.0 507899.0 647906.0 647977.8 33372.0 40781.4 41586.4 42138.0 42249.8 43260.4 43288.8 43320.1 44361.1 44406.3 34921.7 36425.8 36477.8 36746.6 37226.8 29231.9 34724.7 35250.3 36011.8 36347.5 35738.6 35939.3 36344.6 36544.0 36728.4 30865.8 31484.5 32178.7 32829.5 32853.0 19567.7 24021.3 24277.7 24343.5 24882.4 17:28:29 INFO - PROCESS | 2611 | 17:28:29 INFO - PROCESS | 2611 | [#2] jquery.html Cycles:180 Average:35790.38 Median:2388.37 stddev:119235.01 (4992.3%) stddev-sans-first:119539.76 17:28:29 INFO - PROCESS | 2611 | Values: 328.8 335.3 358.8 361.6 365.5 15223.9 18696.3 18775.9 18776.5 19025.7 14165.8 15168.1 15272.0 18868.4 19268.0 5566.5 5608.9 5785.9 5829.8 5833.4 5705.2 5766.5 5770.3 5774.4 5780.0 3847.2 4015.6 5583.3 5821.8 5828.2 5556.2 5782.0 5790.5 5793.2 5798.4 5537.3 5543.9 5548.4 5553.1 5555.8 19551.7 22620.3 23494.0 23580.8 23646.3 2301.6 2380.4 2480.8 2566.2 2769.4 9334.4 9370.4 9412.2 9907.4 9932.3 1715.7 1780.8 1800.0 1802.1 1847.3 94139.5 95665.5 96340.0 96502.8 97180.0 10866.7 10877.2 10930.1 10950.3 11012.4 13048.2 13164.8 13185.2 13213.4 13237.1 8203.6 8213.8 8223.4 8305.5 8311.1 6858.9 8131.4 8183.8 8220.8 8275.5 3579.6 4244.1 4337.0 4340.5 4365.7 1691.5 1767.4 1825.5 1871.9 1896.2 394.3 846.8 919.4 969.5 984.9 11149.4 11231.6 11254.7 11324.9 11476.0 377.3 436.3 438.5 453.5 459.3 5798.4 5983.9 10256.3 10755.9 10848.9 646747.0 725843.0 732766.0 753613.0 756344.0 67672.7 100051.0 109586.5 116203.1 117916.0 441.9 484.8 501.3 1143.4 1179.8 10825.6 10890.8 10993.7 11081.9 11089.1 47359.0 48398.8 50590.5 50673.5 50850.2 72583.0 72994.0 73644.0 73996.0 74766.9 7489.9 7532.0 7661.5 7687.3 7753.8 8540.8 10855.5 11609.8 11882.9 12030.1 6897.3 7882.0 9966.7 10186.8 10237.3 8788.2 10173.5 10192.8 10235.7 10257.9 10116.0 10183.6 10286.5 10339.8 10611.0 7359.7 7577.1 7584.6 7595.6 7600.3 8264.5 10313.2 10438.5 10463.9 10660.4 17:28:29 INFO - PROCESS | 2611 | 17:28:29 INFO - PROCESS | 2611 | [#3] mootools.html Cycles:180 Average:6037.40 Median:5424.35 stddev:3189.23 (58.8%) stddev-sans-first:3178.98 17:28:29 INFO - PROCESS | 2611 | Values: 1382.1 1506.1 1541.0 1766.8 1924.0 7919.8 8573.3 8725.5 8736.0 8753.3 8375.7 8666.4 8671.2 8672.1 8678.0 2106.7 2158.8 2211.0 2213.7 2448.3 2215.0 2245.5 2407.3 2465.3 2467.8 2397.3 2423.8 2423.9 2429.6 2457.1 2411.0 2449.5 2460.4 2460.5 2463.8 2438.2 2442.3 2445.7 2449.6 2450.5 8770.9 8849.9 8855.8 8858.3 8883.1 5304.5 5431.8 5507.0 5522.3 5534.1 3415.6 3544.6 3559.6 3562.8 3573.2 975.0 984.0 1004.1 1013.9 1040.1 11673.9 11779.2 11785.5 11787.2 11789.1 4543.2 4673.3 4757.9 4765.3 4773.2 9235.9 9361.4 9371.0 9371.5 9387.8 5361.0 5382.2 5400.5 5407.3 5416.9 4929.8 5003.4 5046.4 5048.8 5050.3 3516.7 3594.4 3670.9 3714.7 3755.1 1120.2 1144.8 1152.9 1166.4 1197.4 1287.4 1312.9 1340.4 1363.6 1368.5 8110.0 8284.4 8285.6 8287.0 8288.7 1179.2 1185.9 1189.3 1197.2 1208.6 6234.1 6261.8 6313.3 6314.3 6324.8 10507.2 10920.0 10933.1 10968.2 10982.7 9115.2 10613.9 10697.0 10812.4 10824.2 8300.0 8384.5 8394.1 8402.6 8405.6 7809.3 7882.7 7893.9 7907.4 7949.8 9431.5 9696.8 9719.0 9817.2 9862.1 9845.9 9978.0 10221.9 10222.3 10223.4 7000.2 7042.0 7059.8 7097.9 7136.9 8235.0 8295.5 8297.3 8301.9 8305.8 7055.9 7120.7 7713.0 7839.8 7984.5 7553.3 7627.5 7683.6 7711.0 7713.1 7457.6 7686.8 7690.8 7741.8 7745.3 6995.3 7014.6 7023.3 7026.5 7028.6 7071.3 7115.4 7169.9 7183.7 7187.2 17:28:29 INFO - PROCESS | 2611 | 17:28:29 INFO - PROCESS | 2611 | [#4] prototype.html Cycles:180 Average:5656.96 Median:6418.94 stddev:1816.36 (28.3%) stddev-sans-first:1776.19 17:28:29 INFO - PROCESS | 2611 | Values: 288.4 319.5 326.3 330.2 332.9 6286.2 6368.1 6417.6 6477.5 6518.2 6342.6 6394.9 6410.8 6421.7 6439.8 4530.1 4675.8 4681.9 4769.8 4793.0 4493.2 4689.4 4711.3 4797.6 4803.0 4722.3 4733.0 4736.7 4743.7 4747.9 4439.7 4713.3 4732.8 4737.8 4748.5 3635.7 3945.1 4030.7 4050.5 4055.1 5704.9 6183.2 6198.4 6201.5 6284.7 5634.5 5638.5 5646.4 5668.5 5671.2 6869.5 6880.3 6886.3 6890.3 6891.2 4595.2 4604.6 4605.9 4609.3 4617.0 6515.9 6632.6 7268.6 7276.4 7299.9 4332.7 4649.5 4659.1 4664.9 4667.2 4611.0 4646.7 4655.3 4660.8 4661.8 4519.3 4715.8 5477.3 5509.5 5517.0 6283.7 6947.5 6953.9 6955.9 6970.5 1567.6 1587.8 1594.8 1609.7 1614.0 1020.5 1034.5 1042.0 1050.1 1053.6 6417.3 6454.5 6459.4 6460.8 6465.2 7200.5 7204.3 7205.0 7205.9 7208.5 6229.2 6418.9 6419.0 6421.8 6433.1 3757.1 3809.4 3810.2 3811.1 3816.8 6622.1 7518.1 7530.6 7537.7 7541.7 5432.0 7218.7 7453.9 7477.0 7524.4 7289.8 7619.4 7620.6 7624.6 7647.0 7054.6 7148.3 7217.1 7280.1 7301.9 7071.9 7106.1 7117.0 7127.5 7141.8 7319.5 7592.2 7616.6 7623.0 7630.1 4289.1 4564.1 4610.7 4621.2 4621.4 6454.3 7177.1 7195.2 7205.5 7207.9 6724.7 6942.2 6977.2 6993.1 6996.2 6939.4 6944.3 6951.4 6964.3 6968.6 6784.9 6786.0 6794.6 6797.2 6815.4 6782.9 6893.1 6978.0 6984.7 6991.3 6814.9 6825.4 6835.5 6835.6 6871.1 17:28:29 INFO - PROCESS | 2611 | 17:28:29 INFO - PROCESS | 2611 | [#5] yui.html Cycles:180 Average:18158.23 Median:613.04 stddev:25336.92 (4133.0%) stddev-sans-first:25374.00 17:28:29 INFO - PROCESS | 2611 | Values: 678.3 714.6 716.2 734.8 775.8 15047.9 15165.7 15212.7 15244.5 15279.7 13950.1 14125.8 14139.9 14156.0 14174.6 704.3 715.3 838.3 853.5 859.4 846.6 856.8 858.9 860.9 862.4 889.7 893.4 893.9 894.8 896.1 724.9 735.3 887.2 908.8 914.2 652.0 656.3 658.2 658.8 659.5 13938.7 13978.0 13992.4 13994.5 14051.9 12409.5 12649.5 12694.2 12719.6 12810.0 9690.3 10101.5 10250.4 10258.1 10803.7 3574.6 3618.1 3635.9 3721.4 3755.7 78966.0 79064.0 79252.6 79575.6 79685.6 9525.0 9599.5 9630.7 9695.0 10368.7 21815.9 22011.0 22024.8 22170.9 22230.3 7389.8 7405.4 7529.0 7649.7 7688.9 3966.6 4008.2 4011.3 4032.7 4036.4 3397.2 3433.6 3434.1 3441.8 3448.8 606.9 614.7 621.0 638.7 639.1 555.4 578.8 603.0 624.7 638.7 7113.5 7513.6 8066.6 8502.2 8750.9 522.3 593.8 602.0 611.4 620.3 3736.8 3967.6 4080.9 4124.6 4255.3 85175.0 85548.0 92968.5 93805.5 94180.0 76253.2 77260.0 78194.2 78206.0 78742.6 70318.0 70428.0 70735.0 70858.0 71007.0 8784.2 8807.9 8888.1 8901.5 8985.1 47740.1 47759.5 48778.0 49250.5 50214.7 62536.7 66553.7 66871.3 67641.7 67705.3 10770.4 10820.7 11223.3 11290.6 11568.7 11605.4 11918.6 11930.6 11963.9 11972.0 9543.8 10111.5 11429.9 11731.9 12038.1 11397.3 11543.7 11558.9 11569.1 11602.5 11278.3 11291.7 11296.9 11316.6 11366.8 9374.7 9784.5 9797.0 9823.8 9854.9 9835.8 10030.8 10035.3 10039.0 10051.3 17:28:29 INFO - PROCESS | 2611 | -------- Summary: end -------- 17:28:29 INFO - PROCESS | 2611 | 17:28:29 INFO - TEST-INFO | 2611: exit 0 17:28:29 INFO - TEST-OK | dromaeo_css | took 1113324ms 17:28:29 INFO - TEST-START | kraken 17:28:29 INFO - operating with platform_type : mac_ 17:28:29 INFO - Initialising browser for kraken test... 17:28:29 INFO - TEST-INFO | started process 2614 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpGq4KyK/profile http://localhost:50662/getInfo.html) 17:28:31 INFO - PROCESS | 2614 | __metrics Screen width/height:1600/1200 17:28:31 INFO - PROCESS | 2614 | colorDepth:24 17:28:31 INFO - PROCESS | 2614 | Browser inner width/height: 1024/689 17:28:31 INFO - PROCESS | 2614 | __metrics 17:28:31 INFO - PROCESS | 2614 | 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" 17:28:31 INFO - PROCESS | 2614 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:28:32 INFO - TEST-INFO | 2614: exit 0 17:28:32 INFO - Browser initialized. 17:28:32 INFO - Running cycle 1/1 for kraken test... 17:28:32 INFO - TEST-INFO | started process 2616 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmpGq4KyK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:44 INFO - PROCESS | 2616 | RSS: Main: 246882304 17:28:44 INFO - PROCESS | 2616 | 17:28:47 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50662/tests/kraken/driver.html?testName=audio-beat-detection) 17:28:47 INFO - PROCESS | 2616 | RSS: Main: 291627008 17:28:47 INFO - PROCESS | 2616 | 17:28:50 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50662/tests/kraken/driver.html?testName=audio-dft) 17:28:51 INFO - PROCESS | 2616 | RSS: Main: 302870528 17:28:51 INFO - PROCESS | 2616 | 17:28:54 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50662/tests/kraken/driver.html?testName=audio-fft) 17:28:54 INFO - PROCESS | 2616 | RSS: Main: 287526912 17:28:54 INFO - PROCESS | 2616 | 17:28:56 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50662/tests/kraken/driver.html?testName=audio-oscillator) 17:28:57 INFO - PROCESS | 2616 | RSS: Main: 288600064 17:28:57 INFO - PROCESS | 2616 | 17:28:59 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50662/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:00 INFO - PROCESS | 2616 | RSS: Main: 291147776 17:29:00 INFO - PROCESS | 2616 | 17:29:02 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50662/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:03 INFO - PROCESS | 2616 | RSS: Main: 291516416 17:29:03 INFO - PROCESS | 2616 | 17:29:06 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50662/tests/kraken/driver.html?testName=imaging-desaturate) 17:29:06 INFO - PROCESS | 2616 | RSS: Main: 290926592 17:29:06 INFO - PROCESS | 2616 | 17:29:09 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50662/tests/kraken/driver.html?testName=json-parse-financial) 17:29:10 INFO - PROCESS | 2616 | RSS: Main: 292102144 17:29:10 INFO - PROCESS | 2616 | 17:29:11 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50662/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:29:12 INFO - PROCESS | 2616 | RSS: Main: 326070272 17:29:12 INFO - PROCESS | 2616 | 17:29:13 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:29:14 INFO - PROCESS | 2616 | RSS: Main: 325312512 17:29:14 INFO - PROCESS | 2616 | 17:29:16 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:29:17 INFO - PROCESS | 2616 | RSS: Main: 334397440 17:29:17 INFO - PROCESS | 2616 | 17:29:19 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:29:20 INFO - PROCESS | 2616 | RSS: Main: 336236544 17:29:20 INFO - PROCESS | 2616 | 17:29:22 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:29:23 INFO - PROCESS | 2616 | RSS: Main: 335904768 17:29:23 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | Cycle 1(1): loaded http://localhost:50662/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50662/tests/kraken/driver.html?testName=ai-astar) 17:29:25 INFO - PROCESS | 2616 | RSS: Main: 396308480 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | __start_tp_report 17:29:25 INFO - PROCESS | 2616 | _x_x_mozilla_page_load 17:29:25 INFO - PROCESS | 2616 | _x_x_mozilla_page_load_details 17:29:25 INFO - PROCESS | 2616 | |i|pagename|runs| 17:29:25 INFO - PROCESS | 2616 | |0;ai-astar;111;110;112;110;112;111;115;111;110;112 17:29:25 INFO - PROCESS | 2616 | |1;audio-beat-detection;158;118;130;178;153;170;135;146;187;167 17:29:25 INFO - PROCESS | 2616 | |2;audio-dft;187;185;188;185;185;184;187;185;182;183 17:29:25 INFO - PROCESS | 2616 | |3;audio-fft;80;74;86;79;57;58;57;87;77;56 17:29:25 INFO - PROCESS | 2616 | |4;audio-oscillator;93;91;125;79;81;81;110;76;77;114 17:29:25 INFO - PROCESS | 2616 | |5;imaging-gaussian-blur;85;90;84;90;84;89;84;89;85;91 17:29:25 INFO - PROCESS | 2616 | |6;imaging-darkroom;94;94;94;94;94;93;94;93;94;93 17:29:25 INFO - PROCESS | 2616 | |7;imaging-desaturate;87;85;85;87;87;86;87;86;85;84 17:29:25 INFO - PROCESS | 2616 | |8;json-parse-financial;54;53;53;53;54;54;53;64;52;50 17:29:25 INFO - PROCESS | 2616 | |9;json-stringify-tinderbox;64;62;63;77;72;71;68;67;67;67 17:29:25 INFO - PROCESS | 2616 | |10;stanford-crypto-aes;84;87;80;82;84;83;83;82;83;83 17:29:25 INFO - PROCESS | 2616 | |11;stanford-crypto-ccm;127;126;123;121;120;126;124;125;121;128 17:29:25 INFO - PROCESS | 2616 | |12;stanford-crypto-pbkdf2;141;126;138;136;141;137;138;137;136;138 17:29:25 INFO - PROCESS | 2616 | |13;stanford-crypto-sha256-iterative;66;65;68;65;66;66;67;71;68;63 17:29:25 INFO - PROCESS | 2616 | __end_tp_report 17:29:25 INFO - PROCESS | 2616 | __start_cc_report 17:29:25 INFO - PROCESS | 2616 | _x_x_mozilla_cycle_collect,1175 17:29:25 INFO - PROCESS | 2616 | __end_cc_report 17:29:25 INFO - PROCESS | 2616 | __startTimestamp1455240565269__endTimestamp 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | ------- Summary: start ------- 17:29:25 INFO - PROCESS | 2616 | Number of tests: 14 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:1.51 (1.4%) stddev-sans-first:1.59 17:29:25 INFO - PROCESS | 2616 | Values: 111.0 110.0 112.0 110.0 112.0 111.0 115.0 111.0 110.0 112.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:162.50 stddev:22.12 (13.6%) stddev-sans-first:23.42 17:29:25 INFO - PROCESS | 2616 | Values: 158.0 118.0 130.0 178.0 153.0 170.0 135.0 146.0 187.0 167.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#2] audio-dft Cycles:10 Average:185.10 Median:185.00 stddev:1.85 (1.0%) stddev-sans-first:1.83 17:29:25 INFO - PROCESS | 2616 | Values: 187.0 185.0 188.0 185.0 185.0 184.0 187.0 185.0 182.0 183.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#3] audio-fft Cycles:10 Average:71.10 Median:78.00 stddev:12.72 (16.3%) stddev-sans-first:13.08 17:29:25 INFO - PROCESS | 2616 | Values: 80.0 74.0 86.0 79.0 57.0 58.0 57.0 87.0 77.0 56.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:80.00 stddev:17.59 (22.0%) stddev-sans-first:18.66 17:29:25 INFO - PROCESS | 2616 | Values: 93.0 91.0 125.0 79.0 81.0 81.0 110.0 76.0 77.0 114.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:89.00 stddev:2.92 (3.3%) stddev-sans-first:3.00 17:29:25 INFO - PROCESS | 2616 | Values: 85.0 90.0 84.0 90.0 84.0 89.0 84.0 89.0 85.0 91.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:29:25 INFO - PROCESS | 2616 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 94.0 93.0 94.0 93.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.50 stddev:1.10 (1.3%) stddev-sans-first:1.09 17:29:25 INFO - PROCESS | 2616 | Values: 87.0 85.0 85.0 87.0 87.0 86.0 87.0 86.0 85.0 84.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:53.50 stddev:3.71 (6.9%) stddev-sans-first:3.94 17:29:25 INFO - PROCESS | 2616 | Values: 54.0 53.0 53.0 53.0 54.0 54.0 53.0 64.0 52.0 50.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.50 stddev:4.54 (6.7%) stddev-sans-first:4.60 17:29:25 INFO - PROCESS | 2616 | Values: 64.0 62.0 63.0 77.0 72.0 71.0 68.0 67.0 67.0 67.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:83.00 stddev:1.79 (2.2%) stddev-sans-first:1.87 17:29:25 INFO - PROCESS | 2616 | Values: 84.0 87.0 80.0 82.0 84.0 83.0 83.0 82.0 83.0 83.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.50 stddev:2.77 (2.2%) stddev-sans-first:2.73 17:29:25 INFO - PROCESS | 2616 | Values: 127.0 126.0 123.0 121.0 120.0 126.0 124.0 125.0 121.0 128.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.80 Median:138.00 stddev:4.18 (3.0%) stddev-sans-first:4.15 17:29:25 INFO - PROCESS | 2616 | Values: 141.0 126.0 138.0 136.0 141.0 137.0 138.0 137.0 136.0 138.0 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - PROCESS | 2616 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:2.17 (3.3%) stddev-sans-first:2.30 17:29:25 INFO - PROCESS | 2616 | Values: 66.0 65.0 68.0 65.0 66.0 66.0 67.0 71.0 68.0 63.0 17:29:25 INFO - PROCESS | 2616 | -------- Summary: end -------- 17:29:25 INFO - PROCESS | 2616 | 17:29:25 INFO - TEST-INFO | 2616: exit 0 17:29:26 INFO - TEST-OK | kraken | took 56230ms 17:29:26 INFO - SUITE-END | took 1169s 17:29:26 INFO - Completed test suite (00:19:29) 17:29:26 INFO - Working with test: dromaeo_css 17:29:26 INFO - Generating results file: dromaeo_css 17:29:26 INFO - Working with test: kraken 17:29:26 INFO - Generating results file: kraken 17:29:26 INFO - javascript benchmark 17:29:26 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:29:26 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 17:29:26 INFO - process_Request line: dromaeo_css 7353.25 graph.html#tests=[[72,64,59]] 17:29:26 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:29:26 INFO - process_Request line: kraken 1413.50 graph.html#tests=[[232,64,59]] 17:29:26 INFO - RETURN: dromaeo_css: 7353.25 17:29:26 INFO - RETURN: kraken: 1413.50 17:29:26 INFO - javascript benchmark 17:29:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2845.857707114644, 3365.0746044837665, 3382.7632065755392, 3397.524346591476, 3410.3520331137083, 5458.0, 5522.5581953443725, 5523.2267482552425, 5545.3622833374175, 5546.556275497961, 5530.308711411074, 5599.048161812491, 5621.550275977922, 5658.575606829484, 5667.659940403569, 4971.502849715036, 5015.172496538076, 5037.269595908591, 5054.469280725526, 5196.272521846944, 5103.3875934887865, 5118.283440318359, 5144.331236939192, 5144.819931302405, 5161.922571161435, 4968.652194346397, 4986.2769898364895, 5055.519725626078, 5099.260607211971, 5110.080185566597, 5070.974645126787, 5071.8985620287385, 5088.033273677989, 5092.719900405476, 5138.152204886189, 5034.697918124924, 5050.065737838511, 5065.544101030888, 5095.286659867622, 5101.183810590325, 5411.891762164734, 5499.477549632818, 5518.061929471999, 5524.723763811833, 5535.225068490415, 6015.4586087252355, 6042.456178943872, 6056.091586262052, 6066.6663333516635, 6077.878442431171, 5966.433188847052, 6071.474957788391, 6111.511079113705, 6119.938800611982, 6122.855605810045, 5641.633293835887, 5643.209950606918, 5650.0959846424375, 5701.885962280731, 5723.484886360247, 6098.573099882966, 6101.3092767044445, 6162.476189523851, 6181.629102253789, 6209.161763162006, 6006.0, 6006.819795406145, 6036.788712395045, 6044.335123136451, 6050.364711705296, 6139.26328840542, 6148.262208534915, 6151.72317245725, 6156.230471191101, 6159.168512250879, 5931.436513531207, 6021.969890150521, 6038.245219347582, 6105.389461053859, 6118.694065296718, 6045.304789949212, 6092.208012958376, 6102.664353460602, 6108.3280839107665, 6116.0, 4713.2458806590785, 4789.161896668069, 4801.759912004456, 4819.95180048195, 4828.758562071883, 3680.742348035665, 4277.230098582285, 4319.200947824663, 4327.653787696977, 4338.8047537860875, 4967.329410529533, 5229.294045303835, 5498.9826882026955, 5563.693996830132, 5570.41510641385, 6015.157877897098, 6129.387061293835, 6138.324784273726, 6168.383161683796, 6198.380161983856, 5017.7491125443585, 5296.285001524822, 5474.233607294982, 5518.641288316247, 5520.723963801794, 5210.6873587584105, 5227.555657769132, 5260.263563101169, 5273.815416460406, 5308.840734777886, 6117.766507567544, 6179.104029915727, 6181.5981961174175, 6190.350013248544, 6192.102145189013, 6091.573589848668, 6135.1408007826785, 6164.3835616438, 6168.0, 6208.3791620839365, 5477.589180811535, 5986.431289027535, 6172.969135154295, 6190.597611155261, 6195.690215489298, 6011.939880601138, 6061.878762424815, 6078.240219972504, 6079.513638908965, 6094.969525152346, 6101.974255744646, 6113.908291375544, 6120.386183820725, 6163.414475624809, 6167.84580385494, 5973.671448070398, 6008.188894499362, 6046.90929636047, 6072.1498990140535, 6101.328853825987, 5800.651960882361, 5911.645301281937, 6064.757409703562, 6067.120267561268, 6080.270367555921, 4936.284238785428, 5757.884842303214, 5826.766929322949, 5841.240638716939, 5865.14955331466, 5952.553558483044, 5954.404559544011, 5978.4021597839865, 5979.491743201703, 6032.90950635732, 5728.79949201776, 5821.301443826768, 5827.300723912988, 5837.270341207349, 5859.472647461749], "unit": "score", "name": "dojo.html", "value": 5552.9730525371715}, {"lowerIsBetter": false, "replicates": [455.3761346954669, 563.0034838336145, 585.5491271720774, 597.3578403216542, 602.3735315272118, 29860.552091718615, 38080.61919380805, 38545.22909541807, 38566.61433385669, 38826.417603735965, 40832.387514187314, 41049.17901641966, 41255.0, 41282.0, 41321.58678413215, 9407.153356197941, 9643.710688679352, 9645.0, 9648.662296819613, 9665.323427360088, 9562.091601297865, 9695.757606059835, 9707.126358627722, 9722.805543889119, 9819.410835349867, 9712.854307185398, 9843.704688859345, 9844.95077524615, 9851.261155413336, 9852.359596626233, 8346.332293416543, 9815.90184098157, 9823.263255255813, 9823.656172033945, 9842.852357214684, 8346.70786522475, 9699.757506062404, 9714.417134971854, 9726.659566915125, 9732.610695572239, 35799.82100089483, 36614.08464788375, 39298.60701392978, 39557.40663890044, 39676.60323396758, 3251.3822373748912, 3291.884784032571, 3358.2108204571905, 3515.806630635314, 3624.4563315502623, 28227.576586351017, 28332.0, 28445.740479055636, 29750.70249297501, 30616.234594135323, 2737.3430376709643, 2804.5232310507263, 2817.619621351112, 2831.362943337753, 2922.4301261254063, 407456.0, 414472.0, 414826.0, 415182.0, 415344.0, 56078.719606401704, 58546.0, 59712.70143649341, 65303.673481632286, 71212.64393678102, 69377.95933061009, 69853.0, 70698.0, 70752.58494830178, 70845.0, 16189.190540473164, 16368.936019158717, 16376.0, 16411.261493232832, 16418.917905410395, 11632.302061876315, 11692.240004399857, 12666.49334026647, 12781.297028663326, 12812.93593532045, 21317.0, 21601.0, 21643.891780541, 21658.458538536663, 21672.674909876365, 9491.905080949102, 9736.0, 9749.0, 9797.755056123511, 9801.705948821547, 857.7562534325253, 898.1333013641867, 1028.9742756431149, 1052.1267348101057, 1068.636663534402, 29295.0, 29680.257993550335, 29956.700432995825, 30988.84505577458, 31977.68022319747, 1062.6333914799382, 1082.9187810914214, 1097.237419993097, 1165.2425923149851, 1178.2753606531921, 14269.858411327068, 14653.706925861423, 14737.042092263968, 15126.470573529874, 15159.848401515843, 541286.0, 631292.0, 633641.0, 635804.0, 636483.0, 57858.710706446196, 58158.0, 58331.5417114567, 58335.83328333494, 58549.414505854395, 1457.9416823326949, 1466.2961778346453, 1476.0922032949659, 1481.8221813382463, 1488.3600051977537, 29148.854255728587, 30093.09720708382, 30555.7360741052, 30695.539566906067, 31246.0, 52201.0, 52867.73566132145, 52913.0, 52948.735256323474, 53023.73488132535, 496811.0, 500357.0, 507899.0, 647906.0, 647977.7601111964, 33372.0, 40781.38827917524, 41586.37620435756, 42138.0, 42249.78875105605, 43260.35109473424, 43288.78355608202, 43320.13359732851, 44361.11277774491, 44406.3339049921, 34921.65078349184, 36425.817870910476, 36477.81761091178, 36746.63253367432, 37226.8138659305, 29231.85384073066, 34724.65275347315, 35250.294994100484, 36011.819940900124, 36347.45478817767, 35738.64261357457, 35939.28121437504, 36344.636553634125, 36544.0, 36728.449073264455, 30865.8456707715, 31484.527732084494, 32178.67821321757, 32829.50755738618, 32853.0, 19567.70648440303, 24021.27936161918, 24277.66365413418, 24343.51312973695, 24882.377940551632], "unit": "score", "name": "ext.html", "value": 20080.629866374176}, {"lowerIsBetter": false, "replicates": [328.7912175768386, 335.3209750255733, 358.81411933559576, 361.5516759218569, 365.4664190282188, 15223.944767456403, 18696.252149914006, 18775.873447593152, 18776.530586735305, 19025.714614280798, 14165.78751318731, 15168.103987001625, 15272.0, 18868.43394698158, 19268.0, 5566.4990150886415, 5608.887822243552, 5785.855353616173, 5829.766809327622, 5833.358330583633, 5705.2012718219485, 5766.481016708495, 5770.307563092435, 5774.422557744213, 5780.046292361755, 3847.153626202231, 4015.558288588253, 5583.3300003999575, 5821.767129314822, 5828.154917536955, 5556.222128901957, 5782.045962416218, 5790.507806836424, 5793.217915581406, 5798.3911689272445, 5537.307836520435, 5543.944560554383, 5548.4174161713245, 5553.111502159675, 5555.805546805843, 19551.706724399144, 22620.321390358316, 23494.0, 23580.7641923582, 23646.29061128169, 2301.5742087713825, 2380.369202161429, 2480.8015358771254, 2566.2044766122563, 2769.3932239522783, 9334.439933604006, 9370.437773733598, 9412.247020238365, 9907.405555666683, 9932.304738668296, 1715.7254839225664, 1780.7863056433182, 1799.9820001799944, 1802.0989505247376, 1847.2703282203454, 94139.52930235305, 95665.52167239189, 96340.0, 96502.81630728752, 97180.0, 10866.67399978002, 10877.184211184192, 10930.070943969693, 10950.34297942126, 11012.39431831241, 13048.217106973612, 13164.802527962089, 13185.219995300704, 13213.405396757169, 13237.139585926883, 8203.58982050895, 8213.753587392388, 8223.383246256555, 8305.46014509067, 8311.127331630212, 6858.902575587882, 8131.390145739093, 8183.79540511492, 8220.8355832883, 8275.54484503346, 3579.552555930509, 4244.10873716523, 4336.956630433719, 4340.457442819647, 4365.650747940157, 1691.4671878358524, 1767.3814165042133, 1825.452364290734, 1871.9438416847515, 1896.1846406045256, 394.2548583177796, 846.7713717296418, 919.4299534288783, 969.5491596407563, 984.8916619172029, 11149.442527873736, 11231.55073797039, 11254.7186320341, 11324.886751132382, 11476.0, 377.2662172075342, 436.28667129243917, 438.45850374787113, 453.51926957425235, 459.3477262287493, 5798.449147330997, 5983.880322393527, 10256.333338333134, 10755.89244107549, 10848.891511084947, 646747.0, 725843.0, 732766.0, 753613.0, 756344.0, 67672.66163669249, 100051.0, 109586.45206773916, 116203.09492262761, 117916.0, 441.9359192917009, 484.8085006422443, 501.3182072381631, 1143.4111432612212, 1179.7817403780327, 10825.566977321134, 10890.78218435611, 10993.670189894316, 11081.944590276997, 11089.112870970142, 47359.0, 48398.75800620974, 50590.48228553149, 50673.47979560619, 50850.23724644059, 72583.0, 72994.0, 73644.0, 73996.0, 74766.87849682367, 7489.8876516851205, 7531.962340188264, 7661.502002369828, 7687.346575541142, 7753.767386978399, 8540.829183416421, 10855.45722713877, 11609.825852612048, 11882.881171188177, 12030.09774266916, 6897.310268973062, 7882.0, 9966.651167209113, 10186.847197291898, 10237.283390162616, 8788.209061184523, 10173.542190601589, 10192.847107293248, 10235.7441063974, 10257.948710256402, 10116.0, 10183.643572474928, 10286.537105830404, 10339.793204135725, 10611.0, 7359.742409015873, 7577.0907491101425, 7584.582847943416, 7595.5822429766895, 7600.315971562586, 8264.504129752235, 10313.22650801178, 10438.53026613789, 10463.873770409886, 10660.413677247516], "unit": "score", "name": "jquery.html", "value": 8374.502038672284}, {"lowerIsBetter": false, "replicates": [1382.1016339379407, 1506.0511877517165, 1541.0291516344705, 1766.7614871992278, 1924.0283656753347, 7919.841603167941, 8573.314134869212, 8725.47647141172, 8735.999999999993, 8753.343499237566, 8375.706850260227, 8666.350023748228, 8671.176238257356, 8672.089430609789, 8678.0, 2106.7261256036772, 2158.84888057836, 2210.9668354974688, 2213.690083388327, 2448.289995901191, 2215.0475295622878, 2245.4723140062074, 2407.325948734357, 2465.2604218734396, 2467.8272520923542, 2397.3167647220544, 2423.8182136339756, 2423.9394015149587, 2429.5991161458337, 2457.1154384421593, 2411.0476361836977, 2449.4856080223176, 2460.3972026853535, 2460.4955984023322, 2463.790577800889, 2438.1588352018703, 2442.2673198040693, 2445.7431969643108, 2449.5835707929696, 2450.48539806639, 8770.868436973451, 8849.867251991225, 8855.778605534848, 8858.335624828163, 8883.111688831064, 5304.549113325372, 5431.83704488866, 5506.972465137648, 5522.254495643077, 5534.059209934321, 3415.55597772288, 3544.5923718772415, 3559.5906470755936, 3562.768420052714, 3573.1960308930543, 974.990250097497, 983.9754006149832, 1004.0762498501323, 1013.8631284776608, 1040.0587468341164, 11673.941630291794, 11779.175457717964, 11785.528578856836, 11787.17489775716, 11789.05687545003, 4543.227651299287, 4673.345731597579, 4757.904841903142, 4765.332853400527, 4773.236282194832, 9235.907640923504, 9361.391509551857, 9370.969193388722, 9371.484568348806, 9387.812243755086, 5360.973195133999, 5382.192671099367, 5400.540954018952, 5407.297051383373, 5416.864578385572, 4929.75351232437, 5003.424606170264, 5046.394432668103, 5048.823291184791, 5050.292958985745, 3516.6659167379057, 3594.424892017317, 3670.8531658733887, 3714.7213958953184, 3755.1363186467265, 1120.1598800899326, 1144.7882141803793, 1152.9020033297095, 1166.4401087478059, 1197.4192516629428, 1287.4463980488292, 1312.9409176587076, 1340.3566288181728, 1363.6250031241489, 1368.493657346788, 8110.026796784306, 8284.378671599654, 8285.58572071394, 8286.958565207256, 8288.668453261922, 1179.151011271883, 1185.8636256830575, 1189.3468079369684, 1197.1619866093595, 1208.5890797128843, 6234.127222188898, 6261.843453913689, 6313.305536390993, 6314.336994615591, 6324.778632747832, 10507.211959103099, 10920.017198452177, 10933.070688991525, 10968.17738669587, 10982.725431864268, 9115.225205857576, 10613.946930265454, 10697.0, 10812.405317707602, 10824.24230303871, 8300.0, 8384.455010424303, 8394.118617545191, 8402.579871006425, 8405.621747021276, 7809.297163255334, 7882.724104656539, 7893.921060789318, 7907.446478746432, 7949.761507154794, 9431.528423578931, 9696.806063878825, 9719.028097190225, 9817.165540928816, 9862.063104005108, 9845.901540984785, 9977.950110249692, 10221.9488902555, 10222.284440089123, 10223.386596804216, 7000.22997470288, 7042.014118023583, 7059.788206353817, 7097.858042839011, 7136.85726285461, 8234.958825205835, 8295.502269863586, 8297.25324720778, 8301.916980830114, 8305.833883322179, 7055.929440705528, 7120.679569419285, 7713.0, 7839.804004899923, 7984.481008734414, 7553.282438168365, 7627.54234745917, 7683.577403242875, 7711.0, 7713.074431068308, 7457.552546847207, 7686.8078298040755, 7690.769276921701, 7741.845163096594, 7745.264199901, 6995.265497122932, 7014.649267536501, 7023.33278338557, 7026.543274687129, 7028.578285302899, 7071.257517960746, 7115.359617634438, 7169.892451613126, 7183.712651494091, 7187.245339239514], "unit": "score", "name": "mootools.html", "value": 4904.48104484877}, {"lowerIsBetter": false, "replicates": [288.35408684546616, 319.5318857873215, 326.34893387691557, 330.1943258449383, 332.8568715452358, 6286.182796236489, 6368.076628888808, 6417.58285711429, 6477.546571739968, 6518.217813862331, 6342.556021078526, 6394.936050639492, 6410.8076757697345, 6421.67891605419, 6439.806805795822, 4530.139273538017, 4675.8363457279, 4681.9297710534365, 4769.833055843046, 4792.952070479303, 4493.191225579394, 4689.413823272091, 4711.269753188244, 4797.59220466259, 4802.97598512007, 4722.338872557844, 4733.029728905566, 4736.739479328636, 4743.739094349809, 4747.90504189916, 4439.689221754478, 4713.293006049103, 4732.763361831895, 4737.810487580493, 4748.548887855665, 3635.6909662678704, 3945.0926286953872, 4030.7380020298588, 4050.521559630743, 4055.0876052887866, 5704.942950570483, 6183.165272688175, 6198.3801619838105, 6201.534884883652, 6284.685765711742, 5634.549236061105, 5638.548916086703, 5646.435356464362, 5668.461496157858, 5671.177679236487, 6869.450443964471, 6880.277570855038, 6886.311368863124, 6890.31096890312, 6891.241963384024, 4595.172868883599, 4604.58558729716, 4605.907881842378, 4609.308603709437, 4617.030423611012, 6515.902261466082, 6632.573996590756, 7268.563886166847, 7276.381507571809, 7299.927000729977, 4332.740035597812, 4649.5350464953235, 4659.068186362673, 4664.930026049612, 4667.183242932473, 4610.95389046112, 4646.651501137429, 4655.324977878188, 4660.813567457264, 4661.836835710734, 4519.276915693474, 4715.83494577695, 5477.260569823103, 5509.531689806411, 5517.0, 6283.685815709287, 6947.548409353477, 6953.913825852224, 6955.93044069563, 6970.477214208955, 1567.6028739385922, 1587.8094628644405, 1594.8484893935058, 1609.7102521546235, 1614.039646410384, 1020.5254556631054, 1034.5086084110137, 1041.984370234432, 1050.112654806687, 1053.6470282455464, 6417.262014868256, 6454.515911306671, 6459.418652321314, 6460.838479037968, 6465.1595292611655, 7200.495965282485, 7204.3155900189395, 7204.9639751800905, 7205.855882882418, 7208.531445456028, 6229.221347331583, 6418.8716225675225, 6419.0, 6421.775237866652, 6433.067205255305, 3757.1170774867883, 3809.4476300936763, 3810.1998580297895, 3811.066288759216, 3816.7709937403843, 6622.072909792633, 7518.135414427411, 7530.623468826537, 7537.660805263777, 7541.698332066766, 5432.0, 7218.67515961783, 7453.925460745323, 7476.962615186889, 7524.398048156135, 7289.817754556178, 7619.390448764086, 7620.618969051525, 7624.618769061524, 7647.044119485065, 7054.611996340045, 7148.28517148281, 7217.097862767154, 7280.089988751406, 7301.926980730337, 7071.929280707127, 7106.076210092655, 7116.964415177891, 7127.46544009191, 7141.785746427616, 7319.451041171827, 7592.202818703957, 7616.619169041636, 7623.0, 7630.084389873251, 4289.099289149313, 4564.109998550251, 4610.662907756847, 4621.168189725747, 4621.376114224537, 6454.322296159024, 7177.066981292607, 7195.244499327495, 7205.531640443354, 7207.9279207207255, 6724.663766811737, 6942.166939967236, 6977.197622273504, 6993.125859267591, 6996.160460744743, 6939.410150137295, 6944.340287672865, 6951.44388448933, 6964.268751781193, 6968.581885086911, 6784.948333008391, 6786.0, 6794.626295553594, 6797.1843378794865, 6815.3866152044575, 6782.879875257437, 6893.0694356261265, 6977.988191712275, 6984.650767461708, 6991.265917078634, 6814.93185068143, 6825.38571528545, 6835.521513494008, 6835.624040677811, 6871.072405225231], "unit": "score", "name": "prototype.html", "value": 5047.190818053678}, {"lowerIsBetter": false, "replicates": [678.2776343194497, 714.6105372571948, 716.226475406561, 734.7501849371213, 775.8254392761626, 15047.94664373493, 15165.6966860663, 15212.695746085072, 15244.542663720093, 15279.69440611187, 13950.093243939136, 14125.78811317831, 14139.858601413982, 14156.0, 14174.645633859158, 704.3484776581668, 715.3490323805338, 838.3042075077701, 853.4623187391934, 859.4456575508793, 846.5851732651018, 856.8157846063095, 858.8582883824192, 860.8837806896083, 862.4480332587149, 889.6752685269895, 893.4415990006246, 893.9150780675825, 894.7628878347243, 896.0904681747999, 724.9057622509066, 735.2867718313228, 887.1660638999319, 908.7500937242245, 914.1955079529971, 651.9869602607969, 656.2977613953072, 658.1871388834833, 658.8352911772057, 659.5086660437956, 13938.651533711738, 13978.0, 13992.440302387893, 13994.510192143227, 14051.929740351336, 12409.503619855195, 12649.494020239179, 12694.238345699288, 12719.618411447671, 12810.039247056415, 9690.32167748258, 10101.49492525378, 10250.436226007567, 10258.128059114984, 10803.729906752395, 3574.60590369756, 3618.077390265492, 3635.9472927027145, 3721.38597131473, 3755.680767134797, 78965.99999999943, 79064.0, 79252.62242132745, 79575.60212198959, 79685.60157199176, 9525.0, 9599.520023998772, 9630.711078667651, 9694.951525242328, 10368.688939331832, 21815.890920545615, 22011.009504572332, 22024.779752202594, 22170.88914555417, 22230.333090007327, 7389.778306650809, 7405.370543503755, 7528.962355188299, 7649.732259370895, 7688.884666730003, 3966.6033396660105, 4008.1983603278877, 4011.277969965376, 4032.6773858091283, 4036.374361973899, 3397.235621985083, 3433.639467855889, 3434.1414646338417, 3441.8451169697423, 3448.810315432625, 606.8937935861206, 614.6926536731634, 620.9875802483925, 638.7476946606065, 639.0733436517069, 555.4362322242927, 578.7829563913532, 603.0050416812295, 624.7219987105785, 638.6966191059303, 7113.502054856214, 7513.586752728653, 8066.637001334954, 8502.234798868132, 8750.86873696895, 522.26621596656, 593.77139801176, 601.9548533859978, 611.3855575146949, 620.2928661326092, 3736.7757934524016, 3967.563568007517, 4080.8775736727944, 4124.628783409447, 4255.340422234559, 85175.0, 85548.0, 92968.53515732514, 93805.53097234607, 94180.0, 76253.23746762572, 77260.0, 78194.21805781983, 78206.0, 78742.60628696934, 70318.0, 70428.0, 70735.0, 70858.0, 71007.0, 8784.165504277084, 8807.867881981647, 8888.066752990842, 8901.499068389801, 8985.146411091197, 47740.090396383755, 47759.52240477551, 48778.0, 49250.50749492459, 50214.74463138451, 62536.687316563126, 66553.66723166354, 66871.33128668845, 67641.66179169073, 67705.32294677188, 10770.407627580558, 10820.67537973862, 11223.326600404002, 11290.604828830952, 11568.668231472497, 11605.361705106301, 11918.582849600569, 11930.642080737593, 11963.880361196276, 11972.0, 9543.76140596463, 10111.494425278559, 11429.885701142883, 11731.88268117308, 12038.06944886894, 11397.258634702313, 11543.653690389301, 11558.94220528892, 11569.132315076571, 11602.47788849487, 11278.266912650652, 11291.661250162508, 11296.943515282372, 11316.6039188628, 11366.772664546828, 9374.718758437259, 9784.51077446139, 9796.951015245164, 9823.754406139904, 9854.852177217204, 9835.803283934425, 10030.799384012425, 10035.34770239932, 10039.0, 10051.296409251283], "unit": "score", "name": "yui.html", "value": 6838.1047021214845}], "name": "dromaeo_css", "value": 7353.249596625891}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 112.0, 110.0, 112.0, 111.0, 115.0, 111.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [158.0, 118.0, 130.0, 178.0, 153.0, 170.0, 135.0, 146.0, 187.0, 167.0], "unit": "score", "name": "audio-beat-detection", "value": 154.2}, {"lowerIsBetter": true, "replicates": [187.0, 185.0, 188.0, 185.0, 185.0, 184.0, 187.0, 185.0, 182.0, 183.0], "unit": "score", "name": "audio-dft", "value": 185.1}, {"lowerIsBetter": true, "replicates": [80.0, 74.0, 86.0, 79.0, 57.0, 58.0, 57.0, 87.0, 77.0, 56.0], "unit": "score", "name": "audio-fft", "value": 71.1}, {"lowerIsBetter": true, "replicates": [93.0, 91.0, 125.0, 79.0, 81.0, 81.0, 110.0, 76.0, 77.0, 114.0], "unit": "score", "name": "audio-oscillator", "value": 92.7}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 84.0, 90.0, 84.0, 89.0, 84.0, 89.0, 85.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.7}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 85.0, 87.0, 87.0, 86.0, 87.0, 86.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.9}, {"lowerIsBetter": true, "replicates": [54.0, 53.0, 53.0, 53.0, 54.0, 54.0, 53.0, 64.0, 52.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 54.0}, {"lowerIsBetter": true, "replicates": [64.0, 62.0, 63.0, 77.0, 72.0, 71.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 80.0, 82.0, 84.0, 83.0, 83.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [127.0, 126.0, 123.0, 121.0, 120.0, 126.0, 124.0, 125.0, 121.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [141.0, 126.0, 138.0, 136.0, 141.0, 137.0, 138.0, 137.0, 136.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.8}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 68.0, 65.0, 66.0, 66.0, 67.0, 71.0, 68.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1413.5}]} 17:29:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1413.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7353.25"}}} 17:29:27 INFO - Return code: 0 17:29:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:29:27 INFO - # TBPL SUCCESS # 17:29:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:29:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:29:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:29:27 INFO - 2016-02-11 17:29:27.168 screenresolution[2620:37129] starting screenresolution argv=screenresolution get 17:29:27 INFO - 2016-02-11 17:29:27.171 screenresolution[2620:37129] Display 0: 1600x1200x32@60 17:29:27 INFO - 2016-02-11 17:29:27.177 screenresolution[2621:37132] starting screenresolution argv=screenresolution list 17:29:27 INFO - Available Modes on Display 0 17:29:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:29:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:29:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:29:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:29:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:29:27 INFO - Intel Iris: 17:29:27 INFO - Chipset Model: Intel Iris 17:29:27 INFO - Type: GPU 17:29:27 INFO - Bus: Built-In 17:29:27 INFO - VRAM (Dynamic, Max): 1536 MB 17:29:27 INFO - Vendor: Intel (0x8086) 17:29:27 INFO - Device ID: 0x0a2e 17:29:27 INFO - Revision ID: 0x0009 17:29:27 INFO - Displays: 17:29:27 INFO - Display: 17:29:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:29:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:29:27 INFO - Display Serial Number: 1600x1200 60 17:29:27 INFO - Main Display: Yes 17:29:27 INFO - Mirror: Off 17:29:27 INFO - Online: Yes 17:29:27 INFO - Rotation: Supported 17:29:27 INFO - Return code: 0 17:29:27 INFO - Running post-action listener: _resource_record_post_action 17:29:27 INFO - Running post-run listener: _resource_record_post_run 17:29:28 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 196608; Write bytes: 708261376; Read time: 2; Write time: 2082 17:29:28 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403659264; Write bytes: 404748288; Read time: 29991; Write time: 682 17:29:28 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 196608; Write bytes: 300500480; Read time: 2; Write time: 1388 17:29:28 INFO - Running post-run listener: _upload_blobber_files 17:29:28 INFO - Blob upload gear active. 17:29:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:29:28 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 17:29:28 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'] 17:29:28 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 17:29:28 INFO - (blobuploader) - INFO - Open directory for files ... 17:29:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:29:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:29:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:29 INFO - (blobuploader) - INFO - Done attempting. 17:29:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:29:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:29:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:30 INFO - (blobuploader) - INFO - Done attempting. 17:29:30 INFO - (blobuploader) - INFO - Iteration through files over. 17:29:30 INFO - Return code: 0 17:29:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:29:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:29:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e58486267f72ae6fa193814e30ffcbf8b359e9b292c8e371a49ec2107dcc715ba3fd24f9b02a533889e0a4b3611fac4c80790e43c0ecc80d2037ddf49bc3a306", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53ec346ebaf8c4398c5f95e65bf02e07d33a1011b6d0e6453cb803ddae3a382eb00760f732ee0111d0baca37958044539392f07fb627bd0aa87554d50362f852"} 17:29:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:29:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:29:30 INFO - Contents: 17:29:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e58486267f72ae6fa193814e30ffcbf8b359e9b292c8e371a49ec2107dcc715ba3fd24f9b02a533889e0a4b3611fac4c80790e43c0ecc80d2037ddf49bc3a306", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53ec346ebaf8c4398c5f95e65bf02e07d33a1011b6d0e6453cb803ddae3a382eb00760f732ee0111d0baca37958044539392f07fb627bd0aa87554d50362f852"} 17:29:30 INFO - Running post-run listener: copy_logs_to_upload_dir 17:29:30 INFO - Copying logs to upload dir... 17:29:30 INFO - mkdir: /builds/slave/test/build/upload/logs 17:29:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.119905 ========= master_lag: 0.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-02-11 17:29:31.146561) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 17:29:31.149773) ========= 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.8FUVfg54vh/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.dlMymHbDxO/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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/e58486267f72ae6fa193814e30ffcbf8b359e9b292c8e371a49ec2107dcc715ba3fd24f9b02a533889e0a4b3611fac4c80790e43c0ecc80d2037ddf49bc3a306", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53ec346ebaf8c4398c5f95e65bf02e07d33a1011b6d0e6453cb803ddae3a382eb00760f732ee0111d0baca37958044539392f07fb627bd0aa87554d50362f852"} build_url:https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011082 build_url: 'https://queue.taskcluster.net/v1/task/frtNIz3SRFi04h2eS79wkA/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/e58486267f72ae6fa193814e30ffcbf8b359e9b292c8e371a49ec2107dcc715ba3fd24f9b02a533889e0a4b3611fac4c80790e43c0ecc80d2037ddf49bc3a306", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53ec346ebaf8c4398c5f95e65bf02e07d33a1011b6d0e6453cb803ddae3a382eb00760f732ee0111d0baca37958044539392f07fb627bd0aa87554d50362f852"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 17:29:31.183597) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:29:31.183983) ========= 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.8FUVfg54vh/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.dlMymHbDxO/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.005391 ========= master_lag: 0.22 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 17:29:31.410908) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 17:29:31.411259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 17:29:31.411962) ========= ========= Total master_lag: 1.30 =========