builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0050 starttime: 1456154830.3 results: success (0) buildid: 20160222053558 builduid: a7a678fb3fc84a8d978285c7435b3d1b revision: 241581e67d7535834591ae9ec031e5f0f37f6210 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:10.297230) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:10.297621) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:10.298334) ========= 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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005829 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:10.363672) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:10.363981) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:10.452056) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:10.452353) ========= 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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005389 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:10.533322) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:10.533580) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:10.533924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:10.534192) ========= 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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-22 07:27:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-02-22 07:27:11 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.609484 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:11.185735) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:11.186105) ========= 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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.019657 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:11.269520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 07:27:11.269885) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 241581e67d7535834591ae9ec031e5f0f37f6210 --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 241581e67d7535834591ae9ec031e5f0f37f6210 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Tk5BWH8gZR/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.FSxstYbYsA/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-22 07:27:11,345 truncating revision to first 12 chars 2016-02-22 07:27:11,345 Setting DEBUG logging. 2016-02-22 07:27:11,345 attempt 1/10 2016-02-22 07:27:11,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/241581e67d75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 07:27:12,430 unpacking tar archive at: mozilla-central-241581e67d75/testing/mozharness/ program finished with exit code 0 elapsedTime=1.328242 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 07:27:12.619015) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:12.619386) ========= echo 241581e67d7535834591ae9ec031e5f0f37f6210 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'241581e67d7535834591ae9ec031e5f0f37f6210'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Tk5BWH8gZR/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.FSxstYbYsA/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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 241581e67d7535834591ae9ec031e5f0f37f6210 program finished with exit code 0 elapsedTime=0.005148 script_repo_revision: '241581e67d7535834591ae9ec031e5f0f37f6210' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:12.669194) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:12.669492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 07:27:12.683818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-02-22 07:27:12.684103) ========= /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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:27:12 INFO - MultiFileLogger online at 20160222 07:27:12 in /builds/slave/test 07:27:12 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 07:27:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:27:12 INFO - {'append_to_log': False, 07:27:12 INFO - 'base_work_dir': '/builds/slave/test', 07:27:12 INFO - 'blob_upload_branch': 'Firefox', 07:27:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:27:12 INFO - 'branch': 'Firefox', 07:27:12 INFO - 'buildbot_json_path': 'buildprops.json', 07:27:12 INFO - 'config_files': ('talos/mac_config.py',), 07:27:12 INFO - 'default_actions': ('clobber', 07:27:12 INFO - 'read-buildbot-config', 07:27:12 INFO - 'download-and-extract', 07:27:12 INFO - 'populate-webroot', 07:27:12 INFO - 'create-virtualenv', 07:27:12 INFO - 'install', 07:27:12 INFO - 'run-tests'), 07:27:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:27:12 INFO - 'download_minidump_stackwalk': True, 07:27:12 INFO - 'download_symbols': 'ondemand', 07:27:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:27:12 INFO - 'tooltool.py': '/tools/tooltool.py', 07:27:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:27:12 INFO - '/tools/misc-python/virtualenv.py')}, 07:27:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:27:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:27:12 INFO - 'installer_path': 'installer.exe', 07:27:12 INFO - 'log_level': 'info', 07:27:12 INFO - 'log_name': 'talos', 07:27:12 INFO - 'log_to_console': True, 07:27:12 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:27:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:27:12 INFO - 'opt_config_files': (), 07:27:12 INFO - 'pip_index': False, 07:27:12 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:27:12 INFO - 'cmd': ('bash', 07:27:12 INFO - '-c', 07:27:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:27:12 INFO - 'enabled': True, 07:27:12 INFO - 'halt_on_failure': False, 07:27:12 INFO - 'name': 'check_screen_resolution'},), 07:27:12 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:27:12 INFO - 'cmd': ('bash', 07:27:12 INFO - '-c', 07:27:12 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:27:12 INFO - 'enabled': True, 07:27:12 INFO - 'halt_on_failure': False, 07:27:12 INFO - 'name': 'check_screen_resolution'},), 07:27:12 INFO - 'run_cmd_checks_enabled': True, 07:27:12 INFO - 'sps_profile': False, 07:27:12 INFO - 'sps_profile_interval': 0, 07:27:12 INFO - 'suite': 'dromaeojs', 07:27:12 INFO - 'system_bits': '32', 07:27:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:27:12 INFO - 'title': 't-yosemite-r7-0050', 07:27:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:27:12 INFO - 'use_talos_json': True, 07:27:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:27:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:27:12 INFO - 'work_dir': 'build'} 07:27:12 INFO - ##### 07:27:12 INFO - ##### Running clobber step. 07:27:12 INFO - ##### 07:27:12 INFO - Running pre-action listener: _resource_record_pre_action 07:27:12 INFO - Running main action method: clobber 07:27:12 INFO - rmtree: /builds/slave/test/build 07:27:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:27:14 INFO - Running post-action listener: _resource_record_post_action 07:27:14 INFO - ##### 07:27:14 INFO - ##### Running read-buildbot-config step. 07:27:14 INFO - ##### 07:27:14 INFO - Running pre-action listener: _resource_record_pre_action 07:27:14 INFO - Running main action method: read_buildbot_config 07:27:14 INFO - Using buildbot properties: 07:27:14 INFO - { 07:27:14 INFO - "project": "", 07:27:14 INFO - "product": "firefox", 07:27:14 INFO - "script_repo_revision": "production", 07:27:14 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:27:14 INFO - "repository": "", 07:27:14 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:27:14 INFO - "buildid": "20160222053558", 07:27:14 INFO - "pgo_build": "False", 07:27:14 INFO - "basedir": "/builds/slave/test", 07:27:14 INFO - "buildnumber": 138, 07:27:14 INFO - "slavename": "t-yosemite-r7-0050", 07:27:14 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:27:14 INFO - "platform": "yosemite_r7", 07:27:14 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:27:14 INFO - "branch": "mozilla-central", 07:27:14 INFO - "repo_path": "mozilla-central", 07:27:14 INFO - "revision": "241581e67d7535834591ae9ec031e5f0f37f6210", 07:27:14 INFO - "stage_platform": "macosx64", 07:27:14 INFO - "builduid": "a7a678fb3fc84a8d978285c7435b3d1b", 07:27:14 INFO - "slavebuilddir": "test" 07:27:14 INFO - } 07:27:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 07:27:14 INFO - Running post-action listener: _resource_record_post_action 07:27:14 INFO - ##### 07:27:14 INFO - ##### Running download-and-extract step. 07:27:14 INFO - ##### 07:27:14 INFO - Running pre-action listener: _resource_record_pre_action 07:27:14 INFO - Running main action method: download_and_extract 07:27:14 INFO - mkdir: /builds/slave/test/build/tests 07:27: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')]} 07:27:14 INFO - https://queue.taskcluster.net/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:27:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/test_packages.json 07:27:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/test_packages.json 07:27:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:27:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:27:19 INFO - Downloaded 1277 bytes. 07:27:19 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:27:19 INFO - Using the following test package requirements: 07:27:19 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:27:19 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:27:19 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 07:27:19 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:27:19 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 07:27:19 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:27:19 INFO - u'jsshell-mac.zip'], 07:27:19 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:27:19 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 07:27:19 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:27:19 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:27:19 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 07:27:19 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:27:19 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 07:27:19 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:27:19 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 07:27:19 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:27:19 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:27:19 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 07:27:19 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:27:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:19 INFO - https://queue.taskcluster.net/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:27:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:27:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:27:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/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 07:27:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/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 07:27:20 INFO - Downloaded 17825449 bytes. 07:27:20 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'] 07:27:20 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 07:27:23 INFO - Return code: 0 07:27:23 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:23 INFO - https://queue.taskcluster.net/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:27:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:27:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:27:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/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 07:27:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/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 07:27:30 INFO - Downloaded 17825449 bytes. 07:27:30 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'] 07:27:30 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 07:27:34 INFO - Return code: 0 07:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:34 INFO - https://queue.taskcluster.net/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:27:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:27:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:27:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/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 07:27:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/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 07:27:35 INFO - Downloaded 10707015 bytes. 07:27:35 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'] 07:27:35 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 07:27:35 INFO - Return code: 0 07:27:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:35 INFO - https://queue.taskcluster.net/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:27:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:27:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:27:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 07:27:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LN8JpYQLQmmtflW1wFDt6g/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 07:27:43 INFO - Downloaded 111264625 bytes. 07:27:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:27:43 INFO - mkdir: /builds/slave/test/properties 07:27:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:27:43 INFO - Writing to file /builds/slave/test/properties/build_url 07:27:43 INFO - Contents: 07:27:43 INFO - build_url:https://queue.taskcluster.net/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:27:44 INFO - Running post-action listener: _resource_record_post_action 07:27:44 INFO - Running post-action listener: set_extra_try_arguments 07:27:44 INFO - ##### 07:27:44 INFO - ##### Running populate-webroot step. 07:27:44 INFO - ##### 07:27:44 INFO - Running pre-action listener: _resource_record_pre_action 07:27:44 INFO - Running main action method: populate_webroot 07:27:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:27:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:27:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:27:44 INFO - '--tppagecycles', 07:27:44 INFO - '7'], 07:27:44 INFO - 'tests': ['tsvgm']}}, 07:27:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:27:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:27:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:27:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:27:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:27:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:27:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:44 INFO - 'talos_options': ['--e10s'], 07:27:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:44 INFO - 'tests': ['damp', 'tps']}, 07:27:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:44 INFO - 'talos_options': ['--e10s'], 07:27:44 INFO - 'tests': ['damp', 'tps']}, 07:27:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:27:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:27:44 INFO - 'other': {'tests': ['a11yr', 07:27:44 INFO - 'ts_paint', 07:27:44 INFO - 'tpaint', 07:27:44 INFO - 'sessionrestore', 07:27:44 INFO - 'sessionrestore_no_auto_restore']}, 07:27:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:27:44 INFO - 'tests': ['a11yr', 07:27:44 INFO - 'ts_paint', 07:27:44 INFO - 'tpaint', 07:27:44 INFO - 'sessionrestore', 07:27:44 INFO - 'sessionrestore_no_auto_restore']}, 07:27:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:27:44 INFO - 'tests': ['a11yr', 07:27:44 INFO - 'ts_paint', 07:27:44 INFO - 'tpaint', 07:27:44 INFO - 'sessionrestore', 07:27:44 INFO - 'sessionrestore_no_auto_restore']}, 07:27:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:27:44 INFO - 'tests': ['a11yr', 07:27:44 INFO - 'ts_paint', 07:27:44 INFO - 'tpaint', 07:27:44 INFO - 'sessionrestore', 07:27:44 INFO - 'sessionrestore_no_auto_restore']}, 07:27:44 INFO - 'other_l64': {'tests': ['a11yr', 07:27:44 INFO - 'ts_paint', 07:27:44 INFO - 'tpaint', 07:27:44 INFO - 'sessionrestore', 07:27:44 INFO - 'sessionrestore_no_auto_restore']}, 07:27:44 INFO - 'other_nol64': {'tests': ['a11yr', 07:27:44 INFO - 'ts_paint', 07:27:44 INFO - 'tpaint', 07:27:44 INFO - 'sessionrestore', 07:27:44 INFO - 'sessionrestore_no_auto_restore']}, 07:27:44 INFO - 'svgr': {'tests': ['tsvgx', 07:27:44 INFO - 'tsvgr_opacity', 07:27:44 INFO - 'tart', 07:27:44 INFO - 'tscrollx', 07:27:44 INFO - 'cart']}, 07:27:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:27:44 INFO - 'tests': ['tsvgx', 07:27:44 INFO - 'tsvgr_opacity', 07:27:44 INFO - 'tart', 07:27:44 INFO - 'tscrollx', 07:27:44 INFO - 'cart']}, 07:27:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:44 INFO - 'tests': ['tp5o']}, 07:27:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:44 INFO - 'talos_options': ['--e10s'], 07:27:44 INFO - 'tests': ['tp5o']}, 07:27:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:44 INFO - 'talos_options': ['--xperf_path', 07:27:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:44 INFO - 'tests': ['tp5n']}, 07:27:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:27:44 INFO - 'talos_options': ['--e10s', 07:27:44 INFO - '--xperf_path', 07:27:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:44 INFO - 'tests': ['tp5n']}}, 07:27:44 INFO - 'talos.zip': {'path': '', 07:27:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:27:44 INFO - Running post-action listener: _resource_record_post_action 07:27:44 INFO - ##### 07:27:44 INFO - ##### Running create-virtualenv step. 07:27:44 INFO - ##### 07:27:44 INFO - Running pre-action listener: _resource_record_pre_action 07:27:44 INFO - Running main action method: create_virtualenv 07:27:44 INFO - Creating virtualenv /builds/slave/test/build/venv 07:27:44 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:27:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:27:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:27:44 INFO - Using real prefix '/tools/python27' 07:27:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:27:45 INFO - Installing distribute.............................................................................................................................................................................................done. 07:27:48 INFO - Installing pip.................done. 07:27:48 INFO - Return code: 0 07:27:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10915ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091634c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a4a580a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fffd30>, '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 0x108e23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ff6b20>, '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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:27:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tk5BWH8gZR/Render', 07:27:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:48 INFO - 'HOME': '/Users/cltbld', 07:27:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:48 INFO - 'LOGNAME': 'cltbld', 07:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:48 INFO - 'MOZ_NO_REMOTE': '1', 07:27:48 INFO - 'NO_EM_RESTART': '1', 07:27:48 INFO - 'PAGER': '/bin/cat', 07:27:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:48 INFO - 'PWD': '/builds/slave/test', 07:27:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:48 INFO - 'SHELL': '/bin/bash', 07:27:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSxstYbYsA/Listeners', 07:27:48 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 07:27:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:48 INFO - 'USER': 'cltbld', 07:27:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:48 INFO - 'XPC_FLAGS': '0x0', 07:27:48 INFO - 'XPC_SERVICE_NAME': '0', 07:27:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:27:48 INFO - Cleaning up... 07:27:48 INFO - Return code: 0 07:27:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10915ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091634c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a4a580a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fffd30>, '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 0x108e23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ff6b20>, '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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:27:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tk5BWH8gZR/Render', 07:27:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:48 INFO - 'HOME': '/Users/cltbld', 07:27:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:48 INFO - 'LOGNAME': 'cltbld', 07:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:48 INFO - 'MOZ_NO_REMOTE': '1', 07:27:48 INFO - 'NO_EM_RESTART': '1', 07:27:48 INFO - 'PAGER': '/bin/cat', 07:27:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:48 INFO - 'PWD': '/builds/slave/test', 07:27:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:48 INFO - 'SHELL': '/bin/bash', 07:27:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSxstYbYsA/Listeners', 07:27:48 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 07:27:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:48 INFO - 'USER': 'cltbld', 07:27:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:48 INFO - 'XPC_FLAGS': '0x0', 07:27:48 INFO - 'XPC_SERVICE_NAME': '0', 07:27:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:48 INFO - Downloading/unpacking psutil>=0.7.1 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:27:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:51 INFO - Installing collected packages: psutil 07:27:51 INFO - Running setup.py install for psutil 07:27:51 INFO - building 'psutil._psutil_osx' extension 07:27:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:27:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:27:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:27:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:27:52 INFO - building 'psutil._psutil_posix' extension 07:27:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:27:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:27:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:27:52 INFO - ^ 07:27:52 INFO - 1 warning generated. 07:27:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:27:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:52 INFO - Successfully installed psutil 07:27:52 INFO - Cleaning up... 07:27:52 INFO - Return code: 0 07:27:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:52 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 0x10915ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091634c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a4a580a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fffd30>, '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 0x108e23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ff6b20>, '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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:27:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tk5BWH8gZR/Render', 07:27:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:52 INFO - 'HOME': '/Users/cltbld', 07:27:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:52 INFO - 'LOGNAME': 'cltbld', 07:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:52 INFO - 'MOZ_NO_REMOTE': '1', 07:27:52 INFO - 'NO_EM_RESTART': '1', 07:27:52 INFO - 'PAGER': '/bin/cat', 07:27:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:52 INFO - 'PWD': '/builds/slave/test', 07:27:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:52 INFO - 'SHELL': '/bin/bash', 07:27:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSxstYbYsA/Listeners', 07:27:52 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 07:27:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:52 INFO - 'USER': 'cltbld', 07:27:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:52 INFO - 'XPC_FLAGS': '0x0', 07:27:52 INFO - 'XPC_SERVICE_NAME': '0', 07:27:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:27:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:27:55 INFO - Installing collected packages: mozsystemmonitor 07:27:55 INFO - Running setup.py install for mozsystemmonitor 07:27:55 INFO - Successfully installed mozsystemmonitor 07:27:55 INFO - Cleaning up... 07:27:55 INFO - Return code: 0 07:27:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:55 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 0x10915ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091634c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a4a580a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fffd30>, '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 0x108e23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ff6b20>, '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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:27:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tk5BWH8gZR/Render', 07:27:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:55 INFO - 'HOME': '/Users/cltbld', 07:27:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:55 INFO - 'LOGNAME': 'cltbld', 07:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:55 INFO - 'MOZ_NO_REMOTE': '1', 07:27:55 INFO - 'NO_EM_RESTART': '1', 07:27:55 INFO - 'PAGER': '/bin/cat', 07:27:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:55 INFO - 'PWD': '/builds/slave/test', 07:27:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:55 INFO - 'SHELL': '/bin/bash', 07:27:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSxstYbYsA/Listeners', 07:27:55 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 07:27:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:55 INFO - 'USER': 'cltbld', 07:27:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:55 INFO - 'XPC_FLAGS': '0x0', 07:27:55 INFO - 'XPC_SERVICE_NAME': '0', 07:27:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:55 INFO - Downloading/unpacking blobuploader==1.2.4 07:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:57 INFO - Downloading blobuploader-1.2.4.tar.gz 07:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:27:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:27:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:59 INFO - Downloading docopt-0.6.1.tar.gz 07:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:27:59 INFO - Installing collected packages: blobuploader, requests, docopt 07:27:59 INFO - Running setup.py install for blobuploader 07:27:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:27:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:27:59 INFO - Running setup.py install for requests 07:27:59 INFO - Running setup.py install for docopt 07:27:59 INFO - Successfully installed blobuploader requests docopt 07:27:59 INFO - Cleaning up... 07:28:00 INFO - Return code: 0 07:28:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:00 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 0x10915ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091634c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a4a580a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fffd30>, '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 0x108e23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ff6b20>, '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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tk5BWH8gZR/Render', 07:28:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:00 INFO - 'HOME': '/Users/cltbld', 07:28:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:00 INFO - 'LOGNAME': 'cltbld', 07:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:00 INFO - 'MOZ_NO_REMOTE': '1', 07:28:00 INFO - 'NO_EM_RESTART': '1', 07:28:00 INFO - 'PAGER': '/bin/cat', 07:28:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:00 INFO - 'PWD': '/builds/slave/test', 07:28:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:00 INFO - 'SHELL': '/bin/bash', 07:28:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSxstYbYsA/Listeners', 07:28:00 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 07:28:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:00 INFO - 'USER': 'cltbld', 07:28:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:00 INFO - 'XPC_FLAGS': '0x0', 07:28:00 INFO - 'XPC_SERVICE_NAME': '0', 07:28:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-2aOR3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-4pt73v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-N2Zb60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-yWzWyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-oCt_GY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-WH2eLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:00 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-wowroj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-kmV1a0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-XFnILQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-y6lFb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-T2lewz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-sqg6h7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-Q8QDkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-9U2wE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-7GJD7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:01 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-wZXBuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:02 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-KVHmMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:28:02 INFO - Running setup.py install for manifestparser 07:28:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:28:02 INFO - Running setup.py install for mozcrash 07:28:02 INFO - Running setup.py install for mozdebug 07:28:02 INFO - Running setup.py install for mozdevice 07:28:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:28:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:28:02 INFO - Running setup.py install for mozfile 07:28:02 INFO - Running setup.py install for mozhttpd 07:28:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:28:03 INFO - Running setup.py install for mozinfo 07:28:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:28:03 INFO - Running setup.py install for mozInstall 07:28:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:28:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:28:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:28:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:28:03 INFO - Running setup.py install for mozleak 07:28:03 INFO - Running setup.py install for mozlog 07:28:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:28:03 INFO - Running setup.py install for moznetwork 07:28:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:28:03 INFO - Running setup.py install for mozprocess 07:28:03 INFO - Running setup.py install for mozprofile 07:28:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:28:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:28:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:28:04 INFO - Running setup.py install for mozrunner 07:28:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:28:04 INFO - Running setup.py install for mozscreenshot 07:28:04 INFO - Running setup.py install for moztest 07:28:04 INFO - Running setup.py install for mozversion 07:28:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:28:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:28:04 INFO - Cleaning up... 07:28:04 INFO - Return code: 0 07:28:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:04 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 0x10915ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091634c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a4a580a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fffd30>, '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 0x108e23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ff6b20>, '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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tk5BWH8gZR/Render', 07:28:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:04 INFO - 'HOME': '/Users/cltbld', 07:28:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:04 INFO - 'LOGNAME': 'cltbld', 07:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:04 INFO - 'MOZ_NO_REMOTE': '1', 07:28:04 INFO - 'NO_EM_RESTART': '1', 07:28:04 INFO - 'PAGER': '/bin/cat', 07:28:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:04 INFO - 'PWD': '/builds/slave/test', 07:28:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:04 INFO - 'SHELL': '/bin/bash', 07:28:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSxstYbYsA/Listeners', 07:28:04 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 07:28:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:04 INFO - 'USER': 'cltbld', 07:28:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:04 INFO - 'XPC_FLAGS': '0x0', 07:28:04 INFO - 'XPC_SERVICE_NAME': '0', 07:28:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:28:04 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-83agAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:28:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-FODHPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:28:05 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)) 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:28:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-bifnKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:28:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-98pzuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:28:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-WSZhuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:28:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-f709Uu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:28:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-JhGu8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:28:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-_GgAXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:28:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-6aiDyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:28:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:28:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:28:05 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-ndVOkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:28:06 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-opKNN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:28:06 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-NlqtBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:28:06 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-GErjjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:28:06 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-nXOjk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:06 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-dT3J7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:28:06 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-bKlYZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:28:06 INFO - Running setup.py (path:/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/pip-MEoNRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:28:06 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)) 07:28:06 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)) 07:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:28:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28: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 07:28:09 INFO - Downloading blessings-1.6.tar.gz 07:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:28:09 INFO - Installing collected packages: blessings 07:28:09 INFO - Running setup.py install for blessings 07:28:09 INFO - Successfully installed blessings 07:28:09 INFO - Cleaning up... 07:28:09 INFO - Return code: 0 07:28:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:28:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:09 INFO - Reading from file tmpfile_stdout 07:28:09 INFO - Current package versions: 07:28:09 INFO - blessings == 1.6 07:28:09 INFO - blobuploader == 1.2.4 07:28:09 INFO - docopt == 0.6.1 07:28:09 INFO - manifestparser == 1.1 07:28:09 INFO - mozInstall == 1.12 07:28:09 INFO - mozcrash == 0.16 07:28:09 INFO - mozdebug == 0.1 07:28:09 INFO - mozdevice == 0.48 07:28:09 INFO - mozfile == 1.2 07:28:09 INFO - mozhttpd == 0.7 07:28:09 INFO - mozinfo == 0.9 07:28:09 INFO - mozleak == 0.1 07:28:09 INFO - mozlog == 3.1 07:28:09 INFO - moznetwork == 0.27 07:28:09 INFO - mozprocess == 0.22 07:28:09 INFO - mozprofile == 0.28 07:28:09 INFO - mozrunner == 6.11 07:28:09 INFO - mozscreenshot == 0.1 07:28:09 INFO - mozsystemmonitor == 0.0 07:28:09 INFO - moztest == 0.7 07:28:09 INFO - mozversion == 1.4 07:28:09 INFO - psutil == 3.1.1 07:28:09 INFO - requests == 1.2.3 07:28:09 INFO - wsgiref == 0.1.2 07:28:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:09 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 0x10915ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091634c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a4a580a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fffd30>, '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 0x108e23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ff6b20>, '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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:28:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tk5BWH8gZR/Render', 07:28:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:09 INFO - 'HOME': '/Users/cltbld', 07:28:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:09 INFO - 'LOGNAME': 'cltbld', 07:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:09 INFO - 'MOZ_NO_REMOTE': '1', 07:28:09 INFO - 'NO_EM_RESTART': '1', 07:28:09 INFO - 'PAGER': '/bin/cat', 07:28:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:09 INFO - 'PWD': '/builds/slave/test', 07:28:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:09 INFO - 'SHELL': '/bin/bash', 07:28:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSxstYbYsA/Listeners', 07:28:09 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 07:28:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:09 INFO - 'USER': 'cltbld', 07:28:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:09 INFO - 'XPC_FLAGS': '0x0', 07:28:09 INFO - 'XPC_SERVICE_NAME': '0', 07:28:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:28:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:28:10 INFO - Cleaning up... 07:28:10 INFO - Return code: 0 07:28:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:10 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 0x10915ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091634c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a4a580a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fffd30>, '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 0x108e23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ff6b20>, '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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:28:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tk5BWH8gZR/Render', 07:28:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:10 INFO - 'HOME': '/Users/cltbld', 07:28:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:10 INFO - 'LOGNAME': 'cltbld', 07:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:10 INFO - 'MOZ_NO_REMOTE': '1', 07:28:10 INFO - 'NO_EM_RESTART': '1', 07:28:10 INFO - 'PAGER': '/bin/cat', 07:28:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:10 INFO - 'PWD': '/builds/slave/test', 07:28:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:10 INFO - 'SHELL': '/bin/bash', 07:28:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSxstYbYsA/Listeners', 07:28:10 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 07:28:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:10 INFO - 'USER': 'cltbld', 07:28:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:10 INFO - 'XPC_FLAGS': '0x0', 07:28:10 INFO - 'XPC_SERVICE_NAME': '0', 07:28:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:10 INFO - Downloading/unpacking jsonschema 07:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:28:12 INFO - Downloading/unpacking functools32 (from jsonschema) 07:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:13 INFO - Downloading functools32-3.2.3-2.tar.gz 07:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:28:13 INFO - warning: no files found matching '*.txt' 07:28:13 INFO - no previously-included directories found matching 'build' 07:28:13 INFO - no previously-included directories found matching 'dist' 07:28:13 INFO - no previously-included directories found matching '.git*' 07:28:13 INFO - Installing collected packages: jsonschema, functools32 07:28:13 INFO - Running setup.py install for functools32 07:28:13 INFO - warning: no files found matching '*.txt' 07:28:13 INFO - no previously-included directories found matching 'build' 07:28:13 INFO - no previously-included directories found matching 'dist' 07:28:13 INFO - no previously-included directories found matching '.git*' 07:28:13 INFO - Successfully installed jsonschema functools32 07:28:13 INFO - Cleaning up... 07:28:13 INFO - Return code: 0 07:28:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:28:13 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 0x10915ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091634c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a4a580a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fffd30>, '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 0x108e23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ff6b20>, '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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tk5BWH8gZR/Render', 07:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:13 INFO - 'HOME': '/Users/cltbld', 07:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:13 INFO - 'LOGNAME': 'cltbld', 07:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:13 INFO - 'MOZ_NO_REMOTE': '1', 07:28:13 INFO - 'NO_EM_RESTART': '1', 07:28:13 INFO - 'PAGER': '/bin/cat', 07:28:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:13 INFO - 'PWD': '/builds/slave/test', 07:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:13 INFO - 'SHELL': '/bin/bash', 07:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSxstYbYsA/Listeners', 07:28:13 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 07:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:13 INFO - 'USER': 'cltbld', 07:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:13 INFO - 'XPC_FLAGS': '0x0', 07:28:13 INFO - 'XPC_SERVICE_NAME': '0', 07:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:28:13 INFO - Downloading/unpacking flake8 07:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:28:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:28:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:28:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:17 INFO - no previously-included directories found matching 'docs/_build' 07:28:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:28:17 INFO - Running setup.py install for pep8 07:28:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:28:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:28:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:28:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:28:17 INFO - no previously-included directories found matching 'docs/_build' 07:28:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:28:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:28:17 INFO - Cleaning up... 07:28:17 INFO - Return code: 0 07:28:17 INFO - Running post-action listener: _resource_record_post_action 07:28:17 INFO - Running post-action listener: _start_resource_monitoring 07:28:17 INFO - Starting resource monitoring. 07:28:17 INFO - ##### 07:28:17 INFO - ##### Running install step. 07:28:17 INFO - ##### 07:28:17 INFO - Running pre-action listener: _resource_record_pre_action 07:28:17 INFO - Running main action method: install 07:28:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:28:17 INFO - Reading from file tmpfile_stdout 07:28:17 INFO - Detecting whether we're running mozinstall >=1.0... 07:28:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:28:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:28:17 INFO - Reading from file tmpfile_stdout 07:28:17 INFO - Output received: 07:28:17 INFO - Usage: mozinstall [options] installer 07:28:17 INFO - Options: 07:28:17 INFO - -h, --help show this help message and exit 07:28:17 INFO - -d DEST, --destination=DEST 07:28:17 INFO - Directory to install application into. [default: 07:28:17 INFO - "/builds/slave/test"] 07:28:17 INFO - --app=APP Application being installed. [default: firefox] 07:28:17 INFO - mkdir: /builds/slave/test/build/application 07:28:17 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'] 07:28:17 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 07:28:52 INFO - Reading from file tmpfile_stdout 07:28:52 INFO - Output received: 07:28:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:28:52 INFO - Running post-action listener: _resource_record_post_action 07:28:52 INFO - ##### 07:28:52 INFO - ##### Running run-tests step. 07:28:52 INFO - ##### 07:28:52 INFO - Running pre-action listener: _resource_record_pre_action 07:28:52 INFO - Running main action method: run_tests 07:28:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:28:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:28:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:28:52 INFO - 2016-02-22 07:28:52.937 screenresolution[1947:12496] starting screenresolution argv=screenresolution get 07:28:52 INFO - 2016-02-22 07:28:52.940 screenresolution[1947:12496] Display 0: 1600x1200x32@60 07:28:52 INFO - 2016-02-22 07:28:52.946 screenresolution[1948:12498] starting screenresolution argv=screenresolution list 07:28:52 INFO - Available Modes on Display 0 07:28:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:28:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:28:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:28:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:28:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:28:53 INFO - Intel Iris: 07:28:53 INFO - Chipset Model: Intel Iris 07:28:53 INFO - Type: GPU 07:28:53 INFO - Bus: Built-In 07:28:53 INFO - VRAM (Dynamic, Max): 1536 MB 07:28:53 INFO - Vendor: Intel (0x8086) 07:28:53 INFO - Device ID: 0x0a2e 07:28:53 INFO - Revision ID: 0x0009 07:28:53 INFO - Displays: 07:28:53 INFO - Display: 07:28:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:28:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:28:53 INFO - Display Serial Number: 1600x1200 60 07:28:53 INFO - Main Display: Yes 07:28:53 INFO - Mirror: Off 07:28:53 INFO - Online: Yes 07:28:53 INFO - Rotation: Supported 07:28:53 INFO - Return code: 0 07:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:28:53 INFO - Python 2.7.3 07:28:53 INFO - Return code: 0 07:28:53 INFO - grabbing minidump binary from tooltool 07:28:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:28:53 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 0x108fffd30>, '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 0x108e23db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108ff6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:28:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:28:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:28:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:28:53 INFO - Return code: 0 07:28:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:28:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:28:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:28:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:28:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:28:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:28:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:28:54 INFO - Return code: 0 07:28:54 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/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:28:54 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/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:28:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Tk5BWH8gZR/Render', 07:28:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:54 INFO - 'HOME': '/Users/cltbld', 07:28:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:54 INFO - 'LOGNAME': 'cltbld', 07:28:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:28:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:54 INFO - 'MOZ_NO_REMOTE': '1', 07:28:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:28:54 INFO - 'NO_EM_RESTART': '1', 07:28:54 INFO - 'PAGER': '/bin/cat', 07:28:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:54 INFO - 'PWD': '/builds/slave/test', 07:28:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:28:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:54 INFO - 'SHELL': '/bin/bash', 07:28:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FSxstYbYsA/Listeners', 07:28:54 INFO - 'TMPDIR': '/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/', 07:28:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:54 INFO - 'USER': 'cltbld', 07:28:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:54 INFO - 'XPC_FLAGS': '0x0', 07:28:54 INFO - 'XPC_SERVICE_NAME': '0', 07:28:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:54 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/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:28:54 INFO - mozversion application_buildid: 20160222053558 07:28:54 INFO - mozversion application_changeset: 241581e67d7535834591ae9ec031e5f0f37f6210 07:28:54 INFO - mozversion application_display_name: Nightly 07:28:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:28:54 INFO - mozversion application_name: Firefox 07:28:54 INFO - mozversion application_remotingname: firefox 07:28:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:28:54 INFO - mozversion application_vendor: Mozilla 07:28:54 INFO - mozversion application_version: 47.0a1 07:28:54 INFO - mozversion platform_buildid: 20160222053558 07:28:54 INFO - mozversion platform_changeset: 241581e67d7535834591ae9ec031e5f0f37f6210 07:28:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:28:54 INFO - mozversion platform_version: 47.0a1 07:28:54 INFO - using testdate: 1456154934 07:28:54 INFO - actual date: 1456154934 07:28:54 INFO - starting webserver on 'localhost:49626' 07:28:54 INFO - SUITE-START | Running 2 tests 07:28:54 INFO - TEST-START | dromaeo_css 07:28:54 INFO - operating with platform_type : mac_ 07:28:54 INFO - Initialising browser for dromaeo_css test... 07:28:54 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpBvVkub/profile http://localhost:49626/getInfo.html) 07:28:56 INFO - PROCESS | 1966 | __metrics Screen width/height:1600/1200 07:28:56 INFO - PROCESS | 1966 | colorDepth:24 07:28:56 INFO - PROCESS | 1966 | Browser inner width/height: 1024/689 07:28:56 INFO - PROCESS | 1966 | __metrics 07:28:56 INFO - PROCESS | 1966 | 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" 07:28:56 INFO - PROCESS | 1966 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:28:57 INFO - TEST-INFO | 1966: exit 0 07:28:57 INFO - Browser initialized. 07:28:57 INFO - Running cycle 1/1 for dromaeo_css test... 07:28:57 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmpBvVkub/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:09 INFO - PROCESS | 1969 | RSS: Main: 244420608 07:29:09 INFO - PROCESS | 1969 | 07:30:00 INFO - PROCESS | 1969 | 1456155000930 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:32:11 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49626/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49626/tests/dromaeo/cssquery-ext.html) 07:32:12 INFO - PROCESS | 1969 | RSS: Main: 366129152 07:32:12 INFO - PROCESS | 1969 | 07:35:15 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49626/tests/dromaeo/cssquery-ext.html (next: http://localhost:49626/tests/dromaeo/cssquery-jquery.html) 07:35:16 INFO - PROCESS | 1969 | RSS: Main: 377176064 07:35:16 INFO - PROCESS | 1969 | 07:38:18 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49626/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49626/tests/dromaeo/cssquery-mootools.html) 07:38:18 INFO - PROCESS | 1969 | RSS: Main: 374603776 07:38:18 INFO - PROCESS | 1969 | 07:41:21 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49626/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49626/tests/dromaeo/cssquery-prototype.html) 07:41:21 INFO - PROCESS | 1969 | RSS: Main: 332582912 07:41:21 INFO - PROCESS | 1969 | 07:44:24 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49626/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49626/tests/dromaeo/cssquery-yui.html) 07:44:25 INFO - PROCESS | 1969 | RSS: Main: 336654336 07:44:25 INFO - PROCESS | 1969 | 07:47:28 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:49626/tests/dromaeo/cssquery-yui.html (next: http://localhost:49626/tests/dromaeo/cssquery-dojo.html) 07:47:28 INFO - PROCESS | 1969 | RSS: Main: 393097216 07:47:28 INFO - PROCESS | 1969 | 07:47:28 INFO - PROCESS | 1969 | __start_tp_report 07:47:28 INFO - PROCESS | 1969 | _x_x_mozilla_page_load 07:47:28 INFO - PROCESS | 1969 | _x_x_mozilla_page_load_details 07:47:28 INFO - PROCESS | 1969 | |i|pagename|runs| 07:47:28 INFO - PROCESS | 1969 | |0;dojo.html;3421.8118003509803;3452.5856897172325;3470.2018535736765;3487.4943133245674;3535.434330507118;5569.275994120769;5649.943500564993;5664.150377443375;5664.207011018456;5682.602217844747;5594.776208951637;5646.18130371096;5652.576056795747;5668.433156684329;5671.376148623658;5151.278820965068;5163.277141200235;5194.818181363653;5199.116150254447;5258.815941442051;5244.292020577212;5248.186531087687;5253.054450198982;5258.842234732964;5269.262303277545;5181.1969144782615;5213.113770658978;5225.947740522584;5239.449857764937;5244.396894357141;5222.425533191365;5265.078611243036;5278.762455689503;5293.3647962244395;5334.1732031535175;5069.771860266297;5080.364954380702;5156.845294641167;5174.793008279665;5177.223416487519;5510.228568000483;5532.3914369419335;5547.306586676666;5550.86122846928;5586.24585680932;6222.81331560054;6226.968865155691;6229.0967809667345;6230.376962303779;6233.2208473940755;6133.44798968095;6166.475849552793;6275.686215689243;6297.055441683784;6297.6536290504;5717.599768016241;5750.913736293959;5767;5819.912701309484;5821.3596504384905;6244.625322480666;6317.873642527215;6328.493720502349;6334.651594162273;6344.904826427607;6091.360407157274;6123.203983482208;6137.539684523678;6146.6004709693725;6148;6207.379262073757;6236.251649802053;6244.781432649836;6268.279147897959;6271.560990730696;6034.969825150846;6049.818505444844;6129.969739641085;6218.409251121137;6225.221847269091;6112.419320164578;6144.279601711528;6152.415520525543;6163.7842675506145;6171.722272497748;4800.399950006249;4860.586850117779;4866.391701037371;4891.55975962158;4901.583365413909;3721.4603882436895;4320.589543993316;4366.235908715962;4373.3221350690055;4394.956050439455;4828.493008234155;5689.857753556194;5721.113227449752;5733.283339582552;5753.108268218432;6109.2528441424865;6279.215098112736;6279.780207692709;6283.08895210192;6287.434130928147;5727.713614319267;5753.137029445533;5776.1624564437925;5780.277465316835;5845.649261044266;5346.198070289488;5346.385165705994;5367.5169234769055;5374.623776335698;5377.300950876439;6239.376062393906;6250.687465626791;6316.2736285326855;6321.557490975588;6351.682415879188;5134.820281290137;6240.812775616739;6263.4362907338555;6270.717817698306;6285.717142728497;6267.269218749058;6321.178246828067;6326.778562750282;6331.398517140864;6333.398327158912;4806.4953179917;5120.078385890575;6045.455908968214;6094.501462640792;6156.969215153896;6224.097505861715;6242.313345531897;6245.843853903507;6248.281447633581;6253.7185826637;5946.226990491208;6020.247469066367;6070;6074.605150665193;6095.603785753912;6053.243344581927;6105.399096011382;6110.133516259585;6115.270764408881;6124.075808605272;4887.975560122177;5832.387599302182;5894.616849904743;5909.468147866541;5910.852228694317;4681.321208424827;5858.091995740667;6033.366496517978;6092.451679348703;6112.235970503687;5790.826275211751;5915.171875937458;5922.348541660328;5938;5951.375105613848 07:47:28 INFO - PROCESS | 1969 | |1;ext.html;423.7118759243713;483.41989612465005;510.24229019905437;547.7507733981038;622.9595076320039;29854.850725746368;30285.84857075714;37842.053948651264;38526.42210366847;38600;40926.38610420846;41406.79296603513;41447.37828932569;41452.792736036354;41703.79148104255;9469.100435458638;9704.078112579293;9711.854322185172;9713.562889669982;9716.028397160298;9498.71503854882;9636.469994150319;9650.469224192666;9656.613735450574;9665.323427360088;9684.322097453181;9740.4642744649;9750.268729845255;9777.217822574212;9788.706338809847;9674.903250967505;9733.90266097337;9758.463284519348;9764.974677658885;9768.413895166243;9588.808223835555;9731.610735570568;9735.902640973642;9738.172255358302;9758.707238782848;38720.61279387198;39117.804410978046;39136.02159945996;39175;39192;3353.5305057292;3490.301939612062;3498.807565583892;3689.317476266899;3855.363864962278;24259.452757460567;28042;28317.15048548547;28384.006559770514;28693.713062869312;2732.194002769188;2775.264554892955;2809.4662014217233;2819.6888446872304;2822.280318518785;421851;423133;424768;425384;425435.9999999969;45004.54995450069;45296.3205551917;45359.77320113379;45417.77291113589;45426.31860522095;43883;44549.10901782011;44575;44593;44621.33068003983;14803.111813291236;14947.925260373628;14954;14984.70030599382;14996.175210363535;12076.21504602198;12138.575149869888;12155.574554890536;12220;12564.497420103276;14567.562973110824;14571.708565828623;14575.708485830224;14642.267886605627;14705.55883323502;6114.571979961449;6221.720022598904;6252.749890004349;6261.405166509175;6276.403741644536;976.7509285132388;982.3074732313702;995.7012896131132;1042.4214560918763;1088.9727756806144;27896.869208135224;27977.300567485974;28523;28638;28684.569731454045;916.7983043730369;1070.9625163119408;1085.4898197846999;1140.6121918547733;1201.7175963648535;14798.112113273022;14871.553853384416;14937;15258.389664413522;15325.157116358485;483846;494743;497809;498026.5098674556;498611;51556.74221628868;56251;59455.702721486115;60037.69981150154;60108.699456502436;1451.75320195567;1464.5752731707685;1471.727730369885;1482.9915657353104;1486.2197346393014;27883.44233115367;29715.851420742758;30395.69604304017;31267.687323126476;31744.841275793475;49223.76940576371;52968;54689.179662304305;54755.63110922259;54776.452235478726;364180;378638;398191;402178;402578;33208.501872472414;33878.78151575695;34166.658333416344;34193.48709769405;34309.91210791041;32689;44659;44890.77554612206;45108.32337514874;45621;37765.81117094397;37959.24081518299;38102.2379552413;38148.427773582865;38949.61050389573;36503;36615.26769464542;36617.267654646224;37695.05762355963;38735;36594.26811463809;37161.25677486381;37641.247175055796;37821.43267850929;37908.620913791616;31328;33357.499637504974;33517.83241083877;33565.66434335626;33664.83167584244;31394.686053139176;31597.84201079072;31667.84166079155;31797.523037154;32194.839025805657 07:47:28 INFO - PROCESS | 1969 | |2;jquery.html;359.9928001439971;362.28991177292505;363.4294158171671;370.621965595093;371.93677074897266;15817.525474235792;16466.752998705;19336.613267734636;20121;21542.784572154273;16905.57736056596;19891.005449727527;20133.697994530095;20627.27804526842;20657.38027859163;5351.652142610737;5729.856753581173;5941.762329506814;5945.405459454041;5962.731677074542;5755.072050862945;5853.239078919756;5878.1476685880525;5880.059190529516;5893.116032595102;5557;5815.651060936336;5821.243238379026;5821.53427725781;5833;5788.82633520995;5826.300843898738;5833.854153646151;5835.008048631743;5845.766169353221;5080.79676812927;5081.28861959326;5199.896002079937;5438.782448702047;5445.782168713286;13067.411966461437;13262.867371326356;13301.667458313523;16883.746743798853;24085.27744167678;1973.3586584359996;2049.0881557706825;2343.250159948817;2428.3200703802963;2585.1210588400036;9416;9620.51897405134;10028.348157369748;11959.880401196051;14775.556733298019;1640.4586486459439;1691.2896583434863;1721.0792226158944;1726.3094762095136;1737.9044152571603;99360.50959235617;100055.49972250166;102032.48983755108;105211.99999999923;110173.44913275383;10615.575376984989;10970.780584388267;11049.447527623586;11112.777744445066;11246.268992515461;12227.449764760608;12531.373431328397;12796.360181990864;13644.362676478688;13697.178169309873;6852.897206541906;8144.633491492897;8153.8776918346275;8235.805808157784;8418.494890306602;6214.937850621526;8512.616932238065;8689.261412779984;8699.91300086991;8932.910670893338;4374.840667223189;4458.464984201916;4472.508024117345;4477.865664030084;4533.0253995390485;1804.756357891694;1833.7616109905894;1850.287639258895;1875.6436277107307;1877.2021890696672;777.4596655324495;853.4026181672854;926.5228407370209;927.646557693945;1003.4531180506641;15523.767143492856;19922.50193745139;20116.19535218604;20155.697664535044;20631.381058568266;904.439247666451;942.4298299528687;988.2291812386206;1000.5497526113278;1011.9324113060792;7821.843563128706;9935.801283974424;10734.087602553871;11017.394043327695;11325.546978120783;579687;580507;593770;601541;602605;104592.47703761584;117356;118099;118124;119672;917.1653795046609;960.1838437328215;991.1872264742985;1034.255336157965;1040.0171837613534;17701.46895593134;18079.36722214716;18102.637947241245;18102.818971810113;18419.355322563646;47654.52345476501;48388.27417588668;49554.746959885604;52113.7394313026;52185.7390713044;67329.66335168293;67409.66295168689;67745.3225467739;68644.6567767158;75734;7845.137034926268;7954.403419743427;8103;8104.149064348394;8165.14266002085;12963.481460741465;13084.411201496147;13397.66505837362;13485.595432137052;13581.185128892299;11241.775164496501;11394.37330946806;11425;11438.256513326607;11613.825792612948;11211.495482703134;11302.547898083985;11355.261907975955;11605.419729013684;11664.708382290512;11239.494222760159;11508.769824603629;11808.70478238051;11973.401329933642;12027.518899243933;6706;6734.494912881455;8076.111627720828;8246.711365102192;8315.584220789058;9729.513524323615;11621.76756464883;11810.40947952616;12055.57805476804;12102.818457723317 07:47:28 INFO - PROCESS | 1969 | |3;mootools.html;1409.5489443378124;1532.1726267815377;1558.4934896158748;1808.7558179645744;1960.9019549022555;7941.920580794191;8530.317574594033;8728.738137855875;8733.388662793606;8735.170158834908;8531.86703324169;8749.825003499926;8764.1674040966;8773.29813614911;8797.648094076229;2194.5172062146303;2400.975990240093;2430.3924018995253;2454.8772561371907;2466.235467005225;2474.7030356357263;2505.235903049569;2505.6116301973225;2511.4474815540552;2518.408174079099;2466.6793316868784;2491.8006559475198;2492.102842976536;2495.513374891897;2498.775110240078;2173.0981642618294;2402.0992127952104;2441.7314095449665;2445.058652418814;2458.9016439342404;2033.5627840014467;2273.079402841852;2433.476802487474;2438.036975394727;2470.3824043989002;8590.140985901422;8669.306455483546;8673.739787806377;8675.826483470359;8690.087540808187;5242.449542797989;5363.892722145574;5391.676499410009;5443.646162999393;5491.807786727485;3652.7443078984484;3691.464737613058;3769.3403654360377;3782.205736795276;3792.374258247386;1024.8265735732618;1063.6117816996818;1065.7495488560182;1095.9616413425572;1099.367863478503;12142.939285303606;12270.631881043582;12279.447424865813;12281.447334869952;12286.385680715928;4840.00779840132;4878.878028049327;4961.355023846949;5005;5039.269305950616;10402.635907743344;10423;10426.322289051188;10428.634997775041;10447.84328235077;4943.604511639132;5541.889162216814;5543.445655434424;5549;5551.111822108443;4525.479569849509;4809.495003024702;4836.927446088312;4879.365682461257;4905.803767849317;3880.1269714314053;3906.980465097656;3912.1197730510407;3954.8220330085214;3997.300472417315;1302.667819705969;1313.9737205255842;1315;1322.1141834970592;1328.7873940169527;1092.7541303206715;1107.0534692837668;1308.4504508106618;1319.5645437005765;1359.3271330691173;8095.433319667567;8172.387070969701;8181.222783835526;8186.713465028695;8189.754307370788;465.74849581226437;488.93888263967006;514.1670493800068;519.1537793396815;521.0828941063755;6169.629822210682;6185.752569897244;6223.502119830403;6223.782167624202;6238.189035425366;10271.794564108826;10649;10666.253362264722;10793.67618971432;10807;10224.335418197794;10542.945705429549;10591.576336946437;10608.363498190134;10624.096951759188;8241.876371854427;8327.167283271745;8365.28895043928;8375.078741338448;8392.328613710888;7974.641141148546;7988.760337189894;8034.67861285542;8071.717489887826;8086.474379165335;9300.255979521487;9421.434713917188;9673.70978870635;9701.417914925127;9773.41359518431;9602.423854568748;10030.749231269278;10047.497625118862;10085.394876307151;10143.543540540546;6903.827404314731;7184.820379490555;7538.246175382637;7620.009398778124;7730.729424470116;8307.127751586238;8319.168083191633;8360.038595561346;8366.330693544624;8369.539675317672;7074.929250707427;7269.672864721206;7425.071866016748;7516.210797866145;7573.46985711017;7218.89171662436;7249.456290778318;7262.201157872735;7286.417086633162;7353.5955522446775;7606.695732170651;7641.465097443125;7664.463487555818;7673.731419400294;7675.078990521173;6908.067410899464;6929.965350173217;6960.756373526902;6982.755603553851;6998.860022799618;7071.611061391673;7117.501774875709;7147.178074521288;7194.316539928698;7199.784006479814 07:47:28 INFO - PROCESS | 1969 | |4;prototype.html;254.42246101349937;321.44871545299804;325.29573473430025;332.7221769822198;335.4950799047433;6498.80503584892;6499.51253655976;6591.60450372978;6607.8348041299;6626.072349871022;5410.782573920876;6474.1907261592305;6501.90247146292;6509.674516274191;6538.3788540088735;4613.723176609415;4719.693219940693;4852;4852.781624826874;4865.829695960642;3771.641694039062;4821.951780482185;4831.541003604652;4837.226043832988;4861.368022157115;4725.716457012573;4732.219183834681;4748.857534273978;4773.665843390947;4782;4536.274196128604;4641.791119399635;4738.123447162286;4742.857714268577;4757.714537127784;4062.167255712601;4073.5926407359025;4081.89795255121;4091.3249313863175;4092.508898932147;5214.791408343662;6036.852997930379;6295.307516173218;6309.305976342599;6318.62088274705;4597.37935378723;5656.547476201894;5668.206451096849;5684.658920464744;5698.373178950312;6954.130733658293;6963.303669633046;6974.58152510851;6979.965100174467;6986;4286;4498.730076195438;4513.480949690795;4608.700434471749;4610.308453731934;5966.194563733884;7279.41764658826;7343.449241306924;7381.8154546136775;7388.3719883809945;3734.3651579231596;3772.2455508897783;4568.565986231302;4570;4595.609373203315;4628.305754136906;4638.744869032235;4657.534246575383;4659.5573420525;4662.953370466252;5535.280413546294;5535.6955367455175;5538.9169162462595;5545.805896793593;5548.9722551386985;6789.932100679029;7033.507654464139;7035.12060992376;7035.753748618774;7038.472114591426;1587.317453494985;1598.0811033655696;1605.6467577133012;1612.065002298664;1624.350259896051;967.9419234845932;1021.6322124035341;1022.6778564752079;1029.7837454134715;1046.0951277145214;6467.2562655294305;6571.244306904671;6662.333766623299;6715.395614394728;6722;7375.483716139819;7381.778546643609;7394.7781566553085;7396.334329910226;7408.666610002563;5871.207387002785;6284.748610055638;6664.466842652576;6677.23211830636;6687.465002799764;3845.384738441892;3884.3590807517007;3892.377219644843;3892.377219644843;3899.8440062397754;7340.339369456775;7615.276548727862;7621.275978782118;7650.19672934345;7718.305352518188;7508.361789247975;7565.621718914143;7574.583397913168;7575.204603516661;7599.734009309758;7694.499857509244;7710.961445192738;7710.961445192738;7712;7754.88367674474;7043.964780176067;7330.303621155982;7333.779986600197;7338.266173382619;7356.558606483628;6206.565540412128;7218.783436496913;7232.819179520554;7239.963800180965;7248.383887369632;7667.194944530744;7674.347680447225;7677.30904218623;7685;7718.53688778675;4241.1941731071;4551.431071116111;4626.259798432235;4634.76826158684;4643.257078867365;6566.9014964774615;6912.965435172993;7258.89111663336;7259.20148783644;7284.562926224444;6381.7128229228865;6494.830930432568;7008.929910700827;7092;7102.715891364288;7027.754028608974;7039.296070392919;7056.400205982549;7074.893876591752;7079.716811327489;6855.862882742417;6858.588484690935;6887.586744795329;6896.724131034903;6927.238003819677;6382.68086595659;6797.626130562867;7056.400205982549;7060;7085.610291433814;5469.589780766379;6666.633335166613;6823.897641535282;6895.275996020346;6914.239433662193 07:47:28 INFO - PROCESS | 1969 | |5;yui.html;684.4524380495603;684.7466437418159;697.7906628011596;712.9607871567065;723.3056265984653;14984.925075374622;15177.165255910948;15208.935374523788;15213.84786152141;15235.771463428044;15595.376184952589;16033.679326413465;16062.59843503913;16065.116418596972;16084.597885052879;700.9754658586951;705;839.9244068033876;877.2368039805378;879.683314006957;862.3360012790148;874.1826392323167;876.0057334924843;876.1238761238761;876.3514998900831;929.6932012435914;936.6066252174069;936.7985883035146;937.4890684576887;938.3103418987039;738.1621859189804;910.3309067835136;925.1488630459993;929.707142250189;929.7303781903274;682.3040498691356;683.0676127086541;683.1221879884374;684.6474065856088;685.0443631134589;14968.925155374154;15031.323590438347;15066.472673456487;15072.095674259579;15084.849151508453;12633.684157896034;12654.367281635974;12677.936610316981;12919.935400322938;13059.804102938464;10222.846657300146;10315.742106447324;10330.79338413235;10365.326253793555;11040.834387484194;3194.1535493094348;3213.2671700254364;3213.550102985584;3233.417984762742;3258.983705081483;82337;82424;83116.16883831145;85070.14929850685;85536.71694924643;9390.436573805593;9441.622335106518;9443;9744.61021559144;9909.702708918743;20944;21175.68236476454;21184.77559856224;21201.25795597147;21215;7303.48875578715;7363.337299642951;7415.59214243211;7574.545527268271;7596.278353556403;4003.659688926474;4018.618231268025;4057.3102572562734;4064.349704047397;4075.7554546727292;3489.860405583748;3549.5563054618174;3556.893293201208;3561.4479755637917;3561.857525698943;465.8183308509684;606.2088973889029;651.2282944710533;664.0935123556408;687.182253118787;495.3411962090483;588.8969430349757;613.8496068463255;618.4341327685207;621.5773274173605;8248.917510824815;8336;8397.286230670461;8536.957315213383;8675.305975521944;555.952744016755;580.9941900581025;591.414499645348;602.3885755957706;604.8548348396441;3938.8818335449982;3979.2638361902564;4076.2051399977313;4139.4204811326435;4198.118395136994;92596;92613.53693231626;96051;96175.51912240534;96430;81768;81837.54487365388;83636.58181709053;84398.5780071108;85227.57386213029;72228.63885680538;72698.63650681713;73483.63258183782;74167.62916185493;74766;8074.636641351036;8096.39277054235;8233.300169485661;8246.175382461946;8385.748427547183;50742;51324;51627;51633.7418312906;52325.953480929405;65983.67008164928;67185.3281467179;68778.65610671915;73134.63432682803;74573.50852983019;9873.802523949336;9925.950370248103;9945.453000085065;9992.450415226942;10604.363738175425;11854.288742675468;11928.1053920958;11990.340531270864;12485.438155282853;12549.93725031369;8875.644974201217;10616.8938310619;10950.461721329193;11236.66290011301;11745.236559623598;11543.826842597537;11732.472038758106;11812.503729636283;11837.408129593658;11869;11306.378149201873;11416.771664566828;11437.313761174357;11819.231749936227;11847.585334513251;9556.61773529051;9654.042661579018;9740.415575065519;9828.213742900694;9928.652497162564;9970.451625160686;9971.90871822338;9985.800283994135;10031.915210928932;10068.748281293027 07:47:28 INFO - PROCESS | 1969 | __end_tp_report 07:47:28 INFO - PROCESS | 1969 | __start_cc_report 07:47:28 INFO - PROCESS | 1969 | _x_x_mozilla_cycle_collect,1222 07:47:28 INFO - PROCESS | 1969 | __end_cc_report 07:47:28 INFO - PROCESS | 1969 | __startTimestamp1456156048268__endTimestamp 07:47:28 INFO - PROCESS | 1969 | 07:47:28 INFO - PROCESS | 1969 | ------- Summary: start ------- 07:47:28 INFO - PROCESS | 1969 | Number of tests: 6 07:47:28 INFO - PROCESS | 1969 | 07:47:28 INFO - PROCESS | 1969 | [#0] dojo.html Cycles:165 Average:5686.60 Median:5858.09 stddev:652.41 (11.1%) stddev-sans-first:629.76 07:47:28 INFO - PROCESS | 1969 | Values: 3421.8 3452.6 3470.2 3487.5 3535.4 5569.3 5649.9 5664.2 5664.2 5682.6 5594.8 5646.2 5652.6 5668.4 5671.4 5151.3 5163.3 5194.8 5199.1 5258.8 5244.3 5248.2 5253.1 5258.8 5269.3 5181.2 5213.1 5225.9 5239.4 5244.4 5222.4 5265.1 5278.8 5293.4 5334.2 5069.8 5080.4 5156.8 5174.8 5177.2 5510.2 5532.4 5547.3 5550.9 5586.2 6222.8 6227.0 6229.1 6230.4 6233.2 6133.4 6166.5 6275.7 6297.1 6297.7 5717.6 5750.9 5767.0 5819.9 5821.4 6244.6 6317.9 6328.5 6334.7 6344.9 6091.4 6123.2 6137.5 6146.6 6148.0 6207.4 6236.3 6244.8 6268.3 6271.6 6035.0 6049.8 6130.0 6218.4 6225.2 6112.4 6144.3 6152.4 6163.8 6171.7 4800.4 4860.6 4866.4 4891.6 4901.6 3721.5 4320.6 4366.2 4373.3 4395.0 4828.5 5689.9 5721.1 5733.3 5753.1 6109.3 6279.2 6279.8 6283.1 6287.4 5727.7 5753.1 5776.2 5780.3 5845.6 5346.2 5346.4 5367.5 5374.6 5377.3 6239.4 6250.7 6316.3 6321.6 6351.7 5134.8 6240.8 6263.4 6270.7 6285.7 6267.3 6321.2 6326.8 6331.4 6333.4 4806.5 5120.1 6045.5 6094.5 6157.0 6224.1 6242.3 6245.8 6248.3 6253.7 5946.2 6020.2 6070.0 6074.6 6095.6 6053.2 6105.4 6110.1 6115.3 6124.1 4888.0 5832.4 5894.6 5909.5 5910.9 4681.3 5858.1 6033.4 6092.5 6112.2 5790.8 5915.2 5922.3 5938.0 5951.4 07:47:28 INFO - PROCESS | 1969 | 07:47:28 INFO - PROCESS | 1969 | [#1] ext.html Cycles:180 Average:57948.30 Median:21227.68 stddev:116172.80 (547.3%) stddev-sans-first:116418.41 07:47:28 INFO - PROCESS | 1969 | Values: 423.7 483.4 510.2 547.8 623.0 29854.9 30285.8 37842.1 38526.4 38600.0 40926.4 41406.8 41447.4 41452.8 41703.8 9469.1 9704.1 9711.9 9713.6 9716.0 9498.7 9636.5 9650.5 9656.6 9665.3 9684.3 9740.5 9750.3 9777.2 9788.7 9674.9 9733.9 9758.5 9765.0 9768.4 9588.8 9731.6 9735.9 9738.2 9758.7 38720.6 39117.8 39136.0 39175.0 39192.0 3353.5 3490.3 3498.8 3689.3 3855.4 24259.5 28042.0 28317.2 28384.0 28693.7 2732.2 2775.3 2809.5 2819.7 2822.3 421851.0 423133.0 424768.0 425384.0 425436.0 45004.5 45296.3 45359.8 45417.8 45426.3 43883.0 44549.1 44575.0 44593.0 44621.3 14803.1 14947.9 14954.0 14984.7 14996.2 12076.2 12138.6 12155.6 12220.0 12564.5 14567.6 14571.7 14575.7 14642.3 14705.6 6114.6 6221.7 6252.7 6261.4 6276.4 976.8 982.3 995.7 1042.4 1089.0 27896.9 27977.3 28523.0 28638.0 28684.6 916.8 1071.0 1085.5 1140.6 1201.7 14798.1 14871.6 14937.0 15258.4 15325.2 483846.0 494743.0 497809.0 498026.5 498611.0 51556.7 56251.0 59455.7 60037.7 60108.7 1451.8 1464.6 1471.7 1483.0 1486.2 27883.4 29715.9 30395.7 31267.7 31744.8 49223.8 52968.0 54689.2 54755.6 54776.5 364180.0 378638.0 398191.0 402178.0 402578.0 33208.5 33878.8 34166.7 34193.5 34309.9 32689.0 44659.0 44890.8 45108.3 45621.0 37765.8 37959.2 38102.2 38148.4 38949.6 36503.0 36615.3 36617.3 37695.1 38735.0 36594.3 37161.3 37641.2 37821.4 37908.6 31328.0 33357.5 33517.8 33565.7 33664.8 31394.7 31597.8 31667.8 31797.5 32194.8 07:47:28 INFO - PROCESS | 1969 | 07:47:28 INFO - PROCESS | 1969 | [#2] jquery.html Cycles:180 Average:33336.98 Median:13214.26 stddev:98156.29 (742.8%) stddev-sans-first:98400.42 07:47:28 INFO - PROCESS | 1969 | Values: 360.0 362.3 363.4 370.6 371.9 15817.5 16466.8 19336.6 20121.0 21542.8 16905.6 19891.0 20133.7 20627.3 20657.4 5351.7 5729.9 5941.8 5945.4 5962.7 5755.1 5853.2 5878.1 5880.1 5893.1 5557.0 5815.7 5821.2 5821.5 5833.0 5788.8 5826.3 5833.9 5835.0 5845.8 5080.8 5081.3 5199.9 5438.8 5445.8 13067.4 13262.9 13301.7 16883.7 24085.3 1973.4 2049.1 2343.3 2428.3 2585.1 9416.0 9620.5 10028.3 11959.9 14775.6 1640.5 1691.3 1721.1 1726.3 1737.9 99360.5 100055.5 102032.5 105212.0 110173.4 10615.6 10970.8 11049.4 11112.8 11246.3 12227.4 12531.4 12796.4 13644.4 13697.2 6852.9 8144.6 8153.9 8235.8 8418.5 6214.9 8512.6 8689.3 8699.9 8932.9 4374.8 4458.5 4472.5 4477.9 4533.0 1804.8 1833.8 1850.3 1875.6 1877.2 777.5 853.4 926.5 927.6 1003.5 15523.8 19922.5 20116.2 20155.7 20631.4 904.4 942.4 988.2 1000.5 1011.9 7821.8 9935.8 10734.1 11017.4 11325.5 579687.0 580507.0 593770.0 601541.0 602605.0 104592.5 117356.0 118099.0 118124.0 119672.0 917.2 960.2 991.2 1034.3 1040.0 17701.5 18079.4 18102.6 18102.8 18419.4 47654.5 48388.3 49554.7 52113.7 52185.7 67329.7 67409.7 67745.3 68644.7 75734.0 7845.1 7954.4 8103.0 8104.1 8165.1 12963.5 13084.4 13397.7 13485.6 13581.2 11241.8 11394.4 11425.0 11438.3 11613.8 11211.5 11302.5 11355.3 11605.4 11664.7 11239.5 11508.8 11808.7 11973.4 12027.5 6706.0 6734.5 8076.1 8246.7 8315.6 9729.5 11621.8 11810.4 12055.6 12102.8 07:47:28 INFO - PROCESS | 1969 | 07:47:28 INFO - PROCESS | 1969 | [#3] mootools.html Cycles:180 Average:6063.44 Median:5022.13 stddev:3239.38 (64.5%) stddev-sans-first:3229.58 07:47:28 INFO - PROCESS | 1969 | Values: 1409.5 1532.2 1558.5 1808.8 1960.9 7941.9 8530.3 8728.7 8733.4 8735.2 8531.9 8749.8 8764.2 8773.3 8797.6 2194.5 2401.0 2430.4 2454.9 2466.2 2474.7 2505.2 2505.6 2511.4 2518.4 2466.7 2491.8 2492.1 2495.5 2498.8 2173.1 2402.1 2441.7 2445.1 2458.9 2033.6 2273.1 2433.5 2438.0 2470.4 8590.1 8669.3 8673.7 8675.8 8690.1 5242.4 5363.9 5391.7 5443.6 5491.8 3652.7 3691.5 3769.3 3782.2 3792.4 1024.8 1063.6 1065.7 1096.0 1099.4 12142.9 12270.6 12279.4 12281.4 12286.4 4840.0 4878.9 4961.4 5005.0 5039.3 10402.6 10423.0 10426.3 10428.6 10447.8 4943.6 5541.9 5543.4 5549.0 5551.1 4525.5 4809.5 4836.9 4879.4 4905.8 3880.1 3907.0 3912.1 3954.8 3997.3 1302.7 1314.0 1315.0 1322.1 1328.8 1092.8 1107.1 1308.5 1319.6 1359.3 8095.4 8172.4 8181.2 8186.7 8189.8 465.7 488.9 514.2 519.2 521.1 6169.6 6185.8 6223.5 6223.8 6238.2 10271.8 10649.0 10666.3 10793.7 10807.0 10224.3 10542.9 10591.6 10608.4 10624.1 8241.9 8327.2 8365.3 8375.1 8392.3 7974.6 7988.8 8034.7 8071.7 8086.5 9300.3 9421.4 9673.7 9701.4 9773.4 9602.4 10030.7 10047.5 10085.4 10143.5 6903.8 7184.8 7538.2 7620.0 7730.7 8307.1 8319.2 8360.0 8366.3 8369.5 7074.9 7269.7 7425.1 7516.2 7573.5 7218.9 7249.5 7262.2 7286.4 7353.6 7606.7 7641.5 7664.5 7673.7 7675.1 6908.1 6930.0 6960.8 6982.8 6998.9 7071.6 7117.5 7147.2 7194.3 7199.8 07:47:28 INFO - PROCESS | 1969 | 07:47:28 INFO - PROCESS | 1969 | [#4] prototype.html Cycles:180 Average:5699.04 Median:6499.16 stddev:1862.28 (28.7%) stddev-sans-first:1822.11 07:47:28 INFO - PROCESS | 1969 | Values: 254.4 321.4 325.3 332.7 335.5 6498.8 6499.5 6591.6 6607.8 6626.1 5410.8 6474.2 6501.9 6509.7 6538.4 4613.7 4719.7 4852.0 4852.8 4865.8 3771.6 4822.0 4831.5 4837.2 4861.4 4725.7 4732.2 4748.9 4773.7 4782.0 4536.3 4641.8 4738.1 4742.9 4757.7 4062.2 4073.6 4081.9 4091.3 4092.5 5214.8 6036.9 6295.3 6309.3 6318.6 4597.4 5656.5 5668.2 5684.7 5698.4 6954.1 6963.3 6974.6 6980.0 6986.0 4286.0 4498.7 4513.5 4608.7 4610.3 5966.2 7279.4 7343.4 7381.8 7388.4 3734.4 3772.2 4568.6 4570.0 4595.6 4628.3 4638.7 4657.5 4659.6 4663.0 5535.3 5535.7 5538.9 5545.8 5549.0 6789.9 7033.5 7035.1 7035.8 7038.5 1587.3 1598.1 1605.6 1612.1 1624.4 967.9 1021.6 1022.7 1029.8 1046.1 6467.3 6571.2 6662.3 6715.4 6722.0 7375.5 7381.8 7394.8 7396.3 7408.7 5871.2 6284.7 6664.5 6677.2 6687.5 3845.4 3884.4 3892.4 3892.4 3899.8 7340.3 7615.3 7621.3 7650.2 7718.3 7508.4 7565.6 7574.6 7575.2 7599.7 7694.5 7711.0 7711.0 7712.0 7754.9 7044.0 7330.3 7333.8 7338.3 7356.6 6206.6 7218.8 7232.8 7240.0 7248.4 7667.2 7674.3 7677.3 7685.0 7718.5 4241.2 4551.4 4626.3 4634.8 4643.3 6566.9 6913.0 7258.9 7259.2 7284.6 6381.7 6494.8 7008.9 7092.0 7102.7 7027.8 7039.3 7056.4 7074.9 7079.7 6855.9 6858.6 6887.6 6896.7 6927.2 6382.7 6797.6 7056.4 7060.0 7085.6 5469.6 6666.6 6823.9 6895.3 6914.2 07:47:28 INFO - PROCESS | 1969 | 07:47:28 INFO - PROCESS | 1969 | [#5] yui.html Cycles:180 Average:18848.78 Median:33323.88 stddev:26804.24 (80.4%) stddev-sans-first:26844.73 07:47:28 INFO - PROCESS | 1969 | Values: 684.5 684.7 697.8 713.0 723.3 14984.9 15177.2 15208.9 15213.8 15235.8 15595.4 16033.7 16062.6 16065.1 16084.6 701.0 705.0 839.9 877.2 879.7 862.3 874.2 876.0 876.1 876.4 929.7 936.6 936.8 937.5 938.3 738.2 910.3 925.1 929.7 929.7 682.3 683.1 683.1 684.6 685.0 14968.9 15031.3 15066.5 15072.1 15084.8 12633.7 12654.4 12677.9 12919.9 13059.8 10222.8 10315.7 10330.8 10365.3 11040.8 3194.2 3213.3 3213.6 3233.4 3259.0 82337.0 82424.0 83116.2 85070.1 85536.7 9390.4 9441.6 9443.0 9744.6 9909.7 20944.0 21175.7 21184.8 21201.3 21215.0 7303.5 7363.3 7415.6 7574.5 7596.3 4003.7 4018.6 4057.3 4064.3 4075.8 3489.9 3549.6 3556.9 3561.4 3561.9 465.8 606.2 651.2 664.1 687.2 495.3 588.9 613.8 618.4 621.6 8248.9 8336.0 8397.3 8537.0 8675.3 556.0 581.0 591.4 602.4 604.9 3938.9 3979.3 4076.2 4139.4 4198.1 92596.0 92613.5 96051.0 96175.5 96430.0 81768.0 81837.5 83636.6 84398.6 85227.6 72228.6 72698.6 73483.6 74167.6 74766.0 8074.6 8096.4 8233.3 8246.2 8385.7 50742.0 51324.0 51627.0 51633.7 52326.0 65983.7 67185.3 68778.7 73134.6 74573.5 9873.8 9926.0 9945.5 9992.5 10604.4 11854.3 11928.1 11990.3 12485.4 12549.9 8875.6 10616.9 10950.5 11236.7 11745.2 11543.8 11732.5 11812.5 11837.4 11869.0 11306.4 11416.8 11437.3 11819.2 11847.6 9556.6 9654.0 9740.4 9828.2 9928.7 9970.5 9971.9 9985.8 10031.9 10068.7 07:47:28 INFO - PROCESS | 1969 | -------- Summary: end -------- 07:47:28 INFO - PROCESS | 1969 | 07:47:28 INFO - TEST-INFO | 1969: exit 0 07:47:28 INFO - TEST-OK | dromaeo_css | took 1114067ms 07:47:28 INFO - TEST-START | kraken 07:47:28 INFO - operating with platform_type : mac_ 07:47:28 INFO - Initialising browser for kraken test... 07:47:28 INFO - TEST-INFO | started process 1974 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmplMWc9A/profile http://localhost:49626/getInfo.html) 07:47:31 INFO - PROCESS | 1974 | __metrics Screen width/height:1600/1200 07:47:31 INFO - PROCESS | 1974 | colorDepth:24 07:47:31 INFO - PROCESS | 1974 | Browser inner width/height: 1024/689 07:47:31 INFO - PROCESS | 1974 | __metrics 07:47:31 INFO - PROCESS | 1974 | 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" 07:47:31 INFO - PROCESS | 1974 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:47:31 INFO - TEST-INFO | 1974: exit 0 07:47:31 INFO - Browser initialized. 07:47:31 INFO - Running cycle 1/1 for kraken test... 07:47:31 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/T/tmplMWc9A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:43 INFO - PROCESS | 1976 | RSS: Main: 244625408 07:47:43 INFO - PROCESS | 1976 | 07:47:46 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49626/tests/kraken/driver.html?testName=audio-beat-detection) 07:47:47 INFO - PROCESS | 1976 | RSS: Main: 289792000 07:47:47 INFO - PROCESS | 1976 | 07:47:49 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49626/tests/kraken/driver.html?testName=audio-dft) 07:47:50 INFO - PROCESS | 1976 | RSS: Main: 300875776 07:47:50 INFO - PROCESS | 1976 | 07:47:53 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49626/tests/kraken/driver.html?testName=audio-fft) 07:47:54 INFO - PROCESS | 1976 | RSS: Main: 285700096 07:47:54 INFO - PROCESS | 1976 | 07:47:56 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49626/tests/kraken/driver.html?testName=audio-oscillator) 07:47:57 INFO - PROCESS | 1976 | RSS: Main: 287887360 07:47:57 INFO - PROCESS | 1976 | 07:47:59 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49626/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:47:59 INFO - PROCESS | 1976 | RSS: Main: 288915456 07:47:59 INFO - PROCESS | 1976 | 07:48:02 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49626/tests/kraken/driver.html?testName=imaging-darkroom) 07:48:03 INFO - PROCESS | 1976 | RSS: Main: 291291136 07:48:03 INFO - PROCESS | 1976 | 07:48:06 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49626/tests/kraken/driver.html?testName=imaging-desaturate) 07:48:06 INFO - PROCESS | 1976 | RSS: Main: 290643968 07:48:06 INFO - PROCESS | 1976 | 07:48:09 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49626/tests/kraken/driver.html?testName=json-parse-financial) 07:48:10 INFO - PROCESS | 1976 | RSS: Main: 291958784 07:48:10 INFO - PROCESS | 1976 | 07:48:11 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49626/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:48:12 INFO - PROCESS | 1976 | RSS: Main: 324472832 07:48:12 INFO - PROCESS | 1976 | 07:48:14 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:48:14 INFO - PROCESS | 1976 | RSS: Main: 323387392 07:48:14 INFO - PROCESS | 1976 | 07:48:16 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:48:17 INFO - PROCESS | 1976 | RSS: Main: 331534336 07:48:17 INFO - PROCESS | 1976 | 07:48:20 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:48:20 INFO - PROCESS | 1976 | RSS: Main: 333983744 07:48:20 INFO - PROCESS | 1976 | 07:48:23 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:48:23 INFO - PROCESS | 1976 | RSS: Main: 333025280 07:48:23 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | Cycle 1(1): loaded http://localhost:49626/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49626/tests/kraken/driver.html?testName=ai-astar) 07:48:25 INFO - PROCESS | 1976 | RSS: Main: 393973760 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | __start_tp_report 07:48:25 INFO - PROCESS | 1976 | _x_x_mozilla_page_load 07:48:25 INFO - PROCESS | 1976 | _x_x_mozilla_page_load_details 07:48:25 INFO - PROCESS | 1976 | |i|pagename|runs| 07:48:25 INFO - PROCESS | 1976 | |0;ai-astar;153;156;141;111;111;112;118;112;111;112 07:48:25 INFO - PROCESS | 1976 | |1;audio-beat-detection;162;122;156;187;152;171;141;117;161;122 07:48:25 INFO - PROCESS | 1976 | |2;audio-dft;187;186;187;183;184;185;182;182;180;182 07:48:25 INFO - PROCESS | 1976 | |3;audio-fft;75;82;75;117;57;76;84;85;112;59 07:48:25 INFO - PROCESS | 1976 | |4;audio-oscillator;94;114;124;78;78;85;112;78;78;115 07:48:25 INFO - PROCESS | 1976 | |5;imaging-gaussian-blur;89;93;131;131;88;92;87;94;88;94 07:48:25 INFO - PROCESS | 1976 | |6;imaging-darkroom;96;95;96;95;96;95;95;101;150;127 07:48:25 INFO - PROCESS | 1976 | |7;imaging-desaturate;87;86;86;87;104;139;144;88;85;87 07:48:25 INFO - PROCESS | 1976 | |8;json-parse-financial;57;57;56;53;54;54;56;64;53;53 07:48:25 INFO - PROCESS | 1976 | |9;json-stringify-tinderbox;63;62;73;81;102;106;98;67;65;67 07:48:25 INFO - PROCESS | 1976 | |10;stanford-crypto-aes;92;84;82;82;82;83;81;85;85;84 07:48:25 INFO - PROCESS | 1976 | |11;stanford-crypto-ccm;122;127;125;124;125;120;134;121;124;122 07:48:25 INFO - PROCESS | 1976 | |12;stanford-crypto-pbkdf2;139;128;170;166;140;124;139;138;137;140 07:48:25 INFO - PROCESS | 1976 | |13;stanford-crypto-sha256-iterative;67;66;67;66;67;68;68;98;66;67 07:48:25 INFO - PROCESS | 1976 | __end_tp_report 07:48:25 INFO - PROCESS | 1976 | __start_cc_report 07:48:25 INFO - PROCESS | 1976 | _x_x_mozilla_cycle_collect,1128 07:48:25 INFO - PROCESS | 1976 | __end_cc_report 07:48:25 INFO - PROCESS | 1976 | __startTimestamp1456156105766__endTimestamp 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | ------- Summary: start ------- 07:48:25 INFO - PROCESS | 1976 | Number of tests: 14 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#0] ai-astar Cycles:10 Average:123.70 Median:115.00 stddev:18.64 (16.2%) stddev-sans-first:16.49 07:48:25 INFO - PROCESS | 1976 | Values: 153.0 156.0 141.0 111.0 111.0 112.0 118.0 112.0 111.0 112.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:158.50 stddev:23.20 (14.6%) stddev-sans-first:24.14 07:48:25 INFO - PROCESS | 1976 | Values: 162.0 122.0 156.0 187.0 152.0 171.0 141.0 117.0 161.0 122.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.50 stddev:2.39 (1.3%) stddev-sans-first:2.24 07:48:25 INFO - PROCESS | 1976 | Values: 187.0 186.0 187.0 183.0 184.0 185.0 182.0 182.0 180.0 182.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.50 stddev:19.51 (25.8%) stddev-sans-first:20.52 07:48:25 INFO - PROCESS | 1976 | Values: 75.0 82.0 75.0 117.0 57.0 76.0 84.0 85.0 112.0 59.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:78.00 stddev:18.69 (24.0%) stddev-sans-first:19.82 07:48:25 INFO - PROCESS | 1976 | Values: 94.0 114.0 124.0 78.0 78.0 85.0 112.0 78.0 78.0 115.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#5] imaging-gaussian-blur Cycles:10 Average:98.70 Median:90.50 stddev:17.22 (19.0%) stddev-sans-first:17.90 07:48:25 INFO - PROCESS | 1976 | Values: 89.0 93.0 131.0 131.0 88.0 92.0 87.0 94.0 88.0 94.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#6] imaging-darkroom Cycles:10 Average:104.60 Median:95.00 stddev:18.76 (19.7%) stddev-sans-first:19.63 07:48:25 INFO - PROCESS | 1976 | Values: 96.0 95.0 96.0 95.0 96.0 95.0 95.0 101.0 150.0 127.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#7] imaging-desaturate Cycles:10 Average:99.30 Median:86.50 stddev:22.94 (26.5%) stddev-sans-first:23.90 07:48:25 INFO - PROCESS | 1976 | Values: 87.0 86.0 86.0 87.0 104.0 139.0 144.0 88.0 85.0 87.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:56.00 stddev:3.33 (6.0%) stddev-sans-first:3.50 07:48:25 INFO - PROCESS | 1976 | Values: 57.0 57.0 56.0 53.0 54.0 54.0 56.0 64.0 53.0 53.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#9] json-stringify-tinderbox Cycles:10 Average:78.40 Median:67.00 stddev:17.27 (25.8%) stddev-sans-first:17.40 07:48:25 INFO - PROCESS | 1976 | Values: 63.0 62.0 73.0 81.0 102.0 106.0 98.0 67.0 65.0 67.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:3.13 (3.7%) stddev-sans-first:1.45 07:48:25 INFO - PROCESS | 1976 | Values: 92.0 84.0 82.0 82.0 82.0 83.0 81.0 85.0 85.0 84.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:124.50 stddev:3.98 (3.2%) stddev-sans-first:4.12 07:48:25 INFO - PROCESS | 1976 | Values: 122.0 127.0 125.0 124.0 125.0 120.0 134.0 121.0 124.0 122.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.10 Median:139.50 stddev:14.71 (10.5%) stddev-sans-first:15.56 07:48:25 INFO - PROCESS | 1976 | Values: 139.0 128.0 170.0 166.0 140.0 124.0 139.0 138.0 137.0 140.0 07:48:25 INFO - PROCESS | 1976 | 07:48:25 INFO - PROCESS | 1976 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:67.00 stddev:9.87 (14.7%) stddev-sans-first:10.40 07:48:25 INFO - PROCESS | 1976 | Values: 67.0 66.0 67.0 66.0 67.0 68.0 68.0 98.0 66.0 67.0 07:48:25 INFO - PROCESS | 1976 | -------- Summary: end -------- 07:48:25 INFO - PROCESS | 1976 | 07:48:26 INFO - TEST-INFO | 1976: exit 0 07:48:26 INFO - TEST-OK | kraken | took 57696ms 07:48:26 INFO - SUITE-END | took 1171s 07:48:26 INFO - Completed test suite (00:19:32) 07:48:26 INFO - Working with test: dromaeo_css 07:48:26 INFO - Generating results file: dromaeo_css 07:48:26 INFO - Working with test: kraken 07:48:26 INFO - Generating results file: kraken 07:48:26 INFO - javascript benchmark 07:48:26 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:48:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 07:48:27 INFO - process_Request line: dromaeo_css 7420.00 graph.html#tests=[[72,1,59]] 07:48:27 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:48:27 INFO - process_Request line: kraken 1491.60 graph.html#tests=[[232,1,59]] 07:48:27 INFO - RETURN: dromaeo_css: 7420.00 07:48:27 INFO - RETURN: kraken: 1491.60 07:48:27 INFO - javascript benchmark 07:48:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3421.8118003509803, 3452.5856897172325, 3470.2018535736765, 3487.4943133245674, 3535.434330507118, 5569.275994120769, 5649.943500564993, 5664.150377443375, 5664.207011018456, 5682.602217844747, 5594.776208951637, 5646.18130371096, 5652.576056795747, 5668.433156684329, 5671.376148623658, 5151.278820965068, 5163.277141200235, 5194.818181363653, 5199.116150254447, 5258.815941442051, 5244.292020577212, 5248.186531087687, 5253.054450198982, 5258.842234732964, 5269.262303277545, 5181.1969144782615, 5213.113770658978, 5225.947740522584, 5239.449857764937, 5244.396894357141, 5222.425533191365, 5265.078611243036, 5278.762455689503, 5293.3647962244395, 5334.1732031535175, 5069.771860266297, 5080.364954380702, 5156.845294641167, 5174.793008279665, 5177.223416487519, 5510.228568000483, 5532.3914369419335, 5547.306586676666, 5550.86122846928, 5586.24585680932, 6222.81331560054, 6226.968865155691, 6229.0967809667345, 6230.376962303779, 6233.2208473940755, 6133.44798968095, 6166.475849552793, 6275.686215689243, 6297.055441683784, 6297.6536290504, 5717.599768016241, 5750.913736293959, 5767.0, 5819.912701309484, 5821.3596504384905, 6244.625322480666, 6317.873642527215, 6328.493720502349, 6334.651594162273, 6344.904826427607, 6091.360407157274, 6123.203983482208, 6137.539684523678, 6146.6004709693725, 6148.0, 6207.379262073757, 6236.251649802053, 6244.781432649836, 6268.279147897959, 6271.560990730696, 6034.969825150846, 6049.818505444844, 6129.969739641085, 6218.409251121137, 6225.221847269091, 6112.419320164578, 6144.279601711528, 6152.415520525543, 6163.7842675506145, 6171.722272497748, 4800.399950006249, 4860.586850117779, 4866.391701037371, 4891.55975962158, 4901.583365413909, 3721.4603882436895, 4320.589543993316, 4366.235908715962, 4373.3221350690055, 4394.956050439455, 4828.493008234155, 5689.857753556194, 5721.113227449752, 5733.283339582552, 5753.108268218432, 6109.2528441424865, 6279.215098112736, 6279.780207692709, 6283.08895210192, 6287.434130928147, 5727.713614319267, 5753.137029445533, 5776.1624564437925, 5780.277465316835, 5845.649261044266, 5346.198070289488, 5346.385165705994, 5367.5169234769055, 5374.623776335698, 5377.300950876439, 6239.376062393906, 6250.687465626791, 6316.2736285326855, 6321.557490975588, 6351.682415879188, 5134.820281290137, 6240.812775616739, 6263.4362907338555, 6270.717817698306, 6285.717142728497, 6267.269218749058, 6321.178246828067, 6326.778562750282, 6331.398517140864, 6333.398327158912, 4806.4953179917, 5120.078385890575, 6045.455908968214, 6094.501462640792, 6156.969215153896, 6224.097505861715, 6242.313345531897, 6245.843853903507, 6248.281447633581, 6253.7185826637, 5946.226990491208, 6020.247469066367, 6070.0, 6074.605150665193, 6095.603785753912, 6053.243344581927, 6105.399096011382, 6110.133516259585, 6115.270764408881, 6124.075808605272, 4887.975560122177, 5832.387599302182, 5894.616849904743, 5909.468147866541, 5910.852228694317, 4681.321208424827, 5858.091995740667, 6033.366496517978, 6092.451679348703, 6112.235970503687, 5790.826275211751, 5915.171875937458, 5922.348541660328, 5938.0, 5951.375105613848], "unit": "score", "name": "dojo.html", "value": 5646.981047505577}, {"lowerIsBetter": false, "replicates": [423.7118759243713, 483.41989612465005, 510.24229019905437, 547.7507733981038, 622.9595076320039, 29854.850725746368, 30285.84857075714, 37842.053948651264, 38526.42210366847, 38600.0, 40926.38610420846, 41406.79296603513, 41447.37828932569, 41452.792736036354, 41703.79148104255, 9469.100435458638, 9704.078112579293, 9711.854322185172, 9713.562889669982, 9716.028397160298, 9498.71503854882, 9636.469994150319, 9650.469224192666, 9656.613735450574, 9665.323427360088, 9684.322097453181, 9740.4642744649, 9750.268729845255, 9777.217822574212, 9788.706338809847, 9674.903250967505, 9733.90266097337, 9758.463284519348, 9764.974677658885, 9768.413895166243, 9588.808223835555, 9731.610735570568, 9735.902640973642, 9738.172255358302, 9758.707238782848, 38720.61279387198, 39117.804410978046, 39136.02159945996, 39175.0, 39192.0, 3353.5305057292, 3490.301939612062, 3498.807565583892, 3689.317476266899, 3855.363864962278, 24259.452757460567, 28042.0, 28317.15048548547, 28384.006559770514, 28693.713062869312, 2732.194002769188, 2775.264554892955, 2809.4662014217233, 2819.6888446872304, 2822.280318518785, 421851.0, 423133.0, 424768.0, 425384.0, 425435.9999999969, 45004.54995450069, 45296.3205551917, 45359.77320113379, 45417.77291113589, 45426.31860522095, 43883.0, 44549.10901782011, 44575.0, 44593.0, 44621.33068003983, 14803.111813291236, 14947.925260373628, 14954.0, 14984.70030599382, 14996.175210363535, 12076.21504602198, 12138.575149869888, 12155.574554890536, 12220.0, 12564.497420103276, 14567.562973110824, 14571.708565828623, 14575.708485830224, 14642.267886605627, 14705.55883323502, 6114.571979961449, 6221.720022598904, 6252.749890004349, 6261.405166509175, 6276.403741644536, 976.7509285132388, 982.3074732313702, 995.7012896131132, 1042.4214560918763, 1088.9727756806144, 27896.869208135224, 27977.300567485974, 28523.0, 28638.0, 28684.569731454045, 916.7983043730369, 1070.9625163119408, 1085.4898197846999, 1140.6121918547733, 1201.7175963648535, 14798.112113273022, 14871.553853384416, 14937.0, 15258.389664413522, 15325.157116358485, 483846.0, 494743.0, 497809.0, 498026.5098674556, 498611.0, 51556.74221628868, 56251.0, 59455.702721486115, 60037.69981150154, 60108.699456502436, 1451.75320195567, 1464.5752731707685, 1471.727730369885, 1482.9915657353104, 1486.2197346393014, 27883.44233115367, 29715.851420742758, 30395.69604304017, 31267.687323126476, 31744.841275793475, 49223.76940576371, 52968.0, 54689.179662304305, 54755.63110922259, 54776.452235478726, 364180.0, 378638.0, 398191.0, 402178.0, 402578.0, 33208.501872472414, 33878.78151575695, 34166.658333416344, 34193.48709769405, 34309.91210791041, 32689.0, 44659.0, 44890.77554612206, 45108.32337514874, 45621.0, 37765.81117094397, 37959.24081518299, 38102.2379552413, 38148.427773582865, 38949.61050389573, 36503.0, 36615.26769464542, 36617.267654646224, 37695.05762355963, 38735.0, 36594.26811463809, 37161.25677486381, 37641.247175055796, 37821.43267850929, 37908.620913791616, 31328.0, 33357.499637504974, 33517.83241083877, 33565.66434335626, 33664.83167584244, 31394.686053139176, 31597.84201079072, 31667.84166079155, 31797.523037154, 32194.839025805657], "unit": "score", "name": "ext.html", "value": 18946.374013759043}, {"lowerIsBetter": false, "replicates": [359.9928001439971, 362.28991177292505, 363.4294158171671, 370.621965595093, 371.93677074897266, 15817.525474235792, 16466.752998705, 19336.613267734636, 20121.0, 21542.784572154273, 16905.57736056596, 19891.005449727527, 20133.697994530095, 20627.27804526842, 20657.38027859163, 5351.652142610737, 5729.856753581173, 5941.762329506814, 5945.405459454041, 5962.731677074542, 5755.072050862945, 5853.239078919756, 5878.1476685880525, 5880.059190529516, 5893.116032595102, 5557.0, 5815.651060936336, 5821.243238379026, 5821.53427725781, 5833.0, 5788.82633520995, 5826.300843898738, 5833.854153646151, 5835.008048631743, 5845.766169353221, 5080.79676812927, 5081.28861959326, 5199.896002079937, 5438.782448702047, 5445.782168713286, 13067.411966461437, 13262.867371326356, 13301.667458313523, 16883.746743798853, 24085.27744167678, 1973.3586584359996, 2049.0881557706825, 2343.250159948817, 2428.3200703802963, 2585.1210588400036, 9416.0, 9620.51897405134, 10028.348157369748, 11959.880401196051, 14775.556733298019, 1640.4586486459439, 1691.2896583434863, 1721.0792226158944, 1726.3094762095136, 1737.9044152571603, 99360.50959235617, 100055.49972250166, 102032.48983755108, 105211.99999999923, 110173.44913275383, 10615.575376984989, 10970.780584388267, 11049.447527623586, 11112.777744445066, 11246.268992515461, 12227.449764760608, 12531.373431328397, 12796.360181990864, 13644.362676478688, 13697.178169309873, 6852.897206541906, 8144.633491492897, 8153.8776918346275, 8235.805808157784, 8418.494890306602, 6214.937850621526, 8512.616932238065, 8689.261412779984, 8699.91300086991, 8932.910670893338, 4374.840667223189, 4458.464984201916, 4472.508024117345, 4477.865664030084, 4533.0253995390485, 1804.756357891694, 1833.7616109905894, 1850.287639258895, 1875.6436277107307, 1877.2021890696672, 777.4596655324495, 853.4026181672854, 926.5228407370209, 927.646557693945, 1003.4531180506641, 15523.767143492856, 19922.50193745139, 20116.19535218604, 20155.697664535044, 20631.381058568266, 904.439247666451, 942.4298299528687, 988.2291812386206, 1000.5497526113278, 1011.9324113060792, 7821.843563128706, 9935.801283974424, 10734.087602553871, 11017.394043327695, 11325.546978120783, 579687.0, 580507.0, 593770.0, 601541.0, 602605.0, 104592.47703761584, 117356.0, 118099.0, 118124.0, 119672.0, 917.1653795046609, 960.1838437328215, 991.1872264742985, 1034.255336157965, 1040.0171837613534, 17701.46895593134, 18079.36722214716, 18102.637947241245, 18102.818971810113, 18419.355322563646, 47654.52345476501, 48388.27417588668, 49554.746959885604, 52113.7394313026, 52185.7390713044, 67329.66335168293, 67409.66295168689, 67745.3225467739, 68644.6567767158, 75734.0, 7845.137034926268, 7954.403419743427, 8103.0, 8104.149064348394, 8165.14266002085, 12963.481460741465, 13084.411201496147, 13397.66505837362, 13485.595432137052, 13581.185128892299, 11241.775164496501, 11394.37330946806, 11425.0, 11438.256513326607, 11613.825792612948, 11211.495482703134, 11302.547898083985, 11355.261907975955, 11605.419729013684, 11664.708382290512, 11239.494222760159, 11508.769824603629, 11808.70478238051, 11973.401329933642, 12027.518899243933, 6706.0, 6734.494912881455, 8076.111627720828, 8246.711365102192, 8315.584220789058, 9729.513524323615, 11621.76756464883, 11810.40947952616, 12055.57805476804, 12102.818457723317], "unit": "score", "name": "jquery.html", "value": 9180.692858922288}, {"lowerIsBetter": false, "replicates": [1409.5489443378124, 1532.1726267815377, 1558.4934896158748, 1808.7558179645744, 1960.9019549022555, 7941.920580794191, 8530.317574594033, 8728.738137855875, 8733.388662793606, 8735.170158834908, 8531.86703324169, 8749.825003499926, 8764.1674040966, 8773.29813614911, 8797.648094076229, 2194.5172062146303, 2400.975990240093, 2430.3924018995253, 2454.8772561371907, 2466.235467005225, 2474.7030356357263, 2505.235903049569, 2505.6116301973225, 2511.4474815540552, 2518.408174079099, 2466.6793316868784, 2491.8006559475198, 2492.102842976536, 2495.513374891897, 2498.775110240078, 2173.0981642618294, 2402.0992127952104, 2441.7314095449665, 2445.058652418814, 2458.9016439342404, 2033.5627840014467, 2273.079402841852, 2433.476802487474, 2438.036975394727, 2470.3824043989002, 8590.140985901422, 8669.306455483546, 8673.739787806377, 8675.826483470359, 8690.087540808187, 5242.449542797989, 5363.892722145574, 5391.676499410009, 5443.646162999393, 5491.807786727485, 3652.7443078984484, 3691.464737613058, 3769.3403654360377, 3782.205736795276, 3792.374258247386, 1024.8265735732618, 1063.6117816996818, 1065.7495488560182, 1095.9616413425572, 1099.367863478503, 12142.939285303606, 12270.631881043582, 12279.447424865813, 12281.447334869952, 12286.385680715928, 4840.00779840132, 4878.878028049327, 4961.355023846949, 5005.0, 5039.269305950616, 10402.635907743344, 10423.0, 10426.322289051188, 10428.634997775041, 10447.84328235077, 4943.604511639132, 5541.889162216814, 5543.445655434424, 5549.0, 5551.111822108443, 4525.479569849509, 4809.495003024702, 4836.927446088312, 4879.365682461257, 4905.803767849317, 3880.1269714314053, 3906.980465097656, 3912.1197730510407, 3954.8220330085214, 3997.300472417315, 1302.667819705969, 1313.9737205255842, 1315.0, 1322.1141834970592, 1328.7873940169527, 1092.7541303206715, 1107.0534692837668, 1308.4504508106618, 1319.5645437005765, 1359.3271330691173, 8095.433319667567, 8172.387070969701, 8181.222783835526, 8186.713465028695, 8189.754307370788, 465.74849581226437, 488.93888263967006, 514.1670493800068, 519.1537793396815, 521.0828941063755, 6169.629822210682, 6185.752569897244, 6223.502119830403, 6223.782167624202, 6238.189035425366, 10271.794564108826, 10649.0, 10666.253362264722, 10793.67618971432, 10807.0, 10224.335418197794, 10542.945705429549, 10591.576336946437, 10608.363498190134, 10624.096951759188, 8241.876371854427, 8327.167283271745, 8365.28895043928, 8375.078741338448, 8392.328613710888, 7974.641141148546, 7988.760337189894, 8034.67861285542, 8071.717489887826, 8086.474379165335, 9300.255979521487, 9421.434713917188, 9673.70978870635, 9701.417914925127, 9773.41359518431, 9602.423854568748, 10030.749231269278, 10047.497625118862, 10085.394876307151, 10143.543540540546, 6903.827404314731, 7184.820379490555, 7538.246175382637, 7620.009398778124, 7730.729424470116, 8307.127751586238, 8319.168083191633, 8360.038595561346, 8366.330693544624, 8369.539675317672, 7074.929250707427, 7269.672864721206, 7425.071866016748, 7516.210797866145, 7573.46985711017, 7218.89171662436, 7249.456290778318, 7262.201157872735, 7286.417086633162, 7353.5955522446775, 7606.695732170651, 7641.465097443125, 7664.463487555818, 7673.731419400294, 7675.078990521173, 6908.067410899464, 6929.965350173217, 6960.756373526902, 6982.755603553851, 6998.860022799618, 7071.611061391673, 7117.501774875709, 7147.178074521288, 7194.316539928698, 7199.784006479814], "unit": "score", "name": "mootools.html", "value": 4842.434601484234}, {"lowerIsBetter": false, "replicates": [254.42246101349937, 321.44871545299804, 325.29573473430025, 332.7221769822198, 335.4950799047433, 6498.80503584892, 6499.51253655976, 6591.60450372978, 6607.8348041299, 6626.072349871022, 5410.782573920876, 6474.1907261592305, 6501.90247146292, 6509.674516274191, 6538.3788540088735, 4613.723176609415, 4719.693219940693, 4852.0, 4852.781624826874, 4865.829695960642, 3771.641694039062, 4821.951780482185, 4831.541003604652, 4837.226043832988, 4861.368022157115, 4725.716457012573, 4732.219183834681, 4748.857534273978, 4773.665843390947, 4782.0, 4536.274196128604, 4641.791119399635, 4738.123447162286, 4742.857714268577, 4757.714537127784, 4062.167255712601, 4073.5926407359025, 4081.89795255121, 4091.3249313863175, 4092.508898932147, 5214.791408343662, 6036.852997930379, 6295.307516173218, 6309.305976342599, 6318.62088274705, 4597.37935378723, 5656.547476201894, 5668.206451096849, 5684.658920464744, 5698.373178950312, 6954.130733658293, 6963.303669633046, 6974.58152510851, 6979.965100174467, 6986.0, 4286.0, 4498.730076195438, 4513.480949690795, 4608.700434471749, 4610.308453731934, 5966.194563733884, 7279.41764658826, 7343.449241306924, 7381.8154546136775, 7388.3719883809945, 3734.3651579231596, 3772.2455508897783, 4568.565986231302, 4570.0, 4595.609373203315, 4628.305754136906, 4638.744869032235, 4657.534246575383, 4659.5573420525, 4662.953370466252, 5535.280413546294, 5535.6955367455175, 5538.9169162462595, 5545.805896793593, 5548.9722551386985, 6789.932100679029, 7033.507654464139, 7035.12060992376, 7035.753748618774, 7038.472114591426, 1587.317453494985, 1598.0811033655696, 1605.6467577133012, 1612.065002298664, 1624.350259896051, 967.9419234845932, 1021.6322124035341, 1022.6778564752079, 1029.7837454134715, 1046.0951277145214, 6467.2562655294305, 6571.244306904671, 6662.333766623299, 6715.395614394728, 6722.0, 7375.483716139819, 7381.778546643609, 7394.7781566553085, 7396.334329910226, 7408.666610002563, 5871.207387002785, 6284.748610055638, 6664.466842652576, 6677.23211830636, 6687.465002799764, 3845.384738441892, 3884.3590807517007, 3892.377219644843, 3892.377219644843, 3899.8440062397754, 7340.339369456775, 7615.276548727862, 7621.275978782118, 7650.19672934345, 7718.305352518188, 7508.361789247975, 7565.621718914143, 7574.583397913168, 7575.204603516661, 7599.734009309758, 7694.499857509244, 7710.961445192738, 7710.961445192738, 7712.0, 7754.88367674474, 7043.964780176067, 7330.303621155982, 7333.779986600197, 7338.266173382619, 7356.558606483628, 6206.565540412128, 7218.783436496913, 7232.819179520554, 7239.963800180965, 7248.383887369632, 7667.194944530744, 7674.347680447225, 7677.30904218623, 7685.0, 7718.53688778675, 4241.1941731071, 4551.431071116111, 4626.259798432235, 4634.76826158684, 4643.257078867365, 6566.9014964774615, 6912.965435172993, 7258.89111663336, 7259.20148783644, 7284.562926224444, 6381.7128229228865, 6494.830930432568, 7008.929910700827, 7092.0, 7102.715891364288, 7027.754028608974, 7039.296070392919, 7056.400205982549, 7074.893876591752, 7079.716811327489, 6855.862882742417, 6858.588484690935, 6887.586744795329, 6896.724131034903, 6927.238003819677, 6382.68086595659, 6797.626130562867, 7056.400205982549, 7060.0, 7085.610291433814, 5469.589780766379, 6666.633335166613, 6823.897641535282, 6895.275996020346, 6914.239433662193], "unit": "score", "name": "prototype.html", "value": 5071.881418295218}, {"lowerIsBetter": false, "replicates": [684.4524380495603, 684.7466437418159, 697.7906628011596, 712.9607871567065, 723.3056265984653, 14984.925075374622, 15177.165255910948, 15208.935374523788, 15213.84786152141, 15235.771463428044, 15595.376184952589, 16033.679326413465, 16062.59843503913, 16065.116418596972, 16084.597885052879, 700.9754658586951, 705.0, 839.9244068033876, 877.2368039805378, 879.683314006957, 862.3360012790148, 874.1826392323167, 876.0057334924843, 876.1238761238761, 876.3514998900831, 929.6932012435914, 936.6066252174069, 936.7985883035146, 937.4890684576887, 938.3103418987039, 738.1621859189804, 910.3309067835136, 925.1488630459993, 929.707142250189, 929.7303781903274, 682.3040498691356, 683.0676127086541, 683.1221879884374, 684.6474065856088, 685.0443631134589, 14968.925155374154, 15031.323590438347, 15066.472673456487, 15072.095674259579, 15084.849151508453, 12633.684157896034, 12654.367281635974, 12677.936610316981, 12919.935400322938, 13059.804102938464, 10222.846657300146, 10315.742106447324, 10330.79338413235, 10365.326253793555, 11040.834387484194, 3194.1535493094348, 3213.2671700254364, 3213.550102985584, 3233.417984762742, 3258.983705081483, 82337.0, 82424.0, 83116.16883831145, 85070.14929850685, 85536.71694924643, 9390.436573805593, 9441.622335106518, 9443.0, 9744.61021559144, 9909.702708918743, 20944.0, 21175.68236476454, 21184.77559856224, 21201.25795597147, 21215.0, 7303.48875578715, 7363.337299642951, 7415.59214243211, 7574.545527268271, 7596.278353556403, 4003.659688926474, 4018.618231268025, 4057.3102572562734, 4064.349704047397, 4075.7554546727292, 3489.860405583748, 3549.5563054618174, 3556.893293201208, 3561.4479755637917, 3561.857525698943, 465.8183308509684, 606.2088973889029, 651.2282944710533, 664.0935123556408, 687.182253118787, 495.3411962090483, 588.8969430349757, 613.8496068463255, 618.4341327685207, 621.5773274173605, 8248.917510824815, 8336.0, 8397.286230670461, 8536.957315213383, 8675.305975521944, 555.952744016755, 580.9941900581025, 591.414499645348, 602.3885755957706, 604.8548348396441, 3938.8818335449982, 3979.2638361902564, 4076.2051399977313, 4139.4204811326435, 4198.118395136994, 92596.0, 92613.53693231626, 96051.0, 96175.51912240534, 96430.0, 81768.0, 81837.54487365388, 83636.58181709053, 84398.5780071108, 85227.57386213029, 72228.63885680538, 72698.63650681713, 73483.63258183782, 74167.62916185493, 74766.0, 8074.636641351036, 8096.39277054235, 8233.300169485661, 8246.175382461946, 8385.748427547183, 50742.0, 51324.0, 51627.0, 51633.7418312906, 52325.953480929405, 65983.67008164928, 67185.3281467179, 68778.65610671915, 73134.63432682803, 74573.50852983019, 9873.802523949336, 9925.950370248103, 9945.453000085065, 9992.450415226942, 10604.363738175425, 11854.288742675468, 11928.1053920958, 11990.340531270864, 12485.438155282853, 12549.93725031369, 8875.644974201217, 10616.8938310619, 10950.461721329193, 11236.66290011301, 11745.236559623598, 11543.826842597537, 11732.472038758106, 11812.503729636283, 11837.408129593658, 11869.0, 11306.378149201873, 11416.771664566828, 11437.313761174357, 11819.231749936227, 11847.585334513251, 9556.61773529051, 9654.042661579018, 9740.415575065519, 9828.213742900694, 9928.652497162564, 9970.451625160686, 9971.90871822338, 9985.800283994135, 10031.915210928932, 10068.748281293027], "unit": "score", "name": "yui.html", "value": 6917.368430784763}], "name": "dromaeo_css", "value": 7420.006455860857}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [153.0, 156.0, 141.0, 111.0, 111.0, 112.0, 118.0, 112.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 123.7}, {"lowerIsBetter": true, "replicates": [162.0, 122.0, 156.0, 187.0, 152.0, 171.0, 141.0, 117.0, 161.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [187.0, 186.0, 187.0, 183.0, 184.0, 185.0, 182.0, 182.0, 180.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.8}, {"lowerIsBetter": true, "replicates": [75.0, 82.0, 75.0, 117.0, 57.0, 76.0, 84.0, 85.0, 112.0, 59.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [94.0, 114.0, 124.0, 78.0, 78.0, 85.0, 112.0, 78.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 95.6}, {"lowerIsBetter": true, "replicates": [89.0, 93.0, 131.0, 131.0, 88.0, 92.0, 87.0, 94.0, 88.0, 94.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 98.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 101.0, 150.0, 127.0], "unit": "score", "name": "imaging-darkroom", "value": 104.6}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 86.0, 87.0, 104.0, 139.0, 144.0, 88.0, 85.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 99.3}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 56.0, 53.0, 54.0, 54.0, 56.0, 64.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.7}, {"lowerIsBetter": true, "replicates": [63.0, 62.0, 73.0, 81.0, 102.0, 106.0, 98.0, 67.0, 65.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 78.4}, {"lowerIsBetter": true, "replicates": [92.0, 84.0, 82.0, 82.0, 82.0, 83.0, 81.0, 85.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [122.0, 127.0, 125.0, 124.0, 125.0, 120.0, 134.0, 121.0, 124.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [139.0, 128.0, 170.0, 166.0, 140.0, 124.0, 139.0, 138.0, 137.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.1}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 66.0, 67.0, 68.0, 68.0, 98.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1491.6000000000001}]} 07:48:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1491.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7420.00"}}} 07:48:27 INFO - Return code: 0 07:48:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:48:27 INFO - # TBPL SUCCESS # 07:48:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:48:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:48:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:48:27 INFO - 2016-02-22 07:48:27.780 screenresolution[1980:14367] starting screenresolution argv=screenresolution get 07:48:27 INFO - 2016-02-22 07:48:27.783 screenresolution[1980:14367] Display 0: 1600x1200x32@60 07:48:27 INFO - 2016-02-22 07:48:27.789 screenresolution[1981:14371] starting screenresolution argv=screenresolution list 07:48:27 INFO - Available Modes on Display 0 07:48:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:48:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:48:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:48:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:48:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:48:28 INFO - Intel Iris: 07:48:28 INFO - Chipset Model: Intel Iris 07:48:28 INFO - Type: GPU 07:48:28 INFO - Bus: Built-In 07:48:28 INFO - VRAM (Dynamic, Max): 1536 MB 07:48:28 INFO - Vendor: Intel (0x8086) 07:48:28 INFO - Device ID: 0x0a2e 07:48:28 INFO - Revision ID: 0x0009 07:48:28 INFO - Displays: 07:48:28 INFO - Display: 07:48:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:48:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:48:28 INFO - Display Serial Number: 1600x1200 60 07:48:28 INFO - Main Display: Yes 07:48:28 INFO - Mirror: Off 07:48:28 INFO - Online: Yes 07:48:28 INFO - Rotation: Supported 07:48:28 INFO - Return code: 0 07:48:28 INFO - Running post-action listener: _resource_record_post_action 07:48:28 INFO - Running post-run listener: _resource_record_post_run 07:48:29 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 2584576; Write bytes: 706762240; Read time: 40; Write time: 2235 07:48:29 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 399157760; Write bytes: 393499648; Read time: 31214; Write time: 679 07:48:29 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 2584576; Write bytes: 298567168; Read time: 40; Write time: 1487 07:48:29 INFO - Running post-run listener: _upload_blobber_files 07:48:29 INFO - Blob upload gear active. 07:48:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:48:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:48:29 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'] 07:48:29 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 07:48:29 INFO - (blobuploader) - INFO - Open directory for files ... 07:48:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:48:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:48:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:30 INFO - (blobuploader) - INFO - Done attempting. 07:48:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:48:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:48:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:48:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:48:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:48:31 INFO - (blobuploader) - INFO - Done attempting. 07:48:31 INFO - (blobuploader) - INFO - Iteration through files over. 07:48:31 INFO - Return code: 0 07:48:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:48:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:48:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5147e1d44eef5aa3cfe13e21cd10b7cfba9455d238e013754800b312126c163713f00f8a45b94af4915a113f325afeb5135330b1642c31602ccdf3a3c416372b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb581ce5d53160e7584cbbe306d5d5514b751a11ec92b921dcabd9f355a73fc74e8a5e686a334ce8e5bdb21fa4584dd18b5a01e46e5ca7eaa7984be3806435e0"} 07:48:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:48:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:48:31 INFO - Contents: 07:48:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5147e1d44eef5aa3cfe13e21cd10b7cfba9455d238e013754800b312126c163713f00f8a45b94af4915a113f325afeb5135330b1642c31602ccdf3a3c416372b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb581ce5d53160e7584cbbe306d5d5514b751a11ec92b921dcabd9f355a73fc74e8a5e686a334ce8e5bdb21fa4584dd18b5a01e46e5ca7eaa7984be3806435e0"} 07:48:31 INFO - Running post-run listener: copy_logs_to_upload_dir 07:48:31 INFO - Copying logs to upload dir... 07:48:31 INFO - mkdir: /builds/slave/test/build/upload/logs 07:48:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.715752 ========= master_lag: 3.40 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-02-22 07:48:34.796902) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 07:48:34.800260) ========= 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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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/5147e1d44eef5aa3cfe13e21cd10b7cfba9455d238e013754800b312126c163713f00f8a45b94af4915a113f325afeb5135330b1642c31602ccdf3a3c416372b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb581ce5d53160e7584cbbe306d5d5514b751a11ec92b921dcabd9f355a73fc74e8a5e686a334ce8e5bdb21fa4584dd18b5a01e46e5ca7eaa7984be3806435e0"} build_url:https://queue.taskcluster.net/v1/task/LN8JpYQLQmmtflW1wFDt6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/LN8JpYQLQmmtflW1wFDt6g/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/5147e1d44eef5aa3cfe13e21cd10b7cfba9455d238e013754800b312126c163713f00f8a45b94af4915a113f325afeb5135330b1642c31602ccdf3a3c416372b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb581ce5d53160e7584cbbe306d5d5514b751a11ec92b921dcabd9f355a73fc74e8a5e686a334ce8e5bdb21fa4584dd18b5a01e46e5ca7eaa7984be3806435e0"}' ========= master_lag: 0.72 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 07:48:35.534120) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 07:48:35.534420) ========= 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.Tk5BWH8gZR/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.FSxstYbYsA/Listeners TMPDIR=/var/folders/mg/4p66s20s2m19br0bc1hxf60m00000w/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.005227 ========= master_lag: 1.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-02-22 07:48:36.904757) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 07:48:36.905194) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 07:48:36.910874) ========= ========= Total master_lag: 5.79 =========