builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0009 starttime: 1455840739.85 results: success (0) buildid: 20160218140426 builduid: df533b752b42406c89c03235b7f61701 revision: d5daf10d3b74b04e8fa63c4e5429de8a0adf79f8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 16:12:19.847417) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 16:12:19.847820) ========= ========= Started set props: basedir (results: 0, elapsed: 6 secs) (at 2016-02-18 16:12:19.848108) ========= 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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005491 basedir: '/builds/slave/test' ========= master_lag: 6.99 ========= ========= Finished set props: basedir (results: 0, elapsed: 6 secs) (at 2016-02-18 16:12:26.839297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-02-18 16:12:26.839634) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-02-18 16:12:34.684317) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-02-18 16:12:34.684616) ========= 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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005764 ========= master_lag: 2.59 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-02-18 16:12:37.280171) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 16:12:37.280509) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 16:12:37.280886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-02-18 16:12:37.281161) ========= 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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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-18 16:12:37-- 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% 15.9M=0.001s 2016-02-18 16:12:37 (15.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.484047 ========= master_lag: 5.19 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2016-02-18 16:12:42.953097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 16:12:42.953396) ========= 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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.026091 ========= master_lag: 1.19 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 16:12:44.164854) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 18 secs) (at 2016-02-18 16:12:44.165211) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d5daf10d3b74b04e8fa63c4e5429de8a0adf79f8 --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 d5daf10d3b74b04e8fa63c4e5429de8a0adf79f8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GWqV7NsdbU/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.f6k2DTr0bB/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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-18 16:12:44,488 truncating revision to first 12 chars 2016-02-18 16:12:44,488 Setting DEBUG logging. 2016-02-18 16:12:44,488 attempt 1/10 2016-02-18 16:12:44,488 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d5daf10d3b74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 16:12:45,096 unpacking tar archive at: mozilla-central-d5daf10d3b74/testing/mozharness/ program finished with exit code 0 elapsedTime=0.845637 ========= master_lag: 17.69 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 18 secs) (at 2016-02-18 16:13:02.696529) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-02-18 16:13:02.696893) ========= echo d5daf10d3b74b04e8fa63c4e5429de8a0adf79f8 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd5daf10d3b74b04e8fa63c4e5429de8a0adf79f8'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GWqV7NsdbU/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.f6k2DTr0bB/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 d5daf10d3b74b04e8fa63c4e5429de8a0adf79f8 program finished with exit code 0 elapsedTime=0.005807 script_repo_revision: 'd5daf10d3b74b04e8fa63c4e5429de8a0adf79f8' ========= master_lag: 1.47 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-02-18 16:13:04.172124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 8 secs) (at 2016-02-18 16:13:04.172427) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 8 secs) (at 2016-02-18 16:13:12.522850) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-18 16:13:12.523215) ========= /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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 16:13:13 INFO - MultiFileLogger online at 20160218 16:13:13 in /builds/slave/test 16:13:13 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 16:13:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:13:13 INFO - {'append_to_log': False, 16:13:13 INFO - 'base_work_dir': '/builds/slave/test', 16:13:13 INFO - 'blob_upload_branch': 'Firefox', 16:13:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:13:13 INFO - 'branch': 'Firefox', 16:13:13 INFO - 'buildbot_json_path': 'buildprops.json', 16:13:13 INFO - 'config_files': ('talos/mac_config.py',), 16:13:13 INFO - 'default_actions': ('clobber', 16:13:13 INFO - 'read-buildbot-config', 16:13:13 INFO - 'download-and-extract', 16:13:13 INFO - 'populate-webroot', 16:13:13 INFO - 'create-virtualenv', 16:13:13 INFO - 'install', 16:13:13 INFO - 'run-tests'), 16:13:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:13:13 INFO - 'download_minidump_stackwalk': True, 16:13:13 INFO - 'download_symbols': 'ondemand', 16:13:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:13:13 INFO - 'tooltool.py': '/tools/tooltool.py', 16:13:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:13:13 INFO - '/tools/misc-python/virtualenv.py')}, 16:13:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:13:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:13:13 INFO - 'installer_path': 'installer.exe', 16:13:13 INFO - 'log_level': 'info', 16:13:13 INFO - 'log_name': 'talos', 16:13:13 INFO - 'log_to_console': True, 16:13:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:13:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:13:13 INFO - 'opt_config_files': (), 16:13:13 INFO - 'pip_index': False, 16:13:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:13:13 INFO - 'cmd': ('bash', 16:13:13 INFO - '-c', 16:13:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:13:13 INFO - 'enabled': True, 16:13:13 INFO - 'halt_on_failure': False, 16:13:13 INFO - 'name': 'check_screen_resolution'},), 16:13:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:13:13 INFO - 'cmd': ('bash', 16:13:13 INFO - '-c', 16:13:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:13:13 INFO - 'enabled': True, 16:13:13 INFO - 'halt_on_failure': False, 16:13:13 INFO - 'name': 'check_screen_resolution'},), 16:13:13 INFO - 'run_cmd_checks_enabled': True, 16:13:13 INFO - 'sps_profile': False, 16:13:13 INFO - 'sps_profile_interval': 0, 16:13:13 INFO - 'suite': 'dromaeojs', 16:13:13 INFO - 'system_bits': '32', 16:13:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:13:13 INFO - 'title': 't-yosemite-r7-0009', 16:13:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:13:13 INFO - 'use_talos_json': True, 16:13:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:13:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:13:13 INFO - 'work_dir': 'build'} 16:13:13 INFO - ##### 16:13:13 INFO - ##### Running clobber step. 16:13:13 INFO - ##### 16:13:13 INFO - Running pre-action listener: _resource_record_pre_action 16:13:13 INFO - Running main action method: clobber 16:13:13 INFO - rmtree: /builds/slave/test/build 16:13:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:13:14 INFO - Running post-action listener: _resource_record_post_action 16:13:14 INFO - ##### 16:13:14 INFO - ##### Running read-buildbot-config step. 16:13:14 INFO - ##### 16:13:14 INFO - Running pre-action listener: _resource_record_pre_action 16:13:14 INFO - Running main action method: read_buildbot_config 16:13:14 INFO - Using buildbot properties: 16:13:14 INFO - { 16:13:14 INFO - "project": "", 16:13:14 INFO - "product": "firefox", 16:13:14 INFO - "script_repo_revision": "production", 16:13:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:13:14 INFO - "repository": "", 16:13:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:13:14 INFO - "buildid": "20160218140426", 16:13:14 INFO - "pgo_build": "False", 16:13:14 INFO - "basedir": "/builds/slave/test", 16:13:14 INFO - "buildnumber": 134, 16:13:14 INFO - "slavename": "t-yosemite-r7-0009", 16:13:14 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:13:14 INFO - "platform": "yosemite_r7", 16:13:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:13:14 INFO - "branch": "mozilla-central", 16:13:14 INFO - "repo_path": "mozilla-central", 16:13:14 INFO - "revision": "d5daf10d3b74b04e8fa63c4e5429de8a0adf79f8", 16:13:14 INFO - "stage_platform": "macosx64", 16:13:14 INFO - "builduid": "df533b752b42406c89c03235b7f61701", 16:13:14 INFO - "slavebuilddir": "test" 16:13:14 INFO - } 16:13:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 16:13:14 INFO - Running post-action listener: _resource_record_post_action 16:13:14 INFO - ##### 16:13:14 INFO - ##### Running download-and-extract step. 16:13:14 INFO - ##### 16:13:14 INFO - Running pre-action listener: _resource_record_pre_action 16:13:14 INFO - Running main action method: download_and_extract 16:13:14 INFO - mkdir: /builds/slave/test/build/tests 16:13:14 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')]} 16:13:14 INFO - https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:13:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/test_packages.json 16:13:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/test_packages.json 16:13:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:13:18 INFO - Downloaded 1277 bytes. 16:13:18 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:13:18 INFO - Using the following test package requirements: 16:13:18 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:13:18 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:18 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 16:13:18 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:18 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 16:13:18 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:18 INFO - u'jsshell-mac.zip'], 16:13:18 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:18 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 16:13:18 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:13:18 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:18 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 16:13:18 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:18 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 16:13:18 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:18 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 16:13:18 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:13:18 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:13:18 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 16:13:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:13: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')]} 16:13:18 INFO - https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:13:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:13:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:13:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/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 16:13:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/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 16:13:19 INFO - Downloaded 17807336 bytes. 16:13: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'] 16:13: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 16:13:22 INFO - Return code: 0 16:13:22 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 16:13:22 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')]} 16:13:22 INFO - https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:13:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:13:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:13:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/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 16:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/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 16:13:23 INFO - Downloaded 17807336 bytes. 16:13:23 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'] 16:13:23 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 16:13:27 INFO - Return code: 0 16:13:27 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')]} 16:13:27 INFO - https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:13:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:13:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:13:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/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 16:13:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/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 16:13:29 INFO - Downloaded 10707071 bytes. 16:13: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'] 16:13: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 16:13:29 INFO - Return code: 0 16:13: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')]} 16:13:29 INFO - https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:13:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:13:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:13:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 16:13:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZTGHfYaQImVKewLO6niSg/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 16:13:32 INFO - Downloaded 111345839 bytes. 16:13:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:13:32 INFO - mkdir: /builds/slave/test/properties 16:13:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:13:32 INFO - Writing to file /builds/slave/test/properties/build_url 16:13:32 INFO - Contents: 16:13:32 INFO - build_url:https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:13:33 INFO - Running post-action listener: _resource_record_post_action 16:13:33 INFO - Running post-action listener: set_extra_try_arguments 16:13:33 INFO - ##### 16:13:33 INFO - ##### Running populate-webroot step. 16:13:33 INFO - ##### 16:13:33 INFO - Running pre-action listener: _resource_record_pre_action 16:13:33 INFO - Running main action method: populate_webroot 16:13:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:13:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:13:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:13:33 INFO - '--tppagecycles', 16:13:33 INFO - '7'], 16:13:33 INFO - 'tests': ['tsvgm']}}, 16:13:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:13:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:13:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:13:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:13:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:13:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:13:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'talos_options': ['--e10s'], 16:13:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'tests': ['damp', 'tps']}, 16:13:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'talos_options': ['--e10s'], 16:13:33 INFO - 'tests': ['damp', 'tps']}, 16:13:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:13:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:13:33 INFO - 'other': {'tests': ['a11yr', 16:13:33 INFO - 'ts_paint', 16:13:33 INFO - 'tpaint', 16:13:33 INFO - 'sessionrestore', 16:13:33 INFO - 'sessionrestore_no_auto_restore']}, 16:13:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:13:33 INFO - 'tests': ['a11yr', 16:13:33 INFO - 'ts_paint', 16:13:33 INFO - 'tpaint', 16:13:33 INFO - 'sessionrestore', 16:13:33 INFO - 'sessionrestore_no_auto_restore']}, 16:13:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:13:33 INFO - 'tests': ['a11yr', 16:13:33 INFO - 'ts_paint', 16:13:33 INFO - 'tpaint', 16:13:33 INFO - 'sessionrestore', 16:13:33 INFO - 'sessionrestore_no_auto_restore']}, 16:13:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:13:33 INFO - 'tests': ['a11yr', 16:13:33 INFO - 'ts_paint', 16:13:33 INFO - 'tpaint', 16:13:33 INFO - 'sessionrestore', 16:13:33 INFO - 'sessionrestore_no_auto_restore']}, 16:13:33 INFO - 'other_l64': {'tests': ['a11yr', 16:13:33 INFO - 'ts_paint', 16:13:33 INFO - 'tpaint', 16:13:33 INFO - 'sessionrestore', 16:13:33 INFO - 'sessionrestore_no_auto_restore']}, 16:13:33 INFO - 'other_nol64': {'tests': ['a11yr', 16:13:33 INFO - 'ts_paint', 16:13:33 INFO - 'tpaint', 16:13:33 INFO - 'sessionrestore', 16:13:33 INFO - 'sessionrestore_no_auto_restore']}, 16:13:33 INFO - 'svgr': {'tests': ['tsvgx', 16:13:33 INFO - 'tsvgr_opacity', 16:13:33 INFO - 'tart', 16:13:33 INFO - 'tscrollx', 16:13:33 INFO - 'cart']}, 16:13:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:13:33 INFO - 'tests': ['tsvgx', 16:13:33 INFO - 'tsvgr_opacity', 16:13:33 INFO - 'tart', 16:13:33 INFO - 'tscrollx', 16:13:33 INFO - 'cart']}, 16:13:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'tests': ['tp5o']}, 16:13:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'talos_options': ['--e10s'], 16:13:33 INFO - 'tests': ['tp5o']}, 16:13:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'talos_options': ['--xperf_path', 16:13:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:33 INFO - 'tests': ['tp5n']}, 16:13:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:13:33 INFO - 'talos_options': ['--e10s', 16:13:33 INFO - '--xperf_path', 16:13:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:33 INFO - 'tests': ['tp5n']}}, 16:13:33 INFO - 'talos.zip': {'path': '', 16:13:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:13:33 INFO - Running post-action listener: _resource_record_post_action 16:13:33 INFO - ##### 16:13:33 INFO - ##### Running create-virtualenv step. 16:13:33 INFO - ##### 16:13:33 INFO - Running pre-action listener: _resource_record_pre_action 16:13:33 INFO - Running main action method: create_virtualenv 16:13:33 INFO - Creating virtualenv /builds/slave/test/build/venv 16:13:33 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 16:13:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:13:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:13:33 INFO - Using real prefix '/tools/python27' 16:13:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:13:34 INFO - Installing distribute.............................................................................................................................................................................................done. 16:13:37 INFO - Installing pip.................done. 16:13:37 INFO - Return code: 0 16:13:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:37 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 0x1082d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb8c82d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108177d30>, '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 0x107f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10816eb20>, '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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 16:13:37 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 16:13:37 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 16:13:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GWqV7NsdbU/Render', 16:13:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:37 INFO - 'HOME': '/Users/cltbld', 16:13:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:37 INFO - 'LOGNAME': 'cltbld', 16:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:37 INFO - 'MOZ_NO_REMOTE': '1', 16:13:37 INFO - 'NO_EM_RESTART': '1', 16:13:37 INFO - 'PAGER': '/bin/cat', 16:13:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:37 INFO - 'PWD': '/builds/slave/test', 16:13:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:37 INFO - 'SHELL': '/bin/bash', 16:13:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6k2DTr0bB/Listeners', 16:13:37 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 16:13:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:37 INFO - 'USER': 'cltbld', 16:13:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:37 INFO - 'XPC_FLAGS': '0x0', 16:13:37 INFO - 'XPC_SERVICE_NAME': '0', 16:13:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:37 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 16:13:37 INFO - Cleaning up... 16:13:37 INFO - Return code: 0 16:13:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:37 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 0x1082d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb8c82d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108177d30>, '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 0x107f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10816eb20>, '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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 16:13:37 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 16:13:37 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 16:13:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GWqV7NsdbU/Render', 16:13:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:37 INFO - 'HOME': '/Users/cltbld', 16:13:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:37 INFO - 'LOGNAME': 'cltbld', 16:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:37 INFO - 'MOZ_NO_REMOTE': '1', 16:13:37 INFO - 'NO_EM_RESTART': '1', 16:13:37 INFO - 'PAGER': '/bin/cat', 16:13:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:37 INFO - 'PWD': '/builds/slave/test', 16:13:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:37 INFO - 'SHELL': '/bin/bash', 16:13:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6k2DTr0bB/Listeners', 16:13:37 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 16:13:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:37 INFO - 'USER': 'cltbld', 16:13:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:37 INFO - 'XPC_FLAGS': '0x0', 16:13:37 INFO - 'XPC_SERVICE_NAME': '0', 16:13:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:37 INFO - Downloading/unpacking psutil>=0.7.1 16:13:37 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 16:13:37 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 16:13:37 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 16:13:37 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 16:13:37 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 16:13:37 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 16:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:13:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:40 INFO - Installing collected packages: psutil 16:13:40 INFO - Running setup.py install for psutil 16:13:40 INFO - building 'psutil._psutil_osx' extension 16:13:40 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 16:13:41 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 16:13:41 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 16:13:41 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 16:13:41 INFO - building 'psutil._psutil_posix' extension 16:13:41 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 16:13:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:13:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:13:41 INFO - ^ 16:13:41 INFO - 1 warning generated. 16:13:41 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 16:13:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:41 INFO - Successfully installed psutil 16:13:41 INFO - Cleaning up... 16:13:41 INFO - Return code: 0 16:13:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:13: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')]} 16:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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')]} 16:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13: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', '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 0x1082d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb8c82d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108177d30>, '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 0x107f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10816eb20>, '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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 16:13: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:13: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 mozsystemmonitor==0.0.0 16:13:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GWqV7NsdbU/Render', 16:13:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:41 INFO - 'HOME': '/Users/cltbld', 16:13:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:41 INFO - 'LOGNAME': 'cltbld', 16:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:41 INFO - 'MOZ_NO_REMOTE': '1', 16:13:41 INFO - 'NO_EM_RESTART': '1', 16:13:41 INFO - 'PAGER': '/bin/cat', 16:13:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:41 INFO - 'PWD': '/builds/slave/test', 16:13:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:41 INFO - 'SHELL': '/bin/bash', 16:13:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6k2DTr0bB/Listeners', 16:13:41 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 16:13:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:41 INFO - 'USER': 'cltbld', 16:13:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:41 INFO - 'XPC_FLAGS': '0x0', 16:13:41 INFO - 'XPC_SERVICE_NAME': '0', 16:13:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:13:42 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 16:13:42 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 16:13:42 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 16:13:42 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 16:13:42 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 16:13:42 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 16:13:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:13:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:13:44 INFO - Installing collected packages: mozsystemmonitor 16:13:44 INFO - Running setup.py install for mozsystemmonitor 16:13:44 INFO - Successfully installed mozsystemmonitor 16:13:44 INFO - Cleaning up... 16:13:44 INFO - Return code: 0 16:13:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:13:44 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')]} 16:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:44 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')]} 16:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:44 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 0x1082d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb8c82d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108177d30>, '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 0x107f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10816eb20>, '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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 16:13:44 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 16:13:44 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 16:13:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GWqV7NsdbU/Render', 16:13:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:44 INFO - 'HOME': '/Users/cltbld', 16:13:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:44 INFO - 'LOGNAME': 'cltbld', 16:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:44 INFO - 'MOZ_NO_REMOTE': '1', 16:13:44 INFO - 'NO_EM_RESTART': '1', 16:13:44 INFO - 'PAGER': '/bin/cat', 16:13:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:44 INFO - 'PWD': '/builds/slave/test', 16:13:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:44 INFO - 'SHELL': '/bin/bash', 16:13:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6k2DTr0bB/Listeners', 16:13:44 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 16:13:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:44 INFO - 'USER': 'cltbld', 16:13:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:44 INFO - 'XPC_FLAGS': '0x0', 16:13:44 INFO - 'XPC_SERVICE_NAME': '0', 16:13:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:45 INFO - Downloading/unpacking blobuploader==1.2.4 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13:47 INFO - Downloading blobuploader-1.2.4.tar.gz 16:13:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:13:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:13:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13:48 INFO - Downloading docopt-0.6.1.tar.gz 16:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:13:48 INFO - Installing collected packages: blobuploader, requests, docopt 16:13:48 INFO - Running setup.py install for blobuploader 16:13:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:13:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:13:48 INFO - Running setup.py install for requests 16:13:49 INFO - Running setup.py install for docopt 16:13:49 INFO - Successfully installed blobuploader requests docopt 16:13:49 INFO - Cleaning up... 16:13:49 INFO - Return code: 0 16:13:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:49 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 0x1082d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb8c82d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108177d30>, '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 0x107f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10816eb20>, '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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 16:13:49 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 16:13:49 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 16:13:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GWqV7NsdbU/Render', 16:13:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:49 INFO - 'HOME': '/Users/cltbld', 16:13:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:49 INFO - 'LOGNAME': 'cltbld', 16:13:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:49 INFO - 'MOZ_NO_REMOTE': '1', 16:13:49 INFO - 'NO_EM_RESTART': '1', 16:13:49 INFO - 'PAGER': '/bin/cat', 16:13:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:49 INFO - 'PWD': '/builds/slave/test', 16:13:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:49 INFO - 'SHELL': '/bin/bash', 16:13:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6k2DTr0bB/Listeners', 16:13:49 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 16:13:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:49 INFO - 'USER': 'cltbld', 16:13:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:49 INFO - 'XPC_FLAGS': '0x0', 16:13:49 INFO - 'XPC_SERVICE_NAME': '0', 16:13:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:49 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-efoOeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:49 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-nBgNi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-8TTU9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-UnO1VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-knZDrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-1r53Dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-vn9ALL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-wAcoCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-DLbME6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-6x4UaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:50 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-q_dlqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:51 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-gx2Iui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:51 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-O6uWdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:51 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-dJx3Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:51 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-qrERAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:51 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-VwKIAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:51 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-9S3M8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:13:51 INFO - Running setup.py install for manifestparser 16:13:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:13:51 INFO - Running setup.py install for mozcrash 16:13:51 INFO - Running setup.py install for mozdebug 16:13:52 INFO - Running setup.py install for mozdevice 16:13:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Running setup.py install for mozfile 16:13:52 INFO - Running setup.py install for mozhttpd 16:13:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Running setup.py install for mozinfo 16:13:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Running setup.py install for mozInstall 16:13:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:13:52 INFO - Running setup.py install for mozleak 16:13:52 INFO - Running setup.py install for mozlog 16:13:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:13:53 INFO - Running setup.py install for moznetwork 16:13:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:13:53 INFO - Running setup.py install for mozprocess 16:13:53 INFO - Running setup.py install for mozprofile 16:13:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:13:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:13:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:13:53 INFO - Running setup.py install for mozrunner 16:13:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:13:53 INFO - Running setup.py install for mozscreenshot 16:13:53 INFO - Running setup.py install for moztest 16:13:54 INFO - Running setup.py install for mozversion 16:13:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:13:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:13:54 INFO - Cleaning up... 16:13:54 INFO - Return code: 0 16:13:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:54 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 0x1082d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb8c82d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108177d30>, '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 0x107f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10816eb20>, '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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 16:13:54 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 16:13:54 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 16:13:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GWqV7NsdbU/Render', 16:13:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:54 INFO - 'HOME': '/Users/cltbld', 16:13:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:54 INFO - 'LOGNAME': 'cltbld', 16:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:54 INFO - 'MOZ_NO_REMOTE': '1', 16:13:54 INFO - 'NO_EM_RESTART': '1', 16:13:54 INFO - 'PAGER': '/bin/cat', 16:13:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:54 INFO - 'PWD': '/builds/slave/test', 16:13:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:54 INFO - 'SHELL': '/bin/bash', 16:13:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6k2DTr0bB/Listeners', 16:13:54 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 16:13:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:54 INFO - 'USER': 'cltbld', 16:13:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:54 INFO - 'XPC_FLAGS': '0x0', 16:13:54 INFO - 'XPC_SERVICE_NAME': '0', 16:13:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-mmaBaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:54 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)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-6fXZ6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:54 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)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-kllIov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:54 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)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-EimL6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:54 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)) 16:13:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:54 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-SCelsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:55 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)) 16:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:55 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-loKoBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:55 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)) 16:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:55 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-ilPw37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:55 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)) 16:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:55 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-bbI5OC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:55 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)) 16:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:55 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-GGbgNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:55 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)) 16:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:55 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-4RkVy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:55 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)) 16:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:55 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-LpOJi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:55 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)) 16:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:55 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-icRhKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:55 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)) 16:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:55 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-9IWCNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:55 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)) 16:13:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:55 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-_qkNf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:56 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)) 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:56 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-pLmCXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:56 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)) 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:56 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-sSaTQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:56 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)) 16:13:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:56 INFO - Running setup.py (path:/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/pip-rNupkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:56 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)) 16:13:56 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)) 16:13:56 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)) 16:13:56 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)) 16:13:56 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)) 16:13:56 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)) 16:13:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:13:56 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 16:13:56 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 16:13:56 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 16:13:56 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 16:13:56 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 16:13:56 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 16:13:58 INFO - Downloading blessings-1.6.tar.gz 16:13:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:13:58 INFO - Installing collected packages: blessings 16:13:58 INFO - Running setup.py install for blessings 16:13:58 INFO - Successfully installed blessings 16:13:58 INFO - Cleaning up... 16:13:59 INFO - Return code: 0 16:13:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:13:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:59 INFO - Reading from file tmpfile_stdout 16:13:59 INFO - Current package versions: 16:13:59 INFO - blessings == 1.6 16:13:59 INFO - blobuploader == 1.2.4 16:13:59 INFO - docopt == 0.6.1 16:13:59 INFO - manifestparser == 1.1 16:13:59 INFO - mozInstall == 1.12 16:13:59 INFO - mozcrash == 0.16 16:13:59 INFO - mozdebug == 0.1 16:13:59 INFO - mozdevice == 0.48 16:13:59 INFO - mozfile == 1.2 16:13:59 INFO - mozhttpd == 0.7 16:13:59 INFO - mozinfo == 0.9 16:13:59 INFO - mozleak == 0.1 16:13:59 INFO - mozlog == 3.1 16:13:59 INFO - moznetwork == 0.27 16:13:59 INFO - mozprocess == 0.22 16:13:59 INFO - mozprofile == 0.28 16:13:59 INFO - mozrunner == 6.11 16:13:59 INFO - mozscreenshot == 0.1 16:13:59 INFO - mozsystemmonitor == 0.0 16:13:59 INFO - moztest == 0.7 16:13:59 INFO - mozversion == 1.4 16:13:59 INFO - psutil == 3.1.1 16:13:59 INFO - requests == 1.2.3 16:13:59 INFO - wsgiref == 0.1.2 16:13:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:59 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 0x1082d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb8c82d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108177d30>, '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 0x107f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10816eb20>, '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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 16:13:59 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 16:13:59 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 16:13:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GWqV7NsdbU/Render', 16:13:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:59 INFO - 'HOME': '/Users/cltbld', 16:13:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:59 INFO - 'LOGNAME': 'cltbld', 16:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:59 INFO - 'MOZ_NO_REMOTE': '1', 16:13:59 INFO - 'NO_EM_RESTART': '1', 16:13:59 INFO - 'PAGER': '/bin/cat', 16:13:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:59 INFO - 'PWD': '/builds/slave/test', 16:13:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:59 INFO - 'SHELL': '/bin/bash', 16:13:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6k2DTr0bB/Listeners', 16:13:59 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 16:13:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:59 INFO - 'USER': 'cltbld', 16:13:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:59 INFO - 'XPC_FLAGS': '0x0', 16:13:59 INFO - 'XPC_SERVICE_NAME': '0', 16:13:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:59 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)) 16:13:59 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)) 16:13:59 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)) 16:13:59 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)) 16:13:59 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)) 16:13:59 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)) 16:13:59 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)) 16:13:59 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)) 16:13:59 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)) 16:13:59 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)) 16:13:59 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)) 16:13:59 INFO - Cleaning up... 16:13:59 INFO - Return code: 0 16:13:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:59 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 0x1082d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb8c82d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108177d30>, '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 0x107f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10816eb20>, '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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 16:13:59 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 16:13:59 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 16:13:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GWqV7NsdbU/Render', 16:13:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:59 INFO - 'HOME': '/Users/cltbld', 16:13:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:59 INFO - 'LOGNAME': 'cltbld', 16:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:59 INFO - 'MOZ_NO_REMOTE': '1', 16:13:59 INFO - 'NO_EM_RESTART': '1', 16:13:59 INFO - 'PAGER': '/bin/cat', 16:13:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:59 INFO - 'PWD': '/builds/slave/test', 16:13:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:59 INFO - 'SHELL': '/bin/bash', 16:13:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6k2DTr0bB/Listeners', 16:13:59 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 16:13:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:59 INFO - 'USER': 'cltbld', 16:13:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:59 INFO - 'XPC_FLAGS': '0x0', 16:13:59 INFO - 'XPC_SERVICE_NAME': '0', 16:13:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:59 INFO - Downloading/unpacking jsonschema 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:14:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:14:02 INFO - Downloading/unpacking functools32 (from jsonschema) 16:14:02 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 16:14:02 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 16:14:02 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 16:14:02 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 16:14:02 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 16:14:02 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 16:14:02 INFO - Downloading functools32-3.2.3-2.tar.gz 16:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:14:02 INFO - warning: no files found matching '*.txt' 16:14:02 INFO - no previously-included directories found matching 'build' 16:14:02 INFO - no previously-included directories found matching 'dist' 16:14:02 INFO - no previously-included directories found matching '.git*' 16:14:02 INFO - Installing collected packages: jsonschema, functools32 16:14:02 INFO - Running setup.py install for functools32 16:14:02 INFO - warning: no files found matching '*.txt' 16:14:02 INFO - no previously-included directories found matching 'build' 16:14:02 INFO - no previously-included directories found matching 'dist' 16:14:02 INFO - no previously-included directories found matching '.git*' 16:14:02 INFO - Successfully installed jsonschema functools32 16:14:02 INFO - Cleaning up... 16:14:02 INFO - Return code: 0 16:14:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:02 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 0x1082d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1082db4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cb8c82d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108177d30>, '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 0x107f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10816eb20>, '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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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 16:14:02 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 16:14:02 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 16:14:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GWqV7NsdbU/Render', 16:14:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:02 INFO - 'HOME': '/Users/cltbld', 16:14:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:02 INFO - 'LOGNAME': 'cltbld', 16:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:02 INFO - 'MOZ_NO_REMOTE': '1', 16:14:02 INFO - 'NO_EM_RESTART': '1', 16:14:02 INFO - 'PAGER': '/bin/cat', 16:14:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:02 INFO - 'PWD': '/builds/slave/test', 16:14:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:02 INFO - 'SHELL': '/bin/bash', 16:14:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6k2DTr0bB/Listeners', 16:14:02 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 16:14:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:02 INFO - 'USER': 'cltbld', 16:14:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:02 INFO - 'XPC_FLAGS': '0x0', 16:14:02 INFO - 'XPC_SERVICE_NAME': '0', 16:14:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:03 INFO - Downloading/unpacking flake8 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14: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 16:14:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:14:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:14:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:14:06 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 16:14:06 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 16:14:06 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 16:14:06 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 16:14:06 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 16:14:06 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 16:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:14:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:14:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:14:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:14:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:14:06 INFO - no previously-included directories found matching 'docs/_build' 16:14:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:14:06 INFO - Running setup.py install for pep8 16:14:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:14:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:14:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:14:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:14:06 INFO - no previously-included directories found matching 'docs/_build' 16:14:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:14:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:14:07 INFO - Cleaning up... 16:14:07 INFO - Return code: 0 16:14:07 INFO - Running post-action listener: _resource_record_post_action 16:14:07 INFO - Running post-action listener: _start_resource_monitoring 16:14:07 INFO - Starting resource monitoring. 16:14:07 INFO - ##### 16:14:07 INFO - ##### Running install step. 16:14:07 INFO - ##### 16:14:07 INFO - Running pre-action listener: _resource_record_pre_action 16:14:07 INFO - Running main action method: install 16:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:07 INFO - Reading from file tmpfile_stdout 16:14:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:14:07 INFO - Reading from file tmpfile_stdout 16:14:07 INFO - Output received: 16:14:07 INFO - Usage: mozinstall [options] installer 16:14:07 INFO - Options: 16:14:07 INFO - -h, --help show this help message and exit 16:14:07 INFO - -d DEST, --destination=DEST 16:14:07 INFO - Directory to install application into. [default: 16:14:07 INFO - "/builds/slave/test"] 16:14:07 INFO - --app=APP Application being installed. [default: firefox] 16:14:07 INFO - mkdir: /builds/slave/test/build/application 16:14:07 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'] 16:14:07 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 16:14:41 INFO - Reading from file tmpfile_stdout 16:14:41 INFO - Output received: 16:14:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:14:41 INFO - Running post-action listener: _resource_record_post_action 16:14:41 INFO - ##### 16:14:41 INFO - ##### Running run-tests step. 16:14:41 INFO - ##### 16:14:41 INFO - Running pre-action listener: _resource_record_pre_action 16:14:41 INFO - Running main action method: run_tests 16:14:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:14:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:14:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:14:41 INFO - 2016-02-18 16:14:41.253 screenresolution[1656:8195] starting screenresolution argv=screenresolution get 16:14:41 INFO - 2016-02-18 16:14:41.255 screenresolution[1656:8195] Display 0: 1600x1200x32@60 16:14:41 INFO - 2016-02-18 16:14:41.261 screenresolution[1657:8197] starting screenresolution argv=screenresolution list 16:14:41 INFO - Available Modes on Display 0 16:14:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:14:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:14:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:14:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:14:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:14:41 INFO - Intel Iris: 16:14:41 INFO - Chipset Model: Intel Iris 16:14:41 INFO - Type: GPU 16:14:41 INFO - Bus: Built-In 16:14:41 INFO - VRAM (Dynamic, Max): 1536 MB 16:14:41 INFO - Vendor: Intel (0x8086) 16:14:41 INFO - Device ID: 0x0a2e 16:14:41 INFO - Revision ID: 0x0009 16:14:41 INFO - Displays: 16:14:41 INFO - Display: 16:14:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:14:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:14:41 INFO - Display Serial Number: 1600x1200 60 16:14:41 INFO - Main Display: Yes 16:14:41 INFO - Mirror: Off 16:14:41 INFO - Online: Yes 16:14:41 INFO - Rotation: Supported 16:14:41 INFO - Return code: 0 16:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:14:41 INFO - Python 2.7.3 16:14:41 INFO - Return code: 0 16:14:41 INFO - grabbing minidump binary from tooltool 16:14: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')]} 16:14:41 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 0x108177d30>, '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 0x107f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10816eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:14:41 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 16:14:41 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 16:14:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:14:41 INFO - Return code: 0 16:14:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:14:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:14:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:14:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:14:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:14:42 INFO - Return code: 0 16:14:42 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--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 16:14:42 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0009 --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 16:14:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GWqV7NsdbU/Render', 16:14:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:14:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:14:42 INFO - 'HOME': '/Users/cltbld', 16:14:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:14:42 INFO - 'LOGNAME': 'cltbld', 16:14:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:14:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:42 INFO - 'MOZ_NO_REMOTE': '1', 16:14:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:14:42 INFO - 'NO_EM_RESTART': '1', 16:14:42 INFO - 'PAGER': '/bin/cat', 16:14:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:42 INFO - 'PWD': '/builds/slave/test', 16:14:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:14:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:14:42 INFO - 'SHELL': '/bin/bash', 16:14:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f6k2DTr0bB/Listeners', 16:14:42 INFO - 'TMPDIR': '/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/', 16:14:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:14:42 INFO - 'USER': 'cltbld', 16:14:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:14:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:42 INFO - 'XPC_FLAGS': '0x0', 16:14:42 INFO - 'XPC_SERVICE_NAME': '0', 16:14:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:14:42 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0009', '--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 16:14:43 INFO - mozversion application_buildid: 20160218140426 16:14:43 INFO - mozversion application_changeset: d5daf10d3b74b04e8fa63c4e5429de8a0adf79f8 16:14:43 INFO - mozversion application_display_name: Nightly 16:14:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:14:43 INFO - mozversion application_name: Firefox 16:14:43 INFO - mozversion application_remotingname: firefox 16:14:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:14:43 INFO - mozversion application_vendor: Mozilla 16:14:43 INFO - mozversion application_version: 47.0a1 16:14:43 INFO - mozversion platform_buildid: 20160218140426 16:14:43 INFO - mozversion platform_changeset: d5daf10d3b74b04e8fa63c4e5429de8a0adf79f8 16:14:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:14:43 INFO - mozversion platform_version: 47.0a1 16:14:43 INFO - using testdate: 1455840883 16:14:43 INFO - actual date: 1455840883 16:14:43 INFO - starting webserver on 'localhost:49284' 16:14:43 INFO - SUITE-START | Running 2 tests 16:14:43 INFO - TEST-START | dromaeo_css 16:14:43 INFO - operating with platform_type : mac_ 16:14:43 INFO - Initialising browser for dromaeo_css test... 16:14:43 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpEO1DQ2/profile http://localhost:49284/getInfo.html) 16:14:45 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 16:14:45 INFO - PROCESS | 1675 | colorDepth:24 16:14:45 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 16:14:45 INFO - PROCESS | 1675 | __metrics 16:14:45 INFO - PROCESS | 1675 | 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" 16:14:45 INFO - PROCESS | 1675 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:14:46 INFO - TEST-INFO | 1675: exit 0 16:14:46 INFO - Browser initialized. 16:14:46 INFO - Running cycle 1/1 for dromaeo_css test... 16:14:46 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpEO1DQ2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:58 INFO - PROCESS | 1677 | RSS: Main: 243109888 16:14:58 INFO - PROCESS | 1677 | 16:15:49 INFO - PROCESS | 1677 | 1455840949255 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] 16:17:58 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49284/tests/dromaeo/cssquery-ext.html) 16:18:01 INFO - PROCESS | 1677 | RSS: Main: 430133248 16:18:01 INFO - PROCESS | 1677 | 16:21:03 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-ext.html (next: http://localhost:49284/tests/dromaeo/cssquery-jquery.html) 16:21:04 INFO - PROCESS | 1677 | RSS: Main: 380325888 16:21:04 INFO - PROCESS | 1677 | 16:24:06 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49284/tests/dromaeo/cssquery-mootools.html) 16:24:07 INFO - PROCESS | 1677 | RSS: Main: 379990016 16:24:07 INFO - PROCESS | 1677 | 16:27:09 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49284/tests/dromaeo/cssquery-prototype.html) 16:27:09 INFO - PROCESS | 1677 | RSS: Main: 342294528 16:27:09 INFO - PROCESS | 1677 | 16:30:12 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49284/tests/dromaeo/cssquery-yui.html) 16:30:13 INFO - PROCESS | 1677 | RSS: Main: 340246528 16:30:13 INFO - PROCESS | 1677 | 16:33:16 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49284/tests/dromaeo/cssquery-yui.html (next: http://localhost:49284/tests/dromaeo/cssquery-dojo.html) 16:33:16 INFO - PROCESS | 1677 | RSS: Main: 431882240 16:33:16 INFO - PROCESS | 1677 | 16:33:16 INFO - PROCESS | 1677 | __start_tp_report 16:33:16 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 16:33:16 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 16:33:16 INFO - PROCESS | 1677 | |i|pagename|runs| 16:33:16 INFO - PROCESS | 1677 | |0;dojo.html;3401.6598340165983;3449.2239246169597;3467.9422776053293;3476.391631464493;3515.0157955772393;5544.528715059225;5602.579806514513;5615.663060216385;5623.212750214973;5638.520725738317;5662.462066103713;5670.971645141779;5702.372738998717;5862.0913758367415;5870.765169393229;5094.7197904115255;5096.643234973553;5112.769925353349;5147.871303217431;5261.053010458116;5227.032998895216;5228.111221092423;5269.473052694738;5286.814961476349;5330.520253177213;5080.618953578496;5109.540141387293;5176.534111929945;5230.581553475751;5256.185291279858;5200.8179713710215;5215.452377500384;5225.947740522584;5236.764345604419;5273.762680679379;5149.6910185389;5175.275461435364;5177.870553236162;5187.559057480119;5219;5409.56723462122;5498.257735205736;5525.778968841241;5533.280673512458;5554.777808887639;6094.193889829198;6102.664353460558;6107.969460152715;6111.816645500642;6119.296280927706;6167.105769663419;6229.501639868845;6286.339934306923;6289.150964619764;6313.652749098797;5683.5737319700775;5704.572157088193;5723.840570002451;5739.512141467981;5767.22142510764;6170.290416602148;6216.627002379872;6262.749490020439;6276.058591211264;6276.121343011982;6023.216981792427;6092.664903430354;6105.297890742532;6109.877802443926;6115.331611965994;6204.13142160098;6208.348123447064;6246.3753624637175;6259.624422534663;6268;5962.55280853929;6059.697015149225;6117.082437634302;6161.84595385119;6180.042093475518;6188.628682278988;6210.937890621036;6231.2522497300615;6233.844153896189;6238.500919926395;4831.347768051339;4843.878903027382;4849.75751212438;4856.3201151838775;4885;4273.166732487135;4313.180495705806;4360.563943605614;4387.758673273001;4392.099619577979;5548.389677135512;5559.58303127259;5589.524890384281;5595.18869763882;5605.943940560624;6163.1679723237685;6191.783287585003;6210.378962103844;6212.937870621236;6226.875462490725;5132.666376685504;5188.403333616682;5212.087884620177;5406.729663516887;5589.301337332833;5305.734713264398;5310.017646735367;5311.920321195185;5312.07038768214;5321.36143662763;6225.533085018732;6248.250209974832;6262.5929314594405;6277.246730392382;6283.528735344776;6125.601835880653;6154.230721159855;6199.969000154971;6261.7182226799;6263.342349053284;6224.875502490016;6244.344343843831;6252.718627661857;6254.186955695731;6255.124282600348;5984.790532331347;6118.449339559283;6120.693965301806;6142.293636231891;6168.290646575701;6116.061877111426;6135.600157732601;6158.199434073542;6170.660613666291;6172.598781079216;5979.641221526722;5987.970060149672;5988.341282458839;5993.101034844633;5994.160817485468;5202.817901373433;5901;5970.731317090655;5976.820695379146;5993.850153746192;5834.474897259097;5845.883082338414;5850.882982340415;5919.200907877382;5926.911096333472;5980.940190598212;5997.610155339889;6016.939830601638;6035.366286540026;6053.9091913622215;5874.295084589877;5881.117832325185;5899.085641725539;5908.556858235564;5937.732802024006 16:33:16 INFO - PROCESS | 1677 | |1;ext.html;451.52138732943064;461.0364338532464;493.28227429090674;558.8630785457564;611.7552978808477;28552.85723571382;37414.43878341827;37522.8123859381;37576.43635345472;37609.24781504368;42049.369259461055;43148.568514314844;43363.13273734531;43424.565754342446;43579.78210108953;9416.858747118782;9644;9652.420854748703;9658.179054780352;9669.806603867919;9390.295727820407;9526.476043817587;9537.523123843815;9542.856857147148;9560.856587151164;9486.478243696594;9567.138957493824;9568.043195680446;9590.808183836354;9593.856092158623;9425.34022618417;9471.479068651188;9476.289278304155;9496;9504.192143667797;9396.859047114298;9510.572024258925;9510.762230944212;9544.379615325051;9548.42709437436;39151;39513.209735805125;39604.81185564437;39616.80191599052;39702;3148.861611364955;3200.727938125262;3300.1914530939835;3436.6391528889358;3477.4436090225695;28269.858650706614;28517.287067823472;28663;29037;29304.56043159354;2107.967096122904;2505.812064095182;2507.8244522883224;2582.418955734963;2586.896524139032;460899;462456;462687.3731262678;463829;465029;55110.72444637831;56106;63988.04017939734;64215.03677444842;64628.35371646317;60238;60710.08934865981;60938.78122437615;61017.38982610206;61288.38711612916;16108.516744497683;16284.51146465608;16331.346746130022;16340.428085016967;16342.591435213977;10130.696079117639;11600.361980091177;12474.501019959282;12648.367581620882;12855.357232138356;19297.228110875407;19309.51726206856;19351.90324048371;19452.805471945383;19515.512112197026;7646.350060244941;7949.801254968556;7961.880571791427;7976.680932762741;7994.280514753584;938.8826396700413;974.1865542272141;998.4907697074399;1024.3802499487704;1063.994680026595;22316.665250021262;26228.73771262263;26513.204603861916;26615.467690646077;26653.733462665514;1056.6724315462232;1077.5097330714507;1096.7477480179443;1127.2391135983341;1229.1887354346088;11669.35818529972;13827.930860345836;13969.72060558783;14069.85930140706;14124.717505649829;538314;548068;548831;549578;551856;57804;58173.709131454074;58316.4168358311;58661.70669146627;58875;1379.675776192614;1384.764590019699;1408.3803126624457;1415.4621243927243;1418.1491105336715;27940.161795146178;28077.157685269474;28307.858460707565;28338.724757385553;28496.57255141133;48218.5178148214;48326.75836620794;48750.756246218545;48790.75604622096;48881;436666;502167;503206;503886;504157;27807.02675406351;32216;32808.179795505304;32843.8357808219;32860.507092393156;39858.800705996284;40877;41194;42825.357619635106;43953.46162884284;36102.63897360993;36478.4528232082;36593.45109823408;36749.26501469902;37121.443178352885;28260.326906371938;33575;34568.82715586507;34633.65366346304;37211.883643490735;34627.4805877907;35943;36844.81577592202;36938.630613693516;37037.25925481529;28449.857750711115;30329.69670303269;31897.840510797298;32034.67965320317;32131.51802723008;20470.795292047485;23927.812632788846;24167.51664966726;24377;24564.385890352885 16:33:16 INFO - PROCESS | 1677 | |2;jquery.html;308.9150483617005;363.16834449111536;365.8097789149644;370.1800511866216;375.85529571115114;15418.460353887616;15879.206039698027;19964.60070798585;20300.781953082806;20826.89586552067;18959.24163033477;19559.119839607218;19674.11466484008;20692.172313107494;20739.481512962182;5625.493705566509;5838.649681019131;5841.532677385799;5852.356240813507;5911.142884281777;4157.50109986802;4774.785134668931;5758.049921762925;5879.911801322984;6398.680065996681;6499;6549.443297319734;6589.93410065898;6590.176227971504;6605.471562275006;6133.754649814002;6296.37036296369;6301.4328710416285;6305.369463053681;6308.873822523569;4440.888977775581;5408.864778380533;5490.615656903979;5491.28613280275;5497.147942068986;12993.740125197442;13209.075364724473;13426.664333391744;13445.394957226948;13458.461661533527;1927.9807201928081;2117.184883819725;2318.385627808615;2503.8122140839328;2758.4483103379202;9162.175404213653;9243.6302547898;9413.858792118124;9877.654282100164;10335.379877207391;1687.5021868548808;1742.9738553921702;1768.1866341482933;1786.767720196379;1853.962920741591;63635;86347;94193.52903235509;106281;106742.46628766807;11344.376059316817;11386.544538218544;11409.14431417647;11420.600278990361;11556.76886462266;13535.45858165682;13601.387937542835;13625.591232263048;13657;13666.658333541542;8437.57812109392;8515.063343032261;8530.146985301544;8617.95691021541;8626.18051285127;8618;8645.783855403664;8653.394262401698;8704.782380440412;8764.649414023368;4054.8378064877666;4422.889427764331;4493.910121797546;4512.503624601357;4520.932186017212;1552.433361822949;1765.8587313014928;1868.747719057937;1874.5407375193165;1885.2364792259157;411.44044100023945;416.43988835016853;859.9570021498901;882.3911501064246;940.2008292951074;10323.174146068297;10543.525541350658;11408.88591114095;11465.770684586261;11520;389.42948580329386;454.332131766303;458.8669285907116;464.7838754978951;470.2311720337273;6211.006239001738;6245.531585131042;6297.590656607306;6322.083297921776;6329.968350158312;523984;524840;543790;575412;618158;121649;123724.38137809433;124806;125966.37016814857;126791.73208267799;911.562450023979;1036.18659352408;1043.212374657129;1047.7275908263907;1066.4454483668449;18635.534111647317;18806.34177803825;18875.90562047181;18881.339153129575;18962.483001359582;52410.73794631002;52833.47166528286;53591.46408536021;54700.726496367264;55075.898482030934;66123.33876661364;67871.66064169846;68336.6583167081;72645.6367718158;76648.61675691586;7579.772606821804;7949.205079492004;8035.397345199017;8074.596270186585;8077.87883181741;8740.257078148428;10975.835362469728;12572.93713531463;12594.118411711459;12919.289439080942;7753.457257992112;7764.145943946274;7896.32881205104;7978.601069946363;7991.72028978983;7970.84058318842;7980.521168729895;8171.142030086755;8219.917800822155;8320.459170153921;8320.126386729306;8371;8411.495310281403;8412.242898139197;8413.915860841558;11217.439128043401;11323.207375483966;11671.824922625998;11883.940580297043;11892.821607675718;6643.734250629921;6839.863202736017;10746.677599672023;10936.906309369;11605.477753500943 16:33:16 INFO - PROCESS | 1677 | |3;mootools.html;1144.7996600594893;1481.6962522682848;1517.0745845034528;1725.1805392438594;1912.378476994977;7953.84092318154;8551.957240213798;8751.081136480674;8751.518666473357;8780.956095219515;8448.535330556817;8678.47929124253;8697.391182617219;8702.129787021295;8731.170538798804;2091.5189506413535;2158.589867925097;2453.1904471524444;2479.727230004698;2485.2668462803426;2454.7177074636465;2507.3856905058196;2508.122157244959;2514.9940023990366;2517.244826552036;2371.739108698042;2375.572396968545;2405.6391541268777;2436.147348428045;2446.816488763341;2435.6482152405406;2438.2928950604305;2476.3932836455006;2484.7887929526014;2487.912923047703;2437.183543512925;2465.8890349934118;2483.962740558893;2485.155047283914;2492.4641202141447;8872.201501864864;8898.86651700225;8919.643214271422;8926.2412694921;8935.285177185875;5459.099248623972;5568.86077848053;5568.86077848053;5574.721263936787;5575.107982722786;3133.263683034485;3634.9640352499673;3640.7087433005295;3710.8515659373593;3717.033571271489;1035.3477309295097;1045.3309881675734;1055.3667799320424;1077.0360527328075;1080.8057096907883;11871.703207419798;11952.163348565604;12013.97881180092;12016.459259333264;12037.217580857305;4895.412550493964;4903.313536104948;4912.557869791736;4931.112399768076;4989.675671081441;10238.488075596191;10253.179745620333;10258.43578603169;10270;10301.381917084998;5527.143292789624;5532.834014979557;5541.556675465953;5550.58370622205;5557.360903496069;4934.950650493449;4997.200447928387;5003.2995380646735;5007.349044624176;5014.674046186986;3659.213269147093;3737.8691745788765;3869.3808990561374;3947.5460322062754;3966.2860685076384;1260.1116213069763;1303.270168705528;1303.758804621148;1315.3489022933709;1317.5849607373646;1085.9674209773718;1088.8911108889047;1226.1539537718945;1288.4395288049727;1316.835395575553;8037.397195210383;8099.230573095547;8122.7157049502985;8130.959345203354;8142.47073940192;1165.3998190931677;1170.2744298534792;1177.5584155941522;1188.2157775867886;1188.3939191012473;5443.2107344434835;6296.905546416808;6396.136521569529;6401.487880969605;6407.263164736022;10182.287239893285;10497.002784735438;10530.947345263377;10542.209334299958;10547.261691681662;10133.746656333651;10287.794244115075;10290.485475726333;10300.381977081399;10435.478226088817;8128;8257.298129659046;8262.752117436487;8271.2142346477;8275.462094963808;8058.476199047043;8064.112947575644;8110.635021423932;8141.22658347456;8305.792355191168;9704.805903882025;9707.854382184414;9781.755456113655;9856.359336643096;9928.453935033642;9817;10010.04904534068;10129.746756330856;10233.976602340004;10309.536070876678;7513.023306970059;7607.049118860143;7626.694932202871;7852.646630901738;8107.756767296991;7507.962460187664;7645.006149200791;7982.920170798217;8197.221263979913;8211.137830527947;7255.637218138966;7308.853822923618;7309.049823522908;7395.741149059757;7474.738384156529;7188.856222875409;7191.460640451883;7317.487775855639;7321.267873212636;7400.962995185205;7541.057367829021;7572.318491335586;7575.053118360205;7610.277023682741;7626.733064342721;7003.159620845531;7068.964655176691;7079.504434689522;7079.964600176966;7088.362047415757;7081.787546373617;7172.462065345225;7175.210726819942;7178.605176715122;7191.244919283609 16:33:16 INFO - PROCESS | 1677 | |4;prototype.html;318.65744324850783;325.2584108233229;331.2051077414207;331.43986662540306;334.88111720339276;6397.4242318191355;6405;6409.583377080487;6459.09572659828;6459.998700201476;5435.673859568428;6348.777792777254;6382.393672601107;6429.967850160754;6483.962565989443;4852.005338905516;4856.781444834974;4858.5627293543575;4871.585915197213;4876.2198048312275;4728.90542189156;4813.807447702087;4822.276658501218;4853.126437241295;4870.099031679133;4737.73942433166;4741.075490279397;4764.952350476503;4773.594244489205;4782.13921494131;4539.455265368144;4642.210824159901;4774.331593576902;4786.545278198583;4795;4001.159756451149;4064.4309796628495;4066.1257829566784;4093.1199792044554;4097.672186225095;6120.663363515005;6195.473384762301;6214.25428948529;6237;6246.906296405557;5258.158694608883;5379.757910894019;5423.291663126102;5571.4428557144365;5606.579506537026;5798.275215598051;6756.223034351064;6826.317368263183;6865.141857267841;6880.623875224925;4570.177368073745;4577.9542204577865;4582.152301824173;4582.495925448198;4588.967482316485;7097.077379940626;7260.237675044097;7275.927240727578;7283.162436319838;7305.5981920994855;4680.531946805292;4691.108689349013;4710.128626204163;4713.387259656222;4722.763861806896;4776.379070720784;4798.448178459522;4803.5916947059195;4804.735739534359;4814.229723244264;5575.832725018256;5597.216389705444;5598.944010559923;5601.467860553241;5607.607467477237;6736.360045795642;6858.759943401957;6931.757388491479;6932.306769323028;6933.93066069343;1649.9670006599802;1675.9245833937503;1678.4628918745884;1683.1920678074594;1685.2163743858919;1080.935143891369;1089.7657003744232;1093.9781204375868;1103.7351035751522;1114.0808832713044;6555.902560899438;6583.506237032242;6598;6601.70292336846;6609.471242300604;7414.851702965911;7419;7419.554826710415;7429.442791790637;7430.182679905206;6382.585131966407;6568.901466478007;6581.045748366556;6585.209774827052;6629.038789375513;3848.749831260959;3905.589913059088;3909.198614284065;3915.2952468555363;3917.138229589486;7735.265149810759;7739.380849532024;7739.496932699357;7742.845143097106;7747.806304842424;7126.6080365579355;7271.272872712792;7413.740519081806;7652.617369131521;7689.115751688516;7270.927290727025;7404;7417.072865891656;7437.628118594049;7498.812529686801;7110.25342339047;7126.928730712627;7207.1711753146965;7231.602261875437;7261.38278246355;6854.177498699988;7090;7105.502614816914;7107.076080109553;7116.074910261633;7522.3605993491165;7539.736109236151;7547.50941188821;7547.622618869144;7549.50928189666;4724.6456515760765;4769.689970151929;4781.282807578891;4781.784819683053;4786.880327991828;6889.586624802528;7134.678939447634;7142.785716428515;7148;7158.0336654550965;6852.314768523108;6871.244163142151;6879;6884.965575172292;6887.2079710831895;5586.497215250647;6844.897326540006;6866.485013623898;6874.072000279898;6892.104026476526;6534.411902928759;6763.391294783296;6817.113775209191;6855.143107111611;6864.622445765331;6019;6974.511784175059;6985.755498557526;6988;7008.684609192701;6631.568948018364;6815.693293801692;6826.965865170642;6832.111825462658;6863 16:33:16 INFO - PROCESS | 1677 | |5;yui.html;665.9544515111277;683.7094234950147;732.1799584465399;758.7989182866538;786.8308313712557;14530;15040.473583424582;15200.695986080273;15216.010959287638;15220.619484512892;11757.529698812059;13784.448622055106;13853.93073034636;13855.445782168727;13858.930705346484;711.8149281186903;728.0535304104669;872.3762509805488;881.7487016200384;894.8612964990436;886.6231851463102;897.5691667999364;898.0435835834847;900.275278400887;903.4669544968467;938.3431597881477;939.873117129189;942.9764255893589;944.0700909604069;944.7496413450441;748.5994992678918;764.1632412508322;924.4360939826768;939.6617217801586;944.3814301632442;699.5942353434996;700.5586480517293;702.5222848463094;704.1585305559857;704.8378872859271;14778.408863645442;14839.851601483955;14851.2574371281;14859;14878.776818347733;12813.231206127663;12898.161619494796;12964.546240881618;12993.80509292352;13472.461101555926;10669.146468282519;10868.347899126078;10901.29141605801;10929.234953553176;10938.398388088652;3088.737457316131;3578.6779189872777;3596.5684117906017;3605.06268370223;3646.5806432260365;83874.99999999939;84062.15937840665;84673;84941;85021;9504.382215155993;9546.761330966781;9559.091886270793;9563.378380405251;9597.712068637951;20724;20742.27402040921;20752.58494830125;20753.896230518752;20782.27262045821;6786.321367863175;6814.284500127415;7303.525270857377;7489.70041198346;7522.962385188039;3904.590018048121;4069.552349241581;4139.627433530996;4147.564505726855;4159.188958153131;3510.034740446398;3559.875404360835;3560.537130173061;3565.5186549815962;3567.714582833367;689.8792711275506;693.1197379328225;694.2294053600499;708.0688894104236;713.4043074033136;534.9946500535023;553.1150159744377;588.0444278048171;588.326366310572;627.5387590121258;8309.792255193668;8481.40630155883;8495.065542790288;8514.914850851535;8686.913130868737;518.9465385267912;562.44880017583;585.3882692586258;659.7558903205845;661.3981277037873;3695.6489133532273;3771.8868433947027;3903.4144878268485;3923.6076392360537;3991.9401208981308;84407.57796211103;85554.57222713847;85704.57147714222;85773.71339429913;88074;73191;73225.63387183136;76595.61702191565;80421.59789201016;81421;69682.65158674275;70007.29992700109;70413;71482;71750.2824971754;6760.391564759196;7710.4217183710325;7941.444098913021;8412.200840920103;8436.578171091543;49019;49416.25875611797;49572.25641615451;49617.751911240215;49654.758631034514;67297.66351168213;67943;68620.31379686139;68652.28369290808;69037.65481172562;9887.901120988698;9995.300328976902;10004.249681273788;10135.290529662852;10769.353838769699;9465.432074075577;11064.22550421495;11127.332360058423;11169;11251;10397.428141452292;10635.680929572125;11183.401792942203;11284.661460156209;11296.378699171624;8496.830063398822;8911.465312081296;9089.363744538083;10350.22373322019;10623.787524249317;10138.18894488454;10474.476276186313;10494.580216791242;10506.474676266309;10994.34033957965;8908.28133609316;9325.459121377542;9339.953300233456;9356.4386136832;9440.622375104918;8530.70142545008;9201.907980920105;9228.446293222429;9258.768530786785;9436.339456237998 16:33:16 INFO - PROCESS | 1677 | __end_tp_report 16:33:16 INFO - PROCESS | 1677 | __start_cc_report 16:33:16 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,2105 16:33:16 INFO - PROCESS | 1677 | __end_cc_report 16:33:16 INFO - PROCESS | 1677 | __startTimestamp1455841996591__endTimestamp 16:33:16 INFO - PROCESS | 1677 | 16:33:16 INFO - PROCESS | 1677 | ------- Summary: start ------- 16:33:16 INFO - PROCESS | 1677 | Number of tests: 6 16:33:16 INFO - PROCESS | 1677 | 16:33:16 INFO - PROCESS | 1677 | [#0] dojo.html Cycles:165 Average:5680.09 Median:5901.00 stddev:623.32 (10.6%) stddev-sans-first:599.05 16:33:16 INFO - PROCESS | 1677 | Values: 3401.7 3449.2 3467.9 3476.4 3515.0 5544.5 5602.6 5615.7 5623.2 5638.5 5662.5 5671.0 5702.4 5862.1 5870.8 5094.7 5096.6 5112.8 5147.9 5261.1 5227.0 5228.1 5269.5 5286.8 5330.5 5080.6 5109.5 5176.5 5230.6 5256.2 5200.8 5215.5 5225.9 5236.8 5273.8 5149.7 5175.3 5177.9 5187.6 5219.0 5409.6 5498.3 5525.8 5533.3 5554.8 6094.2 6102.7 6108.0 6111.8 6119.3 6167.1 6229.5 6286.3 6289.2 6313.7 5683.6 5704.6 5723.8 5739.5 5767.2 6170.3 6216.6 6262.7 6276.1 6276.1 6023.2 6092.7 6105.3 6109.9 6115.3 6204.1 6208.3 6246.4 6259.6 6268.0 5962.6 6059.7 6117.1 6161.8 6180.0 6188.6 6210.9 6231.3 6233.8 6238.5 4831.3 4843.9 4849.8 4856.3 4885.0 4273.2 4313.2 4360.6 4387.8 4392.1 5548.4 5559.6 5589.5 5595.2 5605.9 6163.2 6191.8 6210.4 6212.9 6226.9 5132.7 5188.4 5212.1 5406.7 5589.3 5305.7 5310.0 5311.9 5312.1 5321.4 6225.5 6248.3 6262.6 6277.2 6283.5 6125.6 6154.2 6200.0 6261.7 6263.3 6224.9 6244.3 6252.7 6254.2 6255.1 5984.8 6118.4 6120.7 6142.3 6168.3 6116.1 6135.6 6158.2 6170.7 6172.6 5979.6 5988.0 5988.3 5993.1 5994.2 5202.8 5901.0 5970.7 5976.8 5993.9 5834.5 5845.9 5850.9 5919.2 5926.9 5980.9 5997.6 6016.9 6035.4 6053.9 5874.3 5881.1 5899.1 5908.6 5937.7 16:33:16 INFO - PROCESS | 1677 | 16:33:16 INFO - PROCESS | 1677 | [#1] ext.html Cycles:180 Average:63636.71 Median:37592.84 stddev:133573.77 (355.3%) stddev-sans-first:133864.24 16:33:16 INFO - PROCESS | 1677 | Values: 451.5 461.0 493.3 558.9 611.8 28552.9 37414.4 37522.8 37576.4 37609.2 42049.4 43148.6 43363.1 43424.6 43579.8 9416.9 9644.0 9652.4 9658.2 9669.8 9390.3 9526.5 9537.5 9542.9 9560.9 9486.5 9567.1 9568.0 9590.8 9593.9 9425.3 9471.5 9476.3 9496.0 9504.2 9396.9 9510.6 9510.8 9544.4 9548.4 39151.0 39513.2 39604.8 39616.8 39702.0 3148.9 3200.7 3300.2 3436.6 3477.4 28269.9 28517.3 28663.0 29037.0 29304.6 2108.0 2505.8 2507.8 2582.4 2586.9 460899.0 462456.0 462687.4 463829.0 465029.0 55110.7 56106.0 63988.0 64215.0 64628.4 60238.0 60710.1 60938.8 61017.4 61288.4 16108.5 16284.5 16331.3 16340.4 16342.6 10130.7 11600.4 12474.5 12648.4 12855.4 19297.2 19309.5 19351.9 19452.8 19515.5 7646.4 7949.8 7961.9 7976.7 7994.3 938.9 974.2 998.5 1024.4 1064.0 22316.7 26228.7 26513.2 26615.5 26653.7 1056.7 1077.5 1096.7 1127.2 1229.2 11669.4 13827.9 13969.7 14069.9 14124.7 538314.0 548068.0 548831.0 549578.0 551856.0 57804.0 58173.7 58316.4 58661.7 58875.0 1379.7 1384.8 1408.4 1415.5 1418.1 27940.2 28077.2 28307.9 28338.7 28496.6 48218.5 48326.8 48750.8 48790.8 48881.0 436666.0 502167.0 503206.0 503886.0 504157.0 27807.0 32216.0 32808.2 32843.8 32860.5 39858.8 40877.0 41194.0 42825.4 43953.5 36102.6 36478.5 36593.5 36749.3 37121.4 28260.3 33575.0 34568.8 34633.7 37211.9 34627.5 35943.0 36844.8 36938.6 37037.3 28449.9 30329.7 31897.8 32034.7 32131.5 20470.8 23927.8 24167.5 24377.0 24564.4 16:33:16 INFO - PROCESS | 1677 | 16:33:16 INFO - PROCESS | 1677 | [#2] jquery.html Cycles:180 Average:31778.57 Median:461.83 stddev:93091.72 (20157.3%) stddev-sans-first:93322.87 16:33:16 INFO - PROCESS | 1677 | Values: 308.9 363.2 365.8 370.2 375.9 15418.5 15879.2 19964.6 20300.8 20826.9 18959.2 19559.1 19674.1 20692.2 20739.5 5625.5 5838.6 5841.5 5852.4 5911.1 4157.5 4774.8 5758.0 5879.9 6398.7 6499.0 6549.4 6589.9 6590.2 6605.5 6133.8 6296.4 6301.4 6305.4 6308.9 4440.9 5408.9 5490.6 5491.3 5497.1 12993.7 13209.1 13426.7 13445.4 13458.5 1928.0 2117.2 2318.4 2503.8 2758.4 9162.2 9243.6 9413.9 9877.7 10335.4 1687.5 1743.0 1768.2 1786.8 1854.0 63635.0 86347.0 94193.5 106281.0 106742.5 11344.4 11386.5 11409.1 11420.6 11556.8 13535.5 13601.4 13625.6 13657.0 13666.7 8437.6 8515.1 8530.1 8618.0 8626.2 8618.0 8645.8 8653.4 8704.8 8764.6 4054.8 4422.9 4493.9 4512.5 4520.9 1552.4 1765.9 1868.7 1874.5 1885.2 411.4 416.4 860.0 882.4 940.2 10323.2 10543.5 11408.9 11465.8 11520.0 389.4 454.3 458.9 464.8 470.2 6211.0 6245.5 6297.6 6322.1 6330.0 523984.0 524840.0 543790.0 575412.0 618158.0 121649.0 123724.4 124806.0 125966.4 126791.7 911.6 1036.2 1043.2 1047.7 1066.4 18635.5 18806.3 18875.9 18881.3 18962.5 52410.7 52833.5 53591.5 54700.7 55075.9 66123.3 67871.7 68336.7 72645.6 76648.6 7579.8 7949.2 8035.4 8074.6 8077.9 8740.3 10975.8 12572.9 12594.1 12919.3 7753.5 7764.1 7896.3 7978.6 7991.7 7970.8 7980.5 8171.1 8219.9 8320.5 8320.1 8371.0 8411.5 8412.2 8413.9 11217.4 11323.2 11671.8 11883.9 11892.8 6643.7 6839.9 10746.7 10936.9 11605.5 16:33:16 INFO - PROCESS | 1677 | 16:33:16 INFO - PROCESS | 1677 | [#3] mootools.html Cycles:180 Average:6073.78 Median:5000.25 stddev:3190.29 (63.8%) stddev-sans-first:3177.71 16:33:16 INFO - PROCESS | 1677 | Values: 1144.8 1481.7 1517.1 1725.2 1912.4 7953.8 8552.0 8751.1 8751.5 8781.0 8448.5 8678.5 8697.4 8702.1 8731.2 2091.5 2158.6 2453.2 2479.7 2485.3 2454.7 2507.4 2508.1 2515.0 2517.2 2371.7 2375.6 2405.6 2436.1 2446.8 2435.6 2438.3 2476.4 2484.8 2487.9 2437.2 2465.9 2484.0 2485.2 2492.5 8872.2 8898.9 8919.6 8926.2 8935.3 5459.1 5568.9 5568.9 5574.7 5575.1 3133.3 3635.0 3640.7 3710.9 3717.0 1035.3 1045.3 1055.4 1077.0 1080.8 11871.7 11952.2 12014.0 12016.5 12037.2 4895.4 4903.3 4912.6 4931.1 4989.7 10238.5 10253.2 10258.4 10270.0 10301.4 5527.1 5532.8 5541.6 5550.6 5557.4 4935.0 4997.2 5003.3 5007.3 5014.7 3659.2 3737.9 3869.4 3947.5 3966.3 1260.1 1303.3 1303.8 1315.3 1317.6 1086.0 1088.9 1226.2 1288.4 1316.8 8037.4 8099.2 8122.7 8131.0 8142.5 1165.4 1170.3 1177.6 1188.2 1188.4 5443.2 6296.9 6396.1 6401.5 6407.3 10182.3 10497.0 10530.9 10542.2 10547.3 10133.7 10287.8 10290.5 10300.4 10435.5 8128.0 8257.3 8262.8 8271.2 8275.5 8058.5 8064.1 8110.6 8141.2 8305.8 9704.8 9707.9 9781.8 9856.4 9928.5 9817.0 10010.0 10129.7 10234.0 10309.5 7513.0 7607.0 7626.7 7852.6 8107.8 7508.0 7645.0 7982.9 8197.2 8211.1 7255.6 7308.9 7309.0 7395.7 7474.7 7188.9 7191.5 7317.5 7321.3 7401.0 7541.1 7572.3 7575.1 7610.3 7626.7 7003.2 7069.0 7079.5 7080.0 7088.4 7081.8 7172.5 7175.2 7178.6 7191.2 16:33:16 INFO - PROCESS | 1677 | 16:33:16 INFO - PROCESS | 1677 | [#4] prototype.html Cycles:180 Average:5710.05 Median:6444.53 stddev:1798.24 (27.9%) stddev-sans-first:1757.17 16:33:16 INFO - PROCESS | 1677 | Values: 318.7 325.3 331.2 331.4 334.9 6397.4 6405.0 6409.6 6459.1 6460.0 5435.7 6348.8 6382.4 6430.0 6484.0 4852.0 4856.8 4858.6 4871.6 4876.2 4728.9 4813.8 4822.3 4853.1 4870.1 4737.7 4741.1 4765.0 4773.6 4782.1 4539.5 4642.2 4774.3 4786.5 4795.0 4001.2 4064.4 4066.1 4093.1 4097.7 6120.7 6195.5 6214.3 6237.0 6246.9 5258.2 5379.8 5423.3 5571.4 5606.6 5798.3 6756.2 6826.3 6865.1 6880.6 4570.2 4578.0 4582.2 4582.5 4589.0 7097.1 7260.2 7275.9 7283.2 7305.6 4680.5 4691.1 4710.1 4713.4 4722.8 4776.4 4798.4 4803.6 4804.7 4814.2 5575.8 5597.2 5598.9 5601.5 5607.6 6736.4 6858.8 6931.8 6932.3 6933.9 1650.0 1675.9 1678.5 1683.2 1685.2 1080.9 1089.8 1094.0 1103.7 1114.1 6555.9 6583.5 6598.0 6601.7 6609.5 7414.9 7419.0 7419.6 7429.4 7430.2 6382.6 6568.9 6581.0 6585.2 6629.0 3848.7 3905.6 3909.2 3915.3 3917.1 7735.3 7739.4 7739.5 7742.8 7747.8 7126.6 7271.3 7413.7 7652.6 7689.1 7270.9 7404.0 7417.1 7437.6 7498.8 7110.3 7126.9 7207.2 7231.6 7261.4 6854.2 7090.0 7105.5 7107.1 7116.1 7522.4 7539.7 7547.5 7547.6 7549.5 4724.6 4769.7 4781.3 4781.8 4786.9 6889.6 7134.7 7142.8 7148.0 7158.0 6852.3 6871.2 6879.0 6885.0 6887.2 5586.5 6844.9 6866.5 6874.1 6892.1 6534.4 6763.4 6817.1 6855.1 6864.6 6019.0 6974.5 6985.8 6988.0 7008.7 6631.6 6815.7 6827.0 6832.1 6863.0 16:33:16 INFO - PROCESS | 1677 | 16:33:16 INFO - PROCESS | 1677 | [#5] yui.html Cycles:180 Average:18028.65 Median:34652.01 stddev:25491.35 (73.6%) stddev-sans-first:25529.52 16:33:16 INFO - PROCESS | 1677 | Values: 666.0 683.7 732.2 758.8 786.8 14530.0 15040.5 15200.7 15216.0 15220.6 11757.5 13784.4 13853.9 13855.4 13858.9 711.8 728.1 872.4 881.7 894.9 886.6 897.6 898.0 900.3 903.5 938.3 939.9 943.0 944.1 944.7 748.6 764.2 924.4 939.7 944.4 699.6 700.6 702.5 704.2 704.8 14778.4 14839.9 14851.3 14859.0 14878.8 12813.2 12898.2 12964.5 12993.8 13472.5 10669.1 10868.3 10901.3 10929.2 10938.4 3088.7 3578.7 3596.6 3605.1 3646.6 83875.0 84062.2 84673.0 84941.0 85021.0 9504.4 9546.8 9559.1 9563.4 9597.7 20724.0 20742.3 20752.6 20753.9 20782.3 6786.3 6814.3 7303.5 7489.7 7523.0 3904.6 4069.6 4139.6 4147.6 4159.2 3510.0 3559.9 3560.5 3565.5 3567.7 689.9 693.1 694.2 708.1 713.4 535.0 553.1 588.0 588.3 627.5 8309.8 8481.4 8495.1 8514.9 8686.9 518.9 562.4 585.4 659.8 661.4 3695.6 3771.9 3903.4 3923.6 3991.9 84407.6 85554.6 85704.6 85773.7 88074.0 73191.0 73225.6 76595.6 80421.6 81421.0 69682.7 70007.3 70413.0 71482.0 71750.3 6760.4 7710.4 7941.4 8412.2 8436.6 49019.0 49416.3 49572.3 49617.8 49654.8 67297.7 67943.0 68620.3 68652.3 69037.7 9887.9 9995.3 10004.2 10135.3 10769.4 9465.4 11064.2 11127.3 11169.0 11251.0 10397.4 10635.7 11183.4 11284.7 11296.4 8496.8 8911.5 9089.4 10350.2 10623.8 10138.2 10474.5 10494.6 10506.5 10994.3 8908.3 9325.5 9340.0 9356.4 9440.6 8530.7 9201.9 9228.4 9258.8 9436.3 16:33:16 INFO - PROCESS | 1677 | -------- Summary: end -------- 16:33:16 INFO - PROCESS | 1677 | 16:33:17 INFO - TEST-INFO | 1677: exit 0 16:33:17 INFO - TEST-OK | dromaeo_css | took 1113677ms 16:33:17 INFO - TEST-START | kraken 16:33:17 INFO - operating with platform_type : mac_ 16:33:17 INFO - Initialising browser for kraken test... 16:33:17 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpwbrv8U/profile http://localhost:49284/getInfo.html) 16:33:19 INFO - PROCESS | 1684 | __metrics Screen width/height:1600/1200 16:33:19 INFO - PROCESS | 1684 | colorDepth:24 16:33:19 INFO - PROCESS | 1684 | Browser inner width/height: 1024/689 16:33:19 INFO - PROCESS | 1684 | __metrics 16:33:19 INFO - PROCESS | 1684 | 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" 16:33:19 INFO - PROCESS | 1684 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:33:19 INFO - TEST-INFO | 1684: exit 0 16:33:19 INFO - Browser initialized. 16:33:19 INFO - Running cycle 1/1 for kraken test... 16:33:19 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/T/tmpwbrv8U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:31 INFO - PROCESS | 1686 | RSS: Main: 243056640 16:33:31 INFO - PROCESS | 1686 | 16:33:34 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-beat-detection) 16:33:35 INFO - PROCESS | 1686 | RSS: Main: 290287616 16:33:35 INFO - PROCESS | 1686 | 16:33:37 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-dft) 16:33:38 INFO - PROCESS | 1686 | RSS: Main: 301715456 16:33:38 INFO - PROCESS | 1686 | 16:33:41 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-fft) 16:33:42 INFO - PROCESS | 1686 | RSS: Main: 285712384 16:33:42 INFO - PROCESS | 1686 | 16:33:44 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49284/tests/kraken/driver.html?testName=audio-oscillator) 16:33:44 INFO - PROCESS | 1686 | RSS: Main: 289304576 16:33:44 INFO - PROCESS | 1686 | 16:33:46 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49284/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:33:47 INFO - PROCESS | 1686 | RSS: Main: 289525760 16:33:47 INFO - PROCESS | 1686 | 16:33:50 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49284/tests/kraken/driver.html?testName=imaging-darkroom) 16:33:50 INFO - PROCESS | 1686 | RSS: Main: 288395264 16:33:50 INFO - PROCESS | 1686 | 16:33:53 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49284/tests/kraken/driver.html?testName=imaging-desaturate) 16:33:54 INFO - PROCESS | 1686 | RSS: Main: 289427456 16:33:54 INFO - PROCESS | 1686 | 16:33:57 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49284/tests/kraken/driver.html?testName=json-parse-financial) 16:33:57 INFO - PROCESS | 1686 | RSS: Main: 290402304 16:33:57 INFO - PROCESS | 1686 | 16:33:59 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49284/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:33:59 INFO - PROCESS | 1686 | RSS: Main: 321265664 16:33:59 INFO - PROCESS | 1686 | 16:34:01 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:34:02 INFO - PROCESS | 1686 | RSS: Main: 321744896 16:34:02 INFO - PROCESS | 1686 | 16:34:04 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:34:04 INFO - PROCESS | 1686 | RSS: Main: 333021184 16:34:04 INFO - PROCESS | 1686 | 16:34:07 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:34:08 INFO - PROCESS | 1686 | RSS: Main: 332746752 16:34:08 INFO - PROCESS | 1686 | 16:34:10 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:34:11 INFO - PROCESS | 1686 | RSS: Main: 332578816 16:34:11 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49284/tests/kraken/driver.html?testName=ai-astar) 16:34:13 INFO - PROCESS | 1686 | RSS: Main: 394162176 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | __start_tp_report 16:34:13 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 16:34:13 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 16:34:13 INFO - PROCESS | 1686 | |i|pagename|runs| 16:34:13 INFO - PROCESS | 1686 | |0;ai-astar;111;106;111;110;112;110;116;111;112;110 16:34:13 INFO - PROCESS | 1686 | |1;audio-beat-detection;157;126;142;156;119;143;143;119;179;145 16:34:13 INFO - PROCESS | 1686 | |2;audio-dft;186;190;187;187;184;185;187;186;183;181 16:34:13 INFO - PROCESS | 1686 | |3;audio-fft;89;76;84;78;48;56;76;104;101;81 16:34:13 INFO - PROCESS | 1686 | |4;audio-oscillator;91;89;128;78;78;80;142;110;111;112 16:34:13 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;83;90;83;93;130;89;83;89;83;89 16:34:13 INFO - PROCESS | 1686 | |6;imaging-darkroom;93;93;93;93;93;93;93;92;93;93 16:34:13 INFO - PROCESS | 1686 | |7;imaging-desaturate;87;90;139;86;86;85;87;85;86;87 16:34:13 INFO - PROCESS | 1686 | |8;json-parse-financial;55;55;53;52;52;53;53;63;50;51 16:34:13 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;61;65;72;78;69;69;66;67;69;67 16:34:13 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;83;71;98;71;97;98;106;104;109;85 16:34:13 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;122;131;121;128;116;131;121;124;119;128 16:34:13 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;142;147;176;172;151;125;124;138;173;172 16:34:13 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;66;67;65;66;65;66;66;66;67;67 16:34:13 INFO - PROCESS | 1686 | __end_tp_report 16:34:13 INFO - PROCESS | 1686 | __start_cc_report 16:34:13 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,1139 16:34:13 INFO - PROCESS | 1686 | __end_cc_report 16:34:13 INFO - PROCESS | 1686 | __startTimestamp1455842053295__endTimestamp 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | ------- Summary: start ------- 16:34:13 INFO - PROCESS | 1686 | Number of tests: 14 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.47 (2.2%) stddev-sans-first:2.62 16:34:13 INFO - PROCESS | 1686 | Values: 111.0 106.0 111.0 110.0 112.0 110.0 116.0 111.0 112.0 110.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:144.00 stddev:18.58 (12.9%) stddev-sans-first:18.99 16:34:13 INFO - PROCESS | 1686 | Values: 157.0 126.0 142.0 156.0 119.0 143.0 143.0 119.0 179.0 145.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:185.60 Median:186.50 stddev:2.50 (1.3%) stddev-sans-first:2.65 16:34:13 INFO - PROCESS | 1686 | Values: 186.0 190.0 187.0 187.0 184.0 185.0 187.0 186.0 183.0 181.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:79.30 Median:77.00 stddev:17.47 (22.7%) stddev-sans-first:18.17 16:34:13 INFO - PROCESS | 1686 | Values: 89.0 76.0 84.0 78.0 48.0 56.0 76.0 104.0 101.0 81.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:101.90 Median:78.00 stddev:22.23 (28.5%) stddev-sans-first:23.22 16:34:13 INFO - PROCESS | 1686 | Values: 91.0 89.0 128.0 78.0 78.0 80.0 142.0 110.0 111.0 112.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:89.00 stddev:14.12 (15.9%) stddev-sans-first:14.66 16:34:13 INFO - PROCESS | 1686 | Values: 83.0 90.0 83.0 93.0 130.0 89.0 83.0 89.0 83.0 89.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:34:13 INFO - PROCESS | 1686 | Values: 93.0 93.0 93.0 93.0 93.0 93.0 93.0 92.0 93.0 93.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:91.80 Median:86.50 stddev:16.65 (19.2%) stddev-sans-first:17.56 16:34:13 INFO - PROCESS | 1686 | Values: 87.0 90.0 139.0 86.0 86.0 85.0 87.0 85.0 86.0 87.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:3.62 (6.8%) stddev-sans-first:3.81 16:34:13 INFO - PROCESS | 1686 | Values: 55.0 55.0 53.0 52.0 52.0 53.0 53.0 63.0 50.0 51.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:69.00 stddev:4.50 (6.5%) stddev-sans-first:3.92 16:34:13 INFO - PROCESS | 1686 | Values: 61.0 65.0 72.0 78.0 69.0 69.0 66.0 67.0 69.0 67.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:84.00 stddev:13.89 (16.5%) stddev-sans-first:14.33 16:34:13 INFO - PROCESS | 1686 | Values: 83.0 71.0 98.0 71.0 97.0 98.0 106.0 104.0 109.0 85.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:126.00 stddev:5.17 (4.1%) stddev-sans-first:5.43 16:34:13 INFO - PROCESS | 1686 | Values: 122.0 131.0 121.0 128.0 116.0 131.0 121.0 124.0 119.0 128.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:161.50 stddev:20.14 (12.5%) stddev-sans-first:21.04 16:34:13 INFO - PROCESS | 1686 | Values: 142.0 147.0 176.0 172.0 151.0 125.0 124.0 138.0 173.0 172.0 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 16:34:13 INFO - PROCESS | 1686 | Values: 66.0 67.0 65.0 66.0 65.0 66.0 66.0 66.0 67.0 67.0 16:34:13 INFO - PROCESS | 1686 | -------- Summary: end -------- 16:34:13 INFO - PROCESS | 1686 | 16:34:13 INFO - TEST-INFO | 1686: exit 0 16:34:14 INFO - TEST-OK | kraken | took 56936ms 16:34:14 INFO - SUITE-END | took 1170s 16:34:14 INFO - Completed test suite (00:19:31) 16:34:14 INFO - Working with test: dromaeo_css 16:34:14 INFO - Generating results file: dromaeo_css 16:34:14 INFO - Working with test: kraken 16:34:14 INFO - Generating results file: kraken 16:34:14 INFO - javascript benchmark 16:34:14 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:34:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 16:34:14 INFO - process_Request line: dromaeo_css 7340.31 graph.html#tests=[[72,1,59]] 16:34:14 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:34:14 INFO - process_Request line: kraken 1452.90 graph.html#tests=[[232,1,59]] 16:34:14 INFO - RETURN: dromaeo_css: 7340.31 16:34:14 INFO - RETURN: kraken: 1452.90 16:34:14 INFO - javascript benchmark 16:34:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3401.6598340165983, 3449.2239246169597, 3467.9422776053293, 3476.391631464493, 3515.0157955772393, 5544.528715059225, 5602.579806514513, 5615.663060216385, 5623.212750214973, 5638.520725738317, 5662.462066103713, 5670.971645141779, 5702.372738998717, 5862.0913758367415, 5870.765169393229, 5094.7197904115255, 5096.643234973553, 5112.769925353349, 5147.871303217431, 5261.053010458116, 5227.032998895216, 5228.111221092423, 5269.473052694738, 5286.814961476349, 5330.520253177213, 5080.618953578496, 5109.540141387293, 5176.534111929945, 5230.581553475751, 5256.185291279858, 5200.8179713710215, 5215.452377500384, 5225.947740522584, 5236.764345604419, 5273.762680679379, 5149.6910185389, 5175.275461435364, 5177.870553236162, 5187.559057480119, 5219.0, 5409.56723462122, 5498.257735205736, 5525.778968841241, 5533.280673512458, 5554.777808887639, 6094.193889829198, 6102.664353460558, 6107.969460152715, 6111.816645500642, 6119.296280927706, 6167.105769663419, 6229.501639868845, 6286.339934306923, 6289.150964619764, 6313.652749098797, 5683.5737319700775, 5704.572157088193, 5723.840570002451, 5739.512141467981, 5767.22142510764, 6170.290416602148, 6216.627002379872, 6262.749490020439, 6276.058591211264, 6276.121343011982, 6023.216981792427, 6092.664903430354, 6105.297890742532, 6109.877802443926, 6115.331611965994, 6204.13142160098, 6208.348123447064, 6246.3753624637175, 6259.624422534663, 6268.0, 5962.55280853929, 6059.697015149225, 6117.082437634302, 6161.84595385119, 6180.042093475518, 6188.628682278988, 6210.937890621036, 6231.2522497300615, 6233.844153896189, 6238.500919926395, 4831.347768051339, 4843.878903027382, 4849.75751212438, 4856.3201151838775, 4885.0, 4273.166732487135, 4313.180495705806, 4360.563943605614, 4387.758673273001, 4392.099619577979, 5548.389677135512, 5559.58303127259, 5589.524890384281, 5595.18869763882, 5605.943940560624, 6163.1679723237685, 6191.783287585003, 6210.378962103844, 6212.937870621236, 6226.875462490725, 5132.666376685504, 5188.403333616682, 5212.087884620177, 5406.729663516887, 5589.301337332833, 5305.734713264398, 5310.017646735367, 5311.920321195185, 5312.07038768214, 5321.36143662763, 6225.533085018732, 6248.250209974832, 6262.5929314594405, 6277.246730392382, 6283.528735344776, 6125.601835880653, 6154.230721159855, 6199.969000154971, 6261.7182226799, 6263.342349053284, 6224.875502490016, 6244.344343843831, 6252.718627661857, 6254.186955695731, 6255.124282600348, 5984.790532331347, 6118.449339559283, 6120.693965301806, 6142.293636231891, 6168.290646575701, 6116.061877111426, 6135.600157732601, 6158.199434073542, 6170.660613666291, 6172.598781079216, 5979.641221526722, 5987.970060149672, 5988.341282458839, 5993.101034844633, 5994.160817485468, 5202.817901373433, 5901.0, 5970.731317090655, 5976.820695379146, 5993.850153746192, 5834.474897259097, 5845.883082338414, 5850.882982340415, 5919.200907877382, 5926.911096333472, 5980.940190598212, 5997.610155339889, 6016.939830601638, 6035.366286540026, 6053.9091913622215, 5874.295084589877, 5881.117832325185, 5899.085641725539, 5908.556858235564, 5937.732802024006], "unit": "score", "name": "dojo.html", "value": 5641.028691952284}, {"lowerIsBetter": false, "replicates": [451.52138732943064, 461.0364338532464, 493.28227429090674, 558.8630785457564, 611.7552978808477, 28552.85723571382, 37414.43878341827, 37522.8123859381, 37576.43635345472, 37609.24781504368, 42049.369259461055, 43148.568514314844, 43363.13273734531, 43424.565754342446, 43579.78210108953, 9416.858747118782, 9644.0, 9652.420854748703, 9658.179054780352, 9669.806603867919, 9390.295727820407, 9526.476043817587, 9537.523123843815, 9542.856857147148, 9560.856587151164, 9486.478243696594, 9567.138957493824, 9568.043195680446, 9590.808183836354, 9593.856092158623, 9425.34022618417, 9471.479068651188, 9476.289278304155, 9496.0, 9504.192143667797, 9396.859047114298, 9510.572024258925, 9510.762230944212, 9544.379615325051, 9548.42709437436, 39151.0, 39513.209735805125, 39604.81185564437, 39616.80191599052, 39702.0, 3148.861611364955, 3200.727938125262, 3300.1914530939835, 3436.6391528889358, 3477.4436090225695, 28269.858650706614, 28517.287067823472, 28663.0, 29037.0, 29304.56043159354, 2107.967096122904, 2505.812064095182, 2507.8244522883224, 2582.418955734963, 2586.896524139032, 460899.0, 462456.0, 462687.3731262678, 463829.0, 465029.0, 55110.72444637831, 56106.0, 63988.04017939734, 64215.03677444842, 64628.35371646317, 60238.0, 60710.08934865981, 60938.78122437615, 61017.38982610206, 61288.38711612916, 16108.516744497683, 16284.51146465608, 16331.346746130022, 16340.428085016967, 16342.591435213977, 10130.696079117639, 11600.361980091177, 12474.501019959282, 12648.367581620882, 12855.357232138356, 19297.228110875407, 19309.51726206856, 19351.90324048371, 19452.805471945383, 19515.512112197026, 7646.350060244941, 7949.801254968556, 7961.880571791427, 7976.680932762741, 7994.280514753584, 938.8826396700413, 974.1865542272141, 998.4907697074399, 1024.3802499487704, 1063.994680026595, 22316.665250021262, 26228.73771262263, 26513.204603861916, 26615.467690646077, 26653.733462665514, 1056.6724315462232, 1077.5097330714507, 1096.7477480179443, 1127.2391135983341, 1229.1887354346088, 11669.35818529972, 13827.930860345836, 13969.72060558783, 14069.85930140706, 14124.717505649829, 538314.0, 548068.0, 548831.0, 549578.0, 551856.0, 57804.0, 58173.709131454074, 58316.4168358311, 58661.70669146627, 58875.0, 1379.675776192614, 1384.764590019699, 1408.3803126624457, 1415.4621243927243, 1418.1491105336715, 27940.161795146178, 28077.157685269474, 28307.858460707565, 28338.724757385553, 28496.57255141133, 48218.5178148214, 48326.75836620794, 48750.756246218545, 48790.75604622096, 48881.0, 436666.0, 502167.0, 503206.0, 503886.0, 504157.0, 27807.02675406351, 32216.0, 32808.179795505304, 32843.8357808219, 32860.507092393156, 39858.800705996284, 40877.0, 41194.0, 42825.357619635106, 43953.46162884284, 36102.63897360993, 36478.4528232082, 36593.45109823408, 36749.26501469902, 37121.443178352885, 28260.326906371938, 33575.0, 34568.82715586507, 34633.65366346304, 37211.883643490735, 34627.4805877907, 35943.0, 36844.81577592202, 36938.630613693516, 37037.25925481529, 28449.857750711115, 30329.69670303269, 31897.840510797298, 32034.67965320317, 32131.51802723008, 20470.795292047485, 23927.812632788846, 24167.51664966726, 24377.0, 24564.385890352885], "unit": "score", "name": "ext.html", "value": 19168.63218559187}, {"lowerIsBetter": false, "replicates": [308.9150483617005, 363.16834449111536, 365.8097789149644, 370.1800511866216, 375.85529571115114, 15418.460353887616, 15879.206039698027, 19964.60070798585, 20300.781953082806, 20826.89586552067, 18959.24163033477, 19559.119839607218, 19674.11466484008, 20692.172313107494, 20739.481512962182, 5625.493705566509, 5838.649681019131, 5841.532677385799, 5852.356240813507, 5911.142884281777, 4157.50109986802, 4774.785134668931, 5758.049921762925, 5879.911801322984, 6398.680065996681, 6499.0, 6549.443297319734, 6589.93410065898, 6590.176227971504, 6605.471562275006, 6133.754649814002, 6296.37036296369, 6301.4328710416285, 6305.369463053681, 6308.873822523569, 4440.888977775581, 5408.864778380533, 5490.615656903979, 5491.28613280275, 5497.147942068986, 12993.740125197442, 13209.075364724473, 13426.664333391744, 13445.394957226948, 13458.461661533527, 1927.9807201928081, 2117.184883819725, 2318.385627808615, 2503.8122140839328, 2758.4483103379202, 9162.175404213653, 9243.6302547898, 9413.858792118124, 9877.654282100164, 10335.379877207391, 1687.5021868548808, 1742.9738553921702, 1768.1866341482933, 1786.767720196379, 1853.962920741591, 63635.0, 86347.0, 94193.52903235509, 106281.0, 106742.46628766807, 11344.376059316817, 11386.544538218544, 11409.14431417647, 11420.600278990361, 11556.76886462266, 13535.45858165682, 13601.387937542835, 13625.591232263048, 13657.0, 13666.658333541542, 8437.57812109392, 8515.063343032261, 8530.146985301544, 8617.95691021541, 8626.18051285127, 8618.0, 8645.783855403664, 8653.394262401698, 8704.782380440412, 8764.649414023368, 4054.8378064877666, 4422.889427764331, 4493.910121797546, 4512.503624601357, 4520.932186017212, 1552.433361822949, 1765.8587313014928, 1868.747719057937, 1874.5407375193165, 1885.2364792259157, 411.44044100023945, 416.43988835016853, 859.9570021498901, 882.3911501064246, 940.2008292951074, 10323.174146068297, 10543.525541350658, 11408.88591114095, 11465.770684586261, 11520.0, 389.42948580329386, 454.332131766303, 458.8669285907116, 464.7838754978951, 470.2311720337273, 6211.006239001738, 6245.531585131042, 6297.590656607306, 6322.083297921776, 6329.968350158312, 523984.0, 524840.0, 543790.0, 575412.0, 618158.0, 121649.0, 123724.38137809433, 124806.0, 125966.37016814857, 126791.73208267799, 911.562450023979, 1036.18659352408, 1043.212374657129, 1047.7275908263907, 1066.4454483668449, 18635.534111647317, 18806.34177803825, 18875.90562047181, 18881.339153129575, 18962.483001359582, 52410.73794631002, 52833.47166528286, 53591.46408536021, 54700.726496367264, 55075.898482030934, 66123.33876661364, 67871.66064169846, 68336.6583167081, 72645.6367718158, 76648.61675691586, 7579.772606821804, 7949.205079492004, 8035.397345199017, 8074.596270186585, 8077.87883181741, 8740.257078148428, 10975.835362469728, 12572.93713531463, 12594.118411711459, 12919.289439080942, 7753.457257992112, 7764.145943946274, 7896.32881205104, 7978.601069946363, 7991.72028978983, 7970.84058318842, 7980.521168729895, 8171.142030086755, 8219.917800822155, 8320.459170153921, 8320.126386729306, 8371.0, 8411.495310281403, 8412.242898139197, 8413.915860841558, 11217.439128043401, 11323.207375483966, 11671.824922625998, 11883.940580297043, 11892.821607675718, 6643.734250629921, 6839.863202736017, 10746.677599672023, 10936.906309369, 11605.477753500943], "unit": "score", "name": "jquery.html", "value": 8448.47165545102}, {"lowerIsBetter": false, "replicates": [1144.7996600594893, 1481.6962522682848, 1517.0745845034528, 1725.1805392438594, 1912.378476994977, 7953.84092318154, 8551.957240213798, 8751.081136480674, 8751.518666473357, 8780.956095219515, 8448.535330556817, 8678.47929124253, 8697.391182617219, 8702.129787021295, 8731.170538798804, 2091.5189506413535, 2158.589867925097, 2453.1904471524444, 2479.727230004698, 2485.2668462803426, 2454.7177074636465, 2507.3856905058196, 2508.122157244959, 2514.9940023990366, 2517.244826552036, 2371.739108698042, 2375.572396968545, 2405.6391541268777, 2436.147348428045, 2446.816488763341, 2435.6482152405406, 2438.2928950604305, 2476.3932836455006, 2484.7887929526014, 2487.912923047703, 2437.183543512925, 2465.8890349934118, 2483.962740558893, 2485.155047283914, 2492.4641202141447, 8872.201501864864, 8898.86651700225, 8919.643214271422, 8926.2412694921, 8935.285177185875, 5459.099248623972, 5568.86077848053, 5568.86077848053, 5574.721263936787, 5575.107982722786, 3133.263683034485, 3634.9640352499673, 3640.7087433005295, 3710.8515659373593, 3717.033571271489, 1035.3477309295097, 1045.3309881675734, 1055.3667799320424, 1077.0360527328075, 1080.8057096907883, 11871.703207419798, 11952.163348565604, 12013.97881180092, 12016.459259333264, 12037.217580857305, 4895.412550493964, 4903.313536104948, 4912.557869791736, 4931.112399768076, 4989.675671081441, 10238.488075596191, 10253.179745620333, 10258.43578603169, 10270.0, 10301.381917084998, 5527.143292789624, 5532.834014979557, 5541.556675465953, 5550.58370622205, 5557.360903496069, 4934.950650493449, 4997.200447928387, 5003.2995380646735, 5007.349044624176, 5014.674046186986, 3659.213269147093, 3737.8691745788765, 3869.3808990561374, 3947.5460322062754, 3966.2860685076384, 1260.1116213069763, 1303.270168705528, 1303.758804621148, 1315.3489022933709, 1317.5849607373646, 1085.9674209773718, 1088.8911108889047, 1226.1539537718945, 1288.4395288049727, 1316.835395575553, 8037.397195210383, 8099.230573095547, 8122.7157049502985, 8130.959345203354, 8142.47073940192, 1165.3998190931677, 1170.2744298534792, 1177.5584155941522, 1188.2157775867886, 1188.3939191012473, 5443.2107344434835, 6296.905546416808, 6396.136521569529, 6401.487880969605, 6407.263164736022, 10182.287239893285, 10497.002784735438, 10530.947345263377, 10542.209334299958, 10547.261691681662, 10133.746656333651, 10287.794244115075, 10290.485475726333, 10300.381977081399, 10435.478226088817, 8128.0, 8257.298129659046, 8262.752117436487, 8271.2142346477, 8275.462094963808, 8058.476199047043, 8064.112947575644, 8110.635021423932, 8141.22658347456, 8305.792355191168, 9704.805903882025, 9707.854382184414, 9781.755456113655, 9856.359336643096, 9928.453935033642, 9817.0, 10010.04904534068, 10129.746756330856, 10233.976602340004, 10309.536070876678, 7513.023306970059, 7607.049118860143, 7626.694932202871, 7852.646630901738, 8107.756767296991, 7507.962460187664, 7645.006149200791, 7982.920170798217, 8197.221263979913, 8211.137830527947, 7255.637218138966, 7308.853822923618, 7309.049823522908, 7395.741149059757, 7474.738384156529, 7188.856222875409, 7191.460640451883, 7317.487775855639, 7321.267873212636, 7400.962995185205, 7541.057367829021, 7572.318491335586, 7575.053118360205, 7610.277023682741, 7626.733064342721, 7003.159620845531, 7068.964655176691, 7079.504434689522, 7079.964600176966, 7088.362047415757, 7081.787546373617, 7172.462065345225, 7175.210726819942, 7178.605176715122, 7191.244919283609], "unit": "score", "name": "mootools.html", "value": 4945.8469885067325}, {"lowerIsBetter": false, "replicates": [318.65744324850783, 325.2584108233229, 331.2051077414207, 331.43986662540306, 334.88111720339276, 6397.4242318191355, 6405.0, 6409.583377080487, 6459.09572659828, 6459.998700201476, 5435.673859568428, 6348.777792777254, 6382.393672601107, 6429.967850160754, 6483.962565989443, 4852.005338905516, 4856.781444834974, 4858.5627293543575, 4871.585915197213, 4876.2198048312275, 4728.90542189156, 4813.807447702087, 4822.276658501218, 4853.126437241295, 4870.099031679133, 4737.73942433166, 4741.075490279397, 4764.952350476503, 4773.594244489205, 4782.13921494131, 4539.455265368144, 4642.210824159901, 4774.331593576902, 4786.545278198583, 4795.0, 4001.159756451149, 4064.4309796628495, 4066.1257829566784, 4093.1199792044554, 4097.672186225095, 6120.663363515005, 6195.473384762301, 6214.25428948529, 6237.0, 6246.906296405557, 5258.158694608883, 5379.757910894019, 5423.291663126102, 5571.4428557144365, 5606.579506537026, 5798.275215598051, 6756.223034351064, 6826.317368263183, 6865.141857267841, 6880.623875224925, 4570.177368073745, 4577.9542204577865, 4582.152301824173, 4582.495925448198, 4588.967482316485, 7097.077379940626, 7260.237675044097, 7275.927240727578, 7283.162436319838, 7305.5981920994855, 4680.531946805292, 4691.108689349013, 4710.128626204163, 4713.387259656222, 4722.763861806896, 4776.379070720784, 4798.448178459522, 4803.5916947059195, 4804.735739534359, 4814.229723244264, 5575.832725018256, 5597.216389705444, 5598.944010559923, 5601.467860553241, 5607.607467477237, 6736.360045795642, 6858.759943401957, 6931.757388491479, 6932.306769323028, 6933.93066069343, 1649.9670006599802, 1675.9245833937503, 1678.4628918745884, 1683.1920678074594, 1685.2163743858919, 1080.935143891369, 1089.7657003744232, 1093.9781204375868, 1103.7351035751522, 1114.0808832713044, 6555.902560899438, 6583.506237032242, 6598.0, 6601.70292336846, 6609.471242300604, 7414.851702965911, 7419.0, 7419.554826710415, 7429.442791790637, 7430.182679905206, 6382.585131966407, 6568.901466478007, 6581.045748366556, 6585.209774827052, 6629.038789375513, 3848.749831260959, 3905.589913059088, 3909.198614284065, 3915.2952468555363, 3917.138229589486, 7735.265149810759, 7739.380849532024, 7739.496932699357, 7742.845143097106, 7747.806304842424, 7126.6080365579355, 7271.272872712792, 7413.740519081806, 7652.617369131521, 7689.115751688516, 7270.927290727025, 7404.0, 7417.072865891656, 7437.628118594049, 7498.812529686801, 7110.25342339047, 7126.928730712627, 7207.1711753146965, 7231.602261875437, 7261.38278246355, 6854.177498699988, 7090.0, 7105.502614816914, 7107.076080109553, 7116.074910261633, 7522.3605993491165, 7539.736109236151, 7547.50941188821, 7547.622618869144, 7549.50928189666, 4724.6456515760765, 4769.689970151929, 4781.282807578891, 4781.784819683053, 4786.880327991828, 6889.586624802528, 7134.678939447634, 7142.785716428515, 7148.0, 7158.0336654550965, 6852.314768523108, 6871.244163142151, 6879.0, 6884.965575172292, 6887.2079710831895, 5586.497215250647, 6844.897326540006, 6866.485013623898, 6874.072000279898, 6892.104026476526, 6534.411902928759, 6763.391294783296, 6817.113775209191, 6855.143107111611, 6864.622445765331, 6019.0, 6974.511784175059, 6985.755498557526, 6988.0, 7008.684609192701, 6631.568948018364, 6815.693293801692, 6826.965865170642, 6832.111825462658, 6863.0], "unit": "score", "name": "prototype.html", "value": 5112.976853698347}, {"lowerIsBetter": false, "replicates": [665.9544515111277, 683.7094234950147, 732.1799584465399, 758.7989182866538, 786.8308313712557, 14530.0, 15040.473583424582, 15200.695986080273, 15216.010959287638, 15220.619484512892, 11757.529698812059, 13784.448622055106, 13853.93073034636, 13855.445782168727, 13858.930705346484, 711.8149281186903, 728.0535304104669, 872.3762509805488, 881.7487016200384, 894.8612964990436, 886.6231851463102, 897.5691667999364, 898.0435835834847, 900.275278400887, 903.4669544968467, 938.3431597881477, 939.873117129189, 942.9764255893589, 944.0700909604069, 944.7496413450441, 748.5994992678918, 764.1632412508322, 924.4360939826768, 939.6617217801586, 944.3814301632442, 699.5942353434996, 700.5586480517293, 702.5222848463094, 704.1585305559857, 704.8378872859271, 14778.408863645442, 14839.851601483955, 14851.2574371281, 14859.0, 14878.776818347733, 12813.231206127663, 12898.161619494796, 12964.546240881618, 12993.80509292352, 13472.461101555926, 10669.146468282519, 10868.347899126078, 10901.29141605801, 10929.234953553176, 10938.398388088652, 3088.737457316131, 3578.6779189872777, 3596.5684117906017, 3605.06268370223, 3646.5806432260365, 83874.99999999939, 84062.15937840665, 84673.0, 84941.0, 85021.0, 9504.382215155993, 9546.761330966781, 9559.091886270793, 9563.378380405251, 9597.712068637951, 20724.0, 20742.27402040921, 20752.58494830125, 20753.896230518752, 20782.27262045821, 6786.321367863175, 6814.284500127415, 7303.525270857377, 7489.70041198346, 7522.962385188039, 3904.590018048121, 4069.552349241581, 4139.627433530996, 4147.564505726855, 4159.188958153131, 3510.034740446398, 3559.875404360835, 3560.537130173061, 3565.5186549815962, 3567.714582833367, 689.8792711275506, 693.1197379328225, 694.2294053600499, 708.0688894104236, 713.4043074033136, 534.9946500535023, 553.1150159744377, 588.0444278048171, 588.326366310572, 627.5387590121258, 8309.792255193668, 8481.40630155883, 8495.065542790288, 8514.914850851535, 8686.913130868737, 518.9465385267912, 562.44880017583, 585.3882692586258, 659.7558903205845, 661.3981277037873, 3695.6489133532273, 3771.8868433947027, 3903.4144878268485, 3923.6076392360537, 3991.9401208981308, 84407.57796211103, 85554.57222713847, 85704.57147714222, 85773.71339429913, 88074.0, 73191.0, 73225.63387183136, 76595.61702191565, 80421.59789201016, 81421.0, 69682.65158674275, 70007.29992700109, 70413.0, 71482.0, 71750.2824971754, 6760.391564759196, 7710.4217183710325, 7941.444098913021, 8412.200840920103, 8436.578171091543, 49019.0, 49416.25875611797, 49572.25641615451, 49617.751911240215, 49654.758631034514, 67297.66351168213, 67943.0, 68620.31379686139, 68652.28369290808, 69037.65481172562, 9887.901120988698, 9995.300328976902, 10004.249681273788, 10135.290529662852, 10769.353838769699, 9465.432074075577, 11064.22550421495, 11127.332360058423, 11169.0, 11251.0, 10397.428141452292, 10635.680929572125, 11183.401792942203, 11284.661460156209, 11296.378699171624, 8496.830063398822, 8911.465312081296, 9089.363744538083, 10350.22373322019, 10623.787524249317, 10138.18894488454, 10474.476276186313, 10494.580216791242, 10506.474676266309, 10994.34033957965, 8908.28133609316, 9325.459121377542, 9339.953300233456, 9356.4386136832, 9440.622375104918, 8530.70142545008, 9201.907980920105, 9228.446293222429, 9258.768530786785, 9436.339456237998], "unit": "score", "name": "yui.html", "value": 6770.32935623214}], "name": "dromaeo_css", "value": 7340.305541775362}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 111.0, 110.0, 112.0, 110.0, 116.0, 111.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 142.0, 156.0, 119.0, 143.0, 143.0, 119.0, 179.0, 145.0], "unit": "score", "name": "audio-beat-detection", "value": 142.9}, {"lowerIsBetter": true, "replicates": [186.0, 190.0, 187.0, 187.0, 184.0, 185.0, 187.0, 186.0, 183.0, 181.0], "unit": "score", "name": "audio-dft", "value": 185.6}, {"lowerIsBetter": true, "replicates": [89.0, 76.0, 84.0, 78.0, 48.0, 56.0, 76.0, 104.0, 101.0, 81.0], "unit": "score", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [91.0, 89.0, 128.0, 78.0, 78.0, 80.0, 142.0, 110.0, 111.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 101.9}, {"lowerIsBetter": true, "replicates": [83.0, 90.0, 83.0, 93.0, 130.0, 89.0, 83.0, 89.0, 83.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 92.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 92.9}, {"lowerIsBetter": true, "replicates": [87.0, 90.0, 139.0, 86.0, 86.0, 85.0, 87.0, 85.0, 86.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 91.8}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 53.0, 52.0, 52.0, 53.0, 53.0, 63.0, 50.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 53.7}, {"lowerIsBetter": true, "replicates": [61.0, 65.0, 72.0, 78.0, 69.0, 69.0, 66.0, 67.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 71.0, 98.0, 71.0, 97.0, 98.0, 106.0, 104.0, 109.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 92.2}, {"lowerIsBetter": true, "replicates": [122.0, 131.0, 121.0, 128.0, 116.0, 131.0, 121.0, 124.0, 119.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [142.0, 147.0, 176.0, 172.0, 151.0, 125.0, 124.0, 138.0, 173.0, 172.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 66.0, 65.0, 66.0, 66.0, 66.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1452.8999999999996}]} 16:34:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1452.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7340.31"}}} 16:34:14 INFO - Return code: 0 16:34:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:34:14 INFO - # TBPL SUCCESS # 16:34:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:34:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:34:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:34:14 INFO - 2016-02-18 16:34:14.704 screenresolution[1690:10420] starting screenresolution argv=screenresolution get 16:34:14 INFO - 2016-02-18 16:34:14.707 screenresolution[1690:10420] Display 0: 1600x1200x32@60 16:34:14 INFO - 2016-02-18 16:34:14.713 screenresolution[1691:10423] starting screenresolution argv=screenresolution list 16:34:14 INFO - Available Modes on Display 0 16:34:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:34:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:34:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:34:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:34:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:34:14 INFO - Intel Iris: 16:34:14 INFO - Chipset Model: Intel Iris 16:34:14 INFO - Type: GPU 16:34:14 INFO - Bus: Built-In 16:34:14 INFO - VRAM (Dynamic, Max): 1536 MB 16:34:14 INFO - Vendor: Intel (0x8086) 16:34:14 INFO - Device ID: 0x0a2e 16:34:14 INFO - Revision ID: 0x0009 16:34:14 INFO - Displays: 16:34:14 INFO - Display: 16:34:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:34:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:34:14 INFO - Display Serial Number: 1600x1200 60 16:34:14 INFO - Main Display: Yes 16:34:14 INFO - Mirror: Off 16:34:14 INFO - Online: Yes 16:34:14 INFO - Rotation: Supported 16:34:14 INFO - Return code: 0 16:34:14 INFO - Running post-action listener: _resource_record_post_action 16:34:14 INFO - Running post-run listener: _resource_record_post_run 16:34:16 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 34012672; Write bytes: 709314048; Read time: 357; Write time: 1958 16:34:16 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 405391872; Write bytes: 408017920; Read time: 30249; Write time: 802 16:34:16 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32112128; Write bytes: 300415488; Read time: 337; Write time: 1152 16:34:16 INFO - Running post-run listener: _upload_blobber_files 16:34:16 INFO - Blob upload gear active. 16:34:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:34:16 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 16:34:16 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'] 16:34:16 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 16:34:16 INFO - (blobuploader) - INFO - Open directory for files ... 16:34:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:34:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:34:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:17 INFO - (blobuploader) - INFO - Done attempting. 16:34:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:34:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:34:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:18 INFO - (blobuploader) - INFO - Done attempting. 16:34:18 INFO - (blobuploader) - INFO - Iteration through files over. 16:34:18 INFO - Return code: 0 16:34:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:34:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:34:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ab559de56bd5674c288bb5ea2ba2457b41fbe8c9d8ab429f1dc08ae31bba8e64dd7d4dccd8b1e9f6b56aac54a52026d15221c63d4f08cf6d0dd1b23d4283849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00aa3332b681e15552032fd99a1559df6c94ef5a56de6d5dcf20f6f1fbb8ddda364fe802f42b403c7d90611c2285b0b6fc21a4d731ecfd07d0f170bcd87f134c"} 16:34:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:34:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:34:18 INFO - Contents: 16:34:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7ab559de56bd5674c288bb5ea2ba2457b41fbe8c9d8ab429f1dc08ae31bba8e64dd7d4dccd8b1e9f6b56aac54a52026d15221c63d4f08cf6d0dd1b23d4283849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00aa3332b681e15552032fd99a1559df6c94ef5a56de6d5dcf20f6f1fbb8ddda364fe802f42b403c7d90611c2285b0b6fc21a4d731ecfd07d0f170bcd87f134c"} 16:34:18 INFO - Running post-run listener: copy_logs_to_upload_dir 16:34:18 INFO - Copying logs to upload dir... 16:34:18 INFO - mkdir: /builds/slave/test/build/upload/logs 16:34:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.603731 ========= master_lag: 4.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-18 16:34:22.169422) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 11 secs) (at 2016-02-18 16:34:22.176087) ========= 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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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/7ab559de56bd5674c288bb5ea2ba2457b41fbe8c9d8ab429f1dc08ae31bba8e64dd7d4dccd8b1e9f6b56aac54a52026d15221c63d4f08cf6d0dd1b23d4283849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00aa3332b681e15552032fd99a1559df6c94ef5a56de6d5dcf20f6f1fbb8ddda364fe802f42b403c7d90611c2285b0b6fc21a4d731ecfd07d0f170bcd87f134c"} build_url:https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011177 build_url: 'https://queue.taskcluster.net/v1/task/FZTGHfYaQImVKewLO6niSg/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/7ab559de56bd5674c288bb5ea2ba2457b41fbe8c9d8ab429f1dc08ae31bba8e64dd7d4dccd8b1e9f6b56aac54a52026d15221c63d4f08cf6d0dd1b23d4283849", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00aa3332b681e15552032fd99a1559df6c94ef5a56de6d5dcf20f6f1fbb8ddda364fe802f42b403c7d90611c2285b0b6fc21a4d731ecfd07d0f170bcd87f134c"}' ========= master_lag: 11.42 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 11 secs) (at 2016-02-18 16:34:33.603515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-02-18 16:34:33.603848) ========= 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.GWqV7NsdbU/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.f6k2DTr0bB/Listeners TMPDIR=/var/folders/1r/5dhvqs_52pbg86_h8rkrnzj800000w/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.005167 ========= master_lag: 12.43 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 12 secs) (at 2016-02-18 16:34:46.042718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 16:34:46.043084) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 16:34:46.741824) ========= ========= Total master_lag: 63.00 =========