builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0184 starttime: 1455628687.5 results: success (0) buildid: 20160216030245 builduid: 6a59ac61660b4d67a07fa64db5a5cd1c revision: 6ea654cad929c9bedd8a4161a182b6189fbeae6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:07.497579) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:07.501152) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:07.501573) ========= 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.Bh938qLlux/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.xghoh37cg4/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.005731 basedir: '/builds/slave/test' ========= master_lag: 0.12 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:07.631828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:07.632196) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:07.998253) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:07.998531) ========= 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.Bh938qLlux/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.xghoh37cg4/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.005749 ========= master_lag: 0.20 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.208613) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.208877) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.209212) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.209528) ========= 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.Bh938qLlux/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.xghoh37cg4/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-16 05:18:08-- 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% 14.1M=0.001s 2016-02-16 05:18:08 (14.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.605095 ========= master_lag: 0.18 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.990708) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:08.990979) ========= 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.Bh938qLlux/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.xghoh37cg4/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.026231 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:09.047936) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-16 05:18:09.048356) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6ea654cad929c9bedd8a4161a182b6189fbeae6a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 6ea654cad929c9bedd8a4161a182b6189fbeae6a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Bh938qLlux/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.xghoh37cg4/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-16 05:18:09,143 truncating revision to first 12 chars 2016-02-16 05:18:09,143 Setting DEBUG logging. 2016-02-16 05:18:09,143 attempt 1/10 2016-02-16 05:18:09,143 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6ea654cad929?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-16 05:18:09,885 unpacking tar archive at: mozilla-central-6ea654cad929/testing/mozharness/ program finished with exit code 0 elapsedTime=0.993405 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-16 05:18:10.059561) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:10.059908) ========= echo 6ea654cad929c9bedd8a4161a182b6189fbeae6a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6ea654cad929c9bedd8a4161a182b6189fbeae6a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Bh938qLlux/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.xghoh37cg4/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 6ea654cad929c9bedd8a4161a182b6189fbeae6a program finished with exit code 0 elapsedTime=0.005723 script_repo_revision: '6ea654cad929c9bedd8a4161a182b6189fbeae6a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:10.115225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:10.115532) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-16 05:18:10.130433) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-02-16 05:18:10.130730) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Bh938qLlux/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.xghoh37cg4/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 05:18:10 INFO - MultiFileLogger online at 20160216 05:18:10 in /builds/slave/test 05:18:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:18:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:18:10 INFO - {'append_to_log': False, 05:18:10 INFO - 'base_work_dir': '/builds/slave/test', 05:18:10 INFO - 'blob_upload_branch': 'Firefox', 05:18:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:18:10 INFO - 'branch': 'Firefox', 05:18:10 INFO - 'buildbot_json_path': 'buildprops.json', 05:18:10 INFO - 'config_files': ('talos/mac_config.py',), 05:18:10 INFO - 'default_actions': ('clobber', 05:18:10 INFO - 'read-buildbot-config', 05:18:10 INFO - 'download-and-extract', 05:18:10 INFO - 'populate-webroot', 05:18:10 INFO - 'create-virtualenv', 05:18:10 INFO - 'install', 05:18:10 INFO - 'run-tests'), 05:18:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:18:10 INFO - 'download_minidump_stackwalk': True, 05:18:10 INFO - 'download_symbols': 'ondemand', 05:18:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:18:10 INFO - 'tooltool.py': '/tools/tooltool.py', 05:18:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:18:10 INFO - '/tools/misc-python/virtualenv.py')}, 05:18:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:18:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:18:10 INFO - 'installer_path': 'installer.exe', 05:18:10 INFO - 'log_level': 'info', 05:18:10 INFO - 'log_name': 'talos', 05:18:10 INFO - 'log_to_console': True, 05:18:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:18:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:18:10 INFO - 'opt_config_files': (), 05:18:10 INFO - 'pip_index': False, 05:18:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:18:10 INFO - 'cmd': ('bash', 05:18:10 INFO - '-c', 05:18:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:18:10 INFO - 'enabled': True, 05:18:10 INFO - 'halt_on_failure': False, 05:18:10 INFO - 'name': 'check_screen_resolution'},), 05:18:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:18:10 INFO - 'cmd': ('bash', 05:18:10 INFO - '-c', 05:18:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:18:10 INFO - 'enabled': True, 05:18:10 INFO - 'halt_on_failure': False, 05:18:10 INFO - 'name': 'check_screen_resolution'},), 05:18:10 INFO - 'run_cmd_checks_enabled': True, 05:18:10 INFO - 'sps_profile': False, 05:18:10 INFO - 'sps_profile_interval': 0, 05:18:10 INFO - 'suite': 'dromaeojs', 05:18:10 INFO - 'system_bits': '32', 05:18:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:18:10 INFO - 'title': 't-yosemite-r7-0184', 05:18:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:18:10 INFO - 'use_talos_json': True, 05:18:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:18:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:18:10 INFO - 'work_dir': 'build'} 05:18:10 INFO - ##### 05:18:10 INFO - ##### Running clobber step. 05:18:10 INFO - ##### 05:18:10 INFO - Running pre-action listener: _resource_record_pre_action 05:18:10 INFO - Running main action method: clobber 05:18:10 INFO - rmtree: /builds/slave/test/build 05:18:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:18:11 INFO - Running post-action listener: _resource_record_post_action 05:18:11 INFO - ##### 05:18:11 INFO - ##### Running read-buildbot-config step. 05:18:11 INFO - ##### 05:18:11 INFO - Running pre-action listener: _resource_record_pre_action 05:18:11 INFO - Running main action method: read_buildbot_config 05:18:11 INFO - Using buildbot properties: 05:18:11 INFO - { 05:18:11 INFO - "project": "", 05:18:11 INFO - "product": "firefox", 05:18:11 INFO - "script_repo_revision": "production", 05:18:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:18:11 INFO - "repository": "", 05:18:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:18:11 INFO - "buildid": "20160216030245", 05:18:11 INFO - "stage_platform": "macosx64", 05:18:11 INFO - "basedir": "/builds/slave/test", 05:18:11 INFO - "nightly_build": "True", 05:18:11 INFO - "buildnumber": 120, 05:18:11 INFO - "slavename": "t-yosemite-r7-0184", 05:18:11 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:18:11 INFO - "platform": "yosemite_r7", 05:18:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:18:11 INFO - "branch": "mozilla-central", 05:18:11 INFO - "repo_path": "mozilla-central", 05:18:11 INFO - "revision": "6ea654cad929c9bedd8a4161a182b6189fbeae6a", 05:18:11 INFO - "pgo_build": "False", 05:18:11 INFO - "builduid": "6a59ac61660b4d67a07fa64db5a5cd1c", 05:18:11 INFO - "slavebuilddir": "test" 05:18:11 INFO - } 05:18:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 05:18:11 INFO - Running post-action listener: _resource_record_post_action 05:18:11 INFO - ##### 05:18:11 INFO - ##### Running download-and-extract step. 05:18:11 INFO - ##### 05:18:11 INFO - Running pre-action listener: _resource_record_pre_action 05:18:11 INFO - Running main action method: download_and_extract 05:18:11 INFO - mkdir: /builds/slave/test/build/tests 05:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:11 INFO - https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:18:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/test_packages.json 05:18:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/test_packages.json 05:18:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:18:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:18:18 INFO - Downloaded 1277 bytes. 05:18:18 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:18:18 INFO - Using the following test package requirements: 05:18:18 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:18:18 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:18:18 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 05:18:18 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:18:18 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 05:18:18 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:18:18 INFO - u'jsshell-mac.zip'], 05:18:18 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:18:18 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 05:18:18 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:18:18 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:18:18 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 05:18:18 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:18:18 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 05:18:18 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:18:18 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 05:18:18 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 05:18:18 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 05:18:18 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 05:18:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:18 INFO - https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:18:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:18:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:18:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:18:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:18:19 INFO - Downloaded 17803184 bytes. 05:18:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:18:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:18:23 INFO - Return code: 0 05:18:23 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:23 INFO - https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:18:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:18:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:18:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 05:18:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:18:24 INFO - Downloaded 17803184 bytes. 05:18:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:18:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:18:28 INFO - Return code: 0 05:18:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:28 INFO - https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:18:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:18:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:18:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 05:18:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:18:29 INFO - Downloaded 10707071 bytes. 05:18:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:18:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:18:29 INFO - Return code: 0 05:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:29 INFO - https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:18:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:18:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:18:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 05:18:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 05:18:36 INFO - Downloaded 111283151 bytes. 05:18:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:18:36 INFO - mkdir: /builds/slave/test/properties 05:18:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:18:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:18:36 INFO - Contents: 05:18:36 INFO - build_url:https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 05:18:37 INFO - Running post-action listener: _resource_record_post_action 05:18:37 INFO - Running post-action listener: set_extra_try_arguments 05:18:37 INFO - ##### 05:18:37 INFO - ##### Running populate-webroot step. 05:18:37 INFO - ##### 05:18:37 INFO - Running pre-action listener: _resource_record_pre_action 05:18:37 INFO - Running main action method: populate_webroot 05:18:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:18:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:18:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:18:37 INFO - '--tppagecycles', 05:18:37 INFO - '7'], 05:18:37 INFO - 'tests': ['tsvgm']}}, 05:18:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:18:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:18:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:18:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:18:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:18:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:18:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:37 INFO - 'talos_options': ['--e10s'], 05:18:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:18:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:37 INFO - 'tests': ['damp', 'tps']}, 05:18:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:37 INFO - 'talos_options': ['--e10s'], 05:18:37 INFO - 'tests': ['damp', 'tps']}, 05:18:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:18:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:18:37 INFO - 'other': {'tests': ['a11yr', 05:18:37 INFO - 'ts_paint', 05:18:37 INFO - 'tpaint', 05:18:37 INFO - 'sessionrestore', 05:18:37 INFO - 'sessionrestore_no_auto_restore']}, 05:18:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:18:37 INFO - 'tests': ['a11yr', 05:18:37 INFO - 'ts_paint', 05:18:37 INFO - 'tpaint', 05:18:37 INFO - 'sessionrestore', 05:18:37 INFO - 'sessionrestore_no_auto_restore']}, 05:18:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:18:37 INFO - 'tests': ['a11yr', 05:18:37 INFO - 'ts_paint', 05:18:37 INFO - 'tpaint', 05:18:37 INFO - 'sessionrestore', 05:18:37 INFO - 'sessionrestore_no_auto_restore']}, 05:18:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:18:37 INFO - 'tests': ['a11yr', 05:18:37 INFO - 'ts_paint', 05:18:37 INFO - 'tpaint', 05:18:37 INFO - 'sessionrestore', 05:18:37 INFO - 'sessionrestore_no_auto_restore']}, 05:18:37 INFO - 'other_l64': {'tests': ['a11yr', 05:18:37 INFO - 'ts_paint', 05:18:37 INFO - 'tpaint', 05:18:37 INFO - 'sessionrestore', 05:18:37 INFO - 'sessionrestore_no_auto_restore']}, 05:18:37 INFO - 'other_nol64': {'tests': ['a11yr', 05:18:37 INFO - 'ts_paint', 05:18:37 INFO - 'tpaint', 05:18:37 INFO - 'sessionrestore', 05:18:37 INFO - 'sessionrestore_no_auto_restore']}, 05:18:37 INFO - 'svgr': {'tests': ['tsvgx', 05:18:37 INFO - 'tsvgr_opacity', 05:18:37 INFO - 'tart', 05:18:37 INFO - 'tscrollx', 05:18:37 INFO - 'cart']}, 05:18:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:18:37 INFO - 'tests': ['tsvgx', 05:18:37 INFO - 'tsvgr_opacity', 05:18:37 INFO - 'tart', 05:18:37 INFO - 'tscrollx', 05:18:37 INFO - 'cart']}, 05:18:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:37 INFO - 'tests': ['tp5o']}, 05:18:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:37 INFO - 'talos_options': ['--e10s'], 05:18:37 INFO - 'tests': ['tp5o']}, 05:18:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:37 INFO - 'talos_options': ['--xperf_path', 05:18:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:37 INFO - 'tests': ['tp5n']}, 05:18:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:18:37 INFO - 'talos_options': ['--e10s', 05:18:37 INFO - '--xperf_path', 05:18:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:18:37 INFO - 'tests': ['tp5n']}}, 05:18:37 INFO - 'talos.zip': {'path': '', 05:18:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:18:37 INFO - Running post-action listener: _resource_record_post_action 05:18:37 INFO - ##### 05:18:37 INFO - ##### Running create-virtualenv step. 05:18:37 INFO - ##### 05:18:37 INFO - Running pre-action listener: _resource_record_pre_action 05:18:37 INFO - Running main action method: create_virtualenv 05:18:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:18:37 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 05:18:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:18:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:18:37 INFO - Using real prefix '/tools/python27' 05:18:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:18:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:18:41 INFO - Installing pip.................done. 05:18:41 INFO - Return code: 0 05:18:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:41 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 0x10e116a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e11e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0ca55f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfbad30>, '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 0x10dddedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfb1b20>, '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.Bh938qLlux/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.xghoh37cg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:18:41 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 05:18:41 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 05:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh938qLlux/Render', 05:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:41 INFO - 'HOME': '/Users/cltbld', 05:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:41 INFO - 'LOGNAME': 'cltbld', 05:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:41 INFO - 'MOZ_NO_REMOTE': '1', 05:18:41 INFO - 'NO_EM_RESTART': '1', 05:18:41 INFO - 'PAGER': '/bin/cat', 05:18:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:41 INFO - 'PWD': '/builds/slave/test', 05:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:41 INFO - 'SHELL': '/bin/bash', 05:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xghoh37cg4/Listeners', 05:18:41 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:41 INFO - 'USER': 'cltbld', 05:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:41 INFO - 'XPC_FLAGS': '0x0', 05:18:41 INFO - 'XPC_SERVICE_NAME': '0', 05:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:41 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 05:18:41 INFO - Cleaning up... 05:18:41 INFO - Return code: 0 05:18:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:41 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 0x10e116a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e11e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0ca55f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfbad30>, '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 0x10dddedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfb1b20>, '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.Bh938qLlux/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.xghoh37cg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:18:41 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 05:18:41 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 05:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh938qLlux/Render', 05:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:41 INFO - 'HOME': '/Users/cltbld', 05:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:41 INFO - 'LOGNAME': 'cltbld', 05:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:41 INFO - 'MOZ_NO_REMOTE': '1', 05:18:41 INFO - 'NO_EM_RESTART': '1', 05:18:41 INFO - 'PAGER': '/bin/cat', 05:18:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:41 INFO - 'PWD': '/builds/slave/test', 05:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:41 INFO - 'SHELL': '/bin/bash', 05:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xghoh37cg4/Listeners', 05:18:41 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:41 INFO - 'USER': 'cltbld', 05:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:41 INFO - 'XPC_FLAGS': '0x0', 05:18:41 INFO - 'XPC_SERVICE_NAME': '0', 05:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:41 INFO - Downloading/unpacking psutil>=0.7.1 05:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:18:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:44 INFO - Installing collected packages: psutil 05:18:44 INFO - Running setup.py install for psutil 05:18:44 INFO - building 'psutil._psutil_osx' extension 05:18:44 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 05:18:45 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 05:18:45 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 05:18:45 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 05:18:45 INFO - building 'psutil._psutil_posix' extension 05:18:45 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 05:18:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:18:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:18:45 INFO - ^ 05:18:45 INFO - 1 warning generated. 05:18:45 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 05:18:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:18:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:18:45 INFO - Successfully installed psutil 05:18:45 INFO - Cleaning up... 05:18:45 INFO - Return code: 0 05:18:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:45 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 0x10e116a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e11e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0ca55f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfbad30>, '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 0x10dddedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfb1b20>, '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.Bh938qLlux/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.xghoh37cg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:18:45 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 05:18:45 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 05:18:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh938qLlux/Render', 05:18:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:45 INFO - 'HOME': '/Users/cltbld', 05:18:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:45 INFO - 'LOGNAME': 'cltbld', 05:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:45 INFO - 'MOZ_NO_REMOTE': '1', 05:18:45 INFO - 'NO_EM_RESTART': '1', 05:18:45 INFO - 'PAGER': '/bin/cat', 05:18:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:45 INFO - 'PWD': '/builds/slave/test', 05:18:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:45 INFO - 'SHELL': '/bin/bash', 05:18:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xghoh37cg4/Listeners', 05:18:45 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:18:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:45 INFO - 'USER': 'cltbld', 05:18:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:45 INFO - 'XPC_FLAGS': '0x0', 05:18:45 INFO - 'XPC_SERVICE_NAME': '0', 05:18:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:18:48 INFO - Installing collected packages: mozsystemmonitor 05:18:48 INFO - Running setup.py install for mozsystemmonitor 05:18:48 INFO - Successfully installed mozsystemmonitor 05:18:48 INFO - Cleaning up... 05:18:48 INFO - Return code: 0 05:18:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:48 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 0x10e116a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e11e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0ca55f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfbad30>, '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 0x10dddedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfb1b20>, '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.Bh938qLlux/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.xghoh37cg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:18:48 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 05:18:48 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 05:18:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh938qLlux/Render', 05:18:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:48 INFO - 'HOME': '/Users/cltbld', 05:18:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:48 INFO - 'LOGNAME': 'cltbld', 05:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:48 INFO - 'MOZ_NO_REMOTE': '1', 05:18:48 INFO - 'NO_EM_RESTART': '1', 05:18:48 INFO - 'PAGER': '/bin/cat', 05:18:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:48 INFO - 'PWD': '/builds/slave/test', 05:18:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:48 INFO - 'SHELL': '/bin/bash', 05:18:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xghoh37cg4/Listeners', 05:18:48 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:18:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:48 INFO - 'USER': 'cltbld', 05:18:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:48 INFO - 'XPC_FLAGS': '0x0', 05:18:48 INFO - 'XPC_SERVICE_NAME': '0', 05:18:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:18:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:52 INFO - Downloading docopt-0.6.1.tar.gz 05:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:52 INFO - Running setup.py install for blobuploader 05:18:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:18:52 INFO - Running setup.py install for requests 05:18:52 INFO - Running setup.py install for docopt 05:18:53 INFO - Successfully installed blobuploader requests docopt 05:18:53 INFO - Cleaning up... 05:18:53 INFO - Return code: 0 05:18:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:53 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 0x10e116a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e11e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0ca55f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfbad30>, '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 0x10dddedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfb1b20>, '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.Bh938qLlux/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.xghoh37cg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:18:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh938qLlux/Render', 05:18:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:53 INFO - 'HOME': '/Users/cltbld', 05:18:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:53 INFO - 'LOGNAME': 'cltbld', 05:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:53 INFO - 'MOZ_NO_REMOTE': '1', 05:18:53 INFO - 'NO_EM_RESTART': '1', 05:18:53 INFO - 'PAGER': '/bin/cat', 05:18:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:53 INFO - 'PWD': '/builds/slave/test', 05:18:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:53 INFO - 'SHELL': '/bin/bash', 05:18:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xghoh37cg4/Listeners', 05:18:53 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:18:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:53 INFO - 'USER': 'cltbld', 05:18:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:53 INFO - 'XPC_FLAGS': '0x0', 05:18:53 INFO - 'XPC_SERVICE_NAME': '0', 05:18:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:53 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-pcj3YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:53 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-vhHfB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:53 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-PwZZSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:53 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-4GX8qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:53 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-GlKJxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:53 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-_9Me16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:54 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-K08WEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:54 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-b7xC3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:54 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-bHKnUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:54 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-N25J93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:54 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-hJ086D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:54 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-jmlWyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:54 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-6hGMFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:54 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-2Y735o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:54 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-JvL4j4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:55 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-PxIZ2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:55 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-tH1z3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:18:55 INFO - Running setup.py install for manifestparser 05:18:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:18:55 INFO - Running setup.py install for mozcrash 05:18:55 INFO - Running setup.py install for mozdebug 05:18:55 INFO - Running setup.py install for mozdevice 05:18:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:18:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:18:55 INFO - Running setup.py install for mozfile 05:18:55 INFO - Running setup.py install for mozhttpd 05:18:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:18:56 INFO - Running setup.py install for mozinfo 05:18:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:18:56 INFO - Running setup.py install for mozInstall 05:18:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:18:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:18:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:18:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:18:56 INFO - Running setup.py install for mozleak 05:18:56 INFO - Running setup.py install for mozlog 05:18:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:18:56 INFO - Running setup.py install for moznetwork 05:18:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:18:56 INFO - Running setup.py install for mozprocess 05:18:56 INFO - Running setup.py install for mozprofile 05:18:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Running setup.py install for mozrunner 05:18:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Running setup.py install for mozscreenshot 05:18:57 INFO - Running setup.py install for moztest 05:18:57 INFO - Running setup.py install for mozversion 05:18:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:18:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:18:57 INFO - Cleaning up... 05:18:57 INFO - Return code: 0 05:18:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:57 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 0x10e116a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e11e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0ca55f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfbad30>, '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 0x10dddedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfb1b20>, '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.Bh938qLlux/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.xghoh37cg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:18:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:18:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:18:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh938qLlux/Render', 05:18:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:57 INFO - 'HOME': '/Users/cltbld', 05:18:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:57 INFO - 'LOGNAME': 'cltbld', 05:18:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:57 INFO - 'MOZ_NO_REMOTE': '1', 05:18:57 INFO - 'NO_EM_RESTART': '1', 05:18:57 INFO - 'PAGER': '/bin/cat', 05:18:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:57 INFO - 'PWD': '/builds/slave/test', 05:18:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:57 INFO - 'SHELL': '/bin/bash', 05:18:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xghoh37cg4/Listeners', 05:18:57 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:18:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:57 INFO - 'USER': 'cltbld', 05:18:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:57 INFO - 'XPC_FLAGS': '0x0', 05:18:57 INFO - 'XPC_SERVICE_NAME': '0', 05:18:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:18:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-pOYw8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:18:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-1D0cXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:18:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-PZnHfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:18:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-dVFCld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:18:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-AyTY__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:18:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-2F2x1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:18:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-uc5DTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:18:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-cEenZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:18:58 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-d1EXs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:18:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:18:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:18:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-61IH0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:18:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-tJ04cR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:18:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-DwL3Xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:18:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-ut5Tha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:18:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-3nqhGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-VPypWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:18:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-HuRiKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:18:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:18:59 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-q0iE1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:18:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:02 INFO - Downloading blessings-1.6.tar.gz 05:19:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:19:02 INFO - Installing collected packages: blessings 05:19:02 INFO - Running setup.py install for blessings 05:19:02 INFO - Successfully installed blessings 05:19:02 INFO - Cleaning up... 05:19:02 INFO - Return code: 0 05:19:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:19:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:03 INFO - Reading from file tmpfile_stdout 05:19:03 INFO - Current package versions: 05:19:03 INFO - blessings == 1.6 05:19:03 INFO - blobuploader == 1.2.4 05:19:03 INFO - docopt == 0.6.1 05:19:03 INFO - manifestparser == 1.1 05:19:03 INFO - mozInstall == 1.12 05:19:03 INFO - mozcrash == 0.16 05:19:03 INFO - mozdebug == 0.1 05:19:03 INFO - mozdevice == 0.48 05:19:03 INFO - mozfile == 1.2 05:19:03 INFO - mozhttpd == 0.7 05:19:03 INFO - mozinfo == 0.9 05:19:03 INFO - mozleak == 0.1 05:19:03 INFO - mozlog == 3.1 05:19:03 INFO - moznetwork == 0.27 05:19:03 INFO - mozprocess == 0.22 05:19:03 INFO - mozprofile == 0.28 05:19:03 INFO - mozrunner == 6.11 05:19:03 INFO - mozscreenshot == 0.1 05:19:03 INFO - mozsystemmonitor == 0.0 05:19:03 INFO - moztest == 0.7 05:19:03 INFO - mozversion == 1.4 05:19:03 INFO - psutil == 3.1.1 05:19:03 INFO - requests == 1.2.3 05:19:03 INFO - wsgiref == 0.1.2 05:19:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:03 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 0x10e116a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e11e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0ca55f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfbad30>, '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 0x10dddedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfb1b20>, '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.Bh938qLlux/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.xghoh37cg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:19:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh938qLlux/Render', 05:19:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:03 INFO - 'HOME': '/Users/cltbld', 05:19:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:03 INFO - 'LOGNAME': 'cltbld', 05:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:03 INFO - 'MOZ_NO_REMOTE': '1', 05:19:03 INFO - 'NO_EM_RESTART': '1', 05:19:03 INFO - 'PAGER': '/bin/cat', 05:19:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:03 INFO - 'PWD': '/builds/slave/test', 05:19:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:03 INFO - 'SHELL': '/bin/bash', 05:19:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xghoh37cg4/Listeners', 05:19:03 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:19:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:03 INFO - 'USER': 'cltbld', 05:19:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:03 INFO - 'XPC_FLAGS': '0x0', 05:19:03 INFO - 'XPC_SERVICE_NAME': '0', 05:19:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:19:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:19:03 INFO - Cleaning up... 05:19:03 INFO - Return code: 0 05:19:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:03 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 0x10e116a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e11e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0ca55f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfbad30>, '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 0x10dddedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfb1b20>, '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.Bh938qLlux/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.xghoh37cg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:19:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:19:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh938qLlux/Render', 05:19:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:03 INFO - 'HOME': '/Users/cltbld', 05:19:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:03 INFO - 'LOGNAME': 'cltbld', 05:19:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:03 INFO - 'MOZ_NO_REMOTE': '1', 05:19:03 INFO - 'NO_EM_RESTART': '1', 05:19:03 INFO - 'PAGER': '/bin/cat', 05:19:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:03 INFO - 'PWD': '/builds/slave/test', 05:19:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:03 INFO - 'SHELL': '/bin/bash', 05:19:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xghoh37cg4/Listeners', 05:19:03 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:19:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:03 INFO - 'USER': 'cltbld', 05:19:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:03 INFO - 'XPC_FLAGS': '0x0', 05:19:03 INFO - 'XPC_SERVICE_NAME': '0', 05:19:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:03 INFO - Downloading/unpacking jsonschema 05:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:19:05 INFO - Downloading/unpacking functools32 (from jsonschema) 05:19: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 05:19: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 05:19: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 05:19: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 05:19: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 05:19: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 05:19:06 INFO - Downloading functools32-3.2.3-2.tar.gz 05:19:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:19:06 INFO - warning: no files found matching '*.txt' 05:19:06 INFO - no previously-included directories found matching 'build' 05:19:06 INFO - no previously-included directories found matching 'dist' 05:19:06 INFO - no previously-included directories found matching '.git*' 05:19:06 INFO - Installing collected packages: jsonschema, functools32 05:19:06 INFO - Running setup.py install for functools32 05:19:06 INFO - warning: no files found matching '*.txt' 05:19:06 INFO - no previously-included directories found matching 'build' 05:19:06 INFO - no previously-included directories found matching 'dist' 05:19:06 INFO - no previously-included directories found matching '.git*' 05:19:06 INFO - Successfully installed jsonschema functools32 05:19:06 INFO - Cleaning up... 05:19:06 INFO - Return code: 0 05:19:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:19:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e116a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e11e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0ca55f7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfbad30>, '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 0x10dddedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfb1b20>, '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.Bh938qLlux/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.xghoh37cg4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:19:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:19:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:19:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh938qLlux/Render', 05:19:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:06 INFO - 'HOME': '/Users/cltbld', 05:19:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:06 INFO - 'LOGNAME': 'cltbld', 05:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:06 INFO - 'MOZ_NO_REMOTE': '1', 05:19:06 INFO - 'NO_EM_RESTART': '1', 05:19:06 INFO - 'PAGER': '/bin/cat', 05:19:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:06 INFO - 'PWD': '/builds/slave/test', 05:19:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:06 INFO - 'SHELL': '/bin/bash', 05:19:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xghoh37cg4/Listeners', 05:19:06 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:19:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:06 INFO - 'USER': 'cltbld', 05:19:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:06 INFO - 'XPC_FLAGS': '0x0', 05:19:06 INFO - 'XPC_SERVICE_NAME': '0', 05:19:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:19:07 INFO - Downloading/unpacking flake8 05:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:19:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:19:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:19:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:19:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:19:10 INFO - no previously-included directories found matching 'docs/_build' 05:19:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:19:10 INFO - Running setup.py install for pep8 05:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:19:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:19:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:19:10 INFO - no previously-included directories found matching 'docs/_build' 05:19:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:19:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:19:10 INFO - Cleaning up... 05:19:10 INFO - Return code: 0 05:19:10 INFO - Running post-action listener: _resource_record_post_action 05:19:10 INFO - Running post-action listener: _start_resource_monitoring 05:19:10 INFO - Starting resource monitoring. 05:19:10 INFO - ##### 05:19:10 INFO - ##### Running install step. 05:19:10 INFO - ##### 05:19:10 INFO - Running pre-action listener: _resource_record_pre_action 05:19:10 INFO - Running main action method: install 05:19:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:19:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:19:11 INFO - Reading from file tmpfile_stdout 05:19:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:19:11 INFO - Reading from file tmpfile_stdout 05:19:11 INFO - Output received: 05:19:11 INFO - Usage: mozinstall [options] installer 05:19:11 INFO - Options: 05:19:11 INFO - -h, --help show this help message and exit 05:19:11 INFO - -d DEST, --destination=DEST 05:19:11 INFO - Directory to install application into. [default: 05:19:11 INFO - "/builds/slave/test"] 05:19:11 INFO - --app=APP Application being installed. [default: firefox] 05:19:11 INFO - mkdir: /builds/slave/test/build/application 05:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:19:44 INFO - Reading from file tmpfile_stdout 05:19:44 INFO - Output received: 05:19:44 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:19:44 INFO - Running post-action listener: _resource_record_post_action 05:19:44 INFO - ##### 05:19:44 INFO - ##### Running run-tests step. 05:19:44 INFO - ##### 05:19:44 INFO - Running pre-action listener: _resource_record_pre_action 05:19:44 INFO - Running main action method: run_tests 05:19:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:19:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:19:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:19:45 INFO - 2016-02-16 05:19:45.003 screenresolution[1657:8315] starting screenresolution argv=screenresolution get 05:19:45 INFO - 2016-02-16 05:19:45.006 screenresolution[1657:8315] Display 0: 1600x1200x32@60 05:19:45 INFO - 2016-02-16 05:19:45.011 screenresolution[1658:8317] starting screenresolution argv=screenresolution list 05:19:45 INFO - Available Modes on Display 0 05:19:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:19:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:19:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:19:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:19:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:19:45 INFO - Intel Iris: 05:19:45 INFO - Chipset Model: Intel Iris 05:19:45 INFO - Type: GPU 05:19:45 INFO - Bus: Built-In 05:19:45 INFO - VRAM (Dynamic, Max): 1536 MB 05:19:45 INFO - Vendor: Intel (0x8086) 05:19:45 INFO - Device ID: 0x0a2e 05:19:45 INFO - Revision ID: 0x0009 05:19:45 INFO - Displays: 05:19:45 INFO - Display: 05:19:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:19:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:19:45 INFO - Display Serial Number: 1600x1200 60 05:19:45 INFO - Main Display: Yes 05:19:45 INFO - Mirror: Off 05:19:45 INFO - Online: Yes 05:19:45 INFO - Rotation: Supported 05:19:45 INFO - Return code: 0 05:19:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:19:45 INFO - Python 2.7.3 05:19:45 INFO - Return code: 0 05:19:45 INFO - grabbing minidump binary from tooltool 05:19:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:19:45 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 0x10dfbad30>, '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 0x10dddedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dfb1b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:19:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:19:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:19:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:19:45 INFO - Return code: 0 05:19:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:19:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:19:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:19:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:19:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:19:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:19:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:19:46 INFO - Return code: 0 05:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--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 05:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0184 --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 05:19:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Bh938qLlux/Render', 05:19:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:19:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:19:46 INFO - 'HOME': '/Users/cltbld', 05:19:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:19:46 INFO - 'LOGNAME': 'cltbld', 05:19:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:19:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:19:46 INFO - 'MOZ_NO_REMOTE': '1', 05:19:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:19:46 INFO - 'NO_EM_RESTART': '1', 05:19:46 INFO - 'PAGER': '/bin/cat', 05:19:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:19:46 INFO - 'PWD': '/builds/slave/test', 05:19:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:19:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:19:46 INFO - 'SHELL': '/bin/bash', 05:19:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xghoh37cg4/Listeners', 05:19:46 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 05:19:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:19:46 INFO - 'USER': 'cltbld', 05:19:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:19:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:19:46 INFO - 'XPC_FLAGS': '0x0', 05:19:46 INFO - 'XPC_SERVICE_NAME': '0', 05:19:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:19:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--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 05:19:46 INFO - mozversion application_buildid: 20160216030245 05:19:46 INFO - mozversion application_changeset: 6ea654cad929c9bedd8a4161a182b6189fbeae6a 05:19:46 INFO - mozversion application_display_name: Nightly 05:19:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:19:46 INFO - mozversion application_name: Firefox 05:19:46 INFO - mozversion application_remotingname: firefox 05:19:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:19:46 INFO - mozversion application_vendor: Mozilla 05:19:46 INFO - mozversion application_version: 47.0a1 05:19:46 INFO - mozversion platform_buildid: 20160216030245 05:19:46 INFO - mozversion platform_changeset: 6ea654cad929c9bedd8a4161a182b6189fbeae6a 05:19:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:19:46 INFO - mozversion platform_version: 47.0a1 05:19:46 INFO - using testdate: 1455628786 05:19:46 INFO - actual date: 1455628786 05:19:47 INFO - starting webserver on 'localhost:49275' 05:19:47 INFO - SUITE-START | Running 2 tests 05:19:47 INFO - TEST-START | dromaeo_css 05:19:47 INFO - operating with platform_type : mac_ 05:19:47 INFO - Initialising browser for dromaeo_css test... 05:19:47 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpb4u8T_/profile http://localhost:49275/getInfo.html) 05:19:49 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 05:19:49 INFO - PROCESS | 1676 | colorDepth:24 05:19:49 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 05:19:49 INFO - PROCESS | 1676 | __metrics 05:19:49 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:19:49 INFO - PROCESS | 1676 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:19:50 INFO - TEST-INFO | 1676: exit 0 05:19:50 INFO - Browser initialized. 05:19:50 INFO - Running cycle 1/1 for dromaeo_css test... 05:19:50 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpb4u8T_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:02 INFO - PROCESS | 1681 | RSS: Main: 245657600 05:20:02 INFO - PROCESS | 1681 | 05:20:53 INFO - PROCESS | 1681 | 1455628853832 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:23:04 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 05:23:05 INFO - PROCESS | 1681 | RSS: Main: 337035264 05:23:05 INFO - PROCESS | 1681 | 05:26:08 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 05:26:08 INFO - PROCESS | 1681 | RSS: Main: 373301248 05:26:08 INFO - PROCESS | 1681 | 05:29:11 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 05:29:11 INFO - PROCESS | 1681 | RSS: Main: 379686912 05:29:11 INFO - PROCESS | 1681 | 05:32:13 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 05:32:14 INFO - PROCESS | 1681 | RSS: Main: 338391040 05:32:14 INFO - PROCESS | 1681 | 05:35:17 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 05:35:18 INFO - PROCESS | 1681 | RSS: Main: 339292160 05:35:18 INFO - PROCESS | 1681 | 05:38:20 INFO - PROCESS | 1681 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 05:38:21 INFO - PROCESS | 1681 | RSS: Main: 404230144 05:38:21 INFO - PROCESS | 1681 | 05:38:21 INFO - PROCESS | 1681 | __start_tp_report 05:38:21 INFO - PROCESS | 1681 | _x_x_mozilla_page_load 05:38:21 INFO - PROCESS | 1681 | _x_x_mozilla_page_load_details 05:38:21 INFO - PROCESS | 1681 | |i|pagename|runs| 05:38:21 INFO - PROCESS | 1681 | |0;dojo.html;3420.5040269160972;3451.1199644090752;3476.1657202271463;3494.3011397720456;3534.6465353464655;4649.604783593399;5601.355844077927;5622.409646987069;5658.292713410824;5729.914051289234;5757.078867381219;5759.856003599902;5781.653100813965;5863.882722345551;5905.20279762232;4717.174494463472;5130.769115389817;5177.508136727005;5206.687598744087;5229.450907654698;5250.31745873036;5278.551323137519;5311.840644780663;5317.282166907476;5327.014502317064;5116.692998420107;5161.99341128482;5189.870253243661;5256.26412302278;5267.341582302212;5234.214867769827;5253.028189784902;5261.736913154327;5274.97362513185;5284.154535274338;5219.399769026534;5259.184826351921;5269.341332333458;5270.130428479296;5273.709945952971;5553.694546799924;5668.829935101912;5680.147977803321;5703.4011428799795;5758.193852860602;6338.239411270631;6339.36606339367;6340.682965851735;6340.746370145189;6342.492600591988;5897.115432685088;6338.936610633881;6354.586951848115;6367.6497792621385;6386.936130638727;5676.687782171937;5772.509336706343;5782.739776710058;5860.619059761102;5863.794767183128;6267.874642507216;6293.653849038255;6302.684865756693;6306.873862522724;6309.905351419732;6128.601640893327;6137.60105593135;6226.937730622636;6234.875302493925;6241.906371404432;6142.2839182294065;6251.218597675291;6259.874802503924;6343.841403964845;6370.554061215763;6254.749810007549;6258.937410625836;6277.686115694289;6277.811665650038;6283.088952102011;6286.182796236551;6301.40136687014;6306.527010474141;6310.274318453345;6325.272593651789;4820.68665536739;4862.82980095695;4894.412670479565;4898.706077635354;4917.213245880642;4463.464384273908;4510.368548403226;4524.16302983949;4525.52481989393;4531.3882625845745;5669.461401166883;5717.171010203498;5736.42635736423;5846.795362162304;5858.355580886099;6329.430351268408;6368.713407896563;6373.3945275198785;6381.170447841843;6397.040443933354;5697.6296540724725;5704.629199102045;5734.713264336767;5740.311162660508;5789.942100579025;5293.470652934753;5405.78376864921;5406.459354064641;5420.457954204548;5423.538999185113;6328.905066423915;6332.651704156224;6346.619202847844;6352.555321127476;6366.586171898812;6324.2410910691015;6331.366863313632;6346.809595712136;6364.299927008118;6370.93629063722;6252.812415627538;6305.8108256752375;6331.778387756406;6332.366763323631;6417.326180751141;6258.12386265914;6267.780627678009;6288.308286088435;6308.71610777507;6313.621182729051;6339.144215530844;6342.334054924167;6342.841428964312;6343.9365606343345;6348.682565871595;5947.256592925884;6078.088286757022;6122.142899993915;6173.259208894961;6192.938070619236;6124.14262003311;6143.6928153593035;6154;6170.074488826712;6179.412955769195;5839.15332276809;5976.282846058501;5999.13402246571;6030.75876964934;6088.969555152196;5283.603729720209;6096.268447786294;6174.876502470015;6176.042713379434;6180.7527698891545;4705.4588722296;5887.910736513759;6028.547858910687;6070.878582428415;6070.9089363658695 05:38:21 INFO - PROCESS | 1681 | |1;ext.html;455.15795777811036;463.8515674984004;568.542323429639;570.6918264137363;595.9106134079888;36773.44839827401;37470.250594988116;37487.62512374875;37572.872813815564;37581;39380.60619393805;39798;39841.60158398415;39884.80057599715;39918;9449.102335278138;9674.419534827934;9677.387105481515;9686.612535498572;9688.70933871985;9394.436333819958;9407.482588457631;9429.387089839172;9576.377535460208;9577;9583.185429238523;9665.951670241639;9669.516524173798;9710.951445242765;9711.854322185172;9577.904220957806;9656;9656.324057315991;9656.80686386272;9693.951530242373;9503.239740820718;9645.662401815904;9646.565904534313;9654.855177172349;9662.9516852416;38496.422553661716;38951.610483895085;38999.610003899885;39075.41386879199;39238.60761392407;3143.151349135743;3186.362727454495;3200.9519857201926;3241.173500757315;3362.260302733395;27522.587161192598;28088.876444942176;28138.718612813813;28268.717312826815;28446.862125514956;2740.0957683964243;2750.8624568771484;2838.2620518665294;2963.5999140116023;2965.0956458280216;447935;448765;448817;450032;489464.5526772379;43458.56541434545;59896;60697.39302607006;60762;60781;56629.716851416306;57046.7147664259;57270.854582908105;57308.42691573114;57315.14027289594;14529.491467798787;14743.852561474463;15909.681806363807;16097.758533622005;16144.515664530083;12199.51201951912;12496.562620308245;12504.749905001849;12528.185667931555;12532;15585.376584936703;17769.46691599254;18210.27158913655;18272.54318642018;18334.083295835422;6237.812865614039;7083.150021997393;7969.083555391088;7970.561619111005;8029.915961345144;918.8529835226332;942.528735632184;992.399598243067;1022.9283950123569;1054.6888667843004;25633.231003069937;27214.911403544033;28644.570331445044;29034.854825725735;29443.85278073596;1075.8649624645918;1103.5361960868306;1146.5241924601198;1160.1646814293695;1241.5592464675092;14621.634459138393;14683.632909177357;14790.778138327934;14914.627134321512;14915.850841491447;527546;536035;536617;536691;536934;55683.72158139183;55922.72038639781;55981;56082.158767618515;56094.439055609735;1414.4342263094845;1414.575627311823;1447.985520144806;1449.8187726534395;1452.194032312056;28387.432251354443;28453.288667783472;28533.857330713214;28717.712822871505;28893.711062889943;47757.76121119372;48150.759246203546;48155;48258.27612585884;48265;488930;491170;493356;493752;495286;27138.77875495647;30848;31840.203994900312;31900.361992760478;32004.67995320017;39166.608333916294;39388.212235755695;39598;39764.602353976086;40703.982400440225;32725.18187045343;33891;34029;34155.65844341525;34186.65813341835;24494;33285.235686789536;38375.232495350494;38932.221355573296;42604.72185834306;37114.257714845015;37464.25071498609;38309.04227394338;38407;38572.614273858024;34631.480527792606;37151.88544343674;38353;38449.6155038446;38457.807710962385;30994;31167.68832311648;31167.844160779052;31269.687303127586;31920 05:38:21 INFO - PROCESS | 1681 | |2;jquery.html;350.06532558069955;355.5129472622507;363.26257696875354;371.5578461630659;374.09282489961834;15627.609309767262;15734;16107.033577985329;19300;20150.093245803957;16217.675646487063;18934.337298194565;20206.696899546518;20424.489387765312;20566.177352905866;5690.63010904292;5896.911546326808;5897.823065308047;5901.586888917777;5904.439078287556;4198.790060496978;4373.169097871394;5772.191893134965;5862.179294898718;6095.207623009002;6229.719662615171;6257.812265632016;6322.810315690536;6340.3659634036685;6340.651264180468;6216.409441103111;6292.370762923694;6307.959186734183;6421.068945002995;6421.775237866699;5350.892982140335;5498.202760599731;5502.80740174092;5503.3395992481155;5506.174073888908;24851.378715532075;25004.37489062788;25218.739063046956;25414.983400664136;25476.745232547622;1912.9192006516412;1950.8879938435098;2194.034624765098;2334.9883250583807;2705.971730742325;13384;14509.92745036268;14676.853231467656;14821.184834834079;14997.625059373493;1667.2747354900657;1712.880098393113;1731.1603872122012;1753.9298428062862;1812.8187181281899;92744;93247;93608;94037.5298123505;94536.05463945342;10295.742606434898;10564.366138031743;10763.192760542834;10785.730356740987;10834.187435942336;13032.674183145496;13043.152195107288;13055.543055992996;13061.020423468279;26457.867710661707;10178.13485853696;10187.388756674623;10247.436390998417;10425.791484170275;10640;8863.556822158995;8906.688265910661;8996.59515321812;9055.320850936074;9286.814263714688;6452.548321617442;8410.915890841135;8420.631747301128;8456.619452124669;8539.462896678533;2610.908618198354;3422;3424;3435.604905435857;3575.8748443804343;843.5149788871423;893.7408151636083;900.5767289373983;943.3585162089845;943.7310366545502;16299.376715033295;19168.424947251606;19856.90071549662;20467.385978420672;21620.675689864664;937.8827646544182;974.3666616699061;1020.6529779874878;1047.994760026195;1066.4454483668449;8221;9787.923328433866;10838.837417438745;11356.148288878201;11423.657290281304;612796;650362;678681;732632;741683;94783;109474;123113;124215;127383;1168.6260396673154;1191.9284842909453;1199.8860108289698;1202.0323639470137;1204.2413279633774;15920.442784502487;18516.537086572942;18721;18894.52763680864;18974;47893.5210647903;48144.981877265345;48500.272495911886;49526.00947980948;49750.81603375036;66956;68554.65722671355;69840.65079674569;74757.62621187077;75569.58112729754;7487.6630551626395;7575.810604734926;7681.42389320792;7723.420743444377;7728.806779830549;7505.624718764149;8414.87377689323;11753.294802311888;11979.371683400115;12232.633021009384;8963.551822408985;10227;10377.636782712569;10542.26204165701;10753.784924301626;10393.688189354332;10487.161027117965;10606.46967651599;10608.522616482123;10707;10659.680209593724;10830.67507974762;10890.50992705346;10897.67306980792;10997.835032474679;7594.31651151399;7671;7699.3840492761565;7734.149243583314;7758.9612051939375;9780.804383912424;10693.625723099654;10706.8929310709;10944.945275273572;10973.780524389627 05:38:21 INFO - PROCESS | 1681 | |3;mootools.html;1395.1350162899005;1448.3916754962916;1452.2012892908904;1763.1008185825226;1940.5051711813476;7940;8668.566571671416;8855.645774169025;8857.335699822506;8868;8511.914880851189;8795.384323097369;8812.691555795549;8814.4711317321;8827.867581986275;2179.139240000207;2237.8433509654333;2426;2490.551700693879;2507.5737124688753;2098.391466474728;2489.9751002489925;2500.1624455807328;2503.7245902950663;2506.0727530813624;2351.7765812247894;2421.7820396164343;2427.2596857958315;2429.8056155507606;2439.817013723969;2452.2275483222816;2492.264781889347;2501.6997960244703;2508.8620125893067;2510.8619025953567;2461.1878080233478;2480.2559232230437;2482.5034993001473;2501.962470562925;2506.786923111538;8912.509811960339;8986.640534378617;8987.32595055367;9008.099190081006;9023.278137748965;5447.1829225616075;5580.944190558083;5585.134304182858;5591.580631452657;5593.216949627055;3602.3155600435834;3663.6153203913736;3751.568569614502;3767.321882061228;3769.8680546181026;1040.4693606260862;1045.8535804987307;1063.6596289187464;1089.0688461365576;1093.9726506837312;12144.696382590506;12178.939105304416;12179.756404871852;12181.878181218162;12185.51257949681;4890.1931181355385;4923.163062279421;4970.229614409773;4989.326440930428;4994.750262486861;10326.173906087644;10333.173346132291;10338.53476593555;10346.017128372792;10346.689599312032;4371.322445021026;4568.246239370466;5547.33431988164;5561.63849349791;5564.554835613141;4993.151164302078;5036.597072234213;5051.015052064812;5056.216286475602;5060.139776238048;3752.2870654575545;3801.486799282117;3809.9238015240094;3833.1375440526217;3858.2090671412293;1213.1811027556364;1225.7732319520917;1227.607165706983;1229.244014930829;1233.272369302116;1329.4416345135066;1331.187975335045;1340.7653660609353;1369.7739872920856;1372.3824279074456;8080;8271.503709777433;8277.255047045795;8285.62714677841;8351.874721879176;1198.4966314148078;1199.4722322178388;1206.3124019309084;1219.0369608009573;1239.7954337534206;6188.319284878659;6206.937930620727;6284.717187726564;6292.811215663537;6293.716782744787;10593.788124237471;10989.61536346224;11075.224734268524;11086.611968581223;11091.72270693239;10485.790284194274;10836.0789332906;10947.397893115955;10950;10950.288231264942;8385.371097167737;8508;8516.1058088901;8516.318694504425;8523.74428767138;7859.135495095649;7981.201879812204;8047.396445266511;8079.272865442138;8082.515049096838;9470.668526601536;9750.366226195274;9867.55595998196;9956.153726933291;9975.551100200364;9786.902130978599;10231.028052335314;10318.793624127326;10321.74195645085;10326.432046237229;6385.840353991188;6396.6481843497195;6522.543421960607;6801.455883529206;7005.54463959841;8256.587170641324;8270.958645206736;8305.127961563949;8308.376871734765;8326.958365208135;7493.363064139609;7719.5754233515445;7752.341051010727;7826.295633393022;7844.21557844211;7500.662470188746;7542.170361260367;7602.860028759439;7713.845723085619;7730.574818385043;7726.304632583095;7779.961100194463;7845.333146682596;7853.293203611703;7859.4891332063235;7024.929750702428;7112.182099058675;7121.715131394893;7125.5368401053765;7129.3583577478275;7175.067241258603;7177.031100801325;7183.604901730455;7238.23998480173;7242.565446073042 05:38:21 INFO - PROCESS | 1681 | |4;prototype.html;320.81072167421223;328.1451818014073;333.5713608013702;337.2597149257381;339.8750137046378;6410.1987251593555;6602.768903088387;6612.404883560479;6624;6627.403533681968;5206.635535512506;5766.106253530709;6550.770723024695;6570.371851259499;6578.539502234846;3963.2667956428154;4857.902841943168;4890.21756518957;4897.3878265216845;4912.435069966946;4641.373414589038;4778.761061946906;4791.568758811706;4921.950780492203;4927.162382395001;4828.275758636198;4848.369711937443;4851.927221091686;4853.878653033667;4861.416630004404;4857.63567732418;4867.4889136640495;4872.366592342991;4879.6828206166665;4883.291922671193;3652.4156135018534;3962.405639154121;4154.127633197032;4160.791960401998;4165.500139983191;6183.8503990787185;6303.0545418187185;6328.810135695937;6335;6357.11000459936;5642.097264437671;5642.322921249435;5650.576206784508;5660.971695141539;5661.830145095653;6917.7232910683515;6929;6931.09895713559;6931.133608298963;6946.444284457231;4481.619062379702;4632.027274272406;4632.745199014053;4633.258678611406;4645.303204519315;7325.4139668826365;7343.669534870944;7346.77959661211;7355.521891077063;7376.409887209011;4688.296755486636;4692.741899195577;4704.129735998851;4705.082508910729;4723.149833030019;4779.474257831635;4799.448063472745;4802.519748025239;4815.3017812417;4815.398075240595;5318.414974352818;5546.86132846674;5555.916661250085;5557.749901254453;5790.507806836466;7006.859862802818;7007.334303241184;7019.719211231596;7021.017057611938;7025.051618031603;1600.1919030889326;1620.173711407191;1622.3105180298562;1625.2767518454411;1625.2848746551715;1023.8054769593903;1038.444432228754;1040.8750949886062;1055.5302890213934;1056.4823236614156;6512.153420055457;6514.609123452608;6522.478201743849;6522.543421960418;6529.771457998947;5941.494972927263;7092;7243.9637801811705;7264.927350726531;7306.890396643948;6571.83570410734;6573.835654108686;6590.505712071518;6599.637019963948;6602.60384376939;3812.8093595320124;3860.034991252187;3863.343231650626;3865.3235683755793;3873.3996230584303;7378.778636640909;7599.240075992357;7616.238376162451;7645.006149200568;7660.770176894702;7518.28576285263;7522.887156692654;7523.962380188064;7526.5860377679755;7538.547687138789;6168.907466388007;6831.897521537181;6933.37599616037;7401.779466160238;7614.314711675976;7301.817454563678;7311.926880731125;7321;7322.414206863545;7327.633618318956;7156.534825236343;7162.427005839624;7164.820879478055;7165;7170.282971702788;7359.668814903449;7587.430942679211;7631.198724133886;7638.312551870358;7639.04511936008;4559.794809233659;4641.280601506772;4657.86026419208;4658.953410465852;4660.510646382081;7285.7814265572115;7294.270572942663;7294.744683936036;7307.890381644173;7310.817229569303;6377.808665740035;6828.180618325832;7021.473389495706;7037.1555413350725;7076.761566725905;7043.190033146049;7044.29557044312;7052.717891284291;7058.223595404604;7078;6868.656567171522;6873.725050998104;6879.0025446309;6896.448284137156;6900.447964162755;6778.254392016973;6974.860502789814;6980.394509262796;6997.335253150943;7009.754658586925;5457.235986961908;6633.502487313374;6743.988401739778;6821.863562728817;6854 05:38:21 INFO - PROCESS | 1681 | |5;yui.html;676.2155899156978;738.2691135775581;746.1158527145333;746.9141048779388;748.457368407904;14489.42042318306;14786.40854365824;14820.407183712652;14825.925870370647;14903.776443353358;15096.924515377435;15538.223088845569;15556.299966501507;15564.299606517705;15592.45426410076;698.2982102986491;722.6134018300211;860.0668274921702;884.4030279561302;885.6014793342989;715.6099925540567;860.0410542245414;874.7375787263827;876.2464280718577;877.1097336203758;915.4598786715836;916.1525588830339;920.8434566123741;925.3337596930199;925.888893332801;727.8835386338187;747.712130829629;890.585877566928;910.1080940678172;911.1981456318431;680.425040840489;680.5576375356009;681.0329332348077;681.1655721740877;681.5467713970254;14780.926095369454;14834.777478337834;14850.628734281729;14862.2568871556;14880.51194880514;12188.878111218952;12234.388280585936;12263.877361226363;12270.079744019235;12560.183588066746;10126.9493652532;10164.796704065877;10187.032231937954;10199.286049976505;10221.182305415548;3455.809930453824;3470.2192006798523;3473.9131521711906;3482.2687235680537;3497.3005398920063;76885.23114768836;77700;78828.60585697093;78836;79031;9249.260059195249;9259.537023148816;9498.715038548855;9575.808483830284;9854.852177217348;20289.391318260477;20329.695054574193;20379.694304585442;20418.897905510377;20428.0807363669;7455.7017719290625;7613.885791713129;7619.961900190575;7677.577733224726;7711.228877112244;4172.395002724648;4182.019889853015;4228.619424251832;4255.87232383029;4418.116376724668;3452.171478845059;3488.686018258369;3494.5107684924133;3495.4582039783872;3498.1954150545516;629.6190804563265;639.3318981664172;647.4690753582112;648.7891435283552;653.6633633678659;506.07641055074635;574.9942500575024;613.7943788830792;634.4702173685025;638.8243233110932;9019.413738107001;9103.408278461879;9202.585883635118;9293.953530232306;9669.854952175723;490.7227416509732;554.6394843351853;555.8276934150426;615.3753939751156;651.273829679913;3467.420857212402;3756.6806821420487;3881.844726210976;3955.7626542407547;4097.262492751273;84502;85202.57398712967;85294.14705852987;94337.52831235937;95660;79250.6037469809;79654;80445.59777201076;81011.7848232277;81858;62614.686926565075;66473.33526664671;71249.64375178091;72051;72619;8603.870941936002;8725.432846864933;8786.341024423065;8824;8877.979032411355;45880.31179532243;50507.74746126246;50905.236421452966;51142.74428627833;51477.22784158315;68551.65724171347;71075;71548.28451715625;71551.64224178846;72204.63897680478;10600.46997650099;10930.234883558074;11136.610218642309;11161.274517156358;11225.270357426742;11903.702407439883;12057.879421205676;12314.014878809852;12564.874351256736;12672.176308539916;10942.288751231144;11500.137489688139;11514.94242528782;11572.24780389272;12264.995076206387;11283.774324513628;11354.318740875575;11663.88336116628;11742;11968.341741204318;10892;10899.836502452628;10902.672919812418;11260.662180134608;11864.584739534075;7651.5409075455655;9199.632014719336;9311.530048953406;9486.241100711788;9730;8755.956220219114;8900.910990890266;9263.547018314457;9694.644667895514;9694.709158725249 05:38:21 INFO - PROCESS | 1681 | __end_tp_report 05:38:21 INFO - PROCESS | 1681 | __start_cc_report 05:38:21 INFO - PROCESS | 1681 | _x_x_mozilla_cycle_collect,1018 05:38:21 INFO - PROCESS | 1681 | __end_cc_report 05:38:21 INFO - PROCESS | 1681 | __startTimestamp1455629901099__endTimestamp 05:38:21 INFO - PROCESS | 1681 | 05:38:21 INFO - PROCESS | 1681 | ------- Summary: start ------- 05:38:21 INFO - PROCESS | 1681 | Number of tests: 6 05:38:21 INFO - PROCESS | 1681 | 05:38:21 INFO - PROCESS | 1681 | [#0] dojo.html Cycles:165 Average:5774.00 Median:5999.13 stddev:658.72 (11.0%) stddev-sans-first:634.34 05:38:21 INFO - PROCESS | 1681 | Values: 3420.5 3451.1 3476.2 3494.3 3534.6 4649.6 5601.4 5622.4 5658.3 5729.9 5757.1 5759.9 5781.7 5863.9 5905.2 4717.2 5130.8 5177.5 5206.7 5229.5 5250.3 5278.6 5311.8 5317.3 5327.0 5116.7 5162.0 5189.9 5256.3 5267.3 5234.2 5253.0 5261.7 5275.0 5284.2 5219.4 5259.2 5269.3 5270.1 5273.7 5553.7 5668.8 5680.1 5703.4 5758.2 6338.2 6339.4 6340.7 6340.7 6342.5 5897.1 6338.9 6354.6 6367.6 6386.9 5676.7 5772.5 5782.7 5860.6 5863.8 6267.9 6293.7 6302.7 6306.9 6309.9 6128.6 6137.6 6226.9 6234.9 6241.9 6142.3 6251.2 6259.9 6343.8 6370.6 6254.7 6258.9 6277.7 6277.8 6283.1 6286.2 6301.4 6306.5 6310.3 6325.3 4820.7 4862.8 4894.4 4898.7 4917.2 4463.5 4510.4 4524.2 4525.5 4531.4 5669.5 5717.2 5736.4 5846.8 5858.4 6329.4 6368.7 6373.4 6381.2 6397.0 5697.6 5704.6 5734.7 5740.3 5789.9 5293.5 5405.8 5406.5 5420.5 5423.5 6328.9 6332.7 6346.6 6352.6 6366.6 6324.2 6331.4 6346.8 6364.3 6370.9 6252.8 6305.8 6331.8 6332.4 6417.3 6258.1 6267.8 6288.3 6308.7 6313.6 6339.1 6342.3 6342.8 6343.9 6348.7 5947.3 6078.1 6122.1 6173.3 6192.9 6124.1 6143.7 6154.0 6170.1 6179.4 5839.2 5976.3 5999.1 6030.8 6089.0 5283.6 6096.3 6174.9 6176.0 6180.8 4705.5 5887.9 6028.5 6070.9 6070.9 05:38:21 INFO - PROCESS | 1681 | 05:38:21 INFO - PROCESS | 1681 | [#1] ext.html Cycles:180 Average:63218.99 Median:38752.42 stddev:131912.41 (340.4%) stddev-sans-first:132198.29 05:38:21 INFO - PROCESS | 1681 | Values: 455.2 463.9 568.5 570.7 595.9 36773.4 37470.3 37487.6 37572.9 37581.0 39380.6 39798.0 39841.6 39884.8 39918.0 9449.1 9674.4 9677.4 9686.6 9688.7 9394.4 9407.5 9429.4 9576.4 9577.0 9583.2 9666.0 9669.5 9711.0 9711.9 9577.9 9656.0 9656.3 9656.8 9694.0 9503.2 9645.7 9646.6 9654.9 9663.0 38496.4 38951.6 38999.6 39075.4 39238.6 3143.2 3186.4 3201.0 3241.2 3362.3 27522.6 28088.9 28138.7 28268.7 28446.9 2740.1 2750.9 2838.3 2963.6 2965.1 447935.0 448765.0 448817.0 450032.0 489464.6 43458.6 59896.0 60697.4 60762.0 60781.0 56629.7 57046.7 57270.9 57308.4 57315.1 14529.5 14743.9 15909.7 16097.8 16144.5 12199.5 12496.6 12504.7 12528.2 12532.0 15585.4 17769.5 18210.3 18272.5 18334.1 6237.8 7083.2 7969.1 7970.6 8029.9 918.9 942.5 992.4 1022.9 1054.7 25633.2 27214.9 28644.6 29034.9 29443.9 1075.9 1103.5 1146.5 1160.2 1241.6 14621.6 14683.6 14790.8 14914.6 14915.9 527546.0 536035.0 536617.0 536691.0 536934.0 55683.7 55922.7 55981.0 56082.2 56094.4 1414.4 1414.6 1448.0 1449.8 1452.2 28387.4 28453.3 28533.9 28717.7 28893.7 47757.8 48150.8 48155.0 48258.3 48265.0 488930.0 491170.0 493356.0 493752.0 495286.0 27138.8 30848.0 31840.2 31900.4 32004.7 39166.6 39388.2 39598.0 39764.6 40704.0 32725.2 33891.0 34029.0 34155.7 34186.7 24494.0 33285.2 38375.2 38932.2 42604.7 37114.3 37464.3 38309.0 38407.0 38572.6 34631.5 37151.9 38353.0 38449.6 38457.8 30994.0 31167.7 31167.8 31269.7 31920.0 05:38:21 INFO - PROCESS | 1681 | 05:38:21 INFO - PROCESS | 1681 | [#2] jquery.html Cycles:180 Average:36070.72 Median:14581.92 stddev:112858.37 (774.0%) stddev-sans-first:113143.09 05:38:21 INFO - PROCESS | 1681 | Values: 350.1 355.5 363.3 371.6 374.1 15627.6 15734.0 16107.0 19300.0 20150.1 16217.7 18934.3 20206.7 20424.5 20566.2 5690.6 5896.9 5897.8 5901.6 5904.4 4198.8 4373.2 5772.2 5862.2 6095.2 6229.7 6257.8 6322.8 6340.4 6340.7 6216.4 6292.4 6308.0 6421.1 6421.8 5350.9 5498.2 5502.8 5503.3 5506.2 24851.4 25004.4 25218.7 25415.0 25476.7 1912.9 1950.9 2194.0 2335.0 2706.0 13384.0 14509.9 14676.9 14821.2 14997.6 1667.3 1712.9 1731.2 1753.9 1812.8 92744.0 93247.0 93608.0 94037.5 94536.1 10295.7 10564.4 10763.2 10785.7 10834.2 13032.7 13043.2 13055.5 13061.0 26457.9 10178.1 10187.4 10247.4 10425.8 10640.0 8863.6 8906.7 8996.6 9055.3 9286.8 6452.5 8410.9 8420.6 8456.6 8539.5 2610.9 3422.0 3424.0 3435.6 3575.9 843.5 893.7 900.6 943.4 943.7 16299.4 19168.4 19856.9 20467.4 21620.7 937.9 974.4 1020.7 1048.0 1066.4 8221.0 9787.9 10838.8 11356.1 11423.7 612796.0 650362.0 678681.0 732632.0 741683.0 94783.0 109474.0 123113.0 124215.0 127383.0 1168.6 1191.9 1199.9 1202.0 1204.2 15920.4 18516.5 18721.0 18894.5 18974.0 47893.5 48145.0 48500.3 49526.0 49750.8 66956.0 68554.7 69840.7 74757.6 75569.6 7487.7 7575.8 7681.4 7723.4 7728.8 7505.6 8414.9 11753.3 11979.4 12232.6 8963.6 10227.0 10377.6 10542.3 10753.8 10393.7 10487.2 10606.5 10608.5 10707.0 10659.7 10830.7 10890.5 10897.7 10997.8 7594.3 7671.0 7699.4 7734.1 7759.0 9780.8 10693.6 10706.9 10944.9 10973.8 05:38:21 INFO - PROCESS | 1681 | 05:38:21 INFO - PROCESS | 1681 | [#3] mootools.html Cycles:180 Average:6136.32 Median:4993.95 stddev:3261.31 (65.3%) stddev-sans-first:3250.98 05:38:21 INFO - PROCESS | 1681 | Values: 1395.1 1448.4 1452.2 1763.1 1940.5 7940.0 8668.6 8855.6 8857.3 8868.0 8511.9 8795.4 8812.7 8814.5 8827.9 2179.1 2237.8 2426.0 2490.6 2507.6 2098.4 2490.0 2500.2 2503.7 2506.1 2351.8 2421.8 2427.3 2429.8 2439.8 2452.2 2492.3 2501.7 2508.9 2510.9 2461.2 2480.3 2482.5 2502.0 2506.8 8912.5 8986.6 8987.3 9008.1 9023.3 5447.2 5580.9 5585.1 5591.6 5593.2 3602.3 3663.6 3751.6 3767.3 3769.9 1040.5 1045.9 1063.7 1089.1 1094.0 12144.7 12178.9 12179.8 12181.9 12185.5 4890.2 4923.2 4970.2 4989.3 4994.8 10326.2 10333.2 10338.5 10346.0 10346.7 4371.3 4568.2 5547.3 5561.6 5564.6 4993.2 5036.6 5051.0 5056.2 5060.1 3752.3 3801.5 3809.9 3833.1 3858.2 1213.2 1225.8 1227.6 1229.2 1233.3 1329.4 1331.2 1340.8 1369.8 1372.4 8080.0 8271.5 8277.3 8285.6 8351.9 1198.5 1199.5 1206.3 1219.0 1239.8 6188.3 6206.9 6284.7 6292.8 6293.7 10593.8 10989.6 11075.2 11086.6 11091.7 10485.8 10836.1 10947.4 10950.0 10950.3 8385.4 8508.0 8516.1 8516.3 8523.7 7859.1 7981.2 8047.4 8079.3 8082.5 9470.7 9750.4 9867.6 9956.2 9975.6 9786.9 10231.0 10318.8 10321.7 10326.4 6385.8 6396.6 6522.5 6801.5 7005.5 8256.6 8271.0 8305.1 8308.4 8327.0 7493.4 7719.6 7752.3 7826.3 7844.2 7500.7 7542.2 7602.9 7713.8 7730.6 7726.3 7780.0 7845.3 7853.3 7859.5 7024.9 7112.2 7121.7 7125.5 7129.4 7175.1 7177.0 7183.6 7238.2 7242.6 05:38:21 INFO - PROCESS | 1681 | 05:38:21 INFO - PROCESS | 1681 | [#4] prototype.html Cycles:180 Average:5726.28 Median:6526.16 stddev:1820.58 (27.9%) stddev-sans-first:1779.91 05:38:21 INFO - PROCESS | 1681 | Values: 320.8 328.1 333.6 337.3 339.9 6410.2 6602.8 6612.4 6624.0 6627.4 5206.6 5766.1 6550.8 6570.4 6578.5 3963.3 4857.9 4890.2 4897.4 4912.4 4641.4 4778.8 4791.6 4922.0 4927.2 4828.3 4848.4 4851.9 4853.9 4861.4 4857.6 4867.5 4872.4 4879.7 4883.3 3652.4 3962.4 4154.1 4160.8 4165.5 6183.9 6303.1 6328.8 6335.0 6357.1 5642.1 5642.3 5650.6 5661.0 5661.8 6917.7 6929.0 6931.1 6931.1 6946.4 4481.6 4632.0 4632.7 4633.3 4645.3 7325.4 7343.7 7346.8 7355.5 7376.4 4688.3 4692.7 4704.1 4705.1 4723.1 4779.5 4799.4 4802.5 4815.3 4815.4 5318.4 5546.9 5555.9 5557.7 5790.5 7006.9 7007.3 7019.7 7021.0 7025.1 1600.2 1620.2 1622.3 1625.3 1625.3 1023.8 1038.4 1040.9 1055.5 1056.5 6512.2 6514.6 6522.5 6522.5 6529.8 5941.5 7092.0 7244.0 7264.9 7306.9 6571.8 6573.8 6590.5 6599.6 6602.6 3812.8 3860.0 3863.3 3865.3 3873.4 7378.8 7599.2 7616.2 7645.0 7660.8 7518.3 7522.9 7524.0 7526.6 7538.5 6168.9 6831.9 6933.4 7401.8 7614.3 7301.8 7311.9 7321.0 7322.4 7327.6 7156.5 7162.4 7164.8 7165.0 7170.3 7359.7 7587.4 7631.2 7638.3 7639.0 4559.8 4641.3 4657.9 4659.0 4660.5 7285.8 7294.3 7294.7 7307.9 7310.8 6377.8 6828.2 7021.5 7037.2 7076.8 7043.2 7044.3 7052.7 7058.2 7078.0 6868.7 6873.7 6879.0 6896.4 6900.4 6778.3 6974.9 6980.4 6997.3 7009.8 5457.2 6633.5 6744.0 6821.9 6854.0 05:38:21 INFO - PROCESS | 1681 | 05:38:21 INFO - PROCESS | 1681 | [#5] yui.html Cycles:180 Average:18288.26 Median:639.08 stddev:25553.02 (3998.4%) stddev-sans-first:25590.48 05:38:21 INFO - PROCESS | 1681 | Values: 676.2 738.3 746.1 746.9 748.5 14489.4 14786.4 14820.4 14825.9 14903.8 15096.9 15538.2 15556.3 15564.3 15592.5 698.3 722.6 860.1 884.4 885.6 715.6 860.0 874.7 876.2 877.1 915.5 916.2 920.8 925.3 925.9 727.9 747.7 890.6 910.1 911.2 680.4 680.6 681.0 681.2 681.5 14780.9 14834.8 14850.6 14862.3 14880.5 12188.9 12234.4 12263.9 12270.1 12560.2 10126.9 10164.8 10187.0 10199.3 10221.2 3455.8 3470.2 3473.9 3482.3 3497.3 76885.2 77700.0 78828.6 78836.0 79031.0 9249.3 9259.5 9498.7 9575.8 9854.9 20289.4 20329.7 20379.7 20418.9 20428.1 7455.7 7613.9 7620.0 7677.6 7711.2 4172.4 4182.0 4228.6 4255.9 4418.1 3452.2 3488.7 3494.5 3495.5 3498.2 629.6 639.3 647.5 648.8 653.7 506.1 575.0 613.8 634.5 638.8 9019.4 9103.4 9202.6 9294.0 9669.9 490.7 554.6 555.8 615.4 651.3 3467.4 3756.7 3881.8 3955.8 4097.3 84502.0 85202.6 85294.1 94337.5 95660.0 79250.6 79654.0 80445.6 81011.8 81858.0 62614.7 66473.3 71249.6 72051.0 72619.0 8603.9 8725.4 8786.3 8824.0 8878.0 45880.3 50507.7 50905.2 51142.7 51477.2 68551.7 71075.0 71548.3 71551.6 72204.6 10600.5 10930.2 11136.6 11161.3 11225.3 11903.7 12057.9 12314.0 12564.9 12672.2 10942.3 11500.1 11514.9 11572.2 12265.0 11283.8 11354.3 11663.9 11742.0 11968.3 10892.0 10899.8 10902.7 11260.7 11864.6 7651.5 9199.6 9311.5 9486.2 9730.0 8756.0 8900.9 9263.5 9694.6 9694.7 05:38:21 INFO - PROCESS | 1681 | -------- Summary: end -------- 05:38:21 INFO - PROCESS | 1681 | 05:38:21 INFO - TEST-INFO | 1681: exit 0 05:38:21 INFO - TEST-OK | dromaeo_css | took 1114471ms 05:38:21 INFO - TEST-START | kraken 05:38:21 INFO - operating with platform_type : mac_ 05:38:21 INFO - Initialising browser for kraken test... 05:38:21 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpmuWhqA/profile http://localhost:49275/getInfo.html) 05:38:23 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 05:38:23 INFO - PROCESS | 1688 | colorDepth:24 05:38:23 INFO - PROCESS | 1688 | Browser inner width/height: 1024/689 05:38:23 INFO - PROCESS | 1688 | __metrics 05:38:24 INFO - PROCESS | 1688 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:38:24 INFO - PROCESS | 1688 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:38:24 INFO - TEST-INFO | 1688: exit 0 05:38:24 INFO - Browser initialized. 05:38:24 INFO - Running cycle 1/1 for kraken test... 05:38:24 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpmuWhqA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:36 INFO - PROCESS | 1691 | RSS: Main: 246198272 05:38:36 INFO - PROCESS | 1691 | 05:38:39 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 05:38:39 INFO - PROCESS | 1691 | RSS: Main: 290967552 05:38:39 INFO - PROCESS | 1691 | 05:38:42 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 05:38:43 INFO - PROCESS | 1691 | RSS: Main: 301654016 05:38:43 INFO - PROCESS | 1691 | 05:38:46 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 05:38:46 INFO - PROCESS | 1691 | RSS: Main: 286011392 05:38:46 INFO - PROCESS | 1691 | 05:38:48 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 05:38:49 INFO - PROCESS | 1691 | RSS: Main: 288382976 05:38:49 INFO - PROCESS | 1691 | 05:38:51 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:38:52 INFO - PROCESS | 1691 | RSS: Main: 287817728 05:38:52 INFO - PROCESS | 1691 | 05:38:54 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 05:38:55 INFO - PROCESS | 1691 | RSS: Main: 289218560 05:38:55 INFO - PROCESS | 1691 | 05:38:58 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 05:38:58 INFO - PROCESS | 1691 | RSS: Main: 288657408 05:38:58 INFO - PROCESS | 1691 | 05:39:01 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 05:39:01 INFO - PROCESS | 1691 | RSS: Main: 290766848 05:39:01 INFO - PROCESS | 1691 | 05:39:03 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:39:04 INFO - PROCESS | 1691 | RSS: Main: 324857856 05:39:04 INFO - PROCESS | 1691 | 05:39:05 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:39:06 INFO - PROCESS | 1691 | RSS: Main: 324714496 05:39:06 INFO - PROCESS | 1691 | 05:39:08 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:39:09 INFO - PROCESS | 1691 | RSS: Main: 332992512 05:39:09 INFO - PROCESS | 1691 | 05:39:11 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:39:12 INFO - PROCESS | 1691 | RSS: Main: 334409728 05:39:12 INFO - PROCESS | 1691 | 05:39:14 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:39:15 INFO - PROCESS | 1691 | RSS: Main: 335355904 05:39:15 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 05:39:17 INFO - PROCESS | 1691 | RSS: Main: 394760192 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | __start_tp_report 05:39:17 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 05:39:17 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 05:39:17 INFO - PROCESS | 1691 | |i|pagename|runs| 05:39:17 INFO - PROCESS | 1691 | |0;ai-astar;110;111;156;150;111;110;116;111;111;112 05:39:17 INFO - PROCESS | 1691 | |1;audio-beat-detection;156;121;146;155;124;158;170;148;166;118 05:39:17 INFO - PROCESS | 1691 | |2;audio-dft;186;183;184;186;187;182;185;187;181;185 05:39:17 INFO - PROCESS | 1691 | |3;audio-fft;72;76;83;76;56;58;57;79;77;56 05:39:17 INFO - PROCESS | 1691 | |4;audio-oscillator;95;133;156;79;81;83;110;76;78;110 05:39:17 INFO - PROCESS | 1691 | |5;imaging-gaussian-blur;85;90;84;91;84;89;84;89;85;90 05:39:17 INFO - PROCESS | 1691 | |6;imaging-darkroom;93;93;94;92;94;94;94;93;95;93 05:39:17 INFO - PROCESS | 1691 | |7;imaging-desaturate;86;85;87;89;88;86;87;86;84;85 05:39:17 INFO - PROCESS | 1691 | |8;json-parse-financial;54;53;53;54;54;53;54;64;53;52 05:39:17 INFO - PROCESS | 1691 | |9;json-stringify-tinderbox;62;70;72;69;69;67;66;65;71;96 05:39:17 INFO - PROCESS | 1691 | |10;stanford-crypto-aes;83;83;86;101;83;83;83;82;86;84 05:39:17 INFO - PROCESS | 1691 | |11;stanford-crypto-ccm;126;131;125;112;123;123;117;130;123;122 05:39:17 INFO - PROCESS | 1691 | |12;stanford-crypto-pbkdf2;157;140;124;162;135;127;137;134;135;137 05:39:17 INFO - PROCESS | 1691 | |13;stanford-crypto-sha256-iterative;66;68;65;68;69;83;86;94;91;78 05:39:17 INFO - PROCESS | 1691 | __end_tp_report 05:39:17 INFO - PROCESS | 1691 | __start_cc_report 05:39:17 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,1122 05:39:17 INFO - PROCESS | 1691 | __end_cc_report 05:39:17 INFO - PROCESS | 1691 | __startTimestamp1455629957503__endTimestamp 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | ------- Summary: start ------- 05:39:17 INFO - PROCESS | 1691 | Number of tests: 14 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#0] ai-astar Cycles:10 Average:119.80 Median:111.50 stddev:17.64 (15.8%) stddev-sans-first:18.35 05:39:17 INFO - PROCESS | 1691 | Values: 110.0 111.0 156.0 150.0 111.0 110.0 116.0 111.0 111.0 112.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:155.50 stddev:18.85 (12.1%) stddev-sans-first:19.66 05:39:17 INFO - PROCESS | 1691 | Values: 156.0 121.0 146.0 155.0 124.0 158.0 170.0 148.0 166.0 118.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.50 stddev:2.07 (1.1%) stddev-sans-first:2.13 05:39:17 INFO - PROCESS | 1691 | Values: 186.0 183.0 184.0 186.0 187.0 182.0 185.0 187.0 181.0 185.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#3] audio-fft Cycles:10 Average:69.00 Median:76.00 stddev:10.90 (14.3%) stddev-sans-first:11.51 05:39:17 INFO - PROCESS | 1691 | Values: 72.0 76.0 83.0 76.0 56.0 58.0 57.0 79.0 77.0 56.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#4] audio-oscillator Cycles:10 Average:100.10 Median:78.50 stddev:27.08 (34.5%) stddev-sans-first:28.66 05:39:17 INFO - PROCESS | 1691 | Values: 95.0 133.0 156.0 79.0 81.0 83.0 110.0 76.0 78.0 110.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:89.00 stddev:2.92 (3.3%) stddev-sans-first:3.00 05:39:17 INFO - PROCESS | 1691 | Values: 85.0 90.0 84.0 91.0 84.0 89.0 84.0 89.0 85.0 90.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:94.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 05:39:17 INFO - PROCESS | 1691 | Values: 93.0 93.0 94.0 92.0 94.0 94.0 94.0 93.0 95.0 93.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:86.50 stddev:1.49 (1.7%) stddev-sans-first:1.58 05:39:17 INFO - PROCESS | 1691 | Values: 86.0 85.0 87.0 89.0 88.0 86.0 87.0 86.0 84.0 85.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:3.44 (6.4%) stddev-sans-first:3.64 05:39:17 INFO - PROCESS | 1691 | Values: 54.0 53.0 53.0 54.0 54.0 53.0 54.0 64.0 53.0 52.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:69.50 stddev:9.38 (13.5%) stddev-sans-first:9.41 05:39:17 INFO - PROCESS | 1691 | Values: 62.0 70.0 72.0 69.0 69.0 67.0 66.0 65.0 71.0 96.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:83.00 stddev:5.64 (6.8%) stddev-sans-first:5.92 05:39:17 INFO - PROCESS | 1691 | Values: 83.0 83.0 86.0 101.0 83.0 83.0 83.0 82.0 86.0 84.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.00 stddev:5.61 (4.5%) stddev-sans-first:5.86 05:39:17 INFO - PROCESS | 1691 | Values: 126.0 131.0 125.0 112.0 123.0 123.0 117.0 130.0 123.0 122.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.80 Median:137.00 stddev:11.96 (8.7%) stddev-sans-first:10.72 05:39:17 INFO - PROCESS | 1691 | Values: 157.0 140.0 124.0 162.0 135.0 127.0 137.0 134.0 135.0 137.0 05:39:17 INFO - PROCESS | 1691 | 05:39:17 INFO - PROCESS | 1691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.80 Median:80.50 stddev:11.02 (13.7%) stddev-sans-first:10.98 05:39:17 INFO - PROCESS | 1691 | Values: 66.0 68.0 65.0 68.0 69.0 83.0 86.0 94.0 91.0 78.0 05:39:17 INFO - PROCESS | 1691 | -------- Summary: end -------- 05:39:17 INFO - PROCESS | 1691 | 05:39:18 INFO - TEST-INFO | 1691: exit 0 05:39:18 INFO - TEST-OK | kraken | took 56603ms 05:39:18 INFO - SUITE-END | took 1171s 05:39:18 INFO - Completed test suite (00:19:31) 05:39:18 INFO - Working with test: dromaeo_css 05:39:18 INFO - Generating results file: dromaeo_css 05:39:18 INFO - Working with test: kraken 05:39:18 INFO - Generating results file: kraken 05:39:18 INFO - javascript benchmark 05:39:18 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:39:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 05:39:18 INFO - process_Request line: dromaeo_css 7579.52 graph.html#tests=[[72,1,59]] 05:39:18 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:39:18 INFO - process_Request line: kraken 1435.90 graph.html#tests=[[232,1,59]] 05:39:18 INFO - RETURN: dromaeo_css: 7579.52 05:39:18 INFO - RETURN: kraken: 1435.90 05:39:18 INFO - javascript benchmark 05:39:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3420.5040269160972, 3451.1199644090752, 3476.1657202271463, 3494.3011397720456, 3534.6465353464655, 4649.604783593399, 5601.355844077927, 5622.409646987069, 5658.292713410824, 5729.914051289234, 5757.078867381219, 5759.856003599902, 5781.653100813965, 5863.882722345551, 5905.20279762232, 4717.174494463472, 5130.769115389817, 5177.508136727005, 5206.687598744087, 5229.450907654698, 5250.31745873036, 5278.551323137519, 5311.840644780663, 5317.282166907476, 5327.014502317064, 5116.692998420107, 5161.99341128482, 5189.870253243661, 5256.26412302278, 5267.341582302212, 5234.214867769827, 5253.028189784902, 5261.736913154327, 5274.97362513185, 5284.154535274338, 5219.399769026534, 5259.184826351921, 5269.341332333458, 5270.130428479296, 5273.709945952971, 5553.694546799924, 5668.829935101912, 5680.147977803321, 5703.4011428799795, 5758.193852860602, 6338.239411270631, 6339.36606339367, 6340.682965851735, 6340.746370145189, 6342.492600591988, 5897.115432685088, 6338.936610633881, 6354.586951848115, 6367.6497792621385, 6386.936130638727, 5676.687782171937, 5772.509336706343, 5782.739776710058, 5860.619059761102, 5863.794767183128, 6267.874642507216, 6293.653849038255, 6302.684865756693, 6306.873862522724, 6309.905351419732, 6128.601640893327, 6137.60105593135, 6226.937730622636, 6234.875302493925, 6241.906371404432, 6142.2839182294065, 6251.218597675291, 6259.874802503924, 6343.841403964845, 6370.554061215763, 6254.749810007549, 6258.937410625836, 6277.686115694289, 6277.811665650038, 6283.088952102011, 6286.182796236551, 6301.40136687014, 6306.527010474141, 6310.274318453345, 6325.272593651789, 4820.68665536739, 4862.82980095695, 4894.412670479565, 4898.706077635354, 4917.213245880642, 4463.464384273908, 4510.368548403226, 4524.16302983949, 4525.52481989393, 4531.3882625845745, 5669.461401166883, 5717.171010203498, 5736.42635736423, 5846.795362162304, 5858.355580886099, 6329.430351268408, 6368.713407896563, 6373.3945275198785, 6381.170447841843, 6397.040443933354, 5697.6296540724725, 5704.629199102045, 5734.713264336767, 5740.311162660508, 5789.942100579025, 5293.470652934753, 5405.78376864921, 5406.459354064641, 5420.457954204548, 5423.538999185113, 6328.905066423915, 6332.651704156224, 6346.619202847844, 6352.555321127476, 6366.586171898812, 6324.2410910691015, 6331.366863313632, 6346.809595712136, 6364.299927008118, 6370.93629063722, 6252.812415627538, 6305.8108256752375, 6331.778387756406, 6332.366763323631, 6417.326180751141, 6258.12386265914, 6267.780627678009, 6288.308286088435, 6308.71610777507, 6313.621182729051, 6339.144215530844, 6342.334054924167, 6342.841428964312, 6343.9365606343345, 6348.682565871595, 5947.256592925884, 6078.088286757022, 6122.142899993915, 6173.259208894961, 6192.938070619236, 6124.14262003311, 6143.6928153593035, 6154.0, 6170.074488826712, 6179.412955769195, 5839.15332276809, 5976.282846058501, 5999.13402246571, 6030.75876964934, 6088.969555152196, 5283.603729720209, 6096.268447786294, 6174.876502470015, 6176.042713379434, 6180.7527698891545, 4705.4588722296, 5887.910736513759, 6028.547858910687, 6070.878582428415, 6070.9089363658695], "unit": "score", "name": "dojo.html", "value": 5732.620868848014}, {"lowerIsBetter": false, "replicates": [455.15795777811036, 463.8515674984004, 568.542323429639, 570.6918264137363, 595.9106134079888, 36773.44839827401, 37470.250594988116, 37487.62512374875, 37572.872813815564, 37581.0, 39380.60619393805, 39798.0, 39841.60158398415, 39884.80057599715, 39918.0, 9449.102335278138, 9674.419534827934, 9677.387105481515, 9686.612535498572, 9688.70933871985, 9394.436333819958, 9407.482588457631, 9429.387089839172, 9576.377535460208, 9577.0, 9583.185429238523, 9665.951670241639, 9669.516524173798, 9710.951445242765, 9711.854322185172, 9577.904220957806, 9656.0, 9656.324057315991, 9656.80686386272, 9693.951530242373, 9503.239740820718, 9645.662401815904, 9646.565904534313, 9654.855177172349, 9662.9516852416, 38496.422553661716, 38951.610483895085, 38999.610003899885, 39075.41386879199, 39238.60761392407, 3143.151349135743, 3186.362727454495, 3200.9519857201926, 3241.173500757315, 3362.260302733395, 27522.587161192598, 28088.876444942176, 28138.718612813813, 28268.717312826815, 28446.862125514956, 2740.0957683964243, 2750.8624568771484, 2838.2620518665294, 2963.5999140116023, 2965.0956458280216, 447935.0, 448765.0, 448817.0, 450032.0, 489464.5526772379, 43458.56541434545, 59896.0, 60697.39302607006, 60762.0, 60781.0, 56629.716851416306, 57046.7147664259, 57270.854582908105, 57308.42691573114, 57315.14027289594, 14529.491467798787, 14743.852561474463, 15909.681806363807, 16097.758533622005, 16144.515664530083, 12199.51201951912, 12496.562620308245, 12504.749905001849, 12528.185667931555, 12532.0, 15585.376584936703, 17769.46691599254, 18210.27158913655, 18272.54318642018, 18334.083295835422, 6237.812865614039, 7083.150021997393, 7969.083555391088, 7970.561619111005, 8029.915961345144, 918.8529835226332, 942.528735632184, 992.399598243067, 1022.9283950123569, 1054.6888667843004, 25633.231003069937, 27214.911403544033, 28644.570331445044, 29034.854825725735, 29443.85278073596, 1075.8649624645918, 1103.5361960868306, 1146.5241924601198, 1160.1646814293695, 1241.5592464675092, 14621.634459138393, 14683.632909177357, 14790.778138327934, 14914.627134321512, 14915.850841491447, 527546.0, 536035.0, 536617.0, 536691.0, 536934.0, 55683.72158139183, 55922.72038639781, 55981.0, 56082.158767618515, 56094.439055609735, 1414.4342263094845, 1414.575627311823, 1447.985520144806, 1449.8187726534395, 1452.194032312056, 28387.432251354443, 28453.288667783472, 28533.857330713214, 28717.712822871505, 28893.711062889943, 47757.76121119372, 48150.759246203546, 48155.0, 48258.27612585884, 48265.0, 488930.0, 491170.0, 493356.0, 493752.0, 495286.0, 27138.77875495647, 30848.0, 31840.203994900312, 31900.361992760478, 32004.67995320017, 39166.608333916294, 39388.212235755695, 39598.0, 39764.602353976086, 40703.982400440225, 32725.18187045343, 33891.0, 34029.0, 34155.65844341525, 34186.65813341835, 24494.0, 33285.235686789536, 38375.232495350494, 38932.221355573296, 42604.72185834306, 37114.257714845015, 37464.25071498609, 38309.04227394338, 38407.0, 38572.614273858024, 34631.480527792606, 37151.88544343674, 38353.0, 38449.6155038446, 38457.807710962385, 30994.0, 31167.68832311648, 31167.844160779052, 31269.687303127586, 31920.0], "unit": "score", "name": "ext.html", "value": 19376.334031684975}, {"lowerIsBetter": false, "replicates": [350.06532558069955, 355.5129472622507, 363.26257696875354, 371.5578461630659, 374.09282489961834, 15627.609309767262, 15734.0, 16107.033577985329, 19300.0, 20150.093245803957, 16217.675646487063, 18934.337298194565, 20206.696899546518, 20424.489387765312, 20566.177352905866, 5690.63010904292, 5896.911546326808, 5897.823065308047, 5901.586888917777, 5904.439078287556, 4198.790060496978, 4373.169097871394, 5772.191893134965, 5862.179294898718, 6095.207623009002, 6229.719662615171, 6257.812265632016, 6322.810315690536, 6340.3659634036685, 6340.651264180468, 6216.409441103111, 6292.370762923694, 6307.959186734183, 6421.068945002995, 6421.775237866699, 5350.892982140335, 5498.202760599731, 5502.80740174092, 5503.3395992481155, 5506.174073888908, 24851.378715532075, 25004.37489062788, 25218.739063046956, 25414.983400664136, 25476.745232547622, 1912.9192006516412, 1950.8879938435098, 2194.034624765098, 2334.9883250583807, 2705.971730742325, 13384.0, 14509.92745036268, 14676.853231467656, 14821.184834834079, 14997.625059373493, 1667.2747354900657, 1712.880098393113, 1731.1603872122012, 1753.9298428062862, 1812.8187181281899, 92744.0, 93247.0, 93608.0, 94037.5298123505, 94536.05463945342, 10295.742606434898, 10564.366138031743, 10763.192760542834, 10785.730356740987, 10834.187435942336, 13032.674183145496, 13043.152195107288, 13055.543055992996, 13061.020423468279, 26457.867710661707, 10178.13485853696, 10187.388756674623, 10247.436390998417, 10425.791484170275, 10640.0, 8863.556822158995, 8906.688265910661, 8996.59515321812, 9055.320850936074, 9286.814263714688, 6452.548321617442, 8410.915890841135, 8420.631747301128, 8456.619452124669, 8539.462896678533, 2610.908618198354, 3422.0, 3424.0, 3435.604905435857, 3575.8748443804343, 843.5149788871423, 893.7408151636083, 900.5767289373983, 943.3585162089845, 943.7310366545502, 16299.376715033295, 19168.424947251606, 19856.90071549662, 20467.385978420672, 21620.675689864664, 937.8827646544182, 974.3666616699061, 1020.6529779874878, 1047.994760026195, 1066.4454483668449, 8221.0, 9787.923328433866, 10838.837417438745, 11356.148288878201, 11423.657290281304, 612796.0, 650362.0, 678681.0, 732632.0, 741683.0, 94783.0, 109474.0, 123113.0, 124215.0, 127383.0, 1168.6260396673154, 1191.9284842909453, 1199.8860108289698, 1202.0323639470137, 1204.2413279633774, 15920.442784502487, 18516.537086572942, 18721.0, 18894.52763680864, 18974.0, 47893.5210647903, 48144.981877265345, 48500.272495911886, 49526.00947980948, 49750.81603375036, 66956.0, 68554.65722671355, 69840.65079674569, 74757.62621187077, 75569.58112729754, 7487.6630551626395, 7575.810604734926, 7681.42389320792, 7723.420743444377, 7728.806779830549, 7505.624718764149, 8414.87377689323, 11753.294802311888, 11979.371683400115, 12232.633021009384, 8963.551822408985, 10227.0, 10377.636782712569, 10542.26204165701, 10753.784924301626, 10393.688189354332, 10487.161027117965, 10606.46967651599, 10608.522616482123, 10707.0, 10659.680209593724, 10830.67507974762, 10890.50992705346, 10897.67306980792, 10997.835032474679, 7594.31651151399, 7671.0, 7699.3840492761565, 7734.149243583314, 7758.9612051939375, 9780.804383912424, 10693.625723099654, 10706.8929310709, 10944.945275273572, 10973.780524389627], "unit": "score", "name": "jquery.html", "value": 9728.372797472028}, {"lowerIsBetter": false, "replicates": [1395.1350162899005, 1448.3916754962916, 1452.2012892908904, 1763.1008185825226, 1940.5051711813476, 7940.0, 8668.566571671416, 8855.645774169025, 8857.335699822506, 8868.0, 8511.914880851189, 8795.384323097369, 8812.691555795549, 8814.4711317321, 8827.867581986275, 2179.139240000207, 2237.8433509654333, 2426.0, 2490.551700693879, 2507.5737124688753, 2098.391466474728, 2489.9751002489925, 2500.1624455807328, 2503.7245902950663, 2506.0727530813624, 2351.7765812247894, 2421.7820396164343, 2427.2596857958315, 2429.8056155507606, 2439.817013723969, 2452.2275483222816, 2492.264781889347, 2501.6997960244703, 2508.8620125893067, 2510.8619025953567, 2461.1878080233478, 2480.2559232230437, 2482.5034993001473, 2501.962470562925, 2506.786923111538, 8912.509811960339, 8986.640534378617, 8987.32595055367, 9008.099190081006, 9023.278137748965, 5447.1829225616075, 5580.944190558083, 5585.134304182858, 5591.580631452657, 5593.216949627055, 3602.3155600435834, 3663.6153203913736, 3751.568569614502, 3767.321882061228, 3769.8680546181026, 1040.4693606260862, 1045.8535804987307, 1063.6596289187464, 1089.0688461365576, 1093.9726506837312, 12144.696382590506, 12178.939105304416, 12179.756404871852, 12181.878181218162, 12185.51257949681, 4890.1931181355385, 4923.163062279421, 4970.229614409773, 4989.326440930428, 4994.750262486861, 10326.173906087644, 10333.173346132291, 10338.53476593555, 10346.017128372792, 10346.689599312032, 4371.322445021026, 4568.246239370466, 5547.33431988164, 5561.63849349791, 5564.554835613141, 4993.151164302078, 5036.597072234213, 5051.015052064812, 5056.216286475602, 5060.139776238048, 3752.2870654575545, 3801.486799282117, 3809.9238015240094, 3833.1375440526217, 3858.2090671412293, 1213.1811027556364, 1225.7732319520917, 1227.607165706983, 1229.244014930829, 1233.272369302116, 1329.4416345135066, 1331.187975335045, 1340.7653660609353, 1369.7739872920856, 1372.3824279074456, 8080.0, 8271.503709777433, 8277.255047045795, 8285.62714677841, 8351.874721879176, 1198.4966314148078, 1199.4722322178388, 1206.3124019309084, 1219.0369608009573, 1239.7954337534206, 6188.319284878659, 6206.937930620727, 6284.717187726564, 6292.811215663537, 6293.716782744787, 10593.788124237471, 10989.61536346224, 11075.224734268524, 11086.611968581223, 11091.72270693239, 10485.790284194274, 10836.0789332906, 10947.397893115955, 10950.0, 10950.288231264942, 8385.371097167737, 8508.0, 8516.1058088901, 8516.318694504425, 8523.74428767138, 7859.135495095649, 7981.201879812204, 8047.396445266511, 8079.272865442138, 8082.515049096838, 9470.668526601536, 9750.366226195274, 9867.55595998196, 9956.153726933291, 9975.551100200364, 9786.902130978599, 10231.028052335314, 10318.793624127326, 10321.74195645085, 10326.432046237229, 6385.840353991188, 6396.6481843497195, 6522.543421960607, 6801.455883529206, 7005.54463959841, 8256.587170641324, 8270.958645206736, 8305.127961563949, 8308.376871734765, 8326.958365208135, 7493.363064139609, 7719.5754233515445, 7752.341051010727, 7826.295633393022, 7844.21557844211, 7500.662470188746, 7542.170361260367, 7602.860028759439, 7713.845723085619, 7730.574818385043, 7726.304632583095, 7779.961100194463, 7845.333146682596, 7853.293203611703, 7859.4891332063235, 7024.929750702428, 7112.182099058675, 7121.715131394893, 7125.5368401053765, 7129.3583577478275, 7175.067241258603, 7177.031100801325, 7183.604901730455, 7238.23998480173, 7242.565446073042], "unit": "score", "name": "mootools.html", "value": 4990.807516773169}, {"lowerIsBetter": false, "replicates": [320.81072167421223, 328.1451818014073, 333.5713608013702, 337.2597149257381, 339.8750137046378, 6410.1987251593555, 6602.768903088387, 6612.404883560479, 6624.0, 6627.403533681968, 5206.635535512506, 5766.106253530709, 6550.770723024695, 6570.371851259499, 6578.539502234846, 3963.2667956428154, 4857.902841943168, 4890.21756518957, 4897.3878265216845, 4912.435069966946, 4641.373414589038, 4778.761061946906, 4791.568758811706, 4921.950780492203, 4927.162382395001, 4828.275758636198, 4848.369711937443, 4851.927221091686, 4853.878653033667, 4861.416630004404, 4857.63567732418, 4867.4889136640495, 4872.366592342991, 4879.6828206166665, 4883.291922671193, 3652.4156135018534, 3962.405639154121, 4154.127633197032, 4160.791960401998, 4165.500139983191, 6183.8503990787185, 6303.0545418187185, 6328.810135695937, 6335.0, 6357.11000459936, 5642.097264437671, 5642.322921249435, 5650.576206784508, 5660.971695141539, 5661.830145095653, 6917.7232910683515, 6929.0, 6931.09895713559, 6931.133608298963, 6946.444284457231, 4481.619062379702, 4632.027274272406, 4632.745199014053, 4633.258678611406, 4645.303204519315, 7325.4139668826365, 7343.669534870944, 7346.77959661211, 7355.521891077063, 7376.409887209011, 4688.296755486636, 4692.741899195577, 4704.129735998851, 4705.082508910729, 4723.149833030019, 4779.474257831635, 4799.448063472745, 4802.519748025239, 4815.3017812417, 4815.398075240595, 5318.414974352818, 5546.86132846674, 5555.916661250085, 5557.749901254453, 5790.507806836466, 7006.859862802818, 7007.334303241184, 7019.719211231596, 7021.017057611938, 7025.051618031603, 1600.1919030889326, 1620.173711407191, 1622.3105180298562, 1625.2767518454411, 1625.2848746551715, 1023.8054769593903, 1038.444432228754, 1040.8750949886062, 1055.5302890213934, 1056.4823236614156, 6512.153420055457, 6514.609123452608, 6522.478201743849, 6522.543421960418, 6529.771457998947, 5941.494972927263, 7092.0, 7243.9637801811705, 7264.927350726531, 7306.890396643948, 6571.83570410734, 6573.835654108686, 6590.505712071518, 6599.637019963948, 6602.60384376939, 3812.8093595320124, 3860.034991252187, 3863.343231650626, 3865.3235683755793, 3873.3996230584303, 7378.778636640909, 7599.240075992357, 7616.238376162451, 7645.006149200568, 7660.770176894702, 7518.28576285263, 7522.887156692654, 7523.962380188064, 7526.5860377679755, 7538.547687138789, 6168.907466388007, 6831.897521537181, 6933.37599616037, 7401.779466160238, 7614.314711675976, 7301.817454563678, 7311.926880731125, 7321.0, 7322.414206863545, 7327.633618318956, 7156.534825236343, 7162.427005839624, 7164.820879478055, 7165.0, 7170.282971702788, 7359.668814903449, 7587.430942679211, 7631.198724133886, 7638.312551870358, 7639.04511936008, 4559.794809233659, 4641.280601506772, 4657.86026419208, 4658.953410465852, 4660.510646382081, 7285.7814265572115, 7294.270572942663, 7294.744683936036, 7307.890381644173, 7310.817229569303, 6377.808665740035, 6828.180618325832, 7021.473389495706, 7037.1555413350725, 7076.761566725905, 7043.190033146049, 7044.29557044312, 7052.717891284291, 7058.223595404604, 7078.0, 6868.656567171522, 6873.725050998104, 6879.0025446309, 6896.448284137156, 6900.447964162755, 6778.254392016973, 6974.860502789814, 6980.394509262796, 6997.335253150943, 7009.754658586925, 5457.235986961908, 6633.502487313374, 6743.988401739778, 6821.863562728817, 6854.0], "unit": "score", "name": "prototype.html", "value": 5116.595095699544}, {"lowerIsBetter": false, "replicates": [676.2155899156978, 738.2691135775581, 746.1158527145333, 746.9141048779388, 748.457368407904, 14489.42042318306, 14786.40854365824, 14820.407183712652, 14825.925870370647, 14903.776443353358, 15096.924515377435, 15538.223088845569, 15556.299966501507, 15564.299606517705, 15592.45426410076, 698.2982102986491, 722.6134018300211, 860.0668274921702, 884.4030279561302, 885.6014793342989, 715.6099925540567, 860.0410542245414, 874.7375787263827, 876.2464280718577, 877.1097336203758, 915.4598786715836, 916.1525588830339, 920.8434566123741, 925.3337596930199, 925.888893332801, 727.8835386338187, 747.712130829629, 890.585877566928, 910.1080940678172, 911.1981456318431, 680.425040840489, 680.5576375356009, 681.0329332348077, 681.1655721740877, 681.5467713970254, 14780.926095369454, 14834.777478337834, 14850.628734281729, 14862.2568871556, 14880.51194880514, 12188.878111218952, 12234.388280585936, 12263.877361226363, 12270.079744019235, 12560.183588066746, 10126.9493652532, 10164.796704065877, 10187.032231937954, 10199.286049976505, 10221.182305415548, 3455.809930453824, 3470.2192006798523, 3473.9131521711906, 3482.2687235680537, 3497.3005398920063, 76885.23114768836, 77700.0, 78828.60585697093, 78836.0, 79031.0, 9249.260059195249, 9259.537023148816, 9498.715038548855, 9575.808483830284, 9854.852177217348, 20289.391318260477, 20329.695054574193, 20379.694304585442, 20418.897905510377, 20428.0807363669, 7455.7017719290625, 7613.885791713129, 7619.961900190575, 7677.577733224726, 7711.228877112244, 4172.395002724648, 4182.019889853015, 4228.619424251832, 4255.87232383029, 4418.116376724668, 3452.171478845059, 3488.686018258369, 3494.5107684924133, 3495.4582039783872, 3498.1954150545516, 629.6190804563265, 639.3318981664172, 647.4690753582112, 648.7891435283552, 653.6633633678659, 506.07641055074635, 574.9942500575024, 613.7943788830792, 634.4702173685025, 638.8243233110932, 9019.413738107001, 9103.408278461879, 9202.585883635118, 9293.953530232306, 9669.854952175723, 490.7227416509732, 554.6394843351853, 555.8276934150426, 615.3753939751156, 651.273829679913, 3467.420857212402, 3756.6806821420487, 3881.844726210976, 3955.7626542407547, 4097.262492751273, 84502.0, 85202.57398712967, 85294.14705852987, 94337.52831235937, 95660.0, 79250.6037469809, 79654.0, 80445.59777201076, 81011.7848232277, 81858.0, 62614.686926565075, 66473.33526664671, 71249.64375178091, 72051.0, 72619.0, 8603.870941936002, 8725.432846864933, 8786.341024423065, 8824.0, 8877.979032411355, 45880.31179532243, 50507.74746126246, 50905.236421452966, 51142.74428627833, 51477.22784158315, 68551.65724171347, 71075.0, 71548.28451715625, 71551.64224178846, 72204.63897680478, 10600.46997650099, 10930.234883558074, 11136.610218642309, 11161.274517156358, 11225.270357426742, 11903.702407439883, 12057.879421205676, 12314.014878809852, 12564.874351256736, 12672.176308539916, 10942.288751231144, 11500.137489688139, 11514.94242528782, 11572.24780389272, 12264.995076206387, 11283.774324513628, 11354.318740875575, 11663.88336116628, 11742.0, 11968.341741204318, 10892.0, 10899.836502452628, 10902.672919812418, 11260.662180134608, 11864.584739534075, 7651.5409075455655, 9199.632014719336, 9311.530048953406, 9486.241100711788, 9730.0, 8755.956220219114, 8900.910990890266, 9263.547018314457, 9694.644667895514, 9694.709158725249], "unit": "score", "name": "yui.html", "value": 6870.653508208566}], "name": "dromaeo_css", "value": 7579.516683669328}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 156.0, 150.0, 111.0, 110.0, 116.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 119.8}, {"lowerIsBetter": true, "replicates": [156.0, 121.0, 146.0, 155.0, 124.0, 158.0, 170.0, 148.0, 166.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 146.2}, {"lowerIsBetter": true, "replicates": [186.0, 183.0, 184.0, 186.0, 187.0, 182.0, 185.0, 187.0, 181.0, 185.0], "unit": "score", "name": "audio-dft", "value": 184.6}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 83.0, 76.0, 56.0, 58.0, 57.0, 79.0, 77.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.0}, {"lowerIsBetter": true, "replicates": [95.0, 133.0, 156.0, 79.0, 81.0, 83.0, 110.0, 76.0, 78.0, 110.0], "unit": "score", "name": "audio-oscillator", "value": 100.1}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 84.0, 91.0, 84.0, 89.0, 84.0, 89.0, 85.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 94.0, 92.0, 94.0, 94.0, 94.0, 93.0, 95.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.5}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 87.0, 89.0, 88.0, 86.0, 87.0, 86.0, 84.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 86.3}, {"lowerIsBetter": true, "replicates": [54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 54.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.4}, {"lowerIsBetter": true, "replicates": [62.0, 70.0, 72.0, 69.0, 69.0, 67.0, 66.0, 65.0, 71.0, 96.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.7}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 86.0, 101.0, 83.0, 83.0, 83.0, 82.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [126.0, 131.0, 125.0, 112.0, 123.0, 123.0, 117.0, 130.0, 123.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [157.0, 140.0, 124.0, 162.0, 135.0, 127.0, 137.0, 134.0, 135.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.8}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 65.0, 68.0, 69.0, 83.0, 86.0, 94.0, 91.0, 78.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.8}], "name": "kraken", "value": 1435.9}]} 05:39:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1435.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7579.52"}}} 05:39:18 INFO - Return code: 0 05:39:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:39:18 INFO - # TBPL SUCCESS # 05:39:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:39:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:39:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:39:18 INFO - 2016-02-16 05:39:18.895 screenresolution[1695:10563] starting screenresolution argv=screenresolution get 05:39:18 INFO - 2016-02-16 05:39:18.898 screenresolution[1695:10563] Display 0: 1600x1200x32@60 05:39:18 INFO - 2016-02-16 05:39:18.903 screenresolution[1696:10566] starting screenresolution argv=screenresolution list 05:39:18 INFO - Available Modes on Display 0 05:39:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:39:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:39:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:39:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:39:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:39:19 INFO - Intel Iris: 05:39:19 INFO - Chipset Model: Intel Iris 05:39:19 INFO - Type: GPU 05:39:19 INFO - Bus: Built-In 05:39:19 INFO - VRAM (Dynamic, Max): 1536 MB 05:39:19 INFO - Vendor: Intel (0x8086) 05:39:19 INFO - Device ID: 0x0a2e 05:39:19 INFO - Revision ID: 0x0009 05:39:19 INFO - Displays: 05:39:19 INFO - Display: 05:39:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:39:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:39:19 INFO - Display Serial Number: 1600x1200 60 05:39:19 INFO - Main Display: Yes 05:39:19 INFO - Mirror: Off 05:39:19 INFO - Online: Yes 05:39:19 INFO - Rotation: Supported 05:39:19 INFO - Return code: 0 05:39:19 INFO - Running post-action listener: _resource_record_post_action 05:39:19 INFO - Running post-run listener: _resource_record_post_run 05:39:20 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 33820160; Write bytes: 710446080; Read time: 452; Write time: 2858 05:39:20 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 245760; Write bytes: 406595584; Read time: 5; Write time: 748 05:39:20 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32038400; Write bytes: 303002624; Read time: 433; Write time: 2108 05:39:20 INFO - Running post-run listener: _upload_blobber_files 05:39:20 INFO - Blob upload gear active. 05:39:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:39:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:39:20 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:39:20 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:39:20 INFO - (blobuploader) - INFO - Open directory for files ... 05:39:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:39:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:39:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:21 INFO - (blobuploader) - INFO - Done attempting. 05:39:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:39:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:39:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:39:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:39:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:39:22 INFO - (blobuploader) - INFO - Done attempting. 05:39:22 INFO - (blobuploader) - INFO - Iteration through files over. 05:39:22 INFO - Return code: 0 05:39:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:39:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:39:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22c9d51eb5bf271a23551513133246daa2e83506b227901d2b8d1e253fd66173b631e6da0ea8335f0875cee207c14bc637117e22d9205d735271ed5985dea65e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45d166126430e719e83016f41c34e5f4c9b31c4182baee91e47472ca266ad4e0db7f6e731c9a27b21057671580e3248af5cdd8a72dd5df04a20db2a0749ed7d5"} 05:39:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:39:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:39:22 INFO - Contents: 05:39:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22c9d51eb5bf271a23551513133246daa2e83506b227901d2b8d1e253fd66173b631e6da0ea8335f0875cee207c14bc637117e22d9205d735271ed5985dea65e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45d166126430e719e83016f41c34e5f4c9b31c4182baee91e47472ca266ad4e0db7f6e731c9a27b21057671580e3248af5cdd8a72dd5df04a20db2a0749ed7d5"} 05:39:22 INFO - Running post-run listener: copy_logs_to_upload_dir 05:39:22 INFO - Copying logs to upload dir... 05:39:22 INFO - mkdir: /builds/slave/test/build/upload/logs 05:39:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.204434 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-02-16 05:39:22.343257) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 05:39:22.346549) ========= 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.Bh938qLlux/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.xghoh37cg4/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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/Firefox/sha512/22c9d51eb5bf271a23551513133246daa2e83506b227901d2b8d1e253fd66173b631e6da0ea8335f0875cee207c14bc637117e22d9205d735271ed5985dea65e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45d166126430e719e83016f41c34e5f4c9b31c4182baee91e47472ca266ad4e0db7f6e731c9a27b21057671580e3248af5cdd8a72dd5df04a20db2a0749ed7d5"} build_url:https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/QAaX-w0NQySKY-oBBufJIA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22c9d51eb5bf271a23551513133246daa2e83506b227901d2b8d1e253fd66173b631e6da0ea8335f0875cee207c14bc637117e22d9205d735271ed5985dea65e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45d166126430e719e83016f41c34e5f4c9b31c4182baee91e47472ca266ad4e0db7f6e731c9a27b21057671580e3248af5cdd8a72dd5df04a20db2a0749ed7d5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-16 05:39:22.376584) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:39:22.377316) ========= 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.Bh938qLlux/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.xghoh37cg4/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.005135 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-16 05:39:22.430718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 05:39:22.431463) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-16 05:39:22.432405) ========= ========= Total master_lag: 0.68 =========