builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0023 starttime: 1459260813.51 results: success (0) buildid: 20160329054133 builduid: af0ddd566a0943638136e4774dfd891d revision: b4941d71b4df56c6f49c6f176cd65bf8af4b0e32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:33.506722) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:33.519860) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:33.520231) ========= 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.SrFmVayYcU/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.uyW79JdciI/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005827 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:33.550449) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:33.550719) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:33.595214) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:33.595457) ========= 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.SrFmVayYcU/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.uyW79JdciI/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005345 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:33.647896) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:33.648181) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:33.648514) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:33.648785) ========= 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.SrFmVayYcU/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.uyW79JdciI/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-29 07:13:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 45.4M=0s 2016-03-29 07:13:34 (45.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.506795 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:34.173195) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:34.173512) ========= 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.SrFmVayYcU/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.uyW79JdciI/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.020082 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:34.222712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 07:13:34.223080) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b4941d71b4df56c6f49c6f176cd65bf8af4b0e32 --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 b4941d71b4df56c6f49c6f176cd65bf8af4b0e32 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SrFmVayYcU/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.uyW79JdciI/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-29 07:13:34,297 truncating revision to first 12 chars 2016-03-29 07:13:34,297 Setting DEBUG logging. 2016-03-29 07:13:34,297 attempt 1/10 2016-03-29 07:13:34,297 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b4941d71b4df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-29 07:13:35,039 unpacking tar archive at: fx-team-b4941d71b4df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.986275 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 07:13:35.232205) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:35.232531) ========= echo b4941d71b4df56c6f49c6f176cd65bf8af4b0e32 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b4941d71b4df56c6f49c6f176cd65bf8af4b0e32'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SrFmVayYcU/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.uyW79JdciI/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 b4941d71b4df56c6f49c6f176cd65bf8af4b0e32 program finished with exit code 0 elapsedTime=0.005247 script_repo_revision: 'b4941d71b4df56c6f49c6f176cd65bf8af4b0e32' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:35.283509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:35.283790) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 07:13:35.299103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-03-29 07:13:35.299366) ========= /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.SrFmVayYcU/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.uyW79JdciI/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 07:13:35 INFO - MultiFileLogger online at 20160329 07:13:35 in /builds/slave/test 07:13:35 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 07:13:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:13:35 INFO - {'append_to_log': False, 07:13:35 INFO - 'base_work_dir': '/builds/slave/test', 07:13:35 INFO - 'blob_upload_branch': 'Fx-Team', 07:13:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:13:35 INFO - 'branch': 'Fx-Team', 07:13:35 INFO - 'buildbot_json_path': 'buildprops.json', 07:13:35 INFO - 'config_files': ('talos/mac_config.py',), 07:13:35 INFO - 'default_actions': ('clobber', 07:13:35 INFO - 'read-buildbot-config', 07:13:35 INFO - 'download-and-extract', 07:13:35 INFO - 'populate-webroot', 07:13:35 INFO - 'create-virtualenv', 07:13:35 INFO - 'install', 07:13:35 INFO - 'run-tests'), 07:13:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:13:35 INFO - 'download_minidump_stackwalk': True, 07:13:35 INFO - 'download_symbols': 'ondemand', 07:13:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:13:35 INFO - 'tooltool.py': '/tools/tooltool.py', 07:13:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:13:35 INFO - '/tools/misc-python/virtualenv.py')}, 07:13:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:13:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:13:35 INFO - 'installer_path': 'installer.exe', 07:13:35 INFO - 'log_level': 'info', 07:13:35 INFO - 'log_name': 'talos', 07:13:35 INFO - 'log_to_console': True, 07:13:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:13:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:13:35 INFO - 'opt_config_files': (), 07:13:35 INFO - 'pip_index': False, 07:13:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:13:35 INFO - 'cmd': ('bash', 07:13:35 INFO - '-c', 07:13:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:13:35 INFO - 'enabled': True, 07:13:35 INFO - 'halt_on_failure': False, 07:13:35 INFO - 'name': 'check_screen_resolution'},), 07:13:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:13:35 INFO - 'cmd': ('bash', 07:13:35 INFO - '-c', 07:13:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:13:35 INFO - 'enabled': True, 07:13:35 INFO - 'halt_on_failure': False, 07:13:35 INFO - 'name': 'check_screen_resolution'},), 07:13:35 INFO - 'run_cmd_checks_enabled': True, 07:13:35 INFO - 'sps_profile': False, 07:13:35 INFO - 'sps_profile_interval': 0, 07:13:35 INFO - 'suite': 'dromaeojs', 07:13:35 INFO - 'system_bits': '32', 07:13:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:13:35 INFO - 'title': 't-yosemite-r7-0023', 07:13:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:13:35 INFO - 'use_talos_json': True, 07:13:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:13:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:13:35 INFO - 'work_dir': 'build'} 07:13:35 INFO - ##### 07:13:35 INFO - ##### Running clobber step. 07:13:35 INFO - ##### 07:13:35 INFO - Running pre-action listener: _resource_record_pre_action 07:13:35 INFO - Running main action method: clobber 07:13:35 INFO - rmtree: /builds/slave/test/build 07:13:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:13:36 INFO - Running post-action listener: _resource_record_post_action 07:13:36 INFO - ##### 07:13:36 INFO - ##### Running read-buildbot-config step. 07:13:36 INFO - ##### 07:13:36 INFO - Running pre-action listener: _resource_record_pre_action 07:13:36 INFO - Running main action method: read_buildbot_config 07:13:37 INFO - Using buildbot properties: 07:13:37 INFO - { 07:13:37 INFO - "project": "", 07:13:37 INFO - "product": "firefox", 07:13:37 INFO - "script_repo_revision": "production", 07:13:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:13:37 INFO - "repository": "", 07:13:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:13:37 INFO - "buildid": "20160329054133", 07:13:37 INFO - "pgo_build": "False", 07:13:37 INFO - "basedir": "/builds/slave/test", 07:13:37 INFO - "buildnumber": 564, 07:13:37 INFO - "slavename": "t-yosemite-r7-0023", 07:13:37 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:13:37 INFO - "platform": "yosemite_r7", 07:13:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:13:37 INFO - "branch": "fx-team", 07:13:37 INFO - "repo_path": "integration/fx-team", 07:13:37 INFO - "revision": "b4941d71b4df56c6f49c6f176cd65bf8af4b0e32", 07:13:37 INFO - "stage_platform": "macosx64", 07:13:37 INFO - "builduid": "af0ddd566a0943638136e4774dfd891d", 07:13:37 INFO - "slavebuilddir": "test" 07:13:37 INFO - } 07:13:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 07:13:37 INFO - Running post-action listener: _resource_record_post_action 07:13:37 INFO - ##### 07:13:37 INFO - ##### Running download-and-extract step. 07:13:37 INFO - ##### 07:13:37 INFO - Running pre-action listener: _resource_record_pre_action 07:13:37 INFO - Running main action method: download_and_extract 07:13:37 INFO - mkdir: /builds/slave/test/build/tests 07:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:37 INFO - https://queue.taskcluster.net/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:13:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 07:13:39 INFO - Downloaded 1199 bytes. 07:13:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 07:13:39 INFO - Using the following test package requirements: 07:13:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:13:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 07:13:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 07:13:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:39 INFO - u'jsshell-mac.zip'], 07:13:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 07:13:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 07:13:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 07:13:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 07:13:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 07:13:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 07:13:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 07:13:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:39 INFO - https://queue.taskcluster.net/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:13:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:13:40 INFO - Downloaded 17944786 bytes. 07:13:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:13:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:13:43 INFO - Return code: 0 07:13:43 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:13:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:43 INFO - https://queue.taskcluster.net/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:13:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 07:13:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:13:45 INFO - Downloaded 17944786 bytes. 07:13:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:13:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 07:13:49 INFO - Return code: 0 07:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:13:49 INFO - https://queue.taskcluster.net/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:13:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:13:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:13:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 07:13:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:13:50 INFO - Downloaded 10847531 bytes. 07:13:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:13:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 07:13:50 INFO - Return code: 0 07:13: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')]} 07:13:50 INFO - https://queue.taskcluster.net/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:13:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:13:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:13:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 07:13:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 07:13:59 INFO - Downloaded 111414433 bytes. 07:13:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:13:59 INFO - mkdir: /builds/slave/test/properties 07:13:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:13:59 INFO - Writing to file /builds/slave/test/properties/build_url 07:13:59 INFO - Contents: 07:13:59 INFO - build_url:https://queue.taskcluster.net/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 07:14:00 INFO - Running post-action listener: _resource_record_post_action 07:14:00 INFO - Running post-action listener: set_extra_try_arguments 07:14:00 INFO - ##### 07:14:00 INFO - ##### Running populate-webroot step. 07:14:00 INFO - ##### 07:14:00 INFO - Running pre-action listener: _resource_record_pre_action 07:14:00 INFO - Running main action method: populate_webroot 07:14:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:14:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:14:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:14:00 INFO - '--tppagecycles', 07:14:00 INFO - '7'], 07:14:00 INFO - 'tests': ['tsvgm']}}, 07:14:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:14:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:14:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:14:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:14:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:14:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:14:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:00 INFO - 'talos_options': ['--e10s'], 07:14:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:14:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:00 INFO - 'tests': ['damp', 'tps']}, 07:14:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:00 INFO - 'talos_options': ['--e10s'], 07:14:00 INFO - 'tests': ['damp', 'tps']}, 07:14:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:14:00 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 07:14:00 INFO - 'tests': ['dromaeo_dom']}, 07:14:00 INFO - 'other': {'tests': ['a11yr', 07:14:00 INFO - 'ts_paint', 07:14:00 INFO - 'tpaint', 07:14:00 INFO - 'sessionrestore', 07:14:00 INFO - 'sessionrestore_no_auto_restore', 07:14:00 INFO - 'tabpaint']}, 07:14:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:14:00 INFO - 'tests': ['a11yr', 07:14:00 INFO - 'ts_paint', 07:14:00 INFO - 'tpaint', 07:14:00 INFO - 'sessionrestore', 07:14:00 INFO - 'sessionrestore_no_auto_restore', 07:14:00 INFO - 'tabpaint']}, 07:14:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:14:00 INFO - 'tests': ['a11yr', 07:14:00 INFO - 'ts_paint', 07:14:00 INFO - 'tpaint', 07:14:00 INFO - 'sessionrestore', 07:14:00 INFO - 'sessionrestore_no_auto_restore', 07:14:00 INFO - 'tabpaint']}, 07:14:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:14:00 INFO - 'tests': ['a11yr', 07:14:00 INFO - 'ts_paint', 07:14:00 INFO - 'tpaint', 07:14:00 INFO - 'sessionrestore', 07:14:00 INFO - 'sessionrestore_no_auto_restore', 07:14:00 INFO - 'tabpaint']}, 07:14:00 INFO - 'other_l64': {'tests': ['a11yr', 07:14:00 INFO - 'ts_paint', 07:14:00 INFO - 'tpaint', 07:14:00 INFO - 'sessionrestore', 07:14:00 INFO - 'sessionrestore_no_auto_restore', 07:14:00 INFO - 'tabpaint']}, 07:14:00 INFO - 'other_nol64': {'tests': ['a11yr', 07:14:00 INFO - 'ts_paint', 07:14:00 INFO - 'tpaint', 07:14:00 INFO - 'sessionrestore', 07:14:00 INFO - 'sessionrestore_no_auto_restore', 07:14:00 INFO - 'tabpaint']}, 07:14:00 INFO - 'svgr': {'tests': ['tsvgx', 07:14:00 INFO - 'tsvgr_opacity', 07:14:00 INFO - 'tart', 07:14:00 INFO - 'tscrollx', 07:14:00 INFO - 'cart']}, 07:14:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:14:00 INFO - 'tests': ['tsvgx', 07:14:00 INFO - 'tsvgr_opacity', 07:14:00 INFO - 'tart', 07:14:00 INFO - 'tscrollx', 07:14:00 INFO - 'cart']}, 07:14:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:00 INFO - 'tests': ['tp5o']}, 07:14:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:00 INFO - 'talos_options': ['--e10s'], 07:14:00 INFO - 'tests': ['tp5o']}, 07:14:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:00 INFO - 'talos_options': ['--xperf_path', 07:14:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:00 INFO - 'tests': ['tp5n']}, 07:14:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:14:00 INFO - 'talos_options': ['--e10s', 07:14:00 INFO - '--xperf_path', 07:14:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:14:00 INFO - 'tests': ['tp5n']}}, 07:14:00 INFO - 'talos.zip': {'path': '', 07:14:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:14:00 INFO - Running post-action listener: _resource_record_post_action 07:14:00 INFO - ##### 07:14:00 INFO - ##### Running create-virtualenv step. 07:14:00 INFO - ##### 07:14:00 INFO - Running pre-action listener: _resource_record_pre_action 07:14:00 INFO - Running main action method: create_virtualenv 07:14:00 INFO - Creating virtualenv /builds/slave/test/build/venv 07:14:00 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 07:14:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:14:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:14:01 INFO - Using real prefix '/tools/python27' 07:14:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:14:01 INFO - Installing distribute.............................................................................................................................................................................................done. 07:14:04 INFO - Installing pip.................done. 07:14:04 INFO - Return code: 0 07:14:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:14:04 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')]} 07:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:04 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')]} 07:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:04 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 0x105218a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105228420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc39d55490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050b7e00>, '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 0x104ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050b2b20>, '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.SrFmVayYcU/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.uyW79JdciI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 07:14:04 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 07:14:04 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 07:14:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFmVayYcU/Render', 07:14:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:04 INFO - 'HOME': '/Users/cltbld', 07:14:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:04 INFO - 'LOGNAME': 'cltbld', 07:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:04 INFO - 'MOZ_NO_REMOTE': '1', 07:14:04 INFO - 'NO_EM_RESTART': '1', 07:14:04 INFO - 'PAGER': '/bin/cat', 07:14:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:04 INFO - 'PWD': '/builds/slave/test', 07:14:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:04 INFO - 'SHELL': '/bin/bash', 07:14:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uyW79JdciI/Listeners', 07:14:04 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 07:14:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:04 INFO - 'USER': 'cltbld', 07:14:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:04 INFO - 'XPC_FLAGS': '0x0', 07:14:04 INFO - 'XPC_SERVICE_NAME': '0', 07:14:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:04 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 07:14:04 INFO - Cleaning up... 07:14:04 INFO - Return code: 0 07:14:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:14:04 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')]} 07:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:04 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')]} 07:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:04 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 0x105218a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105228420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc39d55490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050b7e00>, '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 0x104ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050b2b20>, '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.SrFmVayYcU/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.uyW79JdciI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 07:14:04 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 07:14:04 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 07:14:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFmVayYcU/Render', 07:14:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:04 INFO - 'HOME': '/Users/cltbld', 07:14:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:04 INFO - 'LOGNAME': 'cltbld', 07:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:04 INFO - 'MOZ_NO_REMOTE': '1', 07:14:04 INFO - 'NO_EM_RESTART': '1', 07:14:04 INFO - 'PAGER': '/bin/cat', 07:14:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:04 INFO - 'PWD': '/builds/slave/test', 07:14:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:04 INFO - 'SHELL': '/bin/bash', 07:14:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uyW79JdciI/Listeners', 07:14:04 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 07:14:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:04 INFO - 'USER': 'cltbld', 07:14:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:04 INFO - 'XPC_FLAGS': '0x0', 07:14:04 INFO - 'XPC_SERVICE_NAME': '0', 07:14:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:05 INFO - Downloading/unpacking psutil>=0.7.1 07:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:14:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:08 INFO - Installing collected packages: psutil 07:14:08 INFO - Running setup.py install for psutil 07:14:08 INFO - building 'psutil._psutil_osx' extension 07:14:08 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 07:14:08 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 07:14:08 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 07:14:08 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 07:14:08 INFO - building 'psutil._psutil_posix' extension 07:14:08 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 07:14:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:14:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:14:09 INFO - ^ 07:14:09 INFO - 1 warning generated. 07:14:09 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 07:14:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:14:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:14:09 INFO - Successfully installed psutil 07:14:09 INFO - Cleaning up... 07:14:09 INFO - Return code: 0 07:14:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105218a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105228420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc39d55490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050b7e00>, '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 0x104ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050b2b20>, '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.SrFmVayYcU/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.uyW79JdciI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 07:14:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:14:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:14:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFmVayYcU/Render', 07:14:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:09 INFO - 'HOME': '/Users/cltbld', 07:14:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:09 INFO - 'LOGNAME': 'cltbld', 07:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:09 INFO - 'MOZ_NO_REMOTE': '1', 07:14:09 INFO - 'NO_EM_RESTART': '1', 07:14:09 INFO - 'PAGER': '/bin/cat', 07:14:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:09 INFO - 'PWD': '/builds/slave/test', 07:14:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:09 INFO - 'SHELL': '/bin/bash', 07:14:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uyW79JdciI/Listeners', 07:14:09 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 07:14:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:09 INFO - 'USER': 'cltbld', 07:14:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:09 INFO - 'XPC_FLAGS': '0x0', 07:14:09 INFO - 'XPC_SERVICE_NAME': '0', 07:14:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:14:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:14:12 INFO - Installing collected packages: mozsystemmonitor 07:14:12 INFO - Running setup.py install for mozsystemmonitor 07:14:12 INFO - Successfully installed mozsystemmonitor 07:14:12 INFO - Cleaning up... 07:14:12 INFO - Return code: 0 07:14:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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', '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 0x105218a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105228420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc39d55490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050b7e00>, '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 0x104ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050b2b20>, '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.SrFmVayYcU/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.uyW79JdciI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 07:14: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:14: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 blobuploader==1.2.4 07:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFmVayYcU/Render', 07:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:12 INFO - 'HOME': '/Users/cltbld', 07:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:12 INFO - 'LOGNAME': 'cltbld', 07:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:12 INFO - 'MOZ_NO_REMOTE': '1', 07:14:12 INFO - 'NO_EM_RESTART': '1', 07:14:12 INFO - 'PAGER': '/bin/cat', 07:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:12 INFO - 'PWD': '/builds/slave/test', 07:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:12 INFO - 'SHELL': '/bin/bash', 07:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uyW79JdciI/Listeners', 07:14:12 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 07:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:12 INFO - 'USER': 'cltbld', 07:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:12 INFO - 'XPC_FLAGS': '0x0', 07:14:12 INFO - 'XPC_SERVICE_NAME': '0', 07:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:12 INFO - Downloading/unpacking blobuploader==1.2.4 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:14 INFO - Downloading blobuploader-1.2.4.tar.gz 07:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:14:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:14:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14: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 07:14:15 INFO - Downloading docopt-0.6.1.tar.gz 07:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:14:16 INFO - Installing collected packages: blobuploader, requests, docopt 07:14:16 INFO - Running setup.py install for blobuploader 07:14:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:14:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:14:16 INFO - Running setup.py install for requests 07:14:16 INFO - Running setup.py install for docopt 07:14:16 INFO - Successfully installed blobuploader requests docopt 07:14:16 INFO - Cleaning up... 07:14:16 INFO - Return code: 0 07:14:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:16 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 0x105218a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105228420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc39d55490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050b7e00>, '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 0x104ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050b2b20>, '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.SrFmVayYcU/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.uyW79JdciI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 07:14:16 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 07:14:16 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 07:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFmVayYcU/Render', 07:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:17 INFO - 'HOME': '/Users/cltbld', 07:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:17 INFO - 'LOGNAME': 'cltbld', 07:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:17 INFO - 'MOZ_NO_REMOTE': '1', 07:14:17 INFO - 'NO_EM_RESTART': '1', 07:14:17 INFO - 'PAGER': '/bin/cat', 07:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:17 INFO - 'PWD': '/builds/slave/test', 07:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:17 INFO - 'SHELL': '/bin/bash', 07:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uyW79JdciI/Listeners', 07:14:17 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 07:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:17 INFO - 'USER': 'cltbld', 07:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:17 INFO - 'XPC_FLAGS': '0x0', 07:14:17 INFO - 'XPC_SERVICE_NAME': '0', 07:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ausOYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-AHRKMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-S0sSqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-g7LqXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-elwRHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-77xurS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Zlfjv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:17 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-RtDJEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-t7jE6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-AdzAYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-N85wi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-l70w2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-vkpFjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-yMxFCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Mikm_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-L_Wy6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:18 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Qx_X0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:14:19 INFO - Running setup.py install for manifestparser 07:14:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:14:19 INFO - Running setup.py install for mozcrash 07:14:19 INFO - Running setup.py install for mozdebug 07:14:19 INFO - Running setup.py install for mozdevice 07:14:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:14:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:14:19 INFO - Running setup.py install for mozfile 07:14:19 INFO - Running setup.py install for mozhttpd 07:14:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:14:19 INFO - Running setup.py install for mozinfo 07:14:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:14:20 INFO - Running setup.py install for mozInstall 07:14:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:14:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:14:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:14:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:14:20 INFO - Running setup.py install for mozleak 07:14:20 INFO - Running setup.py install for mozlog 07:14:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:14:20 INFO - Running setup.py install for moznetwork 07:14:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:14:20 INFO - Running setup.py install for mozprocess 07:14:20 INFO - Running setup.py install for mozprofile 07:14:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:14:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:14:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:14:20 INFO - Running setup.py install for mozrunner 07:14:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:14:21 INFO - Running setup.py install for mozscreenshot 07:14:21 INFO - Running setup.py install for moztest 07:14:21 INFO - Running setup.py install for mozversion 07:14:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:14:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:14:21 INFO - Cleaning up... 07:14:21 INFO - Return code: 0 07:14:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14:21 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')]} 07:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:21 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')]} 07:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:21 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 0x105218a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105228420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc39d55490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050b7e00>, '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 0x104ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050b2b20>, '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.SrFmVayYcU/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.uyW79JdciI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 07:14:21 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 07:14:21 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 07:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFmVayYcU/Render', 07:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:21 INFO - 'HOME': '/Users/cltbld', 07:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:21 INFO - 'LOGNAME': 'cltbld', 07:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:21 INFO - 'MOZ_NO_REMOTE': '1', 07:14:21 INFO - 'NO_EM_RESTART': '1', 07:14:21 INFO - 'PAGER': '/bin/cat', 07:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:21 INFO - 'PWD': '/builds/slave/test', 07:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:21 INFO - 'SHELL': '/bin/bash', 07:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uyW79JdciI/Listeners', 07:14:21 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 07:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:21 INFO - 'USER': 'cltbld', 07:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:21 INFO - 'XPC_FLAGS': '0x0', 07:14:21 INFO - 'XPC_SERVICE_NAME': '0', 07:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:14:21 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-zsFDQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:14:21 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)) 07:14:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:14:21 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-CmEHQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:14:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-LHBSX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:14:22 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)) 07:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:14:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-6bs9Jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:14:22 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)) 07:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:14:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-05vPaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:14:22 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)) 07:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:14:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-H7hWVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:14:22 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)) 07:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:14:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-z8rRss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:14:22 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)) 07:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:14:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-zww717-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:14:22 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)) 07:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:14:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-nHKAsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:14:22 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)) 07:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:14:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Ddwazt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:14:22 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)) 07:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:14:22 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Wo1rVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:14:23 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)) 07:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:14:23 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ZKtdx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:14:23 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)) 07:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:14:23 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-bBIBjG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:14:23 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)) 07:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:14:23 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-MBuLtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:14:23 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)) 07:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:23 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-7vi29D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:14:23 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)) 07:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:14:23 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-mH_zqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:14:23 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)) 07:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:14:23 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-dHWg8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:14:23 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)) 07:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:14:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:14:23 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)) 07:14:23 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)) 07:14:23 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)) 07:14:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:23 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 07:14:26 INFO - Downloading blessings-1.6.tar.gz 07:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:14:26 INFO - Installing collected packages: blessings 07:14:26 INFO - Running setup.py install for blessings 07:14:26 INFO - Successfully installed blessings 07:14:26 INFO - Cleaning up... 07:14:26 INFO - Return code: 0 07:14:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:14:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:26 INFO - Reading from file tmpfile_stdout 07:14:26 INFO - Current package versions: 07:14:26 INFO - blessings == 1.6 07:14:26 INFO - blobuploader == 1.2.4 07:14:26 INFO - docopt == 0.6.1 07:14:26 INFO - manifestparser == 1.1 07:14:26 INFO - mozInstall == 1.12 07:14:26 INFO - mozcrash == 0.17 07:14:26 INFO - mozdebug == 0.1 07:14:26 INFO - mozdevice == 0.48 07:14:26 INFO - mozfile == 1.2 07:14:26 INFO - mozhttpd == 0.7 07:14:26 INFO - mozinfo == 0.9 07:14:26 INFO - mozleak == 0.1 07:14:26 INFO - mozlog == 3.1 07:14:26 INFO - moznetwork == 0.27 07:14:26 INFO - mozprocess == 0.22 07:14:26 INFO - mozprofile == 0.28 07:14:26 INFO - mozrunner == 6.11 07:14:26 INFO - mozscreenshot == 0.1 07:14:26 INFO - mozsystemmonitor == 0.0 07:14:26 INFO - moztest == 0.7 07:14:26 INFO - mozversion == 1.4 07:14:26 INFO - psutil == 3.1.1 07:14:26 INFO - requests == 1.2.3 07:14:26 INFO - wsgiref == 0.1.2 07:14:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:26 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 0x105218a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105228420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc39d55490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050b7e00>, '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 0x104ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050b2b20>, '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.SrFmVayYcU/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.uyW79JdciI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 07:14:26 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 07:14:26 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 07:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFmVayYcU/Render', 07:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:26 INFO - 'HOME': '/Users/cltbld', 07:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:26 INFO - 'LOGNAME': 'cltbld', 07:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:26 INFO - 'MOZ_NO_REMOTE': '1', 07:14:26 INFO - 'NO_EM_RESTART': '1', 07:14:26 INFO - 'PAGER': '/bin/cat', 07:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:26 INFO - 'PWD': '/builds/slave/test', 07:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:26 INFO - 'SHELL': '/bin/bash', 07:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uyW79JdciI/Listeners', 07:14:26 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 07:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:26 INFO - 'USER': 'cltbld', 07:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:26 INFO - 'XPC_FLAGS': '0x0', 07:14:26 INFO - 'XPC_SERVICE_NAME': '0', 07:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:26 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)) 07:14:26 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)) 07:14:26 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)) 07:14:26 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)) 07:14:26 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)) 07:14:26 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)) 07:14:26 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)) 07:14:26 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)) 07:14:26 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)) 07:14:26 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)) 07:14:26 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)) 07:14:26 INFO - Cleaning up... 07:14:26 INFO - Return code: 0 07:14:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:26 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 0x105218a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105228420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc39d55490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050b7e00>, '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 0x104ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050b2b20>, '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.SrFmVayYcU/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.uyW79JdciI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 07:14:26 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 07:14:26 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 07:14:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFmVayYcU/Render', 07:14:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:26 INFO - 'HOME': '/Users/cltbld', 07:14:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:26 INFO - 'LOGNAME': 'cltbld', 07:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:26 INFO - 'MOZ_NO_REMOTE': '1', 07:14:26 INFO - 'NO_EM_RESTART': '1', 07:14:26 INFO - 'PAGER': '/bin/cat', 07:14:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:26 INFO - 'PWD': '/builds/slave/test', 07:14:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:26 INFO - 'SHELL': '/bin/bash', 07:14:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uyW79JdciI/Listeners', 07:14:26 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 07:14:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:26 INFO - 'USER': 'cltbld', 07:14:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:26 INFO - 'XPC_FLAGS': '0x0', 07:14:26 INFO - 'XPC_SERVICE_NAME': '0', 07:14:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:27 INFO - Downloading/unpacking jsonschema 07:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:14:29 INFO - Downloading/unpacking functools32 (from jsonschema) 07:14:29 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 07:14:29 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 07:14:29 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 07:14:29 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 07:14:29 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 07:14:29 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 07:14:29 INFO - Downloading functools32-3.2.3-2.tar.gz 07:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:14:30 INFO - warning: no files found matching '*.txt' 07:14:30 INFO - no previously-included directories found matching 'build' 07:14:30 INFO - no previously-included directories found matching 'dist' 07:14:30 INFO - no previously-included directories found matching '.git*' 07:14:30 INFO - Installing collected packages: jsonschema, functools32 07:14:30 INFO - Running setup.py install for functools32 07:14:30 INFO - warning: no files found matching '*.txt' 07:14:30 INFO - no previously-included directories found matching 'build' 07:14:30 INFO - no previously-included directories found matching 'dist' 07:14:30 INFO - no previously-included directories found matching '.git*' 07:14:30 INFO - Successfully installed jsonschema functools32 07:14:30 INFO - Cleaning up... 07:14:30 INFO - Return code: 0 07:14:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:14: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')]} 07:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:14:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14: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')]} 07:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:14:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:14:30 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 0x105218a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105228420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc39d55490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050b7e00>, '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 0x104ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050b2b20>, '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.SrFmVayYcU/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.uyW79JdciI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 07:14:30 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 07:14:30 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 07:14:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFmVayYcU/Render', 07:14:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:14:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:14:30 INFO - 'HOME': '/Users/cltbld', 07:14:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:14:30 INFO - 'LOGNAME': 'cltbld', 07:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:14:30 INFO - 'MOZ_NO_REMOTE': '1', 07:14:30 INFO - 'NO_EM_RESTART': '1', 07:14:30 INFO - 'PAGER': '/bin/cat', 07:14:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:14:30 INFO - 'PWD': '/builds/slave/test', 07:14:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:14:30 INFO - 'SHELL': '/bin/bash', 07:14:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uyW79JdciI/Listeners', 07:14:30 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 07:14:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:14:30 INFO - 'USER': 'cltbld', 07:14:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:14:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:14:30 INFO - 'XPC_FLAGS': '0x0', 07:14:30 INFO - 'XPC_SERVICE_NAME': '0', 07:14:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:14:30 INFO - Downloading/unpacking flake8 07:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:14:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:14:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:14:32 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 07:14:32 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 07:14:32 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 07:14:32 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 07:14:32 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 07:14:32 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 07:14:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:14:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:14:33 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 07:14:33 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 07:14:33 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 07:14:33 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 07:14:33 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 07:14:33 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 07:14:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:14:33 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 07:14:33 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 07:14:33 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 07:14:33 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 07:14:33 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 07:14:33 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 07:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:14:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:34 INFO - no previously-included directories found matching 'docs/_build' 07:14:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:14:34 INFO - Running setup.py install for pep8 07:14:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:14:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:14:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:14:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:14:34 INFO - no previously-included directories found matching 'docs/_build' 07:14:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:14:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:14:34 INFO - Cleaning up... 07:14:34 INFO - Return code: 0 07:14:34 INFO - Running post-action listener: _resource_record_post_action 07:14:34 INFO - Running post-action listener: _start_resource_monitoring 07:14:34 INFO - Starting resource monitoring. 07:14:34 INFO - ##### 07:14:34 INFO - ##### Running install step. 07:14:34 INFO - ##### 07:14:34 INFO - Running pre-action listener: _resource_record_pre_action 07:14:34 INFO - Running main action method: install 07:14:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:14:34 INFO - Reading from file tmpfile_stdout 07:14:34 INFO - Detecting whether we're running mozinstall >=1.0... 07:14:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:14:35 INFO - Reading from file tmpfile_stdout 07:14:35 INFO - Output received: 07:14:35 INFO - Usage: mozinstall [options] installer 07:14:35 INFO - Options: 07:14:35 INFO - -h, --help show this help message and exit 07:14:35 INFO - -d DEST, --destination=DEST 07:14:35 INFO - Directory to install application into. [default: 07:14:35 INFO - "/builds/slave/test"] 07:14:35 INFO - --app=APP Application being installed. [default: firefox] 07:14:35 INFO - mkdir: /builds/slave/test/build/application 07:14:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:15:08 INFO - Reading from file tmpfile_stdout 07:15:08 INFO - Output received: 07:15:08 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:15:08 INFO - Running post-action listener: _resource_record_post_action 07:15:08 INFO - ##### 07:15:08 INFO - ##### Running run-tests step. 07:15:08 INFO - ##### 07:15:08 INFO - Running pre-action listener: _resource_record_pre_action 07:15:08 INFO - Running main action method: run_tests 07:15:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:08 INFO - 2016-03-29 07:15:08.974 screenresolution[3128:43036] starting screenresolution argv=screenresolution get 07:15:08 INFO - 2016-03-29 07:15:08.977 screenresolution[3128:43036] Display 0: 1600x1200x32@60 07:15:08 INFO - 2016-03-29 07:15:08.983 screenresolution[3129:43038] starting screenresolution argv=screenresolution list 07:15:08 INFO - Available Modes on Display 0 07:15:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:09 INFO - Intel Iris: 07:15:09 INFO - Chipset Model: Intel Iris 07:15:09 INFO - Type: GPU 07:15:09 INFO - Bus: Built-In 07:15:09 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:09 INFO - Vendor: Intel (0x8086) 07:15:09 INFO - Device ID: 0x0a2e 07:15:09 INFO - Revision ID: 0x0009 07:15:09 INFO - Displays: 07:15:09 INFO - Display: 07:15:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:09 INFO - Display Serial Number: 1600x1200 60 07:15:09 INFO - Main Display: Yes 07:15:09 INFO - Mirror: Off 07:15:09 INFO - Online: Yes 07:15:09 INFO - Rotation: Supported 07:15:09 INFO - Return code: 0 07:15:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:15:09 INFO - Python 2.7.3 07:15:09 INFO - Return code: 0 07:15:09 INFO - grabbing minidump binary from tooltool 07:15:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:15:09 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 0x1050b7e00>, '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 0x104ee0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050b2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:15:09 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 07:15:09 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 07:15:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:15:09 INFO - Return code: 0 07:15:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:15:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:15:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:15:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:15:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:15:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:15:10 INFO - Return code: 0 07:15:10 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/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 07:15:10 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/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --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 07:15:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SrFmVayYcU/Render', 07:15:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:15:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:15:10 INFO - 'HOME': '/Users/cltbld', 07:15:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:15:10 INFO - 'LOGNAME': 'cltbld', 07:15:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:15:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:10 INFO - 'MOZ_NO_REMOTE': '1', 07:15:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:15:10 INFO - 'NO_EM_RESTART': '1', 07:15:10 INFO - 'PAGER': '/bin/cat', 07:15:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:10 INFO - 'PWD': '/builds/slave/test', 07:15:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:15:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:15:10 INFO - 'SHELL': '/bin/bash', 07:15:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uyW79JdciI/Listeners', 07:15:10 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 07:15:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:15:10 INFO - 'USER': 'cltbld', 07:15:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:15:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:10 INFO - 'XPC_FLAGS': '0x0', 07:15:10 INFO - 'XPC_SERVICE_NAME': '0', 07:15:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:15:10 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/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--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 07:15:10 INFO - mozversion application_buildid: 20160329054133 07:15:10 INFO - mozversion application_changeset: b4941d71b4df56c6f49c6f176cd65bf8af4b0e32 07:15:10 INFO - mozversion application_display_name: Nightly 07:15:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:15:10 INFO - mozversion application_name: Firefox 07:15:10 INFO - mozversion application_remotingname: firefox 07:15:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:15:10 INFO - mozversion application_vendor: Mozilla 07:15:10 INFO - mozversion application_version: 48.0a1 07:15:10 INFO - mozversion platform_buildid: 20160329054133 07:15:10 INFO - mozversion platform_changeset: b4941d71b4df56c6f49c6f176cd65bf8af4b0e32 07:15:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:15:10 INFO - mozversion platform_version: 48.0a1 07:15:10 INFO - using testdate: 1459260910 07:15:10 INFO - actual date: 1459260910 07:15:10 INFO - starting webserver on 'localhost:53848' 07:15:10 INFO - SUITE-START | Running 2 tests 07:15:10 INFO - TEST-START | dromaeo_css 07:15:10 INFO - operating with platform_type : mac_ 07:15:10 INFO - Initialising browser for dromaeo_css test... 07:15:10 INFO - TEST-INFO | started process 3147 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmp5lfyev/profile http://localhost:53848/getInfo.html) 07:15:13 INFO - PROCESS | 3147 | __metrics Screen width/height:1600/1200 07:15:13 INFO - PROCESS | 3147 | colorDepth:24 07:15:13 INFO - PROCESS | 3147 | Browser inner width/height: 1024/689 07:15:13 INFO - PROCESS | 3147 | __metrics 07:15:13 INFO - PROCESS | 3147 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:15:13 ERROR - PROCESS | 3147 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:15:13 INFO - TEST-INFO | 3147: exit 0 07:15:13 INFO - Browser initialized. 07:15:13 INFO - Running cycle 1/1 for dromaeo_css test... 07:15:13 INFO - TEST-INFO | started process 3150 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmp5lfyev/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:25 INFO - PROCESS | 3150 | RSS: Main: 244285440 07:15:25 INFO - PROCESS | 3150 | 07:16:17 INFO - PROCESS | 3150 | 1459260977350 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] 07:18:27 INFO - PROCESS | 3150 | Cycle 1(1): loaded http://localhost:53848/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53848/tests/dromaeo/cssquery-ext.html) 07:18:28 INFO - PROCESS | 3150 | RSS: Main: 373743616 07:18:28 INFO - PROCESS | 3150 | 07:21:31 INFO - PROCESS | 3150 | Cycle 1(1): loaded http://localhost:53848/tests/dromaeo/cssquery-ext.html (next: http://localhost:53848/tests/dromaeo/cssquery-jquery.html) 07:21:31 INFO - PROCESS | 3150 | RSS: Main: 373788672 07:21:31 INFO - PROCESS | 3150 | 07:24:33 INFO - PROCESS | 3150 | Cycle 1(1): loaded http://localhost:53848/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53848/tests/dromaeo/cssquery-mootools.html) 07:24:34 INFO - PROCESS | 3150 | RSS: Main: 375238656 07:24:34 INFO - PROCESS | 3150 | 07:27:36 INFO - PROCESS | 3150 | Cycle 1(1): loaded http://localhost:53848/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53848/tests/dromaeo/cssquery-prototype.html) 07:27:36 INFO - PROCESS | 3150 | RSS: Main: 331476992 07:27:36 INFO - PROCESS | 3150 | 07:30:40 INFO - PROCESS | 3150 | Cycle 1(1): loaded http://localhost:53848/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53848/tests/dromaeo/cssquery-yui.html) 07:30:40 INFO - PROCESS | 3150 | RSS: Main: 333430784 07:30:40 INFO - PROCESS | 3150 | 07:33:43 INFO - PROCESS | 3150 | Cycle 1(1): loaded http://localhost:53848/tests/dromaeo/cssquery-yui.html (next: http://localhost:53848/tests/dromaeo/cssquery-dojo.html) 07:33:43 INFO - PROCESS | 3150 | RSS: Main: 396169216 07:33:43 INFO - PROCESS | 3150 | 07:33:43 INFO - PROCESS | 3150 | __start_tp_report 07:33:43 INFO - PROCESS | 3150 | _x_x_mozilla_page_load 07:33:43 INFO - PROCESS | 3150 | _x_x_mozilla_page_load_details 07:33:43 INFO - PROCESS | 3150 | |i|pagename|runs| 07:33:43 INFO - PROCESS | 3150 | |0;dojo.html;3122.7033431823975;3420.7605467617277;3444.586649602048;3468.9072942023263;3508.561429821272;5455.890882182354;5505.311836020497;5647.237622920905;5668.093105103184;5719.513841323493;4683.953160468386;4836.516348365161;5715.514181294585;5784;5837.474627283544;5083.720395378253;5120.129577971754;5141.82003629873;5163.302954101186;5279.260903473517;4461.286194208928;5259.579233661298;5276.12943864262;5307.363116426034;5314.654547454403;5061.949380506185;5156;5166.844994650167;5236.816711415101;5241.213817927322;4162.4796900387455;5027.195648696191;5112.43763186053;5159.922601160948;5185.533302002837;5086.135356989321;5133.998870220308;5154.917467331865;5171.3535808024;5171.689698618057;5563.332400111972;5675.148727690838;5698.31620205578;5709.229254050733;5712.285964254468;6216;6219.40915613016;6232.968835155795;6240.063990401431;6248.031555108965;6083.695815209266;6229.439350458435;6244.781432649836;6246.406591373812;6259.248890133168;5684.516816070598;5788.565857560658;5795.710214489301;5850.444207800252;5915.881682366328;6250.937490625127;6270.780522681775;6276.592021518587;6276.964300890393;6277.2153480814895;6169;6180.6909654517995;6185.628862268279;6194.38056194377;6196.504279657616;5547.77808887648;6148.631082134997;6174;6266.749330026748;6276.403741644536;6216.968915155395;6220.315765265817;6240.594361366497;6251.9687401562705;6255.12428260044;6129.662868542273;6238.781642642576;6240.65676387794;6264.342244064399;6268.934281172212;4592.288195329663;4849.830255941025;4855.247436647325;4875.95124048762;4889.462159162489;4381.518033016366;4403.075354175595;4411.338299255138;4417.763026352626;4449.332600109945;5546.889062218733;5597;5688.345840228344;5699.971500142473;5741.25363702716;6152.077188421773;6200.131981522591;6209.316975132731;6232.034034724625;6259.624422534663;5748.540116790647;5757.165211044375;5765.625234359753;5769.249997500382;5788.102844059177;5289.3652761668845;5395.919061214085;5398.892022159614;5406.972965135149;5411.891762164734;6262.373762623702;6298.7795427160745;6349.174607301022;6366.108744775643;6366.9044964326495;6180.165677633642;6219.813405597839;6242.875142497215;6246.781362652286;6249.468795152463;6141.823559979079;6333;6336.461400780985;6339.366063393623;6372.904406433814;6102.034838985013;6188.690565471618;6191.938080619136;6223.564350495421;6230.968845155745;6213;6241.843953901189;6244.625322480666;6250.343713910156;6279.026750853625;6006.789762358297;6134.969325153345;6141.048137538689;6168.784092556739;6181.196444462191;4920.237363208708;6124.326324104434;6141.881051037385;6144.634315788543;6146.739918316645;5024.497550244946;5823.4176582343125;6014.0678194879865;6018.277806663228;6018.608790428608;5158.845234642967;5978.880422391615;6076.72654730547;6083.178770865877;6107.267127944675;6033.18551995475;6040.36576159497;6084.056971169476;6087.817365479043;6104.755809767559 07:33:43 INFO - PROCESS | 3150 | |1;ext.html;474.03770346197234;514.3580151831885;575.7150210645729;621.813455963211;633.7686744338315;39520;39983.60016399839;40124.59875401245;40125.79937100318;40138;43568;44003.77998110013;44137.11725765483;44284;44312.77843610777;9568.856467152998;9777.560009799541;9777.804443911118;9780.951095244549;9800.215982721365;9716.368436051634;9889.456079915602;9894.158996485306;9900.554475048604;9911.306208565404;9859.901400986006;9934.205263578933;9939.652112176076;9941.552630131662;9943.950280248624;9780.804383912318;9887.258455615822;9897.703068907873;9902.207823374112;9907.752306192402;8488.405811593191;9640.084192001748;9760.609575616967;9792.853107203398;9807.754806129904;42388.57611423877;42788.7163385099;42809.785951070044;42957.78521107406;43017.784911075556;3080.861361238727;3200.519922011694;3357.8153201573905;3437.74216933731;3521.506989021539;28824.711752882624;30338.79367106295;30596.388072238653;30704.078877633707;30885;2656.893724251028;2696.2180967519594;2840.5881147233536;2844.5448728203596;2847.615571897788;485512;491509;498666.50666746794;498831;500297.49851250876;74373.25626743663;74444.62777686077;75208.62395688095;75242.62378688072;75288;79413.20586794174;79618.6019069901;79630.60184699156;79944;80026;17843.553911152325;18054.91670499748;18072;18078.5480362992;18141.274349026156;11553.826692599618;13335.733285334432;13440;13496.662583435493;13526.120802147829;22429.43926401853;23061.405873952455;23645.408864778517;23699.763002370102;23739.52520949606;7291.380232680282;8529.061803201643;9058.864117038249;9160.816783664422;9848.803023939481;939.5396255834592;955.3121752338305;987.693814917378;992.2359782967075;1109.4730003248553;25615;29322.560161597594;29560;31095.533566996513;31728.04815855528;946.8674385586023;1013.6654903881702;1049.5172220778375;1111.699841042914;1131.8302254661867;12000.939995299968;14670.559883203521;14929.10425374481;15168.772468412983;15194.316255768517;660187;670918;672534;675909;679189;60563.09155362673;61128.694356527936;61308.08037879435;61390;61462.078068829;1349.2376807103956;1470.4118352659023;1489.5680252726588;1515.6892836968616;1518.0739748753251;28493;28720.85639571789;29202;29290.7070929288;29418.705812941596;47765.5223447775;47859.76070119627;48180;48275.75862120667;48287.75856120697;351308;355264;355371;356194;356707;28877.422451551272;33275.83362083174;33735.493967591;34134.97595072152;34135.487967681;41364.172716546105;42485.57514424816;42512.362314564685;42716.35925461059;43270.567294326655;29275.975340862966;33412.1646958828;33725.83137084299;33907.49138762871;34641.480377794855;34872.95381138469;35273.823630881685;35349;35660.64339356677;37086;35331.940041798785;35358.823205883804;35737.1065723359;36247;36790;28690.139295821158;31768.523472147474;32014.679853202102;32146.35707285888;32406;23786.52426951486;24195;24235;24293.577981651375;24419.38951526226 07:33:43 INFO - PROCESS | 3150 | |2;jquery.html;337.75850267059053;364.6353646353646;365.0363041570255;367.97792132472034;375.0324163657763;19850.602987940234;20505.692414613775;21143.682844757343;21671.34985950424;21675.674864877;11743.47154378053;12133.968612667933;12157.696057598565;12167.209131406453;12195.573154939579;4588.9541104589025;5072.873178170538;5296.602754793386;5368.758405871726;5383.031054410205;5285.603579731516;5305.230741542474;5340.118880384732;5348.91976620351;5351.545118664918;3145.874165033396;4677.134730074947;5074.467180946003;5340.012097761907;5341.973290133544;5284.920726189111;5316.680999140045;5319.9202011969855;5322.627416080876;5328.067588172094;4431.911361772779;4484.753338566377;4969.701817890902;5083.6441449098575;5114.462981386975;24671.62992555113;24839.751602484106;24893.87977541015;25065;25767.840447179922;2067.059487932987;2185.3990152707975;2199.087378737822;2244.9551008979893;2298.0463107810237;7663.463557550974;7986.321162701177;9975.90024099757;10238.795224095476;14815.851841481663;1622.0997346472702;1719.5787032177072;1748.4404990403077;1794.3091909614761;1833.6882729935942;78636.60681696555;92889;95469.5226523863;100394.49802751013;107894.46052769687;10838.458077096113;10865.456727163768;10914.672559823219;10966.177536684621;11057.834132488018;13577.932110339583;13655.975801814904;13675.24786136772;13686.52097176594;13708.52020179289;8478.06741258461;8492.490450572861;8499.022612399529;8534.829303413897;8595.5702214889;7228.494005419675;8767.868481972775;8787.912120878837;8851.69019084329;8906.643734250558;4412.7793610319995;4418.690691651554;4428.269335559597;4454.309582014793;4477.619402350771;1806.2323512507394;1844.9815501845078;1845.8431033362315;1849.861260405475;1852.9530815089431;916.3631276263067;941.9717408477757;956.4548207521785;981.3670182732097;983.341161421849;18972.715409268872;19795.901020494806;19921.302754403816;19996.60006799885;20144.39566812998;879.5909901895649;948.6584829461389;954.4941181173989;975.6926568131016;1010.2118153895156;8215.835683286301;9139.543022848831;10302.175825933908;10374.533146008447;10392.688219353431;607533;627685;631680;643816.7809160925;644849;107412;115122.69754605029;116299.8370016306;121875;123404;997.683058362954;1028.6502589119734;1043.8173319669027;1046.2519298701466;1060.3160961179997;17409.95540267588;17553.297868085643;17847;18000.639987200444;18129.274829006692;46377.53622463867;48261.27608085952;49191.508084920126;50312.49687503078;52727.73636131795;53034.46965530295;67699.66150169217;68253;68441.65779171072;68590;7488.9625551871895;7772.106207786177;7782.416318776001;7854.096778870503;7911.8813217800625;11927.10546708983;11993.880061199276;12263.608596323631;12443.813342799684;12454.875451245372;10454.581816727246;10541.683749487527;10725.195610329101;10858.945705271422;10867.565297388015;10320.174386049248;10567.676868540493;10576.312539684895;10692.62575809843;10695.358278503314;10125.59497620087;10959.890401096205;11041.503132359223;11045.950634689692;11101.833472497758;7583.848323033619;7606.619669016416;7747.612619369122;7835.177306382976;8031.638576264199;9214.723558293263;10417.531211095671;10541.57833686644;10692.98416650417;10733.355998640107 07:33:43 INFO - PROCESS | 3150 | |3;mootools.html;1269.6825793551611;1624.658821647454;1650.4141029934374;1930.449821800787;2030.2811538879942;7942.046954365477;8704.26013788828;8845.425047371917;8852.690155844546;8889.64441422344;8547.743567692964;8782.209601135897;8793.2965362771;8796.736097917057;8831.867521987175;2183.8908054597287;2425.2724182745196;2438.5610590093775;2459.2622213336017;2489.22833921484;2492.0654754467073;2507.4608959073794;2509.422832748469;2514.6102354135137;2518.4711210645787;2397.8081753459683;2443.6823212982285;2469.777720005199;2471.1721573272885;2476.839005464648;2446.7308596054418;2475.6781618389673;2481.689788776403;2486.751324867517;2492.1152990688406;2442.68245128134;2479.1323036937106;2486.465409936854;2486.825922185448;2495.5258500884956;8851.911480885174;8939.821203575957;8950.910490895072;8954.552272386354;8971.730848074569;5355.143177091685;5516.14499752535;5517.089680202762;5552.694601796899;5584.1902924076185;3561.6438356164435;3692.981535092334;3725.8695945642044;3742.4760533525327;3753.2493501299577;1050.6270274052677;1064.675274041417;1069.8341757027674;1078.4230436716398;1081.826218552871;11868.287902725779;11882.40587970598;11887.524499020028;11932.403379831061;11998.940005299917;4808.735519546459;4856.927146092811;4960.925586116211;4965.131102057126;4976.502349765067;8967.327450441113;9829.967853375292;10010.64962726301;10072.395656260647;10080.546375413123;5499.642523235977;5515.61390702647;5520.806771762969;5535.612507124462;5550.55595552363;4448.888777780581;4587.174308624413;4587.79354929029;4630.32860235264;4774.570288673966;3805.4862593549515;3867.3812190049457;3937.8818635440985;3942.48747662802;3942.6254505821903;1297.1374036265777;1318.0510032776385;1319.7294554616471;1327.3230652367363;1327.5751759436887;1373.2378529915993;1373.7321222361543;1412.5409241996392;1419.4322271091646;1419.9077059991273;7890.566018869017;8272.917270827335;8285.212904774036;8337.041240257327;8350.62422191003;519.9990019213076;528.4741682026331;533.0591505991928;534.8101423994426;539.465928730554;6191.102290167901;6214.5960512566535;6258.280297765815;6274.560780745395;6280.309165991737;10546.209034322457;10965.890341096647;11087.944560277147;11117.499712512956;11157.497912593954;10492.73768155787;10762.300450470695;10776.568937242579;10872.891271087346;10951.945240273906;8446.450980686235;8460.534670593053;8479.70321038773;8492.787680308042;8551.657933682583;7767.223277672188;7998.000249968754;8001.719939802079;8028.397870159644;8047.919520804951;7700.691972321044;9733.124018838056;9735.659251926148;9744.902550974683;9813.411195328303;9905.603775849173;10061.144802691853;10071.295009349275;10111.191104711752;10127.59489620407;7306.3789577884345;7513.924860751323;7571.242875712384;7595.696172153052;7612.733554325572;8315.792105197419;8351.415400921876;8379.45533540318;8385.748427547183;8393.916060839314;7289.817754556178;7353.77938661841;7416;7501.437392195498;7533.1336896257635;7229.313215244543;7299.671514781954;7330.816729581803;7364.410847132323;7375.37309328713;7695.384369250334;7821.139674635671;7876.960615196887;7877.448578599443;7883.5664038478435;6107.4197951194565;7053.682584283617;7086;7139.714411423693;7153.284671533013;7141;7243.5653860768525;7248;7256.7097316106765;7256.7822965311125 07:33:43 INFO - PROCESS | 3150 | |4;prototype.html;286.39713403286083;322.38585494632724;327.08416433984837;332.9550510681059;339.77744577301877;6535.3137920518375;6556.213254409466;6564.671766411672;6622.304658010912;6654.234763002256;6126.23422072241;6444.452221561173;6524.445422139124;6534.934650653492;6545.705443255053;3855.036240939765;4325.610695037446;4613.953860461403;4746.382970213867;4759.500252473493;4724.196886529281;4765.69023013503;4768.61851051915;4827.468978412372;4847.975760121212;4739.336492890998;4748.287756836467;4763.928541071887;4767.5709186173235;4776.402949631296;4750.786214620351;4757.762111894426;4762.261849413329;4763.904721905577;4781.258904869751;3939.5666476687543;4015.9397609035886;4115.42384066228;4115.753054816721;4131.153113611733;6197.202811184751;6217.658028808413;6235.688215589203;6257.405546473078;6289.433950944437;5759.510441612426;5767.307923049219;5774.393688662672;5786.0742281235225;5789.739461724233;5089.745512724386;6866.485013623948;6940.236573976858;6945.201301850301;6962.756303529352;4658.953410465886;4659.930101048487;4664.86005419838;4672.626189904833;4673.299005149221;6955.930440695579;7210.990461335365;7231.493795434321;7233.240509746453;7240.348368646794;4651.767411629405;4730.385049943554;4775.785089670973;4779.569838714463;4787.712737235707;4866.489018653061;4875.293082503017;4879.243717223836;4879.926801097987;4881.707097574157;5698.800541981011;5701.572382071361;5711.057675483582;5716.885662286731;5722.885542289214;6670.299618540081;6927.064846245692;6933.677218131982;6949.131358580177;6960.443164546824;1666.9583260418344;1682.1505139904514;1691.4756425508133;1693.796744390681;1705.6418152187932;1091.3779145886926;1091.49245600796;1106.7177869643351;1110.3615421132881;1111.1166622535104;5597.888042239132;6314.778982735674;6351.142595749607;6469.223693156851;6598.505112116611;7236.9276307237305;7254.528455650366;7260.818479538054;7265.273472652798;7269.127704675367;5767.711614419262;6241.812745617639;6713.362230588086;6757.425618822357;6761.898571521431;3265.820379879082;3317.104381816896;3698.7780733156096;3845.6346647068485;3855.9421608675893;7267;7553.055868016498;7588.772336829904;7602.8099297518;7636.198199189116;7430.888536671954;7474.364679002237;7497.250274972459;7501.737439189602;7503.812404689817;6834.316568343126;7047.788566343018;7592.088949326117;7595.5822429766895;7634.50375725576;5662.462066103713;6987.847005244281;7268.236835132447;7269.127704675473;7301.744438944612;6162.476189523941;6890.552114112566;7135.678894449866;7152.499325047197;7157.7136914522835;6847.897281540681;6952.922297043966;7529.171791103084;7586.544807311579;7595.278448547379;3894.727369084137;4326.97836510828;4602.125596136723;4615.469221039623;4622.260438329851;5854.707264636836;5974.1934838796205;6807.285235050248;7195.6761945713615;7226.385757210696;6724.260331363644;6968.965155174192;6990.370866622028;6997.930020699931;7004.509684322253;6126.754929802936;6494.383033611988;7092.929070709433;7114.14630244374;7176.7846964591145;6826.658667066527;6842.0763196969765;6857.691403886937;6860.108185935996;6860.3139686031;5766.769329226784;6982;6994.790156295319;6995.160580730345;7014.824629384306;6499.870002600016;6572.474202063919;6660.533762636763;6834.350736680008;6839.69221385029 07:33:43 INFO - PROCESS | 3150 | |5;yui.html;686.7562015484502;767.8195624028352;775.6742168289318;779.1585088104847;780.8672525670636;13454.46182152714;15176.696466070685;15342.232888355593;15354.84645153548;15356.61608459789;13734.725305493885;14233.074850134733;14233.288335583205;14234.288285585706;14235.217063061527;753.1489416958829;761.3262262897321;933.785229397239;952.7189479103681;963.3449254506933;757.3524636435851;763.6067425275987;763.728876248932;926.5228407370209;957.7318350861769;988.9554970026367;1000;1002.1331548210818;1002.6490728245093;1005.5073014223015;985.1084768284713;992.5682328187262;994.602159136344;995.9004099590055;999.6701088640731;594.3313772006493;599.2150283129115;739.8113481062295;744.292921724364;754.031070074951;15238.009529380666;15276;15289.006214596016;15316;15317.46388876384;12391.566295179626;12394.938025309815;12410.81383779244;12607.369631518479;12664.68338291541;9544.284178686627;9948.651797187063;10204.183665306758;10280.12618927392;10565.683029509128;3426.1605906552804;3466.4280393735003;3519.5072689823446;3532.5937517185594;3734.309152806712;68631.62736745286;68760.6561967187;71236.64381678162;71349.43252837389;71725;9447.339113833492;9488.146066854017;9502.90497095034;9767.853482197772;9860.112589866947;21283.935803209777;21933.232336868132;21985.010674519366;22000.669989950162;22062.779372206074;7389.224131466226;7524.134724506752;7558.093028836465;7562.357199638092;7858.17489163641;4026.255142798592;4076.4496792932573;4121.814518346681;4143.6892233082635;4202.726822756572;3625.9093522662142;3653.7807731535663;3658.158623516606;3658.835352409148;3670.4310831821113;662.0697919423218;662.6355504472521;672.1396612336217;679.4055201698513;685.9074025006561;568.8208214412447;591.3938213331284;599.3676671112019;629.5372900917822;630.2940706408851;7635.198304177981;8048.356131509465;8183.590820459072;8302.916970830334;8356.247937685637;575.9884802303931;598.6916737879995;602.6052935327367;624.4099326136757;624.6158612453308;3603.621619729943;3728.6457786510236;3783.9243215135543;3891.610838916086;3908.762308363455;94934;96870.0312996861;97603;98383.50808246057;98385;78838;80554.19445805585;80571.38857222823;80611.7908231377;82697.58651206705;71651.56696866138;72782.54434911378;72992.27007729854;73079.63460182665;73918.26081739222;7738.574378409242;7771.961140194263;7855.057393112863;7893.250141236574;8012.158723333966;50570;51231.74384128056;51477.48522514727;51707.741461292455;53459.732701336245;67206;69222;69268.61462770817;70339.64830175816;71281.64359178171;9795.118439340493;9888.159506442033;9891.604335826487;9915.504224788876;10739.731506712395;10644;11025.889741102486;11392.487338069972;11780.882191177978;11935.283882967049;10123;10438.530266138194;10602.151827853908;10668.733281668021;10738.516766745359;8054.184501405318;11101.722456938642;11259.493322800658;11600.129990250596;12288.447019884305;10960.506777195205;10973.945130274298;10981.176411768989;11178.552857885594;12109;9241.768955776159;9381.484018379055;9506.952465237906;9813.607455701978;9818.75453113678;8847.778805529913;9082.545872706207;9578;9594.328397012143;9653.2277417805 07:33:43 INFO - PROCESS | 3150 | __end_tp_report 07:33:43 INFO - PROCESS | 3150 | __start_cc_report 07:33:43 INFO - PROCESS | 3150 | _x_x_mozilla_cycle_collect,1182 07:33:43 INFO - PROCESS | 3150 | __end_cc_report 07:33:43 INFO - PROCESS | 3150 | __startTimestamp1459262023542__endTimestamp 07:33:43 INFO - PROCESS | 3150 | 07:33:43 INFO - PROCESS | 3150 | ------- Summary: start ------- 07:33:43 INFO - PROCESS | 3150 | Number of tests: 6 07:33:43 INFO - PROCESS | 3150 | 07:33:43 INFO - PROCESS | 3150 | [#0] dojo.html Cycles:165 Average:5700.05 Median:6014.07 stddev:677.69 (11.3%) stddev-sans-first:648.91 07:33:43 INFO - PROCESS | 3150 | Values: 3122.7 3420.8 3444.6 3468.9 3508.6 5455.9 5505.3 5647.2 5668.1 5719.5 4684.0 4836.5 5715.5 5784.0 5837.5 5083.7 5120.1 5141.8 5163.3 5279.3 4461.3 5259.6 5276.1 5307.4 5314.7 5061.9 5156.0 5166.8 5236.8 5241.2 4162.5 5027.2 5112.4 5159.9 5185.5 5086.1 5134.0 5154.9 5171.4 5171.7 5563.3 5675.1 5698.3 5709.2 5712.3 6216.0 6219.4 6233.0 6240.1 6248.0 6083.7 6229.4 6244.8 6246.4 6259.2 5684.5 5788.6 5795.7 5850.4 5915.9 6250.9 6270.8 6276.6 6277.0 6277.2 6169.0 6180.7 6185.6 6194.4 6196.5 5547.8 6148.6 6174.0 6266.7 6276.4 6217.0 6220.3 6240.6 6252.0 6255.1 6129.7 6238.8 6240.7 6264.3 6268.9 4592.3 4849.8 4855.2 4876.0 4889.5 4381.5 4403.1 4411.3 4417.8 4449.3 5546.9 5597.0 5688.3 5700.0 5741.3 6152.1 6200.1 6209.3 6232.0 6259.6 5748.5 5757.2 5765.6 5769.2 5788.1 5289.4 5395.9 5398.9 5407.0 5411.9 6262.4 6298.8 6349.2 6366.1 6366.9 6180.2 6219.8 6242.9 6246.8 6249.5 6141.8 6333.0 6336.5 6339.4 6372.9 6102.0 6188.7 6191.9 6223.6 6231.0 6213.0 6241.8 6244.6 6250.3 6279.0 6006.8 6135.0 6141.0 6168.8 6181.2 4920.2 6124.3 6141.9 6144.6 6146.7 5024.5 5823.4 6014.1 6018.3 6018.6 5158.8 5978.9 6076.7 6083.2 6107.3 6033.2 6040.4 6084.1 6087.8 6104.8 07:33:43 INFO - PROCESS | 3150 | 07:33:43 INFO - PROCESS | 3150 | [#1] ext.html Cycles:180 Average:65923.63 Median:39751.80 stddev:140014.39 (352.2%) stddev-sans-first:140320.94 07:33:43 INFO - PROCESS | 3150 | Values: 474.0 514.4 575.7 621.8 633.8 39520.0 39983.6 40124.6 40125.8 40138.0 43568.0 44003.8 44137.1 44284.0 44312.8 9568.9 9777.6 9777.8 9781.0 9800.2 9716.4 9889.5 9894.2 9900.6 9911.3 9859.9 9934.2 9939.7 9941.6 9944.0 9780.8 9887.3 9897.7 9902.2 9907.8 8488.4 9640.1 9760.6 9792.9 9807.8 42388.6 42788.7 42809.8 42957.8 43017.8 3080.9 3200.5 3357.8 3437.7 3521.5 28824.7 30338.8 30596.4 30704.1 30885.0 2656.9 2696.2 2840.6 2844.5 2847.6 485512.0 491509.0 498666.5 498831.0 500297.5 74373.3 74444.6 75208.6 75242.6 75288.0 79413.2 79618.6 79630.6 79944.0 80026.0 17843.6 18054.9 18072.0 18078.5 18141.3 11553.8 13335.7 13440.0 13496.7 13526.1 22429.4 23061.4 23645.4 23699.8 23739.5 7291.4 8529.1 9058.9 9160.8 9848.8 939.5 955.3 987.7 992.2 1109.5 25615.0 29322.6 29560.0 31095.5 31728.0 946.9 1013.7 1049.5 1111.7 1131.8 12000.9 14670.6 14929.1 15168.8 15194.3 660187.0 670918.0 672534.0 675909.0 679189.0 60563.1 61128.7 61308.1 61390.0 61462.1 1349.2 1470.4 1489.6 1515.7 1518.1 28493.0 28720.9 29202.0 29290.7 29418.7 47765.5 47859.8 48180.0 48275.8 48287.8 351308.0 355264.0 355371.0 356194.0 356707.0 28877.4 33275.8 33735.5 34135.0 34135.5 41364.2 42485.6 42512.4 42716.4 43270.6 29276.0 33412.2 33725.8 33907.5 34641.5 34873.0 35273.8 35349.0 35660.6 37086.0 35331.9 35358.8 35737.1 36247.0 36790.0 28690.1 31768.5 32014.7 32146.4 32406.0 23786.5 24195.0 24235.0 24293.6 24419.4 07:33:43 INFO - PROCESS | 3150 | 07:33:43 INFO - PROCESS | 3150 | [#2] jquery.html Cycles:180 Average:33991.05 Median:14456.86 stddev:104359.33 (721.9%) stddev-sans-first:104621.49 07:33:43 INFO - PROCESS | 3150 | Values: 337.8 364.6 365.0 368.0 375.0 19850.6 20505.7 21143.7 21671.3 21675.7 11743.5 12134.0 12157.7 12167.2 12195.6 4589.0 5072.9 5296.6 5368.8 5383.0 5285.6 5305.2 5340.1 5348.9 5351.5 3145.9 4677.1 5074.5 5340.0 5342.0 5284.9 5316.7 5319.9 5322.6 5328.1 4431.9 4484.8 4969.7 5083.6 5114.5 24671.6 24839.8 24893.9 25065.0 25767.8 2067.1 2185.4 2199.1 2245.0 2298.0 7663.5 7986.3 9975.9 10238.8 14815.9 1622.1 1719.6 1748.4 1794.3 1833.7 78636.6 92889.0 95469.5 100394.5 107894.5 10838.5 10865.5 10914.7 10966.2 11057.8 13577.9 13656.0 13675.2 13686.5 13708.5 8478.1 8492.5 8499.0 8534.8 8595.6 7228.5 8767.9 8787.9 8851.7 8906.6 4412.8 4418.7 4428.3 4454.3 4477.6 1806.2 1845.0 1845.8 1849.9 1853.0 916.4 942.0 956.5 981.4 983.3 18972.7 19795.9 19921.3 19996.6 20144.4 879.6 948.7 954.5 975.7 1010.2 8215.8 9139.5 10302.2 10374.5 10392.7 607533.0 627685.0 631680.0 643816.8 644849.0 107412.0 115122.7 116299.8 121875.0 123404.0 997.7 1028.7 1043.8 1046.3 1060.3 17410.0 17553.3 17847.0 18000.6 18129.3 46377.5 48261.3 49191.5 50312.5 52727.7 53034.5 67699.7 68253.0 68441.7 68590.0 7489.0 7772.1 7782.4 7854.1 7911.9 11927.1 11993.9 12263.6 12443.8 12454.9 10454.6 10541.7 10725.2 10858.9 10867.6 10320.2 10567.7 10576.3 10692.6 10695.4 10125.6 10959.9 11041.5 11046.0 11101.8 7583.8 7606.6 7747.6 7835.2 8031.6 9214.7 10417.5 10541.6 10693.0 10733.4 07:33:43 INFO - PROCESS | 3150 | 07:33:43 INFO - PROCESS | 3150 | [#3] mootools.html Cycles:180 Average:6088.30 Median:2944.98 stddev:3227.55 (109.6%) stddev-sans-first:3216.27 07:33:43 INFO - PROCESS | 3150 | Values: 1269.7 1624.7 1650.4 1930.4 2030.3 7942.0 8704.3 8845.4 8852.7 8889.6 8547.7 8782.2 8793.3 8796.7 8831.9 2183.9 2425.3 2438.6 2459.3 2489.2 2492.1 2507.5 2509.4 2514.6 2518.5 2397.8 2443.7 2469.8 2471.2 2476.8 2446.7 2475.7 2481.7 2486.8 2492.1 2442.7 2479.1 2486.5 2486.8 2495.5 8851.9 8939.8 8950.9 8954.6 8971.7 5355.1 5516.1 5517.1 5552.7 5584.2 3561.6 3693.0 3725.9 3742.5 3753.2 1050.6 1064.7 1069.8 1078.4 1081.8 11868.3 11882.4 11887.5 11932.4 11998.9 4808.7 4856.9 4960.9 4965.1 4976.5 8967.3 9830.0 10010.6 10072.4 10080.5 5499.6 5515.6 5520.8 5535.6 5550.6 4448.9 4587.2 4587.8 4630.3 4774.6 3805.5 3867.4 3937.9 3942.5 3942.6 1297.1 1318.1 1319.7 1327.3 1327.6 1373.2 1373.7 1412.5 1419.4 1419.9 7890.6 8272.9 8285.2 8337.0 8350.6 520.0 528.5 533.1 534.8 539.5 6191.1 6214.6 6258.3 6274.6 6280.3 10546.2 10965.9 11087.9 11117.5 11157.5 10492.7 10762.3 10776.6 10872.9 10951.9 8446.5 8460.5 8479.7 8492.8 8551.7 7767.2 7998.0 8001.7 8028.4 8047.9 7700.7 9733.1 9735.7 9744.9 9813.4 9905.6 10061.1 10071.3 10111.2 10127.6 7306.4 7513.9 7571.2 7595.7 7612.7 8315.8 8351.4 8379.5 8385.7 8393.9 7289.8 7353.8 7416.0 7501.4 7533.1 7229.3 7299.7 7330.8 7364.4 7375.4 7695.4 7821.1 7877.0 7877.4 7883.6 6107.4 7053.7 7086.0 7139.7 7153.3 7141.0 7243.6 7248.0 7256.7 7256.8 07:33:43 INFO - PROCESS | 3150 | 07:33:43 INFO - PROCESS | 3150 | [#4] prototype.html Cycles:180 Average:5657.41 Median:6302.11 stddev:1794.16 (28.5%) stddev-sans-first:1753.31 07:33:43 INFO - PROCESS | 3150 | Values: 286.4 322.4 327.1 333.0 339.8 6535.3 6556.2 6564.7 6622.3 6654.2 6126.2 6444.5 6524.4 6534.9 6545.7 3855.0 4325.6 4614.0 4746.4 4759.5 4724.2 4765.7 4768.6 4827.5 4848.0 4739.3 4748.3 4763.9 4767.6 4776.4 4750.8 4757.8 4762.3 4763.9 4781.3 3939.6 4015.9 4115.4 4115.8 4131.2 6197.2 6217.7 6235.7 6257.4 6289.4 5759.5 5767.3 5774.4 5786.1 5789.7 5089.7 6866.5 6940.2 6945.2 6962.8 4659.0 4659.9 4664.9 4672.6 4673.3 6955.9 7211.0 7231.5 7233.2 7240.3 4651.8 4730.4 4775.8 4779.6 4787.7 4866.5 4875.3 4879.2 4879.9 4881.7 5698.8 5701.6 5711.1 5716.9 5722.9 6670.3 6927.1 6933.7 6949.1 6960.4 1667.0 1682.2 1691.5 1693.8 1705.6 1091.4 1091.5 1106.7 1110.4 1111.1 5597.9 6314.8 6351.1 6469.2 6598.5 7236.9 7254.5 7260.8 7265.3 7269.1 5767.7 6241.8 6713.4 6757.4 6761.9 3265.8 3317.1 3698.8 3845.6 3855.9 7267.0 7553.1 7588.8 7602.8 7636.2 7430.9 7474.4 7497.3 7501.7 7503.8 6834.3 7047.8 7592.1 7595.6 7634.5 5662.5 6987.8 7268.2 7269.1 7301.7 6162.5 6890.6 7135.7 7152.5 7157.7 6847.9 6952.9 7529.2 7586.5 7595.3 3894.7 4327.0 4602.1 4615.5 4622.3 5854.7 5974.2 6807.3 7195.7 7226.4 6724.3 6969.0 6990.4 6997.9 7004.5 6126.8 6494.4 7092.9 7114.1 7176.8 6826.7 6842.1 6857.7 6860.1 6860.3 5766.8 6982.0 6994.8 6995.2 7014.8 6499.9 6572.5 6660.5 6834.4 6839.7 07:33:43 INFO - PROCESS | 3150 | 07:33:43 INFO - PROCESS | 3150 | [#5] yui.html Cycles:180 Average:18312.97 Median:667.39 stddev:25973.60 (3891.8%) stddev-sans-first:26012.74 07:33:43 INFO - PROCESS | 3150 | Values: 686.8 767.8 775.7 779.2 780.9 13454.5 15176.7 15342.2 15354.8 15356.6 13734.7 14233.1 14233.3 14234.3 14235.2 753.1 761.3 933.8 952.7 963.3 757.4 763.6 763.7 926.5 957.7 989.0 1000.0 1002.1 1002.6 1005.5 985.1 992.6 994.6 995.9 999.7 594.3 599.2 739.8 744.3 754.0 15238.0 15276.0 15289.0 15316.0 15317.5 12391.6 12394.9 12410.8 12607.4 12664.7 9544.3 9948.7 10204.2 10280.1 10565.7 3426.2 3466.4 3519.5 3532.6 3734.3 68631.6 68760.7 71236.6 71349.4 71725.0 9447.3 9488.1 9502.9 9767.9 9860.1 21283.9 21933.2 21985.0 22000.7 22062.8 7389.2 7524.1 7558.1 7562.4 7858.2 4026.3 4076.4 4121.8 4143.7 4202.7 3625.9 3653.8 3658.2 3658.8 3670.4 662.1 662.6 672.1 679.4 685.9 568.8 591.4 599.4 629.5 630.3 7635.2 8048.4 8183.6 8302.9 8356.2 576.0 598.7 602.6 624.4 624.6 3603.6 3728.6 3783.9 3891.6 3908.8 94934.0 96870.0 97603.0 98383.5 98385.0 78838.0 80554.2 80571.4 80611.8 82697.6 71651.6 72782.5 72992.3 73079.6 73918.3 7738.6 7772.0 7855.1 7893.3 8012.2 50570.0 51231.7 51477.5 51707.7 53459.7 67206.0 69222.0 69268.6 70339.6 71281.6 9795.1 9888.2 9891.6 9915.5 10739.7 10644.0 11025.9 11392.5 11780.9 11935.3 10123.0 10438.5 10602.2 10668.7 10738.5 8054.2 11101.7 11259.5 11600.1 12288.4 10960.5 10973.9 10981.2 11178.6 12109.0 9241.8 9381.5 9507.0 9813.6 9818.8 8847.8 9082.5 9578.0 9594.3 9653.2 07:33:43 INFO - PROCESS | 3150 | -------- Summary: end -------- 07:33:43 INFO - PROCESS | 3150 | 07:33:44 INFO - TEST-INFO | 3150: exit 0 07:33:44 INFO - TEST-OK | dromaeo_css | took 1113435ms 07:33:44 INFO - TEST-START | kraken 07:33:44 INFO - operating with platform_type : mac_ 07:33:44 INFO - Initialising browser for kraken test... 07:33:44 INFO - TEST-INFO | started process 3156 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmphAz0CE/profile http://localhost:53848/getInfo.html) 07:33:46 INFO - PROCESS | 3156 | __metrics Screen width/height:1600/1200 07:33:46 INFO - PROCESS | 3156 | colorDepth:24 07:33:46 INFO - PROCESS | 3156 | Browser inner width/height: 1024/689 07:33:46 INFO - PROCESS | 3156 | __metrics 07:33:46 INFO - PROCESS | 3156 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:33:46 ERROR - PROCESS | 3156 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:33:46 INFO - TEST-INFO | 3156: exit 0 07:33:46 INFO - Browser initialized. 07:33:46 INFO - Running cycle 1/1 for kraken test... 07:33:46 INFO - TEST-INFO | started process 3158 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmphAz0CE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:58 INFO - PROCESS | 3158 | RSS: Main: 244305920 07:33:58 INFO - PROCESS | 3158 | 07:34:01 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53848/tests/kraken/driver.html?testName=audio-beat-detection) 07:34:02 INFO - PROCESS | 3158 | RSS: Main: 291012608 07:34:02 INFO - PROCESS | 3158 | 07:34:04 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53848/tests/kraken/driver.html?testName=audio-dft) 07:34:05 INFO - PROCESS | 3158 | RSS: Main: 300896256 07:34:05 INFO - PROCESS | 3158 | 07:34:08 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53848/tests/kraken/driver.html?testName=audio-fft) 07:34:09 INFO - PROCESS | 3158 | RSS: Main: 288149504 07:34:09 INFO - PROCESS | 3158 | 07:34:11 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53848/tests/kraken/driver.html?testName=audio-oscillator) 07:34:12 INFO - PROCESS | 3158 | RSS: Main: 289775616 07:34:12 INFO - PROCESS | 3158 | 07:34:14 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53848/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:34:14 INFO - PROCESS | 3158 | RSS: Main: 290762752 07:34:14 INFO - PROCESS | 3158 | 07:34:17 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53848/tests/kraken/driver.html?testName=imaging-darkroom) 07:34:18 INFO - PROCESS | 3158 | RSS: Main: 291004416 07:34:18 INFO - PROCESS | 3158 | 07:34:20 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53848/tests/kraken/driver.html?testName=imaging-desaturate) 07:34:21 INFO - PROCESS | 3158 | RSS: Main: 292081664 07:34:21 INFO - PROCESS | 3158 | 07:34:24 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53848/tests/kraken/driver.html?testName=json-parse-financial) 07:34:24 INFO - PROCESS | 3158 | RSS: Main: 291991552 07:34:24 INFO - PROCESS | 3158 | 07:34:26 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53848/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:34:27 INFO - PROCESS | 3158 | RSS: Main: 325484544 07:34:27 INFO - PROCESS | 3158 | 07:34:28 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53848/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:34:29 INFO - PROCESS | 3158 | RSS: Main: 326541312 07:34:29 INFO - PROCESS | 3158 | 07:34:31 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53848/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:34:32 INFO - PROCESS | 3158 | RSS: Main: 331395072 07:34:32 INFO - PROCESS | 3158 | 07:34:34 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:34:35 INFO - PROCESS | 3158 | RSS: Main: 332546048 07:34:35 INFO - PROCESS | 3158 | 07:34:37 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:34:38 INFO - PROCESS | 3158 | RSS: Main: 332386304 07:34:38 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | Cycle 1(1): loaded http://localhost:53848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53848/tests/kraken/driver.html?testName=ai-astar) 07:34:40 INFO - PROCESS | 3158 | RSS: Main: 394850304 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | __start_tp_report 07:34:40 INFO - PROCESS | 3158 | _x_x_mozilla_page_load 07:34:40 INFO - PROCESS | 3158 | _x_x_mozilla_page_load_details 07:34:40 INFO - PROCESS | 3158 | |i|pagename|runs| 07:34:40 INFO - PROCESS | 3158 | |0;ai-astar;114;107;111;112;112;113;116;112;112;115 07:34:40 INFO - PROCESS | 3158 | |1;audio-beat-detection;159;123;170;178;119;145;121;156;152;118 07:34:40 INFO - PROCESS | 3158 | |2;audio-dft;179;182;183;199;247;268;184;185;182;181 07:34:40 INFO - PROCESS | 3158 | |3;audio-fft;82;79;86;80;55;58;58;74;78;59 07:34:40 INFO - PROCESS | 3158 | |4;audio-oscillator;94;96;130;78;78;81;116;88;117;155 07:34:40 INFO - PROCESS | 3158 | |5;imaging-gaussian-blur;88;84;87;84;87;84;88;84;87;84 07:34:40 INFO - PROCESS | 3158 | |6;imaging-darkroom;93;93;94;93;93;93;93;95;91;93 07:34:40 INFO - PROCESS | 3158 | |7;imaging-desaturate;86;85;85;87;86;84;85;83;85;86 07:34:40 INFO - PROCESS | 3158 | |8;json-parse-financial;54;54;52;73;80;78;79;68;56;51 07:34:40 INFO - PROCESS | 3158 | |9;json-stringify-tinderbox;63;67;75;76;71;72;69;65;69;68 07:34:40 INFO - PROCESS | 3158 | |10;stanford-crypto-aes;83;84;85;84;84;82;84;81;85;85 07:34:40 INFO - PROCESS | 3158 | |11;stanford-crypto-ccm;122;136;132;138;122;131;126;132;112;121 07:34:40 INFO - PROCESS | 3158 | |12;stanford-crypto-pbkdf2;141;130;142;135;134;123;139;136;136;138 07:34:40 INFO - PROCESS | 3158 | |13;stanford-crypto-sha256-iterative;67;68;66;68;68;67;65;81;93;91 07:34:40 INFO - PROCESS | 3158 | __end_tp_report 07:34:40 INFO - PROCESS | 3158 | __start_cc_report 07:34:40 INFO - PROCESS | 3158 | _x_x_mozilla_cycle_collect,1227 07:34:40 INFO - PROCESS | 3158 | __end_cc_report 07:34:40 INFO - PROCESS | 3158 | __startTimestamp1459262080573__endTimestamp 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | ------- Summary: start ------- 07:34:40 INFO - PROCESS | 3158 | Number of tests: 14 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:2.46 (2.2%) stddev-sans-first:2.54 07:34:40 INFO - PROCESS | 3158 | Values: 114.0 107.0 111.0 112.0 112.0 113.0 116.0 112.0 112.0 115.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:154.00 stddev:22.45 (14.6%) stddev-sans-first:23.16 07:34:40 INFO - PROCESS | 3158 | Values: 159.0 123.0 170.0 178.0 119.0 145.0 121.0 156.0 152.0 118.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#2] audio-dft Cycles:10 Average:199.00 Median:184.50 stddev:31.70 (17.2%) stddev-sans-first:32.79 07:34:40 INFO - PROCESS | 3158 | Values: 179.0 182.0 183.0 199.0 247.0 268.0 184.0 185.0 182.0 181.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#3] audio-fft Cycles:10 Average:70.90 Median:78.50 stddev:11.96 (15.2%) stddev-sans-first:11.99 07:34:40 INFO - PROCESS | 3158 | Values: 82.0 79.0 86.0 80.0 55.0 58.0 58.0 74.0 78.0 59.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:79.50 stddev:25.57 (32.2%) stddev-sans-first:26.90 07:34:40 INFO - PROCESS | 3158 | Values: 94.0 96.0 130.0 78.0 78.0 81.0 116.0 88.0 117.0 155.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#5] imaging-gaussian-blur Cycles:10 Average:85.70 Median:87.00 stddev:1.83 (2.1%) stddev-sans-first:1.74 07:34:40 INFO - PROCESS | 3158 | Values: 88.0 84.0 87.0 84.0 87.0 84.0 88.0 84.0 87.0 84.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.99 (1.1%) stddev-sans-first:1.05 07:34:40 INFO - PROCESS | 3158 | Values: 93.0 93.0 94.0 93.0 93.0 93.0 93.0 95.0 91.0 93.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:1.14 (1.3%) stddev-sans-first:1.17 07:34:40 INFO - PROCESS | 3158 | Values: 86.0 85.0 85.0 87.0 86.0 84.0 85.0 83.0 85.0 86.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:70.50 stddev:12.24 (17.4%) stddev-sans-first:12.38 07:34:40 INFO - PROCESS | 3158 | Values: 54.0 54.0 52.0 73.0 80.0 78.0 79.0 68.0 56.0 51.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:4.12 (5.9%) stddev-sans-first:3.63 07:34:40 INFO - PROCESS | 3158 | Values: 63.0 67.0 75.0 76.0 71.0 72.0 69.0 65.0 69.0 68.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.34 (1.6%) stddev-sans-first:1.39 07:34:40 INFO - PROCESS | 3158 | Values: 83.0 84.0 85.0 84.0 84.0 82.0 84.0 81.0 85.0 85.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:131.50 stddev:8.02 (6.1%) stddev-sans-first:8.29 07:34:40 INFO - PROCESS | 3158 | Values: 122.0 136.0 132.0 138.0 122.0 131.0 126.0 132.0 112.0 121.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.40 Median:137.00 stddev:5.58 (4.1%) stddev-sans-first:5.54 07:34:40 INFO - PROCESS | 3158 | Values: 141.0 130.0 142.0 135.0 134.0 123.0 139.0 136.0 136.0 138.0 07:34:40 INFO - PROCESS | 3158 | 07:34:40 INFO - PROCESS | 3158 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:68.00 stddev:10.78 (15.9%) stddev-sans-first:11.19 07:34:40 INFO - PROCESS | 3158 | Values: 67.0 68.0 66.0 68.0 68.0 67.0 65.0 81.0 93.0 91.0 07:34:40 INFO - PROCESS | 3158 | -------- Summary: end -------- 07:34:40 INFO - PROCESS | 3158 | 07:34:41 INFO - TEST-INFO | 3158: exit 0 07:34:41 INFO - TEST-OK | kraken | took 57209ms 07:34:41 INFO - SUITE-END | took 1170s 07:34:41 INFO - Completed test suite (00:19:30) 07:34:41 INFO - javascript benchmark 07:34:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3122.7033431823975, 3420.7605467617277, 3444.586649602048, 3468.9072942023263, 3508.561429821272, 5455.890882182354, 5505.311836020497, 5647.237622920905, 5668.093105103184, 5719.513841323493, 4683.953160468386, 4836.516348365161, 5715.514181294585, 5784.0, 5837.474627283544, 5083.720395378253, 5120.129577971754, 5141.82003629873, 5163.302954101186, 5279.260903473517, 4461.286194208928, 5259.579233661298, 5276.12943864262, 5307.363116426034, 5314.654547454403, 5061.949380506185, 5156.0, 5166.844994650167, 5236.816711415101, 5241.213817927322, 4162.4796900387455, 5027.195648696191, 5112.43763186053, 5159.922601160948, 5185.533302002837, 5086.135356989321, 5133.998870220308, 5154.917467331865, 5171.3535808024, 5171.689698618057, 5563.332400111972, 5675.148727690838, 5698.31620205578, 5709.229254050733, 5712.285964254468, 6216.0, 6219.40915613016, 6232.968835155795, 6240.063990401431, 6248.031555108965, 6083.695815209266, 6229.439350458435, 6244.781432649836, 6246.406591373812, 6259.248890133168, 5684.516816070598, 5788.565857560658, 5795.710214489301, 5850.444207800252, 5915.881682366328, 6250.937490625127, 6270.780522681775, 6276.592021518587, 6276.964300890393, 6277.2153480814895, 6169.0, 6180.6909654517995, 6185.628862268279, 6194.38056194377, 6196.504279657616, 5547.77808887648, 6148.631082134997, 6174.0, 6266.749330026748, 6276.403741644536, 6216.968915155395, 6220.315765265817, 6240.594361366497, 6251.9687401562705, 6255.12428260044, 6129.662868542273, 6238.781642642576, 6240.65676387794, 6264.342244064399, 6268.934281172212, 4592.288195329663, 4849.830255941025, 4855.247436647325, 4875.95124048762, 4889.462159162489, 4381.518033016366, 4403.075354175595, 4411.338299255138, 4417.763026352626, 4449.332600109945, 5546.889062218733, 5597.0, 5688.345840228344, 5699.971500142473, 5741.25363702716, 6152.077188421773, 6200.131981522591, 6209.316975132731, 6232.034034724625, 6259.624422534663, 5748.540116790647, 5757.165211044375, 5765.625234359753, 5769.249997500382, 5788.102844059177, 5289.3652761668845, 5395.919061214085, 5398.892022159614, 5406.972965135149, 5411.891762164734, 6262.373762623702, 6298.7795427160745, 6349.174607301022, 6366.108744775643, 6366.9044964326495, 6180.165677633642, 6219.813405597839, 6242.875142497215, 6246.781362652286, 6249.468795152463, 6141.823559979079, 6333.0, 6336.461400780985, 6339.366063393623, 6372.904406433814, 6102.034838985013, 6188.690565471618, 6191.938080619136, 6223.564350495421, 6230.968845155745, 6213.0, 6241.843953901189, 6244.625322480666, 6250.343713910156, 6279.026750853625, 6006.789762358297, 6134.969325153345, 6141.048137538689, 6168.784092556739, 6181.196444462191, 4920.237363208708, 6124.326324104434, 6141.881051037385, 6144.634315788543, 6146.739918316645, 5024.497550244946, 5823.4176582343125, 6014.0678194879865, 6018.277806663228, 6018.608790428608, 5158.845234642967, 5978.880422391615, 6076.72654730547, 6083.178770865877, 6107.267127944675, 6033.18551995475, 6040.36576159497, 6084.056971169476, 6087.817365479043, 6104.755809767559], "unit": "score", "name": "dojo.html", "value": 5656.9856884476}, {"lowerIsBetter": false, "replicates": [474.03770346197234, 514.3580151831885, 575.7150210645729, 621.813455963211, 633.7686744338315, 39520.0, 39983.60016399839, 40124.59875401245, 40125.79937100318, 40138.0, 43568.0, 44003.77998110013, 44137.11725765483, 44284.0, 44312.77843610777, 9568.856467152998, 9777.560009799541, 9777.804443911118, 9780.951095244549, 9800.215982721365, 9716.368436051634, 9889.456079915602, 9894.158996485306, 9900.554475048604, 9911.306208565404, 9859.901400986006, 9934.205263578933, 9939.652112176076, 9941.552630131662, 9943.950280248624, 9780.804383912318, 9887.258455615822, 9897.703068907873, 9902.207823374112, 9907.752306192402, 8488.405811593191, 9640.084192001748, 9760.609575616967, 9792.853107203398, 9807.754806129904, 42388.57611423877, 42788.7163385099, 42809.785951070044, 42957.78521107406, 43017.784911075556, 3080.861361238727, 3200.519922011694, 3357.8153201573905, 3437.74216933731, 3521.506989021539, 28824.711752882624, 30338.79367106295, 30596.388072238653, 30704.078877633707, 30885.0, 2656.893724251028, 2696.2180967519594, 2840.5881147233536, 2844.5448728203596, 2847.615571897788, 485512.0, 491509.0, 498666.50666746794, 498831.0, 500297.49851250876, 74373.25626743663, 74444.62777686077, 75208.62395688095, 75242.62378688072, 75288.0, 79413.20586794174, 79618.6019069901, 79630.60184699156, 79944.0, 80026.0, 17843.553911152325, 18054.91670499748, 18072.0, 18078.5480362992, 18141.274349026156, 11553.826692599618, 13335.733285334432, 13440.0, 13496.662583435493, 13526.120802147829, 22429.43926401853, 23061.405873952455, 23645.408864778517, 23699.763002370102, 23739.52520949606, 7291.380232680282, 8529.061803201643, 9058.864117038249, 9160.816783664422, 9848.803023939481, 939.5396255834592, 955.3121752338305, 987.693814917378, 992.2359782967075, 1109.4730003248553, 25615.0, 29322.560161597594, 29560.0, 31095.533566996513, 31728.04815855528, 946.8674385586023, 1013.6654903881702, 1049.5172220778375, 1111.699841042914, 1131.8302254661867, 12000.939995299968, 14670.559883203521, 14929.10425374481, 15168.772468412983, 15194.316255768517, 660187.0, 670918.0, 672534.0, 675909.0, 679189.0, 60563.09155362673, 61128.694356527936, 61308.08037879435, 61390.0, 61462.078068829, 1349.2376807103956, 1470.4118352659023, 1489.5680252726588, 1515.6892836968616, 1518.0739748753251, 28493.0, 28720.85639571789, 29202.0, 29290.7070929288, 29418.705812941596, 47765.5223447775, 47859.76070119627, 48180.0, 48275.75862120667, 48287.75856120697, 351308.0, 355264.0, 355371.0, 356194.0, 356707.0, 28877.422451551272, 33275.83362083174, 33735.493967591, 34134.97595072152, 34135.487967681, 41364.172716546105, 42485.57514424816, 42512.362314564685, 42716.35925461059, 43270.567294326655, 29275.975340862966, 33412.1646958828, 33725.83137084299, 33907.49138762871, 34641.480377794855, 34872.95381138469, 35273.823630881685, 35349.0, 35660.64339356677, 37086.0, 35331.940041798785, 35358.823205883804, 35737.1065723359, 36247.0, 36790.0, 28690.139295821158, 31768.523472147474, 32014.679853202102, 32146.35707285888, 32406.0, 23786.52426951486, 24195.0, 24235.0, 24293.577981651375, 24419.38951526226], "unit": "score", "name": "ext.html", "value": 20151.85329427525}, {"lowerIsBetter": false, "replicates": [337.75850267059053, 364.6353646353646, 365.0363041570255, 367.97792132472034, 375.0324163657763, 19850.602987940234, 20505.692414613775, 21143.682844757343, 21671.34985950424, 21675.674864877, 11743.47154378053, 12133.968612667933, 12157.696057598565, 12167.209131406453, 12195.573154939579, 4588.9541104589025, 5072.873178170538, 5296.602754793386, 5368.758405871726, 5383.031054410205, 5285.603579731516, 5305.230741542474, 5340.118880384732, 5348.91976620351, 5351.545118664918, 3145.874165033396, 4677.134730074947, 5074.467180946003, 5340.012097761907, 5341.973290133544, 5284.920726189111, 5316.680999140045, 5319.9202011969855, 5322.627416080876, 5328.067588172094, 4431.911361772779, 4484.753338566377, 4969.701817890902, 5083.6441449098575, 5114.462981386975, 24671.62992555113, 24839.751602484106, 24893.87977541015, 25065.0, 25767.840447179922, 2067.059487932987, 2185.3990152707975, 2199.087378737822, 2244.9551008979893, 2298.0463107810237, 7663.463557550974, 7986.321162701177, 9975.90024099757, 10238.795224095476, 14815.851841481663, 1622.0997346472702, 1719.5787032177072, 1748.4404990403077, 1794.3091909614761, 1833.6882729935942, 78636.60681696555, 92889.0, 95469.5226523863, 100394.49802751013, 107894.46052769687, 10838.458077096113, 10865.456727163768, 10914.672559823219, 10966.177536684621, 11057.834132488018, 13577.932110339583, 13655.975801814904, 13675.24786136772, 13686.52097176594, 13708.52020179289, 8478.06741258461, 8492.490450572861, 8499.022612399529, 8534.829303413897, 8595.5702214889, 7228.494005419675, 8767.868481972775, 8787.912120878837, 8851.69019084329, 8906.643734250558, 4412.7793610319995, 4418.690691651554, 4428.269335559597, 4454.309582014793, 4477.619402350771, 1806.2323512507394, 1844.9815501845078, 1845.8431033362315, 1849.861260405475, 1852.9530815089431, 916.3631276263067, 941.9717408477757, 956.4548207521785, 981.3670182732097, 983.341161421849, 18972.715409268872, 19795.901020494806, 19921.302754403816, 19996.60006799885, 20144.39566812998, 879.5909901895649, 948.6584829461389, 954.4941181173989, 975.6926568131016, 1010.2118153895156, 8215.835683286301, 9139.543022848831, 10302.175825933908, 10374.533146008447, 10392.688219353431, 607533.0, 627685.0, 631680.0, 643816.7809160925, 644849.0, 107412.0, 115122.69754605029, 116299.8370016306, 121875.0, 123404.0, 997.683058362954, 1028.6502589119734, 1043.8173319669027, 1046.2519298701466, 1060.3160961179997, 17409.95540267588, 17553.297868085643, 17847.0, 18000.639987200444, 18129.274829006692, 46377.53622463867, 48261.27608085952, 49191.508084920126, 50312.49687503078, 52727.73636131795, 53034.46965530295, 67699.66150169217, 68253.0, 68441.65779171072, 68590.0, 7488.9625551871895, 7772.106207786177, 7782.416318776001, 7854.096778870503, 7911.8813217800625, 11927.10546708983, 11993.880061199276, 12263.608596323631, 12443.813342799684, 12454.875451245372, 10454.581816727246, 10541.683749487527, 10725.195610329101, 10858.945705271422, 10867.565297388015, 10320.174386049248, 10567.676868540493, 10576.312539684895, 10692.62575809843, 10695.358278503314, 10125.59497620087, 10959.890401096205, 11041.503132359223, 11045.950634689692, 11101.833472497758, 7583.848323033619, 7606.619669016416, 7747.612619369122, 7835.177306382976, 8031.638576264199, 9214.723558293263, 10417.531211095671, 10541.57833686644, 10692.98416650417, 10733.355998640107], "unit": "score", "name": "jquery.html", "value": 8940.385862346342}, {"lowerIsBetter": false, "replicates": [1269.6825793551611, 1624.658821647454, 1650.4141029934374, 1930.449821800787, 2030.2811538879942, 7942.046954365477, 8704.26013788828, 8845.425047371917, 8852.690155844546, 8889.64441422344, 8547.743567692964, 8782.209601135897, 8793.2965362771, 8796.736097917057, 8831.867521987175, 2183.8908054597287, 2425.2724182745196, 2438.5610590093775, 2459.2622213336017, 2489.22833921484, 2492.0654754467073, 2507.4608959073794, 2509.422832748469, 2514.6102354135137, 2518.4711210645787, 2397.8081753459683, 2443.6823212982285, 2469.777720005199, 2471.1721573272885, 2476.839005464648, 2446.7308596054418, 2475.6781618389673, 2481.689788776403, 2486.751324867517, 2492.1152990688406, 2442.68245128134, 2479.1323036937106, 2486.465409936854, 2486.825922185448, 2495.5258500884956, 8851.911480885174, 8939.821203575957, 8950.910490895072, 8954.552272386354, 8971.730848074569, 5355.143177091685, 5516.14499752535, 5517.089680202762, 5552.694601796899, 5584.1902924076185, 3561.6438356164435, 3692.981535092334, 3725.8695945642044, 3742.4760533525327, 3753.2493501299577, 1050.6270274052677, 1064.675274041417, 1069.8341757027674, 1078.4230436716398, 1081.826218552871, 11868.287902725779, 11882.40587970598, 11887.524499020028, 11932.403379831061, 11998.940005299917, 4808.735519546459, 4856.927146092811, 4960.925586116211, 4965.131102057126, 4976.502349765067, 8967.327450441113, 9829.967853375292, 10010.64962726301, 10072.395656260647, 10080.546375413123, 5499.642523235977, 5515.61390702647, 5520.806771762969, 5535.612507124462, 5550.55595552363, 4448.888777780581, 4587.174308624413, 4587.79354929029, 4630.32860235264, 4774.570288673966, 3805.4862593549515, 3867.3812190049457, 3937.8818635440985, 3942.48747662802, 3942.6254505821903, 1297.1374036265777, 1318.0510032776385, 1319.7294554616471, 1327.3230652367363, 1327.5751759436887, 1373.2378529915993, 1373.7321222361543, 1412.5409241996392, 1419.4322271091646, 1419.9077059991273, 7890.566018869017, 8272.917270827335, 8285.212904774036, 8337.041240257327, 8350.62422191003, 519.9990019213076, 528.4741682026331, 533.0591505991928, 534.8101423994426, 539.465928730554, 6191.102290167901, 6214.5960512566535, 6258.280297765815, 6274.560780745395, 6280.309165991737, 10546.209034322457, 10965.890341096647, 11087.944560277147, 11117.499712512956, 11157.497912593954, 10492.73768155787, 10762.300450470695, 10776.568937242579, 10872.891271087346, 10951.945240273906, 8446.450980686235, 8460.534670593053, 8479.70321038773, 8492.787680308042, 8551.657933682583, 7767.223277672188, 7998.000249968754, 8001.719939802079, 8028.397870159644, 8047.919520804951, 7700.691972321044, 9733.124018838056, 9735.659251926148, 9744.902550974683, 9813.411195328303, 9905.603775849173, 10061.144802691853, 10071.295009349275, 10111.191104711752, 10127.59489620407, 7306.3789577884345, 7513.924860751323, 7571.242875712384, 7595.696172153052, 7612.733554325572, 8315.792105197419, 8351.415400921876, 8379.45533540318, 8385.748427547183, 8393.916060839314, 7289.817754556178, 7353.77938661841, 7416.0, 7501.437392195498, 7533.1336896257635, 7229.313215244543, 7299.671514781954, 7330.816729581803, 7364.410847132323, 7375.37309328713, 7695.384369250334, 7821.139674635671, 7876.960615196887, 7877.448578599443, 7883.5664038478435, 6107.4197951194565, 7053.682584283617, 7086.0, 7139.714411423693, 7153.284671533013, 7141.0, 7243.5653860768525, 7248.0, 7256.7097316106765, 7256.7822965311125], "unit": "score", "name": "mootools.html", "value": 4889.890589903914}, {"lowerIsBetter": false, "replicates": [286.39713403286083, 322.38585494632724, 327.08416433984837, 332.9550510681059, 339.77744577301877, 6535.3137920518375, 6556.213254409466, 6564.671766411672, 6622.304658010912, 6654.234763002256, 6126.23422072241, 6444.452221561173, 6524.445422139124, 6534.934650653492, 6545.705443255053, 3855.036240939765, 4325.610695037446, 4613.953860461403, 4746.382970213867, 4759.500252473493, 4724.196886529281, 4765.69023013503, 4768.61851051915, 4827.468978412372, 4847.975760121212, 4739.336492890998, 4748.287756836467, 4763.928541071887, 4767.5709186173235, 4776.402949631296, 4750.786214620351, 4757.762111894426, 4762.261849413329, 4763.904721905577, 4781.258904869751, 3939.5666476687543, 4015.9397609035886, 4115.42384066228, 4115.753054816721, 4131.153113611733, 6197.202811184751, 6217.658028808413, 6235.688215589203, 6257.405546473078, 6289.433950944437, 5759.510441612426, 5767.307923049219, 5774.393688662672, 5786.0742281235225, 5789.739461724233, 5089.745512724386, 6866.485013623948, 6940.236573976858, 6945.201301850301, 6962.756303529352, 4658.953410465886, 4659.930101048487, 4664.86005419838, 4672.626189904833, 4673.299005149221, 6955.930440695579, 7210.990461335365, 7231.493795434321, 7233.240509746453, 7240.348368646794, 4651.767411629405, 4730.385049943554, 4775.785089670973, 4779.569838714463, 4787.712737235707, 4866.489018653061, 4875.293082503017, 4879.243717223836, 4879.926801097987, 4881.707097574157, 5698.800541981011, 5701.572382071361, 5711.057675483582, 5716.885662286731, 5722.885542289214, 6670.299618540081, 6927.064846245692, 6933.677218131982, 6949.131358580177, 6960.443164546824, 1666.9583260418344, 1682.1505139904514, 1691.4756425508133, 1693.796744390681, 1705.6418152187932, 1091.3779145886926, 1091.49245600796, 1106.7177869643351, 1110.3615421132881, 1111.1166622535104, 5597.888042239132, 6314.778982735674, 6351.142595749607, 6469.223693156851, 6598.505112116611, 7236.9276307237305, 7254.528455650366, 7260.818479538054, 7265.273472652798, 7269.127704675367, 5767.711614419262, 6241.812745617639, 6713.362230588086, 6757.425618822357, 6761.898571521431, 3265.820379879082, 3317.104381816896, 3698.7780733156096, 3845.6346647068485, 3855.9421608675893, 7267.0, 7553.055868016498, 7588.772336829904, 7602.8099297518, 7636.198199189116, 7430.888536671954, 7474.364679002237, 7497.250274972459, 7501.737439189602, 7503.812404689817, 6834.316568343126, 7047.788566343018, 7592.088949326117, 7595.5822429766895, 7634.50375725576, 5662.462066103713, 6987.847005244281, 7268.236835132447, 7269.127704675473, 7301.744438944612, 6162.476189523941, 6890.552114112566, 7135.678894449866, 7152.499325047197, 7157.7136914522835, 6847.897281540681, 6952.922297043966, 7529.171791103084, 7586.544807311579, 7595.278448547379, 3894.727369084137, 4326.97836510828, 4602.125596136723, 4615.469221039623, 4622.260438329851, 5854.707264636836, 5974.1934838796205, 6807.285235050248, 7195.6761945713615, 7226.385757210696, 6724.260331363644, 6968.965155174192, 6990.370866622028, 6997.930020699931, 7004.509684322253, 6126.754929802936, 6494.383033611988, 7092.929070709433, 7114.14630244374, 7176.7846964591145, 6826.658667066527, 6842.0763196969765, 6857.691403886937, 6860.108185935996, 6860.3139686031, 5766.769329226784, 6982.0, 6994.790156295319, 6995.160580730345, 7014.824629384306, 6499.870002600016, 6572.474202063919, 6660.533762636763, 6834.350736680008, 6839.69221385029], "unit": "score", "name": "prototype.html", "value": 5065.439005335263}, {"lowerIsBetter": false, "replicates": [686.7562015484502, 767.8195624028352, 775.6742168289318, 779.1585088104847, 780.8672525670636, 13454.46182152714, 15176.696466070685, 15342.232888355593, 15354.84645153548, 15356.61608459789, 13734.725305493885, 14233.074850134733, 14233.288335583205, 14234.288285585706, 14235.217063061527, 753.1489416958829, 761.3262262897321, 933.785229397239, 952.7189479103681, 963.3449254506933, 757.3524636435851, 763.6067425275987, 763.728876248932, 926.5228407370209, 957.7318350861769, 988.9554970026367, 1000.0, 1002.1331548210818, 1002.6490728245093, 1005.5073014223015, 985.1084768284713, 992.5682328187262, 994.602159136344, 995.9004099590055, 999.6701088640731, 594.3313772006493, 599.2150283129115, 739.8113481062295, 744.292921724364, 754.031070074951, 15238.009529380666, 15276.0, 15289.006214596016, 15316.0, 15317.46388876384, 12391.566295179626, 12394.938025309815, 12410.81383779244, 12607.369631518479, 12664.68338291541, 9544.284178686627, 9948.651797187063, 10204.183665306758, 10280.12618927392, 10565.683029509128, 3426.1605906552804, 3466.4280393735003, 3519.5072689823446, 3532.5937517185594, 3734.309152806712, 68631.62736745286, 68760.6561967187, 71236.64381678162, 71349.43252837389, 71725.0, 9447.339113833492, 9488.146066854017, 9502.90497095034, 9767.853482197772, 9860.112589866947, 21283.935803209777, 21933.232336868132, 21985.010674519366, 22000.669989950162, 22062.779372206074, 7389.224131466226, 7524.134724506752, 7558.093028836465, 7562.357199638092, 7858.17489163641, 4026.255142798592, 4076.4496792932573, 4121.814518346681, 4143.6892233082635, 4202.726822756572, 3625.9093522662142, 3653.7807731535663, 3658.158623516606, 3658.835352409148, 3670.4310831821113, 662.0697919423218, 662.6355504472521, 672.1396612336217, 679.4055201698513, 685.9074025006561, 568.8208214412447, 591.3938213331284, 599.3676671112019, 629.5372900917822, 630.2940706408851, 7635.198304177981, 8048.356131509465, 8183.590820459072, 8302.916970830334, 8356.247937685637, 575.9884802303931, 598.6916737879995, 602.6052935327367, 624.4099326136757, 624.6158612453308, 3603.621619729943, 3728.6457786510236, 3783.9243215135543, 3891.610838916086, 3908.762308363455, 94934.0, 96870.0312996861, 97603.0, 98383.50808246057, 98385.0, 78838.0, 80554.19445805585, 80571.38857222823, 80611.7908231377, 82697.58651206705, 71651.56696866138, 72782.54434911378, 72992.27007729854, 73079.63460182665, 73918.26081739222, 7738.574378409242, 7771.961140194263, 7855.057393112863, 7893.250141236574, 8012.158723333966, 50570.0, 51231.74384128056, 51477.48522514727, 51707.741461292455, 53459.732701336245, 67206.0, 69222.0, 69268.61462770817, 70339.64830175816, 71281.64359178171, 9795.118439340493, 9888.159506442033, 9891.604335826487, 9915.504224788876, 10739.731506712395, 10644.0, 11025.889741102486, 11392.487338069972, 11780.882191177978, 11935.283882967049, 10123.0, 10438.530266138194, 10602.151827853908, 10668.733281668021, 10738.516766745359, 8054.184501405318, 11101.722456938642, 11259.493322800658, 11600.129990250596, 12288.447019884305, 10960.506777195205, 10973.945130274298, 10981.176411768989, 11178.552857885594, 12109.0, 9241.768955776159, 9381.484018379055, 9506.952465237906, 9813.607455701978, 9818.75453113678, 8847.778805529913, 9082.545872706207, 9578.0, 9594.328397012143, 9653.2277417805], "unit": "score", "name": "yui.html", "value": 6885.426401688361}], "name": "dromaeo_css", "value": 7470.61783802545}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 111.0, 112.0, 112.0, 113.0, 116.0, 112.0, 112.0, 115.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [159.0, 123.0, 170.0, 178.0, 119.0, 145.0, 121.0, 156.0, 152.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [179.0, 182.0, 183.0, 199.0, 247.0, 268.0, 184.0, 185.0, 182.0, 181.0], "unit": "score", "name": "audio-dft", "value": 199.0}, {"lowerIsBetter": true, "replicates": [82.0, 79.0, 86.0, 80.0, 55.0, 58.0, 58.0, 74.0, 78.0, 59.0], "unit": "score", "name": "audio-fft", "value": 70.9}, {"lowerIsBetter": true, "replicates": [94.0, 96.0, 130.0, 78.0, 78.0, 81.0, 116.0, 88.0, 117.0, 155.0], "unit": "score", "name": "audio-oscillator", "value": 103.3}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 87.0, 84.0, 87.0, 84.0, 88.0, 84.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 93.0, 93.0, 93.0, 93.0, 95.0, 91.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.1}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 87.0, 86.0, 84.0, 85.0, 83.0, 85.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 85.2}, {"lowerIsBetter": true, "replicates": [54.0, 54.0, 52.0, 73.0, 80.0, 78.0, 79.0, 68.0, 56.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 64.5}, {"lowerIsBetter": true, "replicates": [63.0, 67.0, 75.0, 76.0, 71.0, 72.0, 69.0, 65.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 85.0, 84.0, 84.0, 82.0, 84.0, 81.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [122.0, 136.0, 132.0, 138.0, 122.0, 131.0, 126.0, 132.0, 112.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.2}, {"lowerIsBetter": true, "replicates": [141.0, 130.0, 142.0, 135.0, 134.0, 123.0, 139.0, 136.0, 136.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.4}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 68.0, 68.0, 67.0, 65.0, 81.0, 93.0, 91.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 73.4}], "name": "kraken", "value": 1447.4000000000003}]} 07:34:41 INFO - Return code: 0 07:34:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:34:41 ERROR - # TBPL SUCCESS # 07:34:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:34:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:34:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:34:41 INFO - 2016-03-29 07:34:41.866 screenresolution[3162:45335] starting screenresolution argv=screenresolution get 07:34:41 INFO - 2016-03-29 07:34:41.868 screenresolution[3162:45335] Display 0: 1600x1200x32@60 07:34:41 INFO - 2016-03-29 07:34:41.874 screenresolution[3163:45338] starting screenresolution argv=screenresolution list 07:34:41 INFO - Available Modes on Display 0 07:34:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:34:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:34:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:34:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:34:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:34:42 INFO - Intel Iris: 07:34:42 INFO - Chipset Model: Intel Iris 07:34:42 INFO - Type: GPU 07:34:42 INFO - Bus: Built-In 07:34:42 INFO - VRAM (Dynamic, Max): 1536 MB 07:34:42 INFO - Vendor: Intel (0x8086) 07:34:42 INFO - Device ID: 0x0a2e 07:34:42 INFO - Revision ID: 0x0009 07:34:42 INFO - Displays: 07:34:42 INFO - Display: 07:34:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:34:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:34:42 INFO - Display Serial Number: 1600x1200 60 07:34:42 INFO - Main Display: Yes 07:34:42 INFO - Mirror: Off 07:34:42 INFO - Online: Yes 07:34:42 INFO - Rotation: Supported 07:34:42 INFO - Return code: 0 07:34:42 INFO - Running post-action listener: _resource_record_post_action 07:34:42 INFO - Running post-run listener: _resource_record_post_run 07:34:43 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 901120; Write bytes: 705866240; Read time: 12; Write time: 1778 07:34:43 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 398215680; Write bytes: 392472064; Read time: 29863; Write time: 692 07:34:43 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 901120; Write bytes: 300188672; Read time: 12; Write time: 1051 07:34:43 INFO - Running post-run listener: _upload_blobber_files 07:34:43 INFO - Blob upload gear active. 07:34:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:34:43 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 07:34:43 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'] 07:34:43 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 07:34:43 INFO - (blobuploader) - INFO - Open directory for files ... 07:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:44 INFO - (blobuploader) - INFO - Done attempting. 07:34:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:34:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:34:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:34:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:34:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:34:45 INFO - (blobuploader) - INFO - Done attempting. 07:34:45 INFO - (blobuploader) - INFO - Iteration through files over. 07:34:45 INFO - Return code: 0 07:34:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:34:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:34:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/380d441f9db5dd0b4247aea805a1ab16b1e3e35d8be88c710e2a829a1cf3bac5173c681b9067e846df0969ac8194b36ae06342561ab0b04602f12ce620629980", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a1d5e0ad1215b7c202b4dc5b6684d37aedc6f46cfdf7cb5fad439f8fba607a996e1f77f4503927c751cc58946d2230ee79fd82dd807ef43ee01a7cde719ba5a"} 07:34:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:34:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:34:45 INFO - Contents: 07:34:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/380d441f9db5dd0b4247aea805a1ab16b1e3e35d8be88c710e2a829a1cf3bac5173c681b9067e846df0969ac8194b36ae06342561ab0b04602f12ce620629980", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a1d5e0ad1215b7c202b4dc5b6684d37aedc6f46cfdf7cb5fad439f8fba607a996e1f77f4503927c751cc58946d2230ee79fd82dd807ef43ee01a7cde719ba5a"} 07:34:45 INFO - Running post-run listener: copy_logs_to_upload_dir 07:34:45 INFO - Copying logs to upload dir... 07:34:45 INFO - mkdir: /builds/slave/test/build/upload/logs 07:34:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.154935 ========= master_lag: 47.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2016-03-29 07:35:33.104057) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 46 secs) (at 2016-03-29 07:35:33.107299) ========= 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.SrFmVayYcU/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.uyW79JdciI/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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/380d441f9db5dd0b4247aea805a1ab16b1e3e35d8be88c710e2a829a1cf3bac5173c681b9067e846df0969ac8194b36ae06342561ab0b04602f12ce620629980", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a1d5e0ad1215b7c202b4dc5b6684d37aedc6f46cfdf7cb5fad439f8fba607a996e1f77f4503927c751cc58946d2230ee79fd82dd807ef43ee01a7cde719ba5a"} build_url:https://queue.taskcluster.net/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011940 build_url: 'https://queue.taskcluster.net/v1/task/d_PmPJWFREuByAIqviEQjw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/380d441f9db5dd0b4247aea805a1ab16b1e3e35d8be88c710e2a829a1cf3bac5173c681b9067e846df0969ac8194b36ae06342561ab0b04602f12ce620629980", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a1d5e0ad1215b7c202b4dc5b6684d37aedc6f46cfdf7cb5fad439f8fba607a996e1f77f4503927c751cc58946d2230ee79fd82dd807ef43ee01a7cde719ba5a"}' ========= master_lag: 46.42 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 46 secs) (at 2016-03-29 07:36:19.541965) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 11 secs) (at 2016-03-29 07:36:19.542288) ========= 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.SrFmVayYcU/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.uyW79JdciI/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005375 ========= master_lag: 11.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 11 secs) (at 2016-03-29 07:36:30.840368) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-03-29 07:36:30.840674) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-03-29 07:36:34.351718) ========= ========= Total master_lag: 105.55 =========