builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0005 starttime: 1456447293.46 results: success (0) buildid: 20160225145929 builduid: 720b979622454e2b8832f8d407315633 revision: 8a390011304e8adb8abe4880792148f6a3a9bf56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.456037) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.456536) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.456875) ========= 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.fp2nMzGE3c/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.p49lwtylIB/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.005924 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.482539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.482849) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.499763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.500373) ========= 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.fp2nMzGE3c/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.p49lwtylIB/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.005304 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.552357) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.553062) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.553718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.554046) ========= 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.fp2nMzGE3c/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.p49lwtylIB/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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-25 16:41:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.14M=0.001s 2016-02-25 16:41:33 (8.14 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175878 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.748754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.749490) ========= 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.fp2nMzGE3c/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.p49lwtylIB/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.020476 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:33.802833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 16:41:33.803607) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8a390011304e8adb8abe4880792148f6a3a9bf56 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 8a390011304e8adb8abe4880792148f6a3a9bf56 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fp2nMzGE3c/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.p49lwtylIB/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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-25 16:41:33,878 truncating revision to first 12 chars 2016-02-25 16:41:33,878 Setting DEBUG logging. 2016-02-25 16:41:33,878 attempt 1/10 2016-02-25 16:41:33,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8a390011304e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 16:41:35,234 unpacking tar archive at: fx-team-8a390011304e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.603548 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 16:41:35.427958) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:35.428735) ========= echo 8a390011304e8adb8abe4880792148f6a3a9bf56 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8a390011304e8adb8abe4880792148f6a3a9bf56'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fp2nMzGE3c/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.p49lwtylIB/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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 8a390011304e8adb8abe4880792148f6a3a9bf56 program finished with exit code 0 elapsedTime=0.005101 script_repo_revision: '8a390011304e8adb8abe4880792148f6a3a9bf56' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:35.485781) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:35.486478) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 16:41:35.502466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-25 16:41:35.503229) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fp2nMzGE3c/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.p49lwtylIB/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:41:35 INFO - MultiFileLogger online at 20160225 16:41:35 in /builds/slave/test 16:41:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:41:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:41:35 INFO - {'append_to_log': False, 16:41:35 INFO - 'base_work_dir': '/builds/slave/test', 16:41:35 INFO - 'blob_upload_branch': 'Fx-Team', 16:41:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:41:35 INFO - 'branch': 'Fx-Team', 16:41:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:41:35 INFO - 'config_files': ('talos/mac_config.py',), 16:41:35 INFO - 'default_actions': ('clobber', 16:41:35 INFO - 'read-buildbot-config', 16:41:35 INFO - 'download-and-extract', 16:41:35 INFO - 'populate-webroot', 16:41:35 INFO - 'create-virtualenv', 16:41:35 INFO - 'install', 16:41:35 INFO - 'run-tests'), 16:41:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:41:35 INFO - 'download_minidump_stackwalk': True, 16:41:35 INFO - 'download_symbols': 'ondemand', 16:41:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:41:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:41:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:41:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:41:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:41:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:41:35 INFO - 'installer_path': 'installer.exe', 16:41:35 INFO - 'log_level': 'info', 16:41:35 INFO - 'log_name': 'talos', 16:41:35 INFO - 'log_to_console': True, 16:41:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:41:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:41:35 INFO - 'opt_config_files': (), 16:41:35 INFO - 'pip_index': False, 16:41:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:41:35 INFO - 'cmd': ('bash', 16:41:35 INFO - '-c', 16:41:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:41:35 INFO - 'enabled': True, 16:41:35 INFO - 'halt_on_failure': False, 16:41:35 INFO - 'name': 'check_screen_resolution'},), 16:41:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:41:35 INFO - 'cmd': ('bash', 16:41:35 INFO - '-c', 16:41:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:41:35 INFO - 'enabled': True, 16:41:35 INFO - 'halt_on_failure': False, 16:41:35 INFO - 'name': 'check_screen_resolution'},), 16:41:35 INFO - 'run_cmd_checks_enabled': True, 16:41:35 INFO - 'sps_profile': False, 16:41:35 INFO - 'sps_profile_interval': 0, 16:41:35 INFO - 'suite': 'dromaeojs-e10s', 16:41:35 INFO - 'system_bits': '32', 16:41:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:41:35 INFO - 'title': 't-yosemite-r7-0005', 16:41:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:41:35 INFO - 'use_talos_json': True, 16:41:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:41:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:41:35 INFO - 'work_dir': 'build'} 16:41:35 INFO - ##### 16:41:35 INFO - ##### Running clobber step. 16:41:35 INFO - ##### 16:41:35 INFO - Running pre-action listener: _resource_record_pre_action 16:41:35 INFO - Running main action method: clobber 16:41:35 INFO - rmtree: /builds/slave/test/build 16:41:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:41:36 INFO - Running post-action listener: _resource_record_post_action 16:41:36 INFO - ##### 16:41:36 INFO - ##### Running read-buildbot-config step. 16:41:36 INFO - ##### 16:41:36 INFO - Running pre-action listener: _resource_record_pre_action 16:41:36 INFO - Running main action method: read_buildbot_config 16:41:36 INFO - Using buildbot properties: 16:41:36 INFO - { 16:41:36 INFO - "project": "", 16:41:36 INFO - "product": "firefox", 16:41:36 INFO - "script_repo_revision": "production", 16:41:36 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:41:36 INFO - "repository": "", 16:41:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:41:36 INFO - "buildid": "20160225145929", 16:41:36 INFO - "pgo_build": "False", 16:41:36 INFO - "basedir": "/builds/slave/test", 16:41:36 INFO - "buildnumber": 519, 16:41:36 INFO - "slavename": "t-yosemite-r7-0005", 16:41:36 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:41:36 INFO - "platform": "yosemite_r7", 16:41:36 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:41:36 INFO - "branch": "fx-team", 16:41:36 INFO - "repo_path": "integration/fx-team", 16:41:36 INFO - "revision": "8a390011304e8adb8abe4880792148f6a3a9bf56", 16:41:36 INFO - "stage_platform": "macosx64", 16:41:36 INFO - "builduid": "720b979622454e2b8832f8d407315633", 16:41:36 INFO - "slavebuilddir": "test" 16:41:36 INFO - } 16:41:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 16:41:36 INFO - Running post-action listener: _resource_record_post_action 16:41:36 INFO - ##### 16:41:36 INFO - ##### Running download-and-extract step. 16:41:36 INFO - ##### 16:41:36 INFO - Running pre-action listener: _resource_record_pre_action 16:41:36 INFO - Running main action method: download_and_extract 16:41:36 INFO - mkdir: /builds/slave/test/build/tests 16:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:36 INFO - https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:41:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/test_packages.json 16:41:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/test_packages.json 16:41:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:41:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:41:38 INFO - Downloaded 1277 bytes. 16:41:38 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:41:38 INFO - Using the following test package requirements: 16:41:38 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:41:38 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:41:38 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 16:41:38 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:41:38 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 16:41:38 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:41:38 INFO - u'jsshell-mac.zip'], 16:41:38 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:41:38 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 16:41:38 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:41:38 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:41:38 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 16:41:38 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:41:38 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 16:41:38 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:41:38 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 16:41:38 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 16:41:38 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 16:41:38 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 16:41:38 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:38 INFO - https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:41:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:41:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:41:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:41:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:41:39 INFO - Downloaded 17830254 bytes. 16:41:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:41:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:41:42 INFO - Return code: 0 16:41:42 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:41:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:42 INFO - https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:41:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:41:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:41:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 16:41:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:41:43 INFO - Downloaded 17830254 bytes. 16:41:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:41:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:41:46 INFO - Return code: 0 16:41:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:46 INFO - https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:41:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:41:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:41:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 16:41:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:41:47 INFO - Downloaded 10713410 bytes. 16:41:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:41:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:41:47 INFO - Return code: 0 16:41:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:47 INFO - https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:41:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:41:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:41:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 16:41:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 16:41:50 INFO - Downloaded 111458813 bytes. 16:41:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:41:50 INFO - mkdir: /builds/slave/test/properties 16:41:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:41:50 INFO - Writing to file /builds/slave/test/properties/build_url 16:41:50 INFO - Contents: 16:41:50 INFO - build_url:https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 16:41:51 INFO - Running post-action listener: _resource_record_post_action 16:41:51 INFO - Running post-action listener: set_extra_try_arguments 16:41:51 INFO - ##### 16:41:51 INFO - ##### Running populate-webroot step. 16:41:51 INFO - ##### 16:41:51 INFO - Running pre-action listener: _resource_record_pre_action 16:41:51 INFO - Running main action method: populate_webroot 16:41:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:41:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:41:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:41:51 INFO - '--tppagecycles', 16:41:51 INFO - '7'], 16:41:51 INFO - 'tests': ['tsvgm']}}, 16:41:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:41:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:41:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:41:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:41:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:41:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:41:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:41:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:51 INFO - 'talos_options': ['--e10s'], 16:41:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:41:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:51 INFO - 'tests': ['damp', 'tps']}, 16:41:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:51 INFO - 'talos_options': ['--e10s'], 16:41:51 INFO - 'tests': ['damp', 'tps']}, 16:41:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:41:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:41:51 INFO - 'other': {'tests': ['a11yr', 16:41:51 INFO - 'ts_paint', 16:41:51 INFO - 'tpaint', 16:41:51 INFO - 'sessionrestore', 16:41:51 INFO - 'sessionrestore_no_auto_restore']}, 16:41:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:41:51 INFO - 'tests': ['a11yr', 16:41:51 INFO - 'ts_paint', 16:41:51 INFO - 'tpaint', 16:41:51 INFO - 'sessionrestore', 16:41:51 INFO - 'sessionrestore_no_auto_restore']}, 16:41:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:41:51 INFO - 'tests': ['a11yr', 16:41:51 INFO - 'ts_paint', 16:41:51 INFO - 'tpaint', 16:41:51 INFO - 'sessionrestore', 16:41:51 INFO - 'sessionrestore_no_auto_restore']}, 16:41:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:41:51 INFO - 'tests': ['a11yr', 16:41:51 INFO - 'ts_paint', 16:41:51 INFO - 'tpaint', 16:41:51 INFO - 'sessionrestore', 16:41:51 INFO - 'sessionrestore_no_auto_restore']}, 16:41:51 INFO - 'other_l64': {'tests': ['a11yr', 16:41:51 INFO - 'ts_paint', 16:41:51 INFO - 'tpaint', 16:41:51 INFO - 'sessionrestore', 16:41:51 INFO - 'sessionrestore_no_auto_restore']}, 16:41:51 INFO - 'other_nol64': {'tests': ['a11yr', 16:41:51 INFO - 'ts_paint', 16:41:51 INFO - 'tpaint', 16:41:51 INFO - 'sessionrestore', 16:41:51 INFO - 'sessionrestore_no_auto_restore']}, 16:41:51 INFO - 'svgr': {'tests': ['tsvgx', 16:41:51 INFO - 'tsvgr_opacity', 16:41:51 INFO - 'tart', 16:41:51 INFO - 'tscrollx', 16:41:51 INFO - 'cart']}, 16:41:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:41:51 INFO - 'tests': ['tsvgx', 16:41:51 INFO - 'tsvgr_opacity', 16:41:51 INFO - 'tart', 16:41:51 INFO - 'tscrollx', 16:41:51 INFO - 'cart']}, 16:41:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:51 INFO - 'tests': ['tp5o']}, 16:41:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:51 INFO - 'talos_options': ['--e10s'], 16:41:51 INFO - 'tests': ['tp5o']}, 16:41:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:51 INFO - 'talos_options': ['--xperf_path', 16:41:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:41:51 INFO - 'tests': ['tp5n']}, 16:41:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:41:51 INFO - 'talos_options': ['--e10s', 16:41:51 INFO - '--xperf_path', 16:41:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:41:51 INFO - 'tests': ['tp5n']}}, 16:41:51 INFO - 'talos.zip': {'path': '', 16:41:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:41:51 INFO - Running post-action listener: _resource_record_post_action 16:41:51 INFO - ##### 16:41:51 INFO - ##### Running create-virtualenv step. 16:41:51 INFO - ##### 16:41:51 INFO - Running pre-action listener: _resource_record_pre_action 16:41:51 INFO - Running main action method: create_virtualenv 16:41:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:41:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:41:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:41:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:41:51 INFO - Using real prefix '/tools/python27' 16:41:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:41:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:41:55 INFO - Installing pip.................done. 16:41:55 INFO - Return code: 0 16:41:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:41: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')]} 16:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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')]} 16:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101a95a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa42256a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101939d30>, '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 0x10175ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101930b20>, '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.fp2nMzGE3c/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.p49lwtylIB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:41: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', 'pip>=1.5'] in /builds/slave/test/build 16:41: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 pip>=1.5 16:41:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp2nMzGE3c/Render', 16:41:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:41:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:41:55 INFO - 'HOME': '/Users/cltbld', 16:41:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:41:55 INFO - 'LOGNAME': 'cltbld', 16:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:55 INFO - 'MOZ_NO_REMOTE': '1', 16:41:55 INFO - 'NO_EM_RESTART': '1', 16:41:55 INFO - 'PAGER': '/bin/cat', 16:41:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:55 INFO - 'PWD': '/builds/slave/test', 16:41:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:41:55 INFO - 'SHELL': '/bin/bash', 16:41:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p49lwtylIB/Listeners', 16:41:55 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 16:41:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:41:55 INFO - 'USER': 'cltbld', 16:41:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:41:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:55 INFO - 'XPC_FLAGS': '0x0', 16:41:55 INFO - 'XPC_SERVICE_NAME': '0', 16:41:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:41:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:41:55 INFO - Cleaning up... 16:41:55 INFO - Return code: 0 16:41:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:41: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')]} 16:41:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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')]} 16:41:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41: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', '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 0x101a95a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa42256a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101939d30>, '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 0x10175ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101930b20>, '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.fp2nMzGE3c/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.p49lwtylIB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:41: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', 'psutil>=0.7.1'] in /builds/slave/test/build 16:41: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 psutil>=0.7.1 16:41:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp2nMzGE3c/Render', 16:41:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:41:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:41:55 INFO - 'HOME': '/Users/cltbld', 16:41:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:41:55 INFO - 'LOGNAME': 'cltbld', 16:41:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:55 INFO - 'MOZ_NO_REMOTE': '1', 16:41:55 INFO - 'NO_EM_RESTART': '1', 16:41:55 INFO - 'PAGER': '/bin/cat', 16:41:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:41:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:55 INFO - 'PWD': '/builds/slave/test', 16:41:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:41:55 INFO - 'SHELL': '/bin/bash', 16:41:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p49lwtylIB/Listeners', 16:41:55 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 16:41:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:41:55 INFO - 'USER': 'cltbld', 16:41:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:41:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:41:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:55 INFO - 'XPC_FLAGS': '0x0', 16:41:55 INFO - 'XPC_SERVICE_NAME': '0', 16:41:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:56 INFO - Downloading/unpacking psutil>=0.7.1 16:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:41:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:41:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:41:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:41:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:41:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:41:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:41:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:41:58 INFO - Installing collected packages: psutil 16:41:58 INFO - Running setup.py install for psutil 16:41:58 INFO - building 'psutil._psutil_osx' extension 16:41:58 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:41:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:41:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:41:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:41:59 INFO - building 'psutil._psutil_posix' extension 16:41:59 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:41:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:41:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:41:59 INFO - ^ 16:41:59 INFO - 1 warning generated. 16:41:59 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:41:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:41:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:41:59 INFO - Successfully installed psutil 16:41:59 INFO - Cleaning up... 16:41:59 INFO - Return code: 0 16:41:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:41:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:41:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:41:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101a95a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa42256a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101939d30>, '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 0x10175ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101930b20>, '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.fp2nMzGE3c/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.p49lwtylIB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:41:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:41:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:41:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp2nMzGE3c/Render', 16:41:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:41:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:41:59 INFO - 'HOME': '/Users/cltbld', 16:41:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:41:59 INFO - 'LOGNAME': 'cltbld', 16:41:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:41:59 INFO - 'MOZ_NO_REMOTE': '1', 16:41:59 INFO - 'NO_EM_RESTART': '1', 16:41:59 INFO - 'PAGER': '/bin/cat', 16:41:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:41:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:41:59 INFO - 'PWD': '/builds/slave/test', 16:41:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:41:59 INFO - 'SHELL': '/bin/bash', 16:41:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p49lwtylIB/Listeners', 16:41:59 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 16:41:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:41:59 INFO - 'USER': 'cltbld', 16:41:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:41:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:41:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:41:59 INFO - 'XPC_FLAGS': '0x0', 16:41:59 INFO - 'XPC_SERVICE_NAME': '0', 16:41:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:41:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:41:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:41:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:41:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:41:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:41:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:42:02 INFO - Installing collected packages: mozsystemmonitor 16:42:02 INFO - Running setup.py install for mozsystemmonitor 16:42:02 INFO - Successfully installed mozsystemmonitor 16:42:02 INFO - Cleaning up... 16:42:02 INFO - Return code: 0 16:42:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101a95a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa42256a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101939d30>, '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 0x10175ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101930b20>, '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.fp2nMzGE3c/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.p49lwtylIB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:42:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:42:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp2nMzGE3c/Render', 16:42:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:02 INFO - 'HOME': '/Users/cltbld', 16:42:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:02 INFO - 'LOGNAME': 'cltbld', 16:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:02 INFO - 'MOZ_NO_REMOTE': '1', 16:42:02 INFO - 'NO_EM_RESTART': '1', 16:42:02 INFO - 'PAGER': '/bin/cat', 16:42:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:02 INFO - 'PWD': '/builds/slave/test', 16:42:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:02 INFO - 'SHELL': '/bin/bash', 16:42:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p49lwtylIB/Listeners', 16:42:02 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 16:42:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:02 INFO - 'USER': 'cltbld', 16:42:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:02 INFO - 'XPC_FLAGS': '0x0', 16:42:02 INFO - 'XPC_SERVICE_NAME': '0', 16:42:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:02 INFO - Downloading/unpacking blobuploader==1.2.4 16:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:05 INFO - Downloading blobuploader-1.2.4.tar.gz 16:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:42:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:42:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:06 INFO - Downloading docopt-0.6.1.tar.gz 16:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:42:06 INFO - Installing collected packages: blobuploader, requests, docopt 16:42:06 INFO - Running setup.py install for blobuploader 16:42:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:42:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:42:06 INFO - Running setup.py install for requests 16:42:07 INFO - Running setup.py install for docopt 16:42:07 INFO - Successfully installed blobuploader requests docopt 16:42:07 INFO - Cleaning up... 16:42:07 INFO - Return code: 0 16:42:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:07 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 0x101a95a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa42256a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101939d30>, '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 0x10175ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101930b20>, '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.fp2nMzGE3c/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.p49lwtylIB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:42:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:42:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:42:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp2nMzGE3c/Render', 16:42:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:07 INFO - 'HOME': '/Users/cltbld', 16:42:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:07 INFO - 'LOGNAME': 'cltbld', 16:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:07 INFO - 'MOZ_NO_REMOTE': '1', 16:42:07 INFO - 'NO_EM_RESTART': '1', 16:42:07 INFO - 'PAGER': '/bin/cat', 16:42:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:07 INFO - 'PWD': '/builds/slave/test', 16:42:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:07 INFO - 'SHELL': '/bin/bash', 16:42:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p49lwtylIB/Listeners', 16:42:07 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 16:42:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:07 INFO - 'USER': 'cltbld', 16:42:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:07 INFO - 'XPC_FLAGS': '0x0', 16:42:07 INFO - 'XPC_SERVICE_NAME': '0', 16:42:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:42:07 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-sPYVJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:42:07 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-PP0yp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:42:07 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-bEee7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:42:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:42:07 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-T5QmNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:42:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-RYjrCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:42:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-MDvTpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:42:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-sVmWZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:42:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-7cnxsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:42:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-ylWShh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:42:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-D_eEFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:42:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-yDUqqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:42:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-Xn7UeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:42:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-38w8D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:42:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:42:08 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-K1TEJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-aWZc8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:42:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-TQ4DtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:42:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:42:09 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-0vvel_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:42:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:42:09 INFO - Running setup.py install for manifestparser 16:42:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:42:09 INFO - Running setup.py install for mozcrash 16:42:09 INFO - Running setup.py install for mozdebug 16:42:09 INFO - Running setup.py install for mozdevice 16:42:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:42:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:42:09 INFO - Running setup.py install for mozfile 16:42:10 INFO - Running setup.py install for mozhttpd 16:42:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:42:10 INFO - Running setup.py install for mozinfo 16:42:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:42:10 INFO - Running setup.py install for mozInstall 16:42:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:42:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:42:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:42:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:42:10 INFO - Running setup.py install for mozleak 16:42:10 INFO - Running setup.py install for mozlog 16:42:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:42:10 INFO - Running setup.py install for moznetwork 16:42:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:42:10 INFO - Running setup.py install for mozprocess 16:42:11 INFO - Running setup.py install for mozprofile 16:42:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:42:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:42:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:42:11 INFO - Running setup.py install for mozrunner 16:42:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:42:11 INFO - Running setup.py install for mozscreenshot 16:42:11 INFO - Running setup.py install for moztest 16:42:11 INFO - Running setup.py install for mozversion 16:42:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:42:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:42:11 INFO - Cleaning up... 16:42:11 INFO - Return code: 0 16:42:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:11 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 0x101a95a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa42256a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101939d30>, '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 0x10175ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101930b20>, '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.fp2nMzGE3c/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.p49lwtylIB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:42:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:42:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp2nMzGE3c/Render', 16:42:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:11 INFO - 'HOME': '/Users/cltbld', 16:42:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:11 INFO - 'LOGNAME': 'cltbld', 16:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:11 INFO - 'MOZ_NO_REMOTE': '1', 16:42:11 INFO - 'NO_EM_RESTART': '1', 16:42:11 INFO - 'PAGER': '/bin/cat', 16:42:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:11 INFO - 'PWD': '/builds/slave/test', 16:42:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:11 INFO - 'SHELL': '/bin/bash', 16:42:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p49lwtylIB/Listeners', 16:42:11 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 16:42:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:11 INFO - 'USER': 'cltbld', 16:42:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:11 INFO - 'XPC_FLAGS': '0x0', 16:42:11 INFO - 'XPC_SERVICE_NAME': '0', 16:42:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:42:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-58gue5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:42:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-E7tGW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:42:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-1DkA6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:42:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-PrYhgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:42:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-R8GTlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:42:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-MHod3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:42:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-2GfVv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:42:12 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-lguPfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:42:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-W07rLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:42:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-NTM4CP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:42:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-GhvZb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:42:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-8nDE4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:42:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-KaD9vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:42:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-0T2qa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-83bQs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:42:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-sutqGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:42:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:42:13 INFO - Running setup.py (path:/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/pip-pVBwZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:42:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:16 INFO - Downloading blessings-1.6.tar.gz 16:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:42:16 INFO - Installing collected packages: blessings 16:42:16 INFO - Running setup.py install for blessings 16:42:16 INFO - Successfully installed blessings 16:42:16 INFO - Cleaning up... 16:42:16 INFO - Return code: 0 16:42:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:42:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:42:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:42:17 INFO - Reading from file tmpfile_stdout 16:42:17 INFO - Current package versions: 16:42:17 INFO - blessings == 1.6 16:42:17 INFO - blobuploader == 1.2.4 16:42:17 INFO - docopt == 0.6.1 16:42:17 INFO - manifestparser == 1.1 16:42:17 INFO - mozInstall == 1.12 16:42:17 INFO - mozcrash == 0.16 16:42:17 INFO - mozdebug == 0.1 16:42:17 INFO - mozdevice == 0.48 16:42:17 INFO - mozfile == 1.2 16:42:17 INFO - mozhttpd == 0.7 16:42:17 INFO - mozinfo == 0.9 16:42:17 INFO - mozleak == 0.1 16:42:17 INFO - mozlog == 3.1 16:42:17 INFO - moznetwork == 0.27 16:42:17 INFO - mozprocess == 0.22 16:42:17 INFO - mozprofile == 0.28 16:42:17 INFO - mozrunner == 6.11 16:42:17 INFO - mozscreenshot == 0.1 16:42:17 INFO - mozsystemmonitor == 0.0 16:42:17 INFO - moztest == 0.7 16:42:17 INFO - mozversion == 1.4 16:42:17 INFO - psutil == 3.1.1 16:42:17 INFO - requests == 1.2.3 16:42:17 INFO - wsgiref == 0.1.2 16:42:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:17 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 0x101a95a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa42256a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101939d30>, '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 0x10175ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101930b20>, '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.fp2nMzGE3c/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.p49lwtylIB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:42:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp2nMzGE3c/Render', 16:42:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:17 INFO - 'HOME': '/Users/cltbld', 16:42:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:17 INFO - 'LOGNAME': 'cltbld', 16:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:17 INFO - 'MOZ_NO_REMOTE': '1', 16:42:17 INFO - 'NO_EM_RESTART': '1', 16:42:17 INFO - 'PAGER': '/bin/cat', 16:42:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:17 INFO - 'PWD': '/builds/slave/test', 16:42:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:17 INFO - 'SHELL': '/bin/bash', 16:42:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p49lwtylIB/Listeners', 16:42:17 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 16:42:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:17 INFO - 'USER': 'cltbld', 16:42:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:17 INFO - 'XPC_FLAGS': '0x0', 16:42:17 INFO - 'XPC_SERVICE_NAME': '0', 16:42:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:42:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:42:17 INFO - Cleaning up... 16:42:17 INFO - Return code: 0 16:42:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:17 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 0x101a95a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa42256a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101939d30>, '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 0x10175ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101930b20>, '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.fp2nMzGE3c/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.p49lwtylIB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:42:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp2nMzGE3c/Render', 16:42:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:17 INFO - 'HOME': '/Users/cltbld', 16:42:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:17 INFO - 'LOGNAME': 'cltbld', 16:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:17 INFO - 'MOZ_NO_REMOTE': '1', 16:42:17 INFO - 'NO_EM_RESTART': '1', 16:42:17 INFO - 'PAGER': '/bin/cat', 16:42:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:17 INFO - 'PWD': '/builds/slave/test', 16:42:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:17 INFO - 'SHELL': '/bin/bash', 16:42:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p49lwtylIB/Listeners', 16:42:17 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 16:42:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:17 INFO - 'USER': 'cltbld', 16:42:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:17 INFO - 'XPC_FLAGS': '0x0', 16:42:17 INFO - 'XPC_SERVICE_NAME': '0', 16:42:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:17 INFO - Downloading/unpacking jsonschema 16:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:42:19 INFO - Downloading/unpacking functools32 (from jsonschema) 16:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:20 INFO - Downloading functools32-3.2.3-2.tar.gz 16:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:42:20 INFO - warning: no files found matching '*.txt' 16:42:20 INFO - no previously-included directories found matching 'build' 16:42:20 INFO - no previously-included directories found matching 'dist' 16:42:20 INFO - no previously-included directories found matching '.git*' 16:42:20 INFO - Installing collected packages: jsonschema, functools32 16:42:20 INFO - Running setup.py install for functools32 16:42:20 INFO - warning: no files found matching '*.txt' 16:42:20 INFO - no previously-included directories found matching 'build' 16:42:20 INFO - no previously-included directories found matching 'dist' 16:42:20 INFO - no previously-included directories found matching '.git*' 16:42:20 INFO - Successfully installed jsonschema functools32 16:42:20 INFO - Cleaning up... 16:42:20 INFO - Return code: 0 16:42:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:20 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 0x101a95a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a9c4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa42256a360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101939d30>, '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 0x10175ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101930b20>, '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.fp2nMzGE3c/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.p49lwtylIB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:42:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:42:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:42:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp2nMzGE3c/Render', 16:42:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:20 INFO - 'HOME': '/Users/cltbld', 16:42:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:20 INFO - 'LOGNAME': 'cltbld', 16:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:20 INFO - 'MOZ_NO_REMOTE': '1', 16:42:20 INFO - 'NO_EM_RESTART': '1', 16:42:20 INFO - 'PAGER': '/bin/cat', 16:42:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:20 INFO - 'PWD': '/builds/slave/test', 16:42:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:20 INFO - 'SHELL': '/bin/bash', 16:42:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p49lwtylIB/Listeners', 16:42:20 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 16:42:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:20 INFO - 'USER': 'cltbld', 16:42:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:20 INFO - 'XPC_FLAGS': '0x0', 16:42:20 INFO - 'XPC_SERVICE_NAME': '0', 16:42:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:21 INFO - Downloading/unpacking flake8 16:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:42:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:42:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:42:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:42:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:42:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:42:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:42:24 INFO - no previously-included directories found matching 'docs/_build' 16:42:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:42:24 INFO - Running setup.py install for pep8 16:42:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:42:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:42:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:42:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:42:24 INFO - no previously-included directories found matching 'docs/_build' 16:42:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:42:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:42:24 INFO - Cleaning up... 16:42:24 INFO - Return code: 0 16:42:24 INFO - Running post-action listener: _resource_record_post_action 16:42:24 INFO - Running post-action listener: _start_resource_monitoring 16:42:24 INFO - Starting resource monitoring. 16:42:24 INFO - ##### 16:42:24 INFO - ##### Running install step. 16:42:24 INFO - ##### 16:42:24 INFO - Running pre-action listener: _resource_record_pre_action 16:42:24 INFO - Running main action method: install 16:42:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:42:25 INFO - Reading from file tmpfile_stdout 16:42:25 INFO - Detecting whether we're running mozinstall >=1.0... 16:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:42:25 INFO - Reading from file tmpfile_stdout 16:42:25 INFO - Output received: 16:42:25 INFO - Usage: mozinstall [options] installer 16:42:25 INFO - Options: 16:42:25 INFO - -h, --help show this help message and exit 16:42:25 INFO - -d DEST, --destination=DEST 16:42:25 INFO - Directory to install application into. [default: 16:42:25 INFO - "/builds/slave/test"] 16:42:25 INFO - --app=APP Application being installed. [default: firefox] 16:42:25 INFO - mkdir: /builds/slave/test/build/application 16:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:42:59 INFO - Reading from file tmpfile_stdout 16:42:59 INFO - Output received: 16:42:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:42:59 INFO - Running post-action listener: _resource_record_post_action 16:42:59 INFO - ##### 16:42:59 INFO - ##### Running run-tests step. 16:42:59 INFO - ##### 16:42:59 INFO - Running pre-action listener: _resource_record_pre_action 16:42:59 INFO - Running main action method: run_tests 16:42:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:42:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:42:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:42:59 INFO - 2016-02-25 16:42:59.946 screenresolution[1976:12579] starting screenresolution argv=screenresolution get 16:42:59 INFO - 2016-02-25 16:42:59.948 screenresolution[1976:12579] Display 0: 1600x1200x32@60 16:42:59 INFO - 2016-02-25 16:42:59.953 screenresolution[1977:12581] starting screenresolution argv=screenresolution list 16:42:59 INFO - Available Modes on Display 0 16:42:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:42:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:42:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:42:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:43:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:43:00 INFO - Intel Iris: 16:43:00 INFO - Chipset Model: Intel Iris 16:43:00 INFO - Type: GPU 16:43:00 INFO - Bus: Built-In 16:43:00 INFO - VRAM (Dynamic, Max): 1536 MB 16:43:00 INFO - Vendor: Intel (0x8086) 16:43:00 INFO - Device ID: 0x0a2e 16:43:00 INFO - Revision ID: 0x0009 16:43:00 INFO - Displays: 16:43:00 INFO - Display: 16:43:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:43:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:43:00 INFO - Display Serial Number: 1600x1200 60 16:43:00 INFO - Main Display: Yes 16:43:00 INFO - Mirror: Off 16:43:00 INFO - Online: Yes 16:43:00 INFO - Rotation: Supported 16:43:00 INFO - Return code: 0 16:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:43:00 INFO - Python 2.7.3 16:43:00 INFO - Return code: 0 16:43:00 INFO - grabbing minidump binary from tooltool 16:43: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')]} 16:43:00 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 0x101939d30>, '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 0x10175ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101930b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:43:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:43:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:43:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:43:00 INFO - Return code: 0 16:43:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:43:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:43:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:43:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:43:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:43:01 INFO - Return code: 0 16:43:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:43:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:43:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fp2nMzGE3c/Render', 16:43:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:01 INFO - 'HOME': '/Users/cltbld', 16:43:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:01 INFO - 'LOGNAME': 'cltbld', 16:43:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:43:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:01 INFO - 'MOZ_NO_REMOTE': '1', 16:43:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:43:01 INFO - 'NO_EM_RESTART': '1', 16:43:01 INFO - 'PAGER': '/bin/cat', 16:43:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:01 INFO - 'PWD': '/builds/slave/test', 16:43:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:43:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:01 INFO - 'SHELL': '/bin/bash', 16:43:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p49lwtylIB/Listeners', 16:43:01 INFO - 'TMPDIR': '/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/', 16:43:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:01 INFO - 'USER': 'cltbld', 16:43:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:01 INFO - 'XPC_FLAGS': '0x0', 16:43:01 INFO - 'XPC_SERVICE_NAME': '0', 16:43:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:43:01 INFO - mozversion application_buildid: 20160225145929 16:43:01 INFO - mozversion application_changeset: 8a390011304e8adb8abe4880792148f6a3a9bf56 16:43:01 INFO - mozversion application_display_name: Nightly 16:43:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:43:01 INFO - mozversion application_name: Firefox 16:43:01 INFO - mozversion application_remotingname: firefox 16:43:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:43:01 INFO - mozversion application_vendor: Mozilla 16:43:01 INFO - mozversion application_version: 47.0a1 16:43:01 INFO - mozversion platform_buildid: 20160225145929 16:43:01 INFO - mozversion platform_changeset: 8a390011304e8adb8abe4880792148f6a3a9bf56 16:43:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:43:01 INFO - mozversion platform_version: 47.0a1 16:43:01 INFO - using testdate: 1456447381 16:43:01 INFO - actual date: 1456447381 16:43:02 INFO - starting webserver on 'localhost:49529' 16:43:02 INFO - SUITE-START | Running 2 tests 16:43:02 INFO - TEST-START | dromaeo_css 16:43:02 INFO - operating with platform_type : mac_ 16:43:02 INFO - Initialising browser for dromaeo_css test... 16:43:02 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpK9RzFt/profile http://localhost:49529/getInfo.html) 16:43:04 INFO - PROCESS | 1995 | __metrics Screen width/height:1600/1200 16:43:04 INFO - PROCESS | 1995 | colorDepth:24 16:43:04 INFO - PROCESS | 1995 | Browser inner width/height: 1024/689 16:43:04 INFO - PROCESS | 1995 | __metrics 16:43:05 ERROR - PROCESS | 1995 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:43:05 INFO - TEST-INFO | 1995: exit 0 16:43:05 INFO - Browser initialized. 16:43:05 INFO - Running cycle 1/1 for dromaeo_css test... 16:43:05 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmpK9RzFt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:18 INFO - PROCESS | 1999 | RSS: Main: 257282048 16:43:18 INFO - PROCESS | 1999 | 16:44:07 INFO - PROCESS | 1999 | 1456447447680 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:46:16 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49529/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49529/tests/dromaeo/cssquery-ext.html) 16:46:17 INFO - PROCESS | 1999 | RSS: Main: 268890112 16:46:17 INFO - PROCESS | 1999 | 16:49:20 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49529/tests/dromaeo/cssquery-ext.html (next: http://localhost:49529/tests/dromaeo/cssquery-jquery.html) 16:49:20 INFO - PROCESS | 1999 | RSS: Main: 280162304 16:49:20 INFO - PROCESS | 1999 | 16:52:22 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49529/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49529/tests/dromaeo/cssquery-mootools.html) 16:52:22 INFO - PROCESS | 1999 | RSS: Main: 281903104 16:52:22 INFO - PROCESS | 1999 | 16:55:24 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49529/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49529/tests/dromaeo/cssquery-prototype.html) 16:55:25 INFO - PROCESS | 1999 | RSS: Main: 283820032 16:55:25 INFO - PROCESS | 1999 | 16:58:27 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49529/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49529/tests/dromaeo/cssquery-yui.html) 16:58:28 INFO - PROCESS | 1999 | RSS: Main: 285782016 16:58:28 INFO - PROCESS | 1999 | 17:01:30 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49529/tests/dromaeo/cssquery-yui.html (next: http://localhost:49529/tests/dromaeo/cssquery-dojo.html) 17:01:31 INFO - PROCESS | 1999 | RSS: Main: 288153600 17:01:31 INFO - PROCESS | 1999 | 17:01:31 INFO - PROCESS | 1999 | __start_tp_report 17:01:31 INFO - PROCESS | 1999 | _x_x_mozilla_page_load 17:01:31 INFO - PROCESS | 1999 | _x_x_mozilla_page_load_details 17:01:31 INFO - PROCESS | 1999 | |i|pagename|runs| 17:01:31 INFO - PROCESS | 1999 | |0;dojo.html;2883.567464880268;2913.4027524357507;2923.766098712103;3470.7049900758434;3520.119970007498;5489.149181876811;5607.57943154263;5644.125160600103;5652.830415087544;5670.886582268352;4829.951700482994;5400.892816972521;5505.476979686933;5628.155776633507;5792.971035144818;5098.949010509894;5117.104506711311;5164.741762911858;5185.507376799198;5261.736913154346;417.35288557883916;5091.032703786269;5140.845774626767;5158.767855446514;5195.740212989354;5110.28456016158;5117.923231151536;5118.897622047538;5144.536991670749;5151.304573882534;5004.724740139291;5147.459516750762;5155.200943853709;5172.353455818023;5174.637775355726;4084.979575102135;5048.62135339851;5062.54437100659;5121.257417674454;5125.4618265082;5383.596230282745;5395.622306438511;5524.033294173544;5548;5570.2480165177585;6079.6048256863605;6141.631502109888;6181.876362472771;6185.8144255672405;6199.101130336076;6156.261248650146;6196.659183744892;6230.470410015154;6239.126522286883;6243.968780156116;5687.118496633028;5695.003374409462;5700.885982280372;5701.087825947829;5758.856028599276;6170.969145154335;6181.81454556355;6203.96898015507;6239.282482514478;6241.344658810759;6090.908636370458;6091.269047714302;6095.573309868267;6113.755449782047;6123.96938015316;6177.073438984188;6193.043987280555;6219.222597175353;6221.440070393686;6253.280872699606;6044.637321760709;6125.295591007091;6132.141360525156;6181.320054793969;6234.189555357774;6072.149899014142;6117.143599896018;6208.4722798562625;6226.346233645492;6239.06414037898;4816.662833601685;4837.879053023703;4863.635227357962;4866.124097662384;4883.755812209375;3615.367310720613;3693.778373297611;4292.48490181174;4299.462567179103;4405.867823965286;5516.393196748354;5603.607747457639;5698.202251684767;5782.508486778671;5794.797182098607;6240.594361366497;6244.687765611701;6245.344238854855;6250.843728906813;6259.906101408483;5616.297962754656;5723.713814309352;5786.479216870418;5795.333536643256;5796;5285.603579731535;5289.994900968803;5294.2852714883;5310.6813591184655;5317.441668624739;6172.753089876354;6248.875022499616;6250.218722659668;6254;6280.246370435577;6138.051223665275;6180.876382472416;6241.843953901189;6247.843803904757;6269.279032911274;6220;6242.812715618538;6250.749970001331;6254.6247225166635;6256.31180570146;4722.740249286322;5295.547601011983;5912.881742365214;6107.267127944675;6136.417040381157;5021.974890125526;6186.010238362021;6196.070589411444;6202.379762023762;6204.348543403058;4952.2819191217795;6028.246469191351;6029.649434346228;6066.7269972850445;6131.84670383244;4701.341812146234;5632.183333416713;5988.191594134736;5991.670458124845;6027.156198132353;5710.914336284876;5761.308642962871;5780;5919.4080591940465;5938.703064846654;5846.56150788684;6069.241344831896;6069.878602427839;6085.4523092921845;6127.632342059491;5778.537716982547;5791.623544469596;5841.853953651193;5880.882382352243;5891.086881533369 17:01:31 INFO - PROCESS | 1999 | |1;ext.html;442.96234820040297;460.8571342883706;488.05804796742285;502.46989426155415;589.1163255117324;29770;37067.77593344401;37092.443613345786;37098.62901370989;37158.885233442976;37523;37539.870614232415;37761.81119094408;37995.810020949924;38300.808495957484;9219.262459003297;9386.249100072013;9387.671431499899;9438.716838494822;9475.431474111541;9314.86027709585;9496.620135194584;9554.761130971712;9563.665271715492;9565.95217023914;9449.95275023624;9514.90485095147;9573.04269573044;9578.664746733866;9622.80754384912;8107.22981316774;9475.526223688823;9483.525823708856;9578.712638620782;9579.281553883417;9350.812983740287;9487.857682134774;9490.525473726355;9508.239340852715;9537.570809313598;37717.43423848644;37937.81031094827;38008.42987355192;38191.618083819085;38202.23595528074;2830.9292267693268;3088.9382212355627;3221.5811944447305;3327.8835240766457;3391.7286617070577;26731;27199.320016999536;27278.5908211377;27362;27944;2769;2774.694783573805;2781.3324802047564;2842.9857850710614;2875.2093174377005;344207;344257.9999999975;345369;345483;348099;44688.776556117664;59350;59600.403995960354;59673.40326596679;59746.70126649426;38462.038449039;42026.94932626709;42597.36103958443;43702.68891933247;44067.77966110149;15194.088354698753;15413.229338533029;15590.9220453897;15613.453529126426;15630.687386252212;12085.154039217347;12146;12556;12575;12663.353764010804;14213.076150050214;14353.425862965572;14353.497627582985;14644.853551464563;14810.594133141325;5856.648601083949;6287.434130928238;6337.7781777637565;6366.872662546723;6393.936060639334;745.5340412242349;832.8917240758784;984.4241118945497;1051;1132.943352832355;25016.874915625307;28991.855040724662;29374.412511749644;29407.558886616716;29957.700422995928;1000.314784372707;1056.1286938275953;1094.8686157661132;1095.309954728516;1133.0878642692546;12182.878171218352;14511.85488145105;14625.707485850224;14746.926265368604;14908.850911490963;460053;528361;533583;534580;536728;55551.72224138853;56530.869382612116;57271.42728572744;57352.713236434385;57523.71238143783;1207.0223119273417;1341.336038660869;1383.481194552043;1391.1166409330149;1418.8155539779762;23211.651825222973;29042.564361535016;29251.976180833568;29293.560596591495;29631.258998560126;41731.7913410431;49204.75397622989;49679.75160124176;51089;51343;482531;494293;494383.5280823573;495479;495936;32431.35137297288;32462.83768581142;33063.33873322472;33549.329013419105;33678.66321336755;45341.77329113333;46151.07697845957;46857.765711171225;46932.7653361731;47134.76432617815;34687.959361219204;36100.81949590235;36790.26419471649;37063.6293637071;37553.62446375501;29170.708292917647;35840.82079589585;36399.362028708245;36798.264034719694;36880.81559592292;25034.499310014064;36301.818490907375;36615.816920915226;36951;37000.62999370079;32840.178995524344;34950.65049349474;35045.82477087598;35067.040075343444;35330.64669353273;24608.876955615106;24674;24704;25073.498530028934;25129.623055654545 17:01:31 INFO - PROCESS | 1999 | |2;jquery.html;307.6907707753707;350.94735789631534;354.51962590689607;357.83718408124304;367.06032556654947;19304.806951930477;19340.419787406383;21011.57976840464;21017.789822101775;21065.578688426223;19593.314234001813;20464.89767551164;20676.68984965223;20721.79278207221;20826.687599686018;5619.185218143367;5913;5951.166836642873;5955.85110372242;5961.672108034057;4166.354215096665;5740.856478588048;6141.600795948271;6422.871542569146;6438.452731517827;6335.3981371769605;6348.143000694917;6348.650824204667;6369.936300637004;6371.076193951874;5369.301990741218;5416.729163541807;6091.695415229221;6360.077788720633;6373.936260637381;4924.901501969976;5033.320501732256;5303.655262407931;5458.754356053987;5485.835424937259;19170.520736981547;20260;23892.641610375857;24726.381840453952;25569.48861022769;2267.943301417461;2429.477662302596;2678.236702539786;2688.852113133777;2863.7136286371406;11833.704157396049;14390.856091439056;14393;14652.340644670909;14657.047291926097;1532.9770053449208;1748.0822568151696;1754.1141723429714;1757.885737427063;1769.1066011664157;102106;104159.47920260426;104202.47898760458;104748.47625761823;105489.99999999923;9177.66923796046;10891.237613367146;10905.073068789083;11030.50362733679;11232.213745037769;13151.408186631625;13263.204207747565;13399.933000334935;13408.664783380298;13445.193288402532;8432.409731318872;8453;8487.151284871463;8570;8582.914170858336;8569.314454843598;8613.440126391764;8682.43564168327;8791.692290769792;8896.377253592187;3700.3709369407266;4366.8034938427845;4443.311286750559;4452.065066336106;4454.22051141049;1755.2276998120785;1823.7446757453968;1846.4737549798242;1874.0723341945825;1903.5812121333286;883.4081165619051;906.6146887572755;906.6735975048977;1031.3601373815668;1038.3043360948184;19705.901470492558;20315.59368812645;20550.58898822015;20616.175352986014;20685.069171887;914.9405288656216;943.9386439881386;946.1626460582435;955.8518429643277;999.2755252441922;9553.949065602917;9632.807343853083;10658.147348212124;10993.61522346714;11061.059809916087;589585;602416;606094;606289;612311;122678.38660806639;124031;125513;126815;127309;994.7363948553639;1015.21320976244;1029.3720830293514;1035.135661722455;1041.7551875309296;17424.651506970044;18062;18153.636927261647;18156.546086347946;18433.262669493608;52733.7363313181;53617;53683.92632147413;54302.185467217234;56121.71939140278;55675;78924;79016;81927.5903620478;83862.16137838544;7991.200879911962;8072;8098.635561399633;8208.671653133808;8248.46384984974;8091.959540202261;12406.751864962469;13524.053316267768;13637.386317615532;13816.516421925184;10147.492625368553;11581.420928953687;11612.12909031809;11788.469518871843;11822;10291.691249262534;11374.601888933848;11633.767324653629;11787;11830;11555.01782348476;11851.585194518495;12061.336626485627;12099.697507562381;12102.394880255775;7972.521648701097;8046.758597242092;8133.75598732039;8203.097659257597;8240.50556966584;8492.617832197442;9758.658446954323;10672.8932710675;11661.708457288296;11906.404679765803 17:01:31 INFO - PROCESS | 1999 | |3;mootools.html;1378.6691194113412;1410.9770416448077;1578.8973716708413;1884.1615481110912;1904.4286713985819;7786.688532458709;8479.95760021199;8617.956910215447;8799.868001979976;8830.60262288197;7676.4242681798805;8629.611667474963;8630.4390214636;8725.301975841934;8729.781755456117;2441.414060625455;2448.4246202142526;2458.5943319352286;2462.064415522108;2462.076721229539;2417.5977932798933;2461.9876900615473;2469.086438017927;2481.305234534333;2488;2117.735283089614;2437.9029436753444;2449.8407603505802;2466.728659847415;2479.764422379871;2433.7322894481595;2437.4759426723163;2466.4080620651002;2468.1978357034036;2472.8763561821925;2446.8409553378974;2447.486027934136;2455.607102863551;2461.9507609847883;2462.532118897404;8733.737987860375;8740.344474164463;8790.252828509585;8807;8826.117388261187;5336.226247194135;5413.296271484682;5451.836444906659;5461.42655021225;5487.6981766002855;3563.5901871284614;3662.597114317423;3667.9266414671824;3677.669009789132;3684.5578530576236;1046.1682962045193;1060.7613287010438;1067.2902519824308;1072.426251955208;1073.1575713065206;11580.88419115815;11720.296782193096;11734.94132529349;11745;11753.177277590572;4800.711957282574;4803.927941080887;4896.192128298862;4903.509649035139;4917.704937703749;8499;10072.496375181358;10075.949620251851;10080.747981300527;10093.69718908434;5376.4085950545405;5376.838694839161;5378.596605254622;5465.9726701366235;5503.477169668875;4404.361367601679;4827.058723548945;4921.557059864629;4928.802847886044;4982.576480999156;3831.080540670275;3865.1496670732395;3906.609339066071;3948.1511475033008;3950.4074388841905;1060.692399204222;1177.9057675385948;1185.7035741064733;1296.2740865115566;1300.811382349554;1085.777415629794;1086.4893500054961;1116.2911551165068;1258.5469231076804;1370.0615078671142;7028.437724981989;8042.195780422028;8125.268725814705;8212.548309843016;8243.381746368927;509.3149713635155;517.5393899429511;521.1843464977298;523.0010679601942;523.6125267302169;6181.320054793969;6187.504999600022;6194.876102477925;6196.287426945869;6214.502839772807;8810.427322224035;10243.7439064024;10407.21945854064;10448.634297799541;10491.842622360671;10117.39295642249;10215.23385746072;10239.795204096024;10295.74260643475;10311.22665800068;8099.919000810034;8214.58927053645;8220.506769593843;8253;8306.8338633227;7940.0471943367165;7997.480163789335;8068.273855353046;8123.7156699515235;8147.959260203661;9442.38624489406;9475.857862131936;9509;9547.952260238655;9654;9390;9648.228141748783;9818.607255709692;10046.497675116068;10070.69787906364;6732.259451460433;7183.20984691673;7424.517406368569;7520.661570229244;7639.274268944441;8061.83876322482;8123.431359804993;8169.468984515987;8171.877421838796;8180.877286840821;7130.215676275502;7298.416126709957;7318.634068296457;7360.926390736024;7368.815779605553;7092.113485814273;7118.572885626879;7225.060742103493;7297.927020729937;7298.452616053711;7625.360547482318;7635.580043097683;7643.847123057619;7665.923340766521;7702.229777022253;6924.272951340238;6957.930420695729;6960.547564408297;6999;7008.299170082951;6092.329843717276;6984.685689143899;7027.367536921702;7038.345988692756;7152.85694286101 17:01:31 INFO - PROCESS | 1999 | |4;prototype.html;272.24995138393734;318.6112942210503;328.76493307285295;329.40213512474844;332.72716372574496;6730.59616423015;6909.378155965968;6965.54723942944;6979.965100174505;6994.650267486618;6834.863302733942;6848.246692863781;6873.587584744919;6879.690413931373;6892.069570607967;4732.574068333849;4865.19724245499;4976.825811096613;5001.374828146481;5001.8249361272365;4739.720275525606;4960.627952903528;4994.900101997958;4999.7500124993785;5009.899802003958;3751.737378383514;4119.361498967664;4746.881327966811;4985.326980857592;4993.350864387625;4032.3145065338817;4446.954965583085;4598.632109431237;4977.850664480072;4984.77568509418;4274.123804620045;4278.743275403485;4287.056847493546;4297.39836422901;4301.311790113598;6345.238571371465;6559.245686746038;6609;6651.767188148391;6660.134182556237;4763.761811909425;5793.681347525884;5954.821355359346;5967.731452084667;5995.310539287994;7233.819154521179;7250.782476525713;7253.7098516059295;7258.201597824235;7290.27097290272;4189.895252618679;4786.305985632064;4790.42514898211;4792.832250871203;4805.135075686375;7264.38252748517;7752.689892404297;7755.573443460607;7781.260780225926;7789.415793815429;4003.7197396181987;4648.930266046012;4794.113089078532;4809.254565542346;4914.901701966012;4964.15609346412;4974.0797952378925;4976.129177394014;4988.401391832931;5000.099982003274;5903.675297858659;5904.61619994699;5929.466348028698;5931.08068249422;5969.940300597025;7353.742619008416;7363.190049094595;7376.594287314249;7380.9630951845975;7391.113066432063;1333.8462230170833;1553.6581951970547;1688.7213609754253;1710.3842616657994;1737.3571778442058;1107.5846557540922;1114.7993361194901;1131.2025022359217;1133.9943300283446;1138.487680543742;6742.42689371409;6765.154355705537;6792.626405547742;6799.11611490503;6799.932000680029;7463.440241981873;7498.287662672037;7502.737404190827;7511.887321690179;7516.233685084001;5563.5271001964475;6774.491913106438;6783.830404239835;6786.59280443175;6853.725850966005;3677.9080522987138;3967.6429121379215;4006.318925782624;4007.899802504961;4018.1561872006623;6552.541322107502;6553.115329430561;6791.185057793096;7022.6488675566015;8006.519608823489;6395.776147834804;7847.489913155627;7951.483153594998;7965.362770978308;7984.640691168911;8036.236557527026;8037.316828069563;8041.839163216703;8066.112727600077;8073.677052917935;7392.26077392278;7683.961580192287;7721.53670779755;7724.806879828049;7737.14891361961;7495.362894154058;7552.471327007057;7565.130010048695;7579.431542634215;7602.771916842504;8049.718259860877;8052.87920681202;8070.87893681607;8072.919270807217;8082.423927334348;4946.3817022872145;4948.15881300187;4955.82654607087;4957.950420495749;4987.102321582005;7297.781066568012;7661.846763064596;7661.88507172404;7667.884981725167;7686.500377475446;7343.48595598303;7344.449166312655;7347.485676002629;7357.411407087313;7363.15323737777;7356.374708149867;7356.705731770669;7359.448041397024;7370.373518251009;7394.075740532434;7151.141862976476;7159.64201789898;7161.892571611325;7163.820904477221;7196.388306993964;7042.366187043191;7342.045534080536;7403.444741644291;7430.071241094864;7434.36807871337;5862.06551837901;7185.497015208885;7196.460265480006;7212.675429605575;7212.963935180291 17:01:31 INFO - PROCESS | 1999 | |5;yui.html;669.1619590361686;706.6713978000232;729.4784229276066;731.177425396429;733.5598640815508;14728.89533285004;15028.02317849339;15342.156181410031;15371.769423458658;15463.149526776022;13202.867971320307;14032.228227447486;14206.36071376788;14209;14251.572452826405;702.2485940044155;765.954042757435;828.5194587139475;847.0386111763162;873.5588527793456;842.4945032980224;853.3727710133047;863.5768473447997;867.1415298854153;867.41449521573;889.5818965086399;889.8531742262551;894.1818236313765;904.764761162096;912.7216199059284;874.6676263020044;889.0753616239136;900.3427497926485;904.9321300902426;910.39003867409;666.0941120076692;674.2414783368711;675.3145557259386;675.4225137507459;677.6340775980964;14921.925390373088;14983.101013939198;14984;14999.100053996795;15050.5484835454;12854.485820567166;12894.80657790134;12985.285809280485;13085.018623603173;13211;9977.201823854075;10075.546600402999;10196.286259961806;10413.062824345769;10507.474626268657;3009.5184770436626;3473;3493.6331685172945;3500.8599656013985;3646.890593282206;55577.72211138959;81360;81745;81909;82745.75881361845;9511.952440237754;9550.99483313366;9577.664781732745;9712.562934667956;10249.692509224735;21951.341459756233;22273.554528909655;22301.21945731924;22340.21809236669;22341.3297601069;6045.516358691294;6437.871242575122;7425.108986921496;7438.4049276057785;7541.208173141851;3504.456809194579;3852.5569559500454;3974.503187101612;3992.5208974923194;4021.4571032910185;3529.488224207527;3572.7677700949357;3595.388783906742;3608.729345299113;3611.2777444511203;596.5615272774508;639.5075791640411;642.3480167629859;644.1207751419372;651.5178767711953;535.2880668710606;586.9148973398833;590.9527237820964;601.503759398498;614.3119705929298;8043.758687239392;8282.378821588405;8344.780049489378;8352.039515455679;8388.07731149573;572.928383952006;574.8476653686693;575.9740811663485;602.4397310501188;617.200725061047;3853.171568112813;3883.37865941448;3897.8635747748694;3948.993006783252;3962.7622342658956;79741;83205;83446;83472.16527834766;84140.57929710312;70591.64704176446;71739.6413017942;72840.2715972844;73145.63427182936;73936;62674.0598891017;62736;64037.99999999907;64312.35687643157;64614.676926615066;7815.6092195388865;7840.84318313642;7862.488938218998;7890.951980451724;7922.643481043482;47071.293930590386;47251.291230632254;47402.051958959935;48478.757606211744;48503.5149648499;59619;61239;63934;65147.67426163029;65176.34823651893;10169.542370593193;10896.291741036806;11061.5022323994;11289.943550282196;11649.475773590379;11869.347185904513;12318.137730358789;12428.502859885502;12528.686782830502;12838.55065072718;11603.245789023686;11607.709807254887;11888.821667674818;11933.701657458285;11940.402979851146;11383.430828458379;11534.59628912984;11595.13036522281;11600;11674.533018679158;10267.665203523495;11258.718532036764;11268.15488838324;11514.884851151717;11842.526298947945;9089.454632722058;9403.811923761623;9513.33406661527;9757.365771224848;9844.015598440099;9569.569369378256;9785.657501987396;9816.214702823614;9821.558029888814;9852.753681158028 17:01:31 INFO - PROCESS | 1999 | __end_tp_report 17:01:31 INFO - PROCESS | 1999 | __start_cc_report 17:01:31 INFO - PROCESS | 1999 | _x_x_mozilla_cycle_collect,349 17:01:31 INFO - PROCESS | 1999 | __end_cc_report 17:01:31 INFO - PROCESS | 1999 | __startTimestamp1456448491128__endTimestamp 17:01:31 INFO - PROCESS | 1999 | 17:01:31 INFO - PROCESS | 1999 | ------- Summary: start ------- 17:01:31 INFO - PROCESS | 1999 | Number of tests: 6 17:01:31 INFO - PROCESS | 1999 | 17:01:31 INFO - PROCESS | 1999 | [#0] dojo.html Cycles:165 Average:5590.83 Median:5792.97 stddev:814.29 (14.1%) stddev-sans-first:788.61 17:01:31 INFO - PROCESS | 1999 | Values: 2883.6 2913.4 2923.8 3470.7 3520.1 5489.1 5607.6 5644.1 5652.8 5670.9 4830.0 5400.9 5505.5 5628.2 5793.0 5098.9 5117.1 5164.7 5185.5 5261.7 417.4 5091.0 5140.8 5158.8 5195.7 5110.3 5117.9 5118.9 5144.5 5151.3 5004.7 5147.5 5155.2 5172.4 5174.6 4085.0 5048.6 5062.5 5121.3 5125.5 5383.6 5395.6 5524.0 5548.0 5570.2 6079.6 6141.6 6181.9 6185.8 6199.1 6156.3 6196.7 6230.5 6239.1 6244.0 5687.1 5695.0 5700.9 5701.1 5758.9 6171.0 6181.8 6204.0 6239.3 6241.3 6090.9 6091.3 6095.6 6113.8 6124.0 6177.1 6193.0 6219.2 6221.4 6253.3 6044.6 6125.3 6132.1 6181.3 6234.2 6072.1 6117.1 6208.5 6226.3 6239.1 4816.7 4837.9 4863.6 4866.1 4883.8 3615.4 3693.8 4292.5 4299.5 4405.9 5516.4 5603.6 5698.2 5782.5 5794.8 6240.6 6244.7 6245.3 6250.8 6259.9 5616.3 5723.7 5786.5 5795.3 5796.0 5285.6 5290.0 5294.3 5310.7 5317.4 6172.8 6248.9 6250.2 6254.0 6280.2 6138.1 6180.9 6241.8 6247.8 6269.3 6220.0 6242.8 6250.7 6254.6 6256.3 4722.7 5295.5 5912.9 6107.3 6136.4 5022.0 6186.0 6196.1 6202.4 6204.3 4952.3 6028.2 6029.6 6066.7 6131.8 4701.3 5632.2 5988.2 5991.7 6027.2 5710.9 5761.3 5780.0 5919.4 5938.7 5846.6 6069.2 6069.9 6085.5 6127.6 5778.5 5791.6 5841.9 5880.9 5891.1 17:01:31 INFO - PROCESS | 1999 | 17:01:31 INFO - PROCESS | 1999 | [#1] ext.html Cycles:180 Average:58915.99 Median:37032.13 stddev:122152.12 (329.9%) stddev-sans-first:122415.90 17:01:31 INFO - PROCESS | 1999 | Values: 443.0 460.9 488.1 502.5 589.1 29770.0 37067.8 37092.4 37098.6 37158.9 37523.0 37539.9 37761.8 37995.8 38300.8 9219.3 9386.2 9387.7 9438.7 9475.4 9314.9 9496.6 9554.8 9563.7 9566.0 9450.0 9514.9 9573.0 9578.7 9622.8 8107.2 9475.5 9483.5 9578.7 9579.3 9350.8 9487.9 9490.5 9508.2 9537.6 37717.4 37937.8 38008.4 38191.6 38202.2 2830.9 3088.9 3221.6 3327.9 3391.7 26731.0 27199.3 27278.6 27362.0 27944.0 2769.0 2774.7 2781.3 2843.0 2875.2 344207.0 344258.0 345369.0 345483.0 348099.0 44688.8 59350.0 59600.4 59673.4 59746.7 38462.0 42026.9 42597.4 43702.7 44067.8 15194.1 15413.2 15590.9 15613.5 15630.7 12085.2 12146.0 12556.0 12575.0 12663.4 14213.1 14353.4 14353.5 14644.9 14810.6 5856.6 6287.4 6337.8 6366.9 6393.9 745.5 832.9 984.4 1051.0 1132.9 25016.9 28991.9 29374.4 29407.6 29957.7 1000.3 1056.1 1094.9 1095.3 1133.1 12182.9 14511.9 14625.7 14746.9 14908.9 460053.0 528361.0 533583.0 534580.0 536728.0 55551.7 56530.9 57271.4 57352.7 57523.7 1207.0 1341.3 1383.5 1391.1 1418.8 23211.7 29042.6 29252.0 29293.6 29631.3 41731.8 49204.8 49679.8 51089.0 51343.0 482531.0 494293.0 494383.5 495479.0 495936.0 32431.4 32462.8 33063.3 33549.3 33678.7 45341.8 46151.1 46857.8 46932.8 47134.8 34688.0 36100.8 36790.3 37063.6 37553.6 29170.7 35840.8 36399.4 36798.3 36880.8 25034.5 36301.8 36615.8 36951.0 37000.6 32840.2 34950.7 35045.8 35067.0 35330.6 24608.9 24674.0 24704.0 25073.5 25129.6 17:01:31 INFO - PROCESS | 1999 | 17:01:31 INFO - PROCESS | 1999 | [#2] jquery.html Cycles:180 Average:34634.91 Median:25147.94 stddev:100289.22 (398.8%) stddev-sans-first:100537.44 17:01:31 INFO - PROCESS | 1999 | Values: 307.7 350.9 354.5 357.8 367.1 19304.8 19340.4 21011.6 21017.8 21065.6 19593.3 20464.9 20676.7 20721.8 20826.7 5619.2 5913.0 5951.2 5955.9 5961.7 4166.4 5740.9 6141.6 6422.9 6438.5 6335.4 6348.1 6348.7 6369.9 6371.1 5369.3 5416.7 6091.7 6360.1 6373.9 4924.9 5033.3 5303.7 5458.8 5485.8 19170.5 20260.0 23892.6 24726.4 25569.5 2267.9 2429.5 2678.2 2688.9 2863.7 11833.7 14390.9 14393.0 14652.3 14657.0 1533.0 1748.1 1754.1 1757.9 1769.1 102106.0 104159.5 104202.5 104748.5 105490.0 9177.7 10891.2 10905.1 11030.5 11232.2 13151.4 13263.2 13399.9 13408.7 13445.2 8432.4 8453.0 8487.2 8570.0 8582.9 8569.3 8613.4 8682.4 8791.7 8896.4 3700.4 4366.8 4443.3 4452.1 4454.2 1755.2 1823.7 1846.5 1874.1 1903.6 883.4 906.6 906.7 1031.4 1038.3 19705.9 20315.6 20550.6 20616.2 20685.1 914.9 943.9 946.2 955.9 999.3 9553.9 9632.8 10658.1 10993.6 11061.1 589585.0 602416.0 606094.0 606289.0 612311.0 122678.4 124031.0 125513.0 126815.0 127309.0 994.7 1015.2 1029.4 1035.1 1041.8 17424.7 18062.0 18153.6 18156.5 18433.3 52733.7 53617.0 53683.9 54302.2 56121.7 55675.0 78924.0 79016.0 81927.6 83862.2 7991.2 8072.0 8098.6 8208.7 8248.5 8092.0 12406.8 13524.1 13637.4 13816.5 10147.5 11581.4 11612.1 11788.5 11822.0 10291.7 11374.6 11633.8 11787.0 11830.0 11555.0 11851.6 12061.3 12099.7 12102.4 7972.5 8046.8 8133.8 8203.1 8240.5 8492.6 9758.7 10672.9 11661.7 11906.4 17:01:31 INFO - PROCESS | 1999 | 17:01:31 INFO - PROCESS | 1999 | [#3] mootools.html Cycles:180 Average:5961.00 Median:5356.32 stddev:3140.24 (58.6%) stddev-sans-first:3130.16 17:01:31 INFO - PROCESS | 1999 | Values: 1378.7 1411.0 1578.9 1884.2 1904.4 7786.7 8480.0 8618.0 8799.9 8830.6 7676.4 8629.6 8630.4 8725.3 8729.8 2441.4 2448.4 2458.6 2462.1 2462.1 2417.6 2462.0 2469.1 2481.3 2488.0 2117.7 2437.9 2449.8 2466.7 2479.8 2433.7 2437.5 2466.4 2468.2 2472.9 2446.8 2447.5 2455.6 2462.0 2462.5 8733.7 8740.3 8790.3 8807.0 8826.1 5336.2 5413.3 5451.8 5461.4 5487.7 3563.6 3662.6 3667.9 3677.7 3684.6 1046.2 1060.8 1067.3 1072.4 1073.2 11580.9 11720.3 11734.9 11745.0 11753.2 4800.7 4803.9 4896.2 4903.5 4917.7 8499.0 10072.5 10075.9 10080.7 10093.7 5376.4 5376.8 5378.6 5466.0 5503.5 4404.4 4827.1 4921.6 4928.8 4982.6 3831.1 3865.1 3906.6 3948.2 3950.4 1060.7 1177.9 1185.7 1296.3 1300.8 1085.8 1086.5 1116.3 1258.5 1370.1 7028.4 8042.2 8125.3 8212.5 8243.4 509.3 517.5 521.2 523.0 523.6 6181.3 6187.5 6194.9 6196.3 6214.5 8810.4 10243.7 10407.2 10448.6 10491.8 10117.4 10215.2 10239.8 10295.7 10311.2 8099.9 8214.6 8220.5 8253.0 8306.8 7940.0 7997.5 8068.3 8123.7 8148.0 9442.4 9475.9 9509.0 9548.0 9654.0 9390.0 9648.2 9818.6 10046.5 10070.7 6732.3 7183.2 7424.5 7520.7 7639.3 8061.8 8123.4 8169.5 8171.9 8180.9 7130.2 7298.4 7318.6 7360.9 7368.8 7092.1 7118.6 7225.1 7297.9 7298.5 7625.4 7635.6 7643.8 7665.9 7702.2 6924.3 6957.9 6960.5 6999.0 7008.3 6092.3 6984.7 7027.4 7038.3 7152.9 17:01:31 INFO - PROCESS | 1999 | 17:01:31 INFO - PROCESS | 1999 | [#4] prototype.html Cycles:180 Average:5952.41 Median:6788.89 stddev:1947.29 (28.7%) stddev-sans-first:1905.51 17:01:31 INFO - PROCESS | 1999 | Values: 272.2 318.6 328.8 329.4 332.7 6730.6 6909.4 6965.5 6980.0 6994.7 6834.9 6848.2 6873.6 6879.7 6892.1 4732.6 4865.2 4976.8 5001.4 5001.8 4739.7 4960.6 4994.9 4999.8 5009.9 3751.7 4119.4 4746.9 4985.3 4993.4 4032.3 4447.0 4598.6 4977.9 4984.8 4274.1 4278.7 4287.1 4297.4 4301.3 6345.2 6559.2 6609.0 6651.8 6660.1 4763.8 5793.7 5954.8 5967.7 5995.3 7233.8 7250.8 7253.7 7258.2 7290.3 4189.9 4786.3 4790.4 4792.8 4805.1 7264.4 7752.7 7755.6 7781.3 7789.4 4003.7 4648.9 4794.1 4809.3 4914.9 4964.2 4974.1 4976.1 4988.4 5000.1 5903.7 5904.6 5929.5 5931.1 5969.9 7353.7 7363.2 7376.6 7381.0 7391.1 1333.8 1553.7 1688.7 1710.4 1737.4 1107.6 1114.8 1131.2 1134.0 1138.5 6742.4 6765.2 6792.6 6799.1 6799.9 7463.4 7498.3 7502.7 7511.9 7516.2 5563.5 6774.5 6783.8 6786.6 6853.7 3677.9 3967.6 4006.3 4007.9 4018.2 6552.5 6553.1 6791.2 7022.6 8006.5 6395.8 7847.5 7951.5 7965.4 7984.6 8036.2 8037.3 8041.8 8066.1 8073.7 7392.3 7684.0 7721.5 7724.8 7737.1 7495.4 7552.5 7565.1 7579.4 7602.8 8049.7 8052.9 8070.9 8072.9 8082.4 4946.4 4948.2 4955.8 4958.0 4987.1 7297.8 7661.8 7661.9 7667.9 7686.5 7343.5 7344.4 7347.5 7357.4 7363.2 7356.4 7356.7 7359.4 7370.4 7394.1 7151.1 7159.6 7161.9 7163.8 7196.4 7042.4 7342.0 7403.4 7430.1 7434.4 5862.1 7185.5 7196.5 7212.7 7213.0 17:01:31 INFO - PROCESS | 1999 | 17:01:31 INFO - PROCESS | 1999 | [#5] yui.html Cycles:180 Average:17432.38 Median:3323.98 stddev:23685.69 (712.6%) stddev-sans-first:23718.68 17:01:31 INFO - PROCESS | 1999 | Values: 669.2 706.7 729.5 731.2 733.6 14728.9 15028.0 15342.2 15371.8 15463.1 13202.9 14032.2 14206.4 14209.0 14251.6 702.2 766.0 828.5 847.0 873.6 842.5 853.4 863.6 867.1 867.4 889.6 889.9 894.2 904.8 912.7 874.7 889.1 900.3 904.9 910.4 666.1 674.2 675.3 675.4 677.6 14921.9 14983.1 14984.0 14999.1 15050.5 12854.5 12894.8 12985.3 13085.0 13211.0 9977.2 10075.5 10196.3 10413.1 10507.5 3009.5 3473.0 3493.6 3500.9 3646.9 55577.7 81360.0 81745.0 81909.0 82745.8 9512.0 9551.0 9577.7 9712.6 10249.7 21951.3 22273.6 22301.2 22340.2 22341.3 6045.5 6437.9 7425.1 7438.4 7541.2 3504.5 3852.6 3974.5 3992.5 4021.5 3529.5 3572.8 3595.4 3608.7 3611.3 596.6 639.5 642.3 644.1 651.5 535.3 586.9 591.0 601.5 614.3 8043.8 8282.4 8344.8 8352.0 8388.1 572.9 574.8 576.0 602.4 617.2 3853.2 3883.4 3897.9 3949.0 3962.8 79741.0 83205.0 83446.0 83472.2 84140.6 70591.6 71739.6 72840.3 73145.6 73936.0 62674.1 62736.0 64038.0 64312.4 64614.7 7815.6 7840.8 7862.5 7891.0 7922.6 47071.3 47251.3 47402.1 48478.8 48503.5 59619.0 61239.0 63934.0 65147.7 65176.3 10169.5 10896.3 11061.5 11289.9 11649.5 11869.3 12318.1 12428.5 12528.7 12838.6 11603.2 11607.7 11888.8 11933.7 11940.4 11383.4 11534.6 11595.1 11600.0 11674.5 10267.7 11258.7 11268.2 11514.9 11842.5 9089.5 9403.8 9513.3 9757.4 9844.0 9569.6 9785.7 9816.2 9821.6 9852.8 17:01:31 INFO - PROCESS | 1999 | -------- Summary: end -------- 17:01:31 INFO - PROCESS | 1999 | 17:01:31 INFO - TEST-INFO | 1999: exit 0 17:01:31 INFO - TEST-OK | dromaeo_css | took 1109427ms 17:01:31 INFO - TEST-START | kraken 17:01:31 INFO - operating with platform_type : mac_ 17:01:31 INFO - Initialising browser for kraken test... 17:01:31 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmp8fEzMK/profile http://localhost:49529/getInfo.html) 17:01:34 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 17:01:34 INFO - PROCESS | 2004 | colorDepth:24 17:01:34 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 17:01:34 INFO - PROCESS | 2004 | __metrics 17:01:34 ERROR - PROCESS | 2004 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 17:01:35 INFO - TEST-INFO | 2004: exit 0 17:01:35 INFO - Browser initialized. 17:01:35 INFO - Running cycle 1/1 for kraken test... 17:01:35 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/T/tmp8fEzMK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:01:47 INFO - PROCESS | 2007 | RSS: Main: 255918080 17:01:47 INFO - PROCESS | 2007 | 17:01:49 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49529/tests/kraken/driver.html?testName=audio-beat-detection) 17:01:50 INFO - PROCESS | 2007 | RSS: Main: 269283328 17:01:50 INFO - PROCESS | 2007 | 17:01:52 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49529/tests/kraken/driver.html?testName=audio-dft) 17:01:53 INFO - PROCESS | 2007 | RSS: Main: 277016576 17:01:53 INFO - PROCESS | 2007 | 17:01:56 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49529/tests/kraken/driver.html?testName=audio-fft) 17:01:57 INFO - PROCESS | 2007 | RSS: Main: 281149440 17:01:57 INFO - PROCESS | 2007 | 17:01:59 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49529/tests/kraken/driver.html?testName=audio-oscillator) 17:02:00 INFO - PROCESS | 2007 | RSS: Main: 281300992 17:02:00 INFO - PROCESS | 2007 | 17:02:02 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49529/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:02:02 INFO - PROCESS | 2007 | RSS: Main: 281812992 17:02:02 INFO - PROCESS | 2007 | 17:02:05 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49529/tests/kraken/driver.html?testName=imaging-darkroom) 17:02:06 INFO - PROCESS | 2007 | RSS: Main: 283553792 17:02:06 INFO - PROCESS | 2007 | 17:02:09 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49529/tests/kraken/driver.html?testName=imaging-desaturate) 17:02:09 INFO - PROCESS | 2007 | RSS: Main: 283340800 17:02:09 INFO - PROCESS | 2007 | 17:02:12 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49529/tests/kraken/driver.html?testName=json-parse-financial) 17:02:13 INFO - PROCESS | 2007 | RSS: Main: 283848704 17:02:13 INFO - PROCESS | 2007 | 17:02:15 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49529/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:02:15 INFO - PROCESS | 2007 | RSS: Main: 282599424 17:02:15 INFO - PROCESS | 2007 | 17:02:17 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49529/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:02:18 INFO - PROCESS | 2007 | RSS: Main: 282722304 17:02:18 INFO - PROCESS | 2007 | 17:02:20 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49529/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:02:20 INFO - PROCESS | 2007 | RSS: Main: 282480640 17:02:20 INFO - PROCESS | 2007 | 17:02:23 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49529/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:02:24 INFO - PROCESS | 2007 | RSS: Main: 282525696 17:02:24 INFO - PROCESS | 2007 | 17:02:26 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49529/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:02:27 INFO - PROCESS | 2007 | RSS: Main: 283279360 17:02:27 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:49529/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49529/tests/kraken/driver.html?testName=ai-astar) 17:02:29 INFO - PROCESS | 2007 | RSS: Main: 284114944 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | __start_tp_report 17:02:29 INFO - PROCESS | 2007 | _x_x_mozilla_page_load 17:02:29 INFO - PROCESS | 2007 | _x_x_mozilla_page_load_details 17:02:29 INFO - PROCESS | 2007 | |i|pagename|runs| 17:02:29 INFO - PROCESS | 2007 | |0;ai-astar;115;110;116;116;117;127;116;116;117;115 17:02:29 INFO - PROCESS | 2007 | |1;audio-beat-detection;165;159;147;158;122;143;143;121;157;122 17:02:29 INFO - PROCESS | 2007 | |2;audio-dft;193;193;199;197;208;209;246;251;204;252 17:02:29 INFO - PROCESS | 2007 | |3;audio-fft;71;78;74;123;83;58;57;71;130;57 17:02:29 INFO - PROCESS | 2007 | |4;audio-oscillator;85;89;121;94;85;75;151;118;100;106 17:02:29 INFO - PROCESS | 2007 | |5;imaging-gaussian-blur;96;139;106;94;104;91;131;141;86;93 17:02:29 INFO - PROCESS | 2007 | |6;imaging-darkroom;97;96;97;96;96;99;151;124;96;97 17:02:29 INFO - PROCESS | 2007 | |7;imaging-desaturate;92;97;93;92;95;128;147;102;91;92 17:02:29 INFO - PROCESS | 2007 | |8;json-parse-financial;56;58;58;56;57;59;57;64;61;56 17:02:29 INFO - PROCESS | 2007 | |9;json-stringify-tinderbox;63;67;74;72;80;105;106;93;68;68 17:02:29 INFO - PROCESS | 2007 | |10;stanford-crypto-aes;86;84;89;86;89;87;85;88;88;85 17:02:29 INFO - PROCESS | 2007 | |11;stanford-crypto-ccm;125;128;124;135;137;147;123;132;136;125 17:02:29 INFO - PROCESS | 2007 | |12;stanford-crypto-pbkdf2;138;142;144;138;181;162;139;141;149;171 17:02:29 INFO - PROCESS | 2007 | |13;stanford-crypto-sha256-iterative;69;67;70;70;64;56;70;91;98;58 17:02:29 INFO - PROCESS | 2007 | __end_tp_report 17:02:29 INFO - PROCESS | 2007 | __start_cc_report 17:02:29 INFO - PROCESS | 2007 | _x_x_mozilla_cycle_collect,886 17:02:29 INFO - PROCESS | 2007 | __end_cc_report 17:02:29 INFO - PROCESS | 2007 | __startTimestamp1456448549266__endTimestamp 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | ------- Summary: start ------- 17:02:29 INFO - PROCESS | 2007 | Number of tests: 14 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#0] ai-astar Cycles:10 Average:116.50 Median:116.00 stddev:4.20 (3.6%) stddev-sans-first:4.42 17:02:29 INFO - PROCESS | 2007 | Values: 115.0 110.0 116.0 116.0 117.0 127.0 116.0 116.0 117.0 115.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:152.00 stddev:16.79 (11.0%) stddev-sans-first:15.95 17:02:29 INFO - PROCESS | 2007 | Values: 165.0 159.0 147.0 158.0 122.0 143.0 143.0 121.0 157.0 122.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#2] audio-dft Cycles:10 Average:215.20 Median:208.50 stddev:24.45 (11.7%) stddev-sans-first:24.58 17:02:29 INFO - PROCESS | 2007 | Values: 193.0 193.0 199.0 197.0 208.0 209.0 246.0 251.0 204.0 252.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#3] audio-fft Cycles:10 Average:80.20 Median:71.00 stddev:26.04 (36.7%) stddev-sans-first:27.40 17:02:29 INFO - PROCESS | 2007 | Values: 71.0 78.0 74.0 123.0 83.0 58.0 57.0 71.0 130.0 57.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:80.00 stddev:22.55 (28.2%) stddev-sans-first:23.02 17:02:29 INFO - PROCESS | 2007 | Values: 85.0 89.0 121.0 94.0 85.0 75.0 151.0 118.0 100.0 106.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#5] imaging-gaussian-blur Cycles:10 Average:108.10 Median:88.50 stddev:20.91 (23.6%) stddev-sans-first:21.72 17:02:29 INFO - PROCESS | 2007 | Values: 96.0 139.0 106.0 94.0 104.0 91.0 131.0 141.0 86.0 93.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#6] imaging-darkroom Cycles:10 Average:104.90 Median:96.50 stddev:18.35 (19.0%) stddev-sans-first:19.23 17:02:29 INFO - PROCESS | 2007 | Values: 97.0 96.0 97.0 96.0 96.0 99.0 151.0 124.0 96.0 97.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#7] imaging-desaturate Cycles:10 Average:102.90 Median:92.00 stddev:19.06 (20.7%) stddev-sans-first:19.80 17:02:29 INFO - PROCESS | 2007 | Values: 92.0 97.0 93.0 92.0 95.0 128.0 147.0 102.0 91.0 92.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:58.00 stddev:2.57 (4.4%) stddev-sans-first:2.60 17:02:29 INFO - PROCESS | 2007 | Values: 56.0 58.0 58.0 56.0 57.0 59.0 57.0 64.0 61.0 56.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#9] json-stringify-tinderbox Cycles:10 Average:79.60 Median:70.00 stddev:16.04 (22.9%) stddev-sans-first:15.84 17:02:29 INFO - PROCESS | 2007 | Values: 63.0 67.0 74.0 72.0 80.0 105.0 106.0 93.0 68.0 68.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.50 stddev:1.77 (2.0%) stddev-sans-first:1.86 17:02:29 INFO - PROCESS | 2007 | Values: 86.0 84.0 89.0 86.0 89.0 87.0 85.0 88.0 88.0 85.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:133.50 stddev:7.66 (5.7%) stddev-sans-first:7.79 17:02:29 INFO - PROCESS | 2007 | Values: 125.0 128.0 124.0 135.0 137.0 147.0 123.0 132.0 136.0 125.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:146.50 stddev:15.40 (10.5%) stddev-sans-first:15.66 17:02:29 INFO - PROCESS | 2007 | Values: 138.0 142.0 144.0 138.0 181.0 162.0 139.0 141.0 149.0 171.0 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - PROCESS | 2007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:70.00 stddev:13.31 (19.0%) stddev-sans-first:14.09 17:02:29 INFO - PROCESS | 2007 | Values: 69.0 67.0 70.0 70.0 64.0 56.0 70.0 91.0 98.0 58.0 17:02:29 INFO - PROCESS | 2007 | -------- Summary: end -------- 17:02:29 INFO - PROCESS | 2007 | 17:02:29 INFO - TEST-INFO | 2007: exit 0 17:02:29 INFO - TEST-OK | kraken | took 58328ms 17:02:29 INFO - SUITE-END | took 1167s 17:02:30 INFO - Completed test suite (00:19:28) 17:02:30 INFO - Working with test: dromaeo_css 17:02:30 INFO - Generating results file: dromaeo_css 17:02:30 INFO - Working with test: kraken 17:02:30 INFO - Generating results file: kraken 17:02:30 INFO - javascript benchmark 17:02:30 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:02:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 17:02:30 INFO - process_Request line: dromaeo_css 7421.36 graph.html#tests=[[72,64,61]] 17:02:30 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:02:30 INFO - process_Request line: kraken 1551.40 graph.html#tests=[[232,64,61]] 17:02:30 INFO - RETURN: dromaeo_css: 7421.36 17:02:30 INFO - RETURN: kraken: 1551.40 17:02:30 INFO - javascript benchmark 17:02:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2883.567464880268, 2913.4027524357507, 2923.766098712103, 3470.7049900758434, 3520.119970007498, 5489.149181876811, 5607.57943154263, 5644.125160600103, 5652.830415087544, 5670.886582268352, 4829.951700482994, 5400.892816972521, 5505.476979686933, 5628.155776633507, 5792.971035144818, 5098.949010509894, 5117.104506711311, 5164.741762911858, 5185.507376799198, 5261.736913154346, 417.35288557883916, 5091.032703786269, 5140.845774626767, 5158.767855446514, 5195.740212989354, 5110.28456016158, 5117.923231151536, 5118.897622047538, 5144.536991670749, 5151.304573882534, 5004.724740139291, 5147.459516750762, 5155.200943853709, 5172.353455818023, 5174.637775355726, 4084.979575102135, 5048.62135339851, 5062.54437100659, 5121.257417674454, 5125.4618265082, 5383.596230282745, 5395.622306438511, 5524.033294173544, 5548.0, 5570.2480165177585, 6079.6048256863605, 6141.631502109888, 6181.876362472771, 6185.8144255672405, 6199.101130336076, 6156.261248650146, 6196.659183744892, 6230.470410015154, 6239.126522286883, 6243.968780156116, 5687.118496633028, 5695.003374409462, 5700.885982280372, 5701.087825947829, 5758.856028599276, 6170.969145154335, 6181.81454556355, 6203.96898015507, 6239.282482514478, 6241.344658810759, 6090.908636370458, 6091.269047714302, 6095.573309868267, 6113.755449782047, 6123.96938015316, 6177.073438984188, 6193.043987280555, 6219.222597175353, 6221.440070393686, 6253.280872699606, 6044.637321760709, 6125.295591007091, 6132.141360525156, 6181.320054793969, 6234.189555357774, 6072.149899014142, 6117.143599896018, 6208.4722798562625, 6226.346233645492, 6239.06414037898, 4816.662833601685, 4837.879053023703, 4863.635227357962, 4866.124097662384, 4883.755812209375, 3615.367310720613, 3693.778373297611, 4292.48490181174, 4299.462567179103, 4405.867823965286, 5516.393196748354, 5603.607747457639, 5698.202251684767, 5782.508486778671, 5794.797182098607, 6240.594361366497, 6244.687765611701, 6245.344238854855, 6250.843728906813, 6259.906101408483, 5616.297962754656, 5723.713814309352, 5786.479216870418, 5795.333536643256, 5796.0, 5285.603579731535, 5289.994900968803, 5294.2852714883, 5310.6813591184655, 5317.441668624739, 6172.753089876354, 6248.875022499616, 6250.218722659668, 6254.0, 6280.246370435577, 6138.051223665275, 6180.876382472416, 6241.843953901189, 6247.843803904757, 6269.279032911274, 6220.0, 6242.812715618538, 6250.749970001331, 6254.6247225166635, 6256.31180570146, 4722.740249286322, 5295.547601011983, 5912.881742365214, 6107.267127944675, 6136.417040381157, 5021.974890125526, 6186.010238362021, 6196.070589411444, 6202.379762023762, 6204.348543403058, 4952.2819191217795, 6028.246469191351, 6029.649434346228, 6066.7269972850445, 6131.84670383244, 4701.341812146234, 5632.183333416713, 5988.191594134736, 5991.670458124845, 6027.156198132353, 5710.914336284876, 5761.308642962871, 5780.0, 5919.4080591940465, 5938.703064846654, 5846.56150788684, 6069.241344831896, 6069.878602427839, 6085.4523092921845, 6127.632342059491, 5778.537716982547, 5791.623544469596, 5841.853953651193, 5880.882382352243, 5891.086881533369], "unit": "score", "name": "dojo.html", "value": 5536.691467136912}, {"lowerIsBetter": false, "replicates": [442.96234820040297, 460.8571342883706, 488.05804796742285, 502.46989426155415, 589.1163255117324, 29770.0, 37067.77593344401, 37092.443613345786, 37098.62901370989, 37158.885233442976, 37523.0, 37539.870614232415, 37761.81119094408, 37995.810020949924, 38300.808495957484, 9219.262459003297, 9386.249100072013, 9387.671431499899, 9438.716838494822, 9475.431474111541, 9314.86027709585, 9496.620135194584, 9554.761130971712, 9563.665271715492, 9565.95217023914, 9449.95275023624, 9514.90485095147, 9573.04269573044, 9578.664746733866, 9622.80754384912, 8107.22981316774, 9475.526223688823, 9483.525823708856, 9578.712638620782, 9579.281553883417, 9350.812983740287, 9487.857682134774, 9490.525473726355, 9508.239340852715, 9537.570809313598, 37717.43423848644, 37937.81031094827, 38008.42987355192, 38191.618083819085, 38202.23595528074, 2830.9292267693268, 3088.9382212355627, 3221.5811944447305, 3327.8835240766457, 3391.7286617070577, 26731.0, 27199.320016999536, 27278.5908211377, 27362.0, 27944.0, 2769.0, 2774.694783573805, 2781.3324802047564, 2842.9857850710614, 2875.2093174377005, 344207.0, 344257.9999999975, 345369.0, 345483.0, 348099.0, 44688.776556117664, 59350.0, 59600.403995960354, 59673.40326596679, 59746.70126649426, 38462.038449039, 42026.94932626709, 42597.36103958443, 43702.68891933247, 44067.77966110149, 15194.088354698753, 15413.229338533029, 15590.9220453897, 15613.453529126426, 15630.687386252212, 12085.154039217347, 12146.0, 12556.0, 12575.0, 12663.353764010804, 14213.076150050214, 14353.425862965572, 14353.497627582985, 14644.853551464563, 14810.594133141325, 5856.648601083949, 6287.434130928238, 6337.7781777637565, 6366.872662546723, 6393.936060639334, 745.5340412242349, 832.8917240758784, 984.4241118945497, 1051.0, 1132.943352832355, 25016.874915625307, 28991.855040724662, 29374.412511749644, 29407.558886616716, 29957.700422995928, 1000.314784372707, 1056.1286938275953, 1094.8686157661132, 1095.309954728516, 1133.0878642692546, 12182.878171218352, 14511.85488145105, 14625.707485850224, 14746.926265368604, 14908.850911490963, 460053.0, 528361.0, 533583.0, 534580.0, 536728.0, 55551.72224138853, 56530.869382612116, 57271.42728572744, 57352.713236434385, 57523.71238143783, 1207.0223119273417, 1341.336038660869, 1383.481194552043, 1391.1166409330149, 1418.8155539779762, 23211.651825222973, 29042.564361535016, 29251.976180833568, 29293.560596591495, 29631.258998560126, 41731.7913410431, 49204.75397622989, 49679.75160124176, 51089.0, 51343.0, 482531.0, 494293.0, 494383.5280823573, 495479.0, 495936.0, 32431.35137297288, 32462.83768581142, 33063.33873322472, 33549.329013419105, 33678.66321336755, 45341.77329113333, 46151.07697845957, 46857.765711171225, 46932.7653361731, 47134.76432617815, 34687.959361219204, 36100.81949590235, 36790.26419471649, 37063.6293637071, 37553.62446375501, 29170.708292917647, 35840.82079589585, 36399.362028708245, 36798.264034719694, 36880.81559592292, 25034.499310014064, 36301.818490907375, 36615.816920915226, 36951.0, 37000.62999370079, 32840.178995524344, 34950.65049349474, 35045.82477087598, 35067.040075343444, 35330.64669353273, 24608.876955615106, 24674.0, 24704.0, 25073.498530028934, 25129.623055654545], "unit": "score", "name": "ext.html", "value": 18513.80199331776}, {"lowerIsBetter": false, "replicates": [307.6907707753707, 350.94735789631534, 354.51962590689607, 357.83718408124304, 367.06032556654947, 19304.806951930477, 19340.419787406383, 21011.57976840464, 21017.789822101775, 21065.578688426223, 19593.314234001813, 20464.89767551164, 20676.68984965223, 20721.79278207221, 20826.687599686018, 5619.185218143367, 5913.0, 5951.166836642873, 5955.85110372242, 5961.672108034057, 4166.354215096665, 5740.856478588048, 6141.600795948271, 6422.871542569146, 6438.452731517827, 6335.3981371769605, 6348.143000694917, 6348.650824204667, 6369.936300637004, 6371.076193951874, 5369.301990741218, 5416.729163541807, 6091.695415229221, 6360.077788720633, 6373.936260637381, 4924.901501969976, 5033.320501732256, 5303.655262407931, 5458.754356053987, 5485.835424937259, 19170.520736981547, 20260.0, 23892.641610375857, 24726.381840453952, 25569.48861022769, 2267.943301417461, 2429.477662302596, 2678.236702539786, 2688.852113133777, 2863.7136286371406, 11833.704157396049, 14390.856091439056, 14393.0, 14652.340644670909, 14657.047291926097, 1532.9770053449208, 1748.0822568151696, 1754.1141723429714, 1757.885737427063, 1769.1066011664157, 102106.0, 104159.47920260426, 104202.47898760458, 104748.47625761823, 105489.99999999923, 9177.66923796046, 10891.237613367146, 10905.073068789083, 11030.50362733679, 11232.213745037769, 13151.408186631625, 13263.204207747565, 13399.933000334935, 13408.664783380298, 13445.193288402532, 8432.409731318872, 8453.0, 8487.151284871463, 8570.0, 8582.914170858336, 8569.314454843598, 8613.440126391764, 8682.43564168327, 8791.692290769792, 8896.377253592187, 3700.3709369407266, 4366.8034938427845, 4443.311286750559, 4452.065066336106, 4454.22051141049, 1755.2276998120785, 1823.7446757453968, 1846.4737549798242, 1874.0723341945825, 1903.5812121333286, 883.4081165619051, 906.6146887572755, 906.6735975048977, 1031.3601373815668, 1038.3043360948184, 19705.901470492558, 20315.59368812645, 20550.58898822015, 20616.175352986014, 20685.069171887, 914.9405288656216, 943.9386439881386, 946.1626460582435, 955.8518429643277, 999.2755252441922, 9553.949065602917, 9632.807343853083, 10658.147348212124, 10993.61522346714, 11061.059809916087, 589585.0, 602416.0, 606094.0, 606289.0, 612311.0, 122678.38660806639, 124031.0, 125513.0, 126815.0, 127309.0, 994.7363948553639, 1015.21320976244, 1029.3720830293514, 1035.135661722455, 1041.7551875309296, 17424.651506970044, 18062.0, 18153.636927261647, 18156.546086347946, 18433.262669493608, 52733.7363313181, 53617.0, 53683.92632147413, 54302.185467217234, 56121.71939140278, 55675.0, 78924.0, 79016.0, 81927.5903620478, 83862.16137838544, 7991.200879911962, 8072.0, 8098.635561399633, 8208.671653133808, 8248.46384984974, 8091.959540202261, 12406.751864962469, 13524.053316267768, 13637.386317615532, 13816.516421925184, 10147.492625368553, 11581.420928953687, 11612.12909031809, 11788.469518871843, 11822.0, 10291.691249262534, 11374.601888933848, 11633.767324653629, 11787.0, 11830.0, 11555.01782348476, 11851.585194518495, 12061.336626485627, 12099.697507562381, 12102.394880255775, 7972.521648701097, 8046.758597242092, 8133.75598732039, 8203.097659257597, 8240.50556966584, 8492.617832197442, 9758.658446954323, 10672.8932710675, 11661.708457288296, 11906.404679765803], "unit": "score", "name": "jquery.html", "value": 9522.626544932553}, {"lowerIsBetter": false, "replicates": [1378.6691194113412, 1410.9770416448077, 1578.8973716708413, 1884.1615481110912, 1904.4286713985819, 7786.688532458709, 8479.95760021199, 8617.956910215447, 8799.868001979976, 8830.60262288197, 7676.4242681798805, 8629.611667474963, 8630.4390214636, 8725.301975841934, 8729.781755456117, 2441.414060625455, 2448.4246202142526, 2458.5943319352286, 2462.064415522108, 2462.076721229539, 2417.5977932798933, 2461.9876900615473, 2469.086438017927, 2481.305234534333, 2488.0, 2117.735283089614, 2437.9029436753444, 2449.8407603505802, 2466.728659847415, 2479.764422379871, 2433.7322894481595, 2437.4759426723163, 2466.4080620651002, 2468.1978357034036, 2472.8763561821925, 2446.8409553378974, 2447.486027934136, 2455.607102863551, 2461.9507609847883, 2462.532118897404, 8733.737987860375, 8740.344474164463, 8790.252828509585, 8807.0, 8826.117388261187, 5336.226247194135, 5413.296271484682, 5451.836444906659, 5461.42655021225, 5487.6981766002855, 3563.5901871284614, 3662.597114317423, 3667.9266414671824, 3677.669009789132, 3684.5578530576236, 1046.1682962045193, 1060.7613287010438, 1067.2902519824308, 1072.426251955208, 1073.1575713065206, 11580.88419115815, 11720.296782193096, 11734.94132529349, 11745.0, 11753.177277590572, 4800.711957282574, 4803.927941080887, 4896.192128298862, 4903.509649035139, 4917.704937703749, 8499.0, 10072.496375181358, 10075.949620251851, 10080.747981300527, 10093.69718908434, 5376.4085950545405, 5376.838694839161, 5378.596605254622, 5465.9726701366235, 5503.477169668875, 4404.361367601679, 4827.058723548945, 4921.557059864629, 4928.802847886044, 4982.576480999156, 3831.080540670275, 3865.1496670732395, 3906.609339066071, 3948.1511475033008, 3950.4074388841905, 1060.692399204222, 1177.9057675385948, 1185.7035741064733, 1296.2740865115566, 1300.811382349554, 1085.777415629794, 1086.4893500054961, 1116.2911551165068, 1258.5469231076804, 1370.0615078671142, 7028.437724981989, 8042.195780422028, 8125.268725814705, 8212.548309843016, 8243.381746368927, 509.3149713635155, 517.5393899429511, 521.1843464977298, 523.0010679601942, 523.6125267302169, 6181.320054793969, 6187.504999600022, 6194.876102477925, 6196.287426945869, 6214.502839772807, 8810.427322224035, 10243.7439064024, 10407.21945854064, 10448.634297799541, 10491.842622360671, 10117.39295642249, 10215.23385746072, 10239.795204096024, 10295.74260643475, 10311.22665800068, 8099.919000810034, 8214.58927053645, 8220.506769593843, 8253.0, 8306.8338633227, 7940.0471943367165, 7997.480163789335, 8068.273855353046, 8123.7156699515235, 8147.959260203661, 9442.38624489406, 9475.857862131936, 9509.0, 9547.952260238655, 9654.0, 9390.0, 9648.228141748783, 9818.607255709692, 10046.497675116068, 10070.69787906364, 6732.259451460433, 7183.20984691673, 7424.517406368569, 7520.661570229244, 7639.274268944441, 8061.83876322482, 8123.431359804993, 8169.468984515987, 8171.877421838796, 8180.877286840821, 7130.215676275502, 7298.416126709957, 7318.634068296457, 7360.926390736024, 7368.815779605553, 7092.113485814273, 7118.572885626879, 7225.060742103493, 7297.927020729937, 7298.452616053711, 7625.360547482318, 7635.580043097683, 7643.847123057619, 7665.923340766521, 7702.229777022253, 6924.272951340238, 6957.930420695729, 6960.547564408297, 6999.0, 7008.299170082951, 6092.329843717276, 6984.685689143899, 7027.367536921702, 7038.345988692756, 7152.85694286101], "unit": "score", "name": "mootools.html", "value": 4778.765178906331}, {"lowerIsBetter": false, "replicates": [272.24995138393734, 318.6112942210503, 328.76493307285295, 329.40213512474844, 332.72716372574496, 6730.59616423015, 6909.378155965968, 6965.54723942944, 6979.965100174505, 6994.650267486618, 6834.863302733942, 6848.246692863781, 6873.587584744919, 6879.690413931373, 6892.069570607967, 4732.574068333849, 4865.19724245499, 4976.825811096613, 5001.374828146481, 5001.8249361272365, 4739.720275525606, 4960.627952903528, 4994.900101997958, 4999.7500124993785, 5009.899802003958, 3751.737378383514, 4119.361498967664, 4746.881327966811, 4985.326980857592, 4993.350864387625, 4032.3145065338817, 4446.954965583085, 4598.632109431237, 4977.850664480072, 4984.77568509418, 4274.123804620045, 4278.743275403485, 4287.056847493546, 4297.39836422901, 4301.311790113598, 6345.238571371465, 6559.245686746038, 6609.0, 6651.767188148391, 6660.134182556237, 4763.761811909425, 5793.681347525884, 5954.821355359346, 5967.731452084667, 5995.310539287994, 7233.819154521179, 7250.782476525713, 7253.7098516059295, 7258.201597824235, 7290.27097290272, 4189.895252618679, 4786.305985632064, 4790.42514898211, 4792.832250871203, 4805.135075686375, 7264.38252748517, 7752.689892404297, 7755.573443460607, 7781.260780225926, 7789.415793815429, 4003.7197396181987, 4648.930266046012, 4794.113089078532, 4809.254565542346, 4914.901701966012, 4964.15609346412, 4974.0797952378925, 4976.129177394014, 4988.401391832931, 5000.099982003274, 5903.675297858659, 5904.61619994699, 5929.466348028698, 5931.08068249422, 5969.940300597025, 7353.742619008416, 7363.190049094595, 7376.594287314249, 7380.9630951845975, 7391.113066432063, 1333.8462230170833, 1553.6581951970547, 1688.7213609754253, 1710.3842616657994, 1737.3571778442058, 1107.5846557540922, 1114.7993361194901, 1131.2025022359217, 1133.9943300283446, 1138.487680543742, 6742.42689371409, 6765.154355705537, 6792.626405547742, 6799.11611490503, 6799.932000680029, 7463.440241981873, 7498.287662672037, 7502.737404190827, 7511.887321690179, 7516.233685084001, 5563.5271001964475, 6774.491913106438, 6783.830404239835, 6786.59280443175, 6853.725850966005, 3677.9080522987138, 3967.6429121379215, 4006.318925782624, 4007.899802504961, 4018.1561872006623, 6552.541322107502, 6553.115329430561, 6791.185057793096, 7022.6488675566015, 8006.519608823489, 6395.776147834804, 7847.489913155627, 7951.483153594998, 7965.362770978308, 7984.640691168911, 8036.236557527026, 8037.316828069563, 8041.839163216703, 8066.112727600077, 8073.677052917935, 7392.26077392278, 7683.961580192287, 7721.53670779755, 7724.806879828049, 7737.14891361961, 7495.362894154058, 7552.471327007057, 7565.130010048695, 7579.431542634215, 7602.771916842504, 8049.718259860877, 8052.87920681202, 8070.87893681607, 8072.919270807217, 8082.423927334348, 4946.3817022872145, 4948.15881300187, 4955.82654607087, 4957.950420495749, 4987.102321582005, 7297.781066568012, 7661.846763064596, 7661.88507172404, 7667.884981725167, 7686.500377475446, 7343.48595598303, 7344.449166312655, 7347.485676002629, 7357.411407087313, 7363.15323737777, 7356.374708149867, 7356.705731770669, 7359.448041397024, 7370.373518251009, 7394.075740532434, 7151.141862976476, 7159.64201789898, 7161.892571611325, 7163.820904477221, 7196.388306993964, 7042.366187043191, 7342.045534080536, 7403.444741644291, 7430.071241094864, 7434.36807871337, 5862.06551837901, 7185.497015208885, 7196.460265480006, 7212.675429605575, 7212.963935180291], "unit": "score", "name": "prototype.html", "value": 5292.784210363621}, {"lowerIsBetter": false, "replicates": [669.1619590361686, 706.6713978000232, 729.4784229276066, 731.177425396429, 733.5598640815508, 14728.89533285004, 15028.02317849339, 15342.156181410031, 15371.769423458658, 15463.149526776022, 13202.867971320307, 14032.228227447486, 14206.36071376788, 14209.0, 14251.572452826405, 702.2485940044155, 765.954042757435, 828.5194587139475, 847.0386111763162, 873.5588527793456, 842.4945032980224, 853.3727710133047, 863.5768473447997, 867.1415298854153, 867.41449521573, 889.5818965086399, 889.8531742262551, 894.1818236313765, 904.764761162096, 912.7216199059284, 874.6676263020044, 889.0753616239136, 900.3427497926485, 904.9321300902426, 910.39003867409, 666.0941120076692, 674.2414783368711, 675.3145557259386, 675.4225137507459, 677.6340775980964, 14921.925390373088, 14983.101013939198, 14984.0, 14999.100053996795, 15050.5484835454, 12854.485820567166, 12894.80657790134, 12985.285809280485, 13085.018623603173, 13211.0, 9977.201823854075, 10075.546600402999, 10196.286259961806, 10413.062824345769, 10507.474626268657, 3009.5184770436626, 3473.0, 3493.6331685172945, 3500.8599656013985, 3646.890593282206, 55577.72211138959, 81360.0, 81745.0, 81909.0, 82745.75881361845, 9511.952440237754, 9550.99483313366, 9577.664781732745, 9712.562934667956, 10249.692509224735, 21951.341459756233, 22273.554528909655, 22301.21945731924, 22340.21809236669, 22341.3297601069, 6045.516358691294, 6437.871242575122, 7425.108986921496, 7438.4049276057785, 7541.208173141851, 3504.456809194579, 3852.5569559500454, 3974.503187101612, 3992.5208974923194, 4021.4571032910185, 3529.488224207527, 3572.7677700949357, 3595.388783906742, 3608.729345299113, 3611.2777444511203, 596.5615272774508, 639.5075791640411, 642.3480167629859, 644.1207751419372, 651.5178767711953, 535.2880668710606, 586.9148973398833, 590.9527237820964, 601.503759398498, 614.3119705929298, 8043.758687239392, 8282.378821588405, 8344.780049489378, 8352.039515455679, 8388.07731149573, 572.928383952006, 574.8476653686693, 575.9740811663485, 602.4397310501188, 617.200725061047, 3853.171568112813, 3883.37865941448, 3897.8635747748694, 3948.993006783252, 3962.7622342658956, 79741.0, 83205.0, 83446.0, 83472.16527834766, 84140.57929710312, 70591.64704176446, 71739.6413017942, 72840.2715972844, 73145.63427182936, 73936.0, 62674.0598891017, 62736.0, 64037.99999999907, 64312.35687643157, 64614.676926615066, 7815.6092195388865, 7840.84318313642, 7862.488938218998, 7890.951980451724, 7922.643481043482, 47071.293930590386, 47251.291230632254, 47402.051958959935, 48478.757606211744, 48503.5149648499, 59619.0, 61239.0, 63934.0, 65147.67426163029, 65176.34823651893, 10169.542370593193, 10896.291741036806, 11061.5022323994, 11289.943550282196, 11649.475773590379, 11869.347185904513, 12318.137730358789, 12428.502859885502, 12528.686782830502, 12838.55065072718, 11603.245789023686, 11607.709807254887, 11888.821667674818, 11933.701657458285, 11940.402979851146, 11383.430828458379, 11534.59628912984, 11595.13036522281, 11600.0, 11674.533018679158, 10267.665203523495, 11258.718532036764, 11268.15488838324, 11514.884851151717, 11842.526298947945, 9089.454632722058, 9403.811923761623, 9513.33406661527, 9757.365771224848, 9844.015598440099, 9569.569369378256, 9785.657501987396, 9816.214702823614, 9821.558029888814, 9852.753681158028], "unit": "score", "name": "yui.html", "value": 6766.498155947632}], "name": "dromaeo_css", "value": 7421.357257343817}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 116.0, 116.0, 117.0, 127.0, 116.0, 116.0, 117.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.5}, {"lowerIsBetter": true, "replicates": [165.0, 159.0, 147.0, 158.0, 122.0, 143.0, 143.0, 121.0, 157.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 143.7}, {"lowerIsBetter": true, "replicates": [193.0, 193.0, 199.0, 197.0, 208.0, 209.0, 246.0, 251.0, 204.0, 252.0], "unit": "score", "name": "audio-dft", "value": 215.2}, {"lowerIsBetter": true, "replicates": [71.0, 78.0, 74.0, 123.0, 83.0, 58.0, 57.0, 71.0, 130.0, 57.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [85.0, 89.0, 121.0, 94.0, 85.0, 75.0, 151.0, 118.0, 100.0, 106.0], "unit": "score", "name": "audio-oscillator", "value": 102.4}, {"lowerIsBetter": true, "replicates": [96.0, 139.0, 106.0, 94.0, 104.0, 91.0, 131.0, 141.0, 86.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 96.0, 96.0, 99.0, 151.0, 124.0, 96.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 104.9}, {"lowerIsBetter": true, "replicates": [92.0, 97.0, 93.0, 92.0, 95.0, 128.0, 147.0, 102.0, 91.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 102.9}, {"lowerIsBetter": true, "replicates": [56.0, 58.0, 58.0, 56.0, 57.0, 59.0, 57.0, 64.0, 61.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [63.0, 67.0, 74.0, 72.0, 80.0, 105.0, 106.0, 93.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 79.6}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 89.0, 86.0, 89.0, 87.0, 85.0, 88.0, 88.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [125.0, 128.0, 124.0, 135.0, 137.0, 147.0, 123.0, 132.0, 136.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.2}, {"lowerIsBetter": true, "replicates": [138.0, 142.0, 144.0, 138.0, 181.0, 162.0, 139.0, 141.0, 149.0, 171.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.5}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 70.0, 70.0, 64.0, 56.0, 70.0, 91.0, 98.0, 58.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1551.3999999999999}]} 17:02:30 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1551.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7421.36"}}} 17:02:30 INFO - Return code: 0 17:02:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:02:30 ERROR - # TBPL SUCCESS # 17:02:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:02:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:02:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:02:30 INFO - 2016-02-25 17:02:30.985 screenresolution[2012:15156] starting screenresolution argv=screenresolution get 17:02:30 INFO - 2016-02-25 17:02:30.987 screenresolution[2012:15156] Display 0: 1600x1200x32@60 17:02:30 INFO - 2016-02-25 17:02:30.993 screenresolution[2013:15159] starting screenresolution argv=screenresolution list 17:02:30 INFO - Available Modes on Display 0 17:02:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:02:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:02:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:02:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:02:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:02:31 INFO - Intel Iris: 17:02:31 INFO - Chipset Model: Intel Iris 17:02:31 INFO - Type: GPU 17:02:31 INFO - Bus: Built-In 17:02:31 INFO - VRAM (Dynamic, Max): 1536 MB 17:02:31 INFO - Vendor: Intel (0x8086) 17:02:31 INFO - Device ID: 0x0a2e 17:02:31 INFO - Revision ID: 0x0009 17:02:31 INFO - Displays: 17:02:31 INFO - Display: 17:02:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:02:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:02:31 INFO - Display Serial Number: 1600x1200 60 17:02:31 INFO - Main Display: Yes 17:02:31 INFO - Mirror: Off 17:02:31 INFO - Online: Yes 17:02:31 INFO - Rotation: Supported 17:02:31 INFO - Return code: 0 17:02:31 INFO - Running post-action listener: _resource_record_post_action 17:02:31 INFO - Running post-run listener: _resource_record_post_run 17:02:32 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 1613824; Write bytes: 708502016; Read time: 15; Write time: 2153 17:02:32 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 384848384; Write bytes: 379627008; Read time: 28838; Write time: 831 17:02:32 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 1613824; Write bytes: 301358080; Read time: 15; Write time: 1269 17:02:32 INFO - Running post-run listener: _upload_blobber_files 17:02:32 INFO - Blob upload gear active. 17:02:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:02:32 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:02:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:02:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:02:32 INFO - (blobuploader) - INFO - Open directory for files ... 17:02:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:02:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:02:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:02:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:02:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:02:33 INFO - (blobuploader) - INFO - Done attempting. 17:02:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:02:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:02:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:02:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:02:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:02:34 INFO - (blobuploader) - INFO - Done attempting. 17:02:34 INFO - (blobuploader) - INFO - Iteration through files over. 17:02:34 INFO - Return code: 0 17:02:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:02:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:02:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a64839d7d4199020a6d0bbf2b3b0b224e75f67b77315d35115314e53ac86c1e83b156855d3b8ab482b57c3ae793a9c97fb121d9f6d52484fe6ad031799c242bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/671c60a5bf9e8d1171f46877c56d90c0b1c5525b757e68ec998ac89e00fd8d3db399cd2c8b5b500f4ec6e61caad9054ee7ca7a9a928512ef684f24e6f4836df8"} 17:02:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:02:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:02:34 INFO - Contents: 17:02:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a64839d7d4199020a6d0bbf2b3b0b224e75f67b77315d35115314e53ac86c1e83b156855d3b8ab482b57c3ae793a9c97fb121d9f6d52484fe6ad031799c242bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/671c60a5bf9e8d1171f46877c56d90c0b1c5525b757e68ec998ac89e00fd8d3db399cd2c8b5b500f4ec6e61caad9054ee7ca7a9a928512ef684f24e6f4836df8"} 17:02:34 INFO - Running post-run listener: copy_logs_to_upload_dir 17:02:34 INFO - Copying logs to upload dir... 17:02:34 INFO - mkdir: /builds/slave/test/build/upload/logs 17:02:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.472178 ========= master_lag: 2.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-25 17:02:37.477567) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-25 17:02:37.482118) ========= 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.fp2nMzGE3c/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.p49lwtylIB/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a64839d7d4199020a6d0bbf2b3b0b224e75f67b77315d35115314e53ac86c1e83b156855d3b8ab482b57c3ae793a9c97fb121d9f6d52484fe6ad031799c242bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/671c60a5bf9e8d1171f46877c56d90c0b1c5525b757e68ec998ac89e00fd8d3db399cd2c8b5b500f4ec6e61caad9054ee7ca7a9a928512ef684f24e6f4836df8"} build_url:https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/eoIdUuXOQGyGt26gguU5Jg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a64839d7d4199020a6d0bbf2b3b0b224e75f67b77315d35115314e53ac86c1e83b156855d3b8ab482b57c3ae793a9c97fb121d9f6d52484fe6ad031799c242bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/671c60a5bf9e8d1171f46877c56d90c0b1c5525b757e68ec998ac89e00fd8d3db399cd2c8b5b500f4ec6e61caad9054ee7ca7a9a928512ef684f24e6f4836df8"}' ========= master_lag: 1.66 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-02-25 17:02:39.156756) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-02-25 17:02:39.157151) ========= 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.fp2nMzGE3c/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.p49lwtylIB/Listeners TMPDIR=/var/folders/y_/gkptfz8n2s9frngl8ywr38k000000w/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.005265 ========= master_lag: 4.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2016-02-25 17:02:43.319808) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 17:02:43.323178) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 17:02:43.331945) ========= ========= Total master_lag: 8.51 =========