builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0037 starttime: 1456322660.72 results: success (0) buildid: 20160224043249 builduid: be0151c46f924ffe8eb84b0723ed87bd revision: d785fddce4c1c3c0f45e31acba243037292324eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:20.719957) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:20.720549) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:20.720888) ========= 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.wTODBySpX6/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.eRzu43jRcK/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005634 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:20.753105) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:20.753439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:20.771013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:20.771684) ========= 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.wTODBySpX6/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.eRzu43jRcK/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005793 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:20.824135) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:20.824778) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:20.825957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:20.826638) ========= 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.wTODBySpX6/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.eRzu43jRcK/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-24 06:04:20-- 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% 13.8M=0.001s 2016-02-24 06:04:21 (13.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.218952 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:21.062522) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:21.062887) ========= 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.wTODBySpX6/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.eRzu43jRcK/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.026452 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:21.115971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 06:04:21.116349) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d785fddce4c1c3c0f45e31acba243037292324eb --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 d785fddce4c1c3c0f45e31acba243037292324eb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wTODBySpX6/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.eRzu43jRcK/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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-24 06:04:21,194 truncating revision to first 12 chars 2016-02-24 06:04:21,194 Setting DEBUG logging. 2016-02-24 06:04:21,194 attempt 1/10 2016-02-24 06:04:21,194 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d785fddce4c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 06:04:22,333 unpacking tar archive at: fx-team-d785fddce4c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.789726 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 06:04:22.926106) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:22.926605) ========= echo d785fddce4c1c3c0f45e31acba243037292324eb in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd785fddce4c1c3c0f45e31acba243037292324eb'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wTODBySpX6/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.eRzu43jRcK/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 d785fddce4c1c3c0f45e31acba243037292324eb program finished with exit code 0 elapsedTime=0.005745 script_repo_revision: 'd785fddce4c1c3c0f45e31acba243037292324eb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:22.978513) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:22.978892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 06:04:22.993232) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-24 06:04:22.993563) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wTODBySpX6/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.eRzu43jRcK/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:04:23 INFO - MultiFileLogger online at 20160224 06:04:23 in /builds/slave/test 06:04:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:04:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:04:23 INFO - {'append_to_log': False, 06:04:23 INFO - 'base_work_dir': '/builds/slave/test', 06:04:23 INFO - 'blob_upload_branch': 'Fx-Team', 06:04:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:04:23 INFO - 'branch': 'Fx-Team', 06:04:23 INFO - 'buildbot_json_path': 'buildprops.json', 06:04:23 INFO - 'config_files': ('talos/mac_config.py',), 06:04:23 INFO - 'default_actions': ('clobber', 06:04:23 INFO - 'read-buildbot-config', 06:04:23 INFO - 'download-and-extract', 06:04:23 INFO - 'populate-webroot', 06:04:23 INFO - 'create-virtualenv', 06:04:23 INFO - 'install', 06:04:23 INFO - 'run-tests'), 06:04:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:04:23 INFO - 'download_minidump_stackwalk': True, 06:04:23 INFO - 'download_symbols': 'ondemand', 06:04:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:04:23 INFO - 'tooltool.py': '/tools/tooltool.py', 06:04:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:04:23 INFO - '/tools/misc-python/virtualenv.py')}, 06:04:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:04:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:04:23 INFO - 'installer_path': 'installer.exe', 06:04:23 INFO - 'log_level': 'info', 06:04:23 INFO - 'log_name': 'talos', 06:04:23 INFO - 'log_to_console': True, 06:04:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:04:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:04:23 INFO - 'opt_config_files': (), 06:04:23 INFO - 'pip_index': False, 06:04:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:04:23 INFO - 'cmd': ('bash', 06:04:23 INFO - '-c', 06:04:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:04:23 INFO - 'enabled': True, 06:04:23 INFO - 'halt_on_failure': False, 06:04:23 INFO - 'name': 'check_screen_resolution'},), 06:04:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:04:23 INFO - 'cmd': ('bash', 06:04:23 INFO - '-c', 06:04:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:04:23 INFO - 'enabled': True, 06:04:23 INFO - 'halt_on_failure': False, 06:04:23 INFO - 'name': 'check_screen_resolution'},), 06:04:23 INFO - 'run_cmd_checks_enabled': True, 06:04:23 INFO - 'sps_profile': False, 06:04:23 INFO - 'sps_profile_interval': 0, 06:04:23 INFO - 'suite': 'dromaeojs', 06:04:23 INFO - 'system_bits': '32', 06:04:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:04:23 INFO - 'title': 't-yosemite-r7-0037', 06:04:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:04:23 INFO - 'use_talos_json': True, 06:04:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:04:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:04:23 INFO - 'work_dir': 'build'} 06:04:23 INFO - ##### 06:04:23 INFO - ##### Running clobber step. 06:04:23 INFO - ##### 06:04:23 INFO - Running pre-action listener: _resource_record_pre_action 06:04:23 INFO - Running main action method: clobber 06:04:23 INFO - rmtree: /builds/slave/test/build 06:04:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:04:24 INFO - Running post-action listener: _resource_record_post_action 06:04:24 INFO - ##### 06:04:24 INFO - ##### Running read-buildbot-config step. 06:04:24 INFO - ##### 06:04:24 INFO - Running pre-action listener: _resource_record_pre_action 06:04:24 INFO - Running main action method: read_buildbot_config 06:04:24 INFO - Using buildbot properties: 06:04:24 INFO - { 06:04:24 INFO - "project": "", 06:04:24 INFO - "product": "firefox", 06:04:24 INFO - "script_repo_revision": "production", 06:04:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:04:24 INFO - "repository": "", 06:04:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:04:24 INFO - "buildid": "20160224043249", 06:04:24 INFO - "pgo_build": "False", 06:04:24 INFO - "basedir": "/builds/slave/test", 06:04:24 INFO - "buildnumber": 407, 06:04:24 INFO - "slavename": "t-yosemite-r7-0037", 06:04:24 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:04:24 INFO - "platform": "yosemite_r7", 06:04:24 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:04:24 INFO - "branch": "fx-team", 06:04:24 INFO - "repo_path": "integration/fx-team", 06:04:24 INFO - "revision": "d785fddce4c1c3c0f45e31acba243037292324eb", 06:04:24 INFO - "stage_platform": "macosx64", 06:04:24 INFO - "builduid": "be0151c46f924ffe8eb84b0723ed87bd", 06:04:24 INFO - "slavebuilddir": "test" 06:04:24 INFO - } 06:04:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 06:04:24 INFO - Running post-action listener: _resource_record_post_action 06:04:24 INFO - ##### 06:04:24 INFO - ##### Running download-and-extract step. 06:04:24 INFO - ##### 06:04:24 INFO - Running pre-action listener: _resource_record_pre_action 06:04:24 INFO - Running main action method: download_and_extract 06:04:24 INFO - mkdir: /builds/slave/test/build/tests 06:04:24 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')]} 06:04:24 INFO - https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:04:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/test_packages.json 06:04:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/test_packages.json 06:04:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:04:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:04:27 INFO - Downloaded 1277 bytes. 06:04:27 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:04:27 INFO - Using the following test package requirements: 06:04:27 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:04:27 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:04:27 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 06:04:27 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:04:27 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 06:04:27 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:04:27 INFO - u'jsshell-mac.zip'], 06:04:27 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:04:27 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 06:04:27 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:04:27 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:04:27 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 06:04:27 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:04:27 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 06:04:27 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:04:27 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 06:04:27 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:04:27 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:04:27 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 06:04:27 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:04:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:27 INFO - https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:04:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:04:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:04:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/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 06:04:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/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 06:04:28 INFO - Downloaded 17827731 bytes. 06:04:28 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'] 06:04:28 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 06:04:31 INFO - Return code: 0 06:04:31 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 06:04:31 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')]} 06:04:31 INFO - https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:04:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:04:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:04:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/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 06:04:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/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 06:04:35 INFO - Downloaded 17827731 bytes. 06:04:35 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'] 06:04:35 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 06:04:39 INFO - Return code: 0 06:04:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:39 INFO - https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:04:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:04:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:04:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/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 06:04:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/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 06:04:40 INFO - Downloaded 10707015 bytes. 06:04:40 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'] 06:04:40 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 06:04:41 INFO - Return code: 0 06:04:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:41 INFO - https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:04:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:04:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:04:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 06:04:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dQRvHBCPSlureB-W6hto4A/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 06:04:44 INFO - Downloaded 111449760 bytes. 06:04:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:04:44 INFO - mkdir: /builds/slave/test/properties 06:04:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:04:44 INFO - Writing to file /builds/slave/test/properties/build_url 06:04:44 INFO - Contents: 06:04:44 INFO - build_url:https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:04:45 INFO - Running post-action listener: _resource_record_post_action 06:04:45 INFO - Running post-action listener: set_extra_try_arguments 06:04:45 INFO - ##### 06:04:45 INFO - ##### Running populate-webroot step. 06:04:45 INFO - ##### 06:04:45 INFO - Running pre-action listener: _resource_record_pre_action 06:04:45 INFO - Running main action method: populate_webroot 06:04:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:04:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:04:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:04:45 INFO - '--tppagecycles', 06:04:45 INFO - '7'], 06:04:45 INFO - 'tests': ['tsvgm']}}, 06:04:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:04:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:04:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:04:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:04:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:04:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:04:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:04:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:45 INFO - 'talos_options': ['--e10s'], 06:04:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:04:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:45 INFO - 'tests': ['damp', 'tps']}, 06:04:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:45 INFO - 'talos_options': ['--e10s'], 06:04:45 INFO - 'tests': ['damp', 'tps']}, 06:04:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:04:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:04:45 INFO - 'other': {'tests': ['a11yr', 06:04:45 INFO - 'ts_paint', 06:04:45 INFO - 'tpaint', 06:04:45 INFO - 'sessionrestore', 06:04:45 INFO - 'sessionrestore_no_auto_restore']}, 06:04:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:04:45 INFO - 'tests': ['a11yr', 06:04:45 INFO - 'ts_paint', 06:04:45 INFO - 'tpaint', 06:04:45 INFO - 'sessionrestore', 06:04:45 INFO - 'sessionrestore_no_auto_restore']}, 06:04:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:04:45 INFO - 'tests': ['a11yr', 06:04:45 INFO - 'ts_paint', 06:04:45 INFO - 'tpaint', 06:04:45 INFO - 'sessionrestore', 06:04:45 INFO - 'sessionrestore_no_auto_restore']}, 06:04:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:04:45 INFO - 'tests': ['a11yr', 06:04:45 INFO - 'ts_paint', 06:04:45 INFO - 'tpaint', 06:04:45 INFO - 'sessionrestore', 06:04:45 INFO - 'sessionrestore_no_auto_restore']}, 06:04:45 INFO - 'other_l64': {'tests': ['a11yr', 06:04:45 INFO - 'ts_paint', 06:04:45 INFO - 'tpaint', 06:04:45 INFO - 'sessionrestore', 06:04:45 INFO - 'sessionrestore_no_auto_restore']}, 06:04:45 INFO - 'other_nol64': {'tests': ['a11yr', 06:04:45 INFO - 'ts_paint', 06:04:45 INFO - 'tpaint', 06:04:45 INFO - 'sessionrestore', 06:04:45 INFO - 'sessionrestore_no_auto_restore']}, 06:04:45 INFO - 'svgr': {'tests': ['tsvgx', 06:04:45 INFO - 'tsvgr_opacity', 06:04:45 INFO - 'tart', 06:04:45 INFO - 'tscrollx', 06:04:45 INFO - 'cart']}, 06:04:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:04:45 INFO - 'tests': ['tsvgx', 06:04:45 INFO - 'tsvgr_opacity', 06:04:45 INFO - 'tart', 06:04:45 INFO - 'tscrollx', 06:04:45 INFO - 'cart']}, 06:04:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:45 INFO - 'tests': ['tp5o']}, 06:04:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:45 INFO - 'talos_options': ['--e10s'], 06:04:45 INFO - 'tests': ['tp5o']}, 06:04:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:45 INFO - 'talos_options': ['--xperf_path', 06:04:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:04:45 INFO - 'tests': ['tp5n']}, 06:04:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:04:45 INFO - 'talos_options': ['--e10s', 06:04:45 INFO - '--xperf_path', 06:04:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:04:45 INFO - 'tests': ['tp5n']}}, 06:04:45 INFO - 'talos.zip': {'path': '', 06:04:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:04:45 INFO - Running post-action listener: _resource_record_post_action 06:04:45 INFO - ##### 06:04:45 INFO - ##### Running create-virtualenv step. 06:04:45 INFO - ##### 06:04:45 INFO - Running pre-action listener: _resource_record_pre_action 06:04:45 INFO - Running main action method: create_virtualenv 06:04:45 INFO - Creating virtualenv /builds/slave/test/build/venv 06:04:45 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 06:04:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:04:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:04:45 INFO - Using real prefix '/tools/python27' 06:04:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:04:46 INFO - Installing distribute.............................................................................................................................................................................................done. 06:04:49 INFO - Installing pip.................done. 06:04:49 INFO - Return code: 0 06:04:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:49 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 0x10d7c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7c84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa7bd9b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664d30>, '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 0x10d488db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d65bb20>, '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.wTODBySpX6/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.eRzu43jRcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:04:49 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 06:04:49 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 06:04:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTODBySpX6/Render', 06:04:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:49 INFO - 'HOME': '/Users/cltbld', 06:04:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:49 INFO - 'LOGNAME': 'cltbld', 06:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:49 INFO - 'MOZ_NO_REMOTE': '1', 06:04:49 INFO - 'NO_EM_RESTART': '1', 06:04:49 INFO - 'PAGER': '/bin/cat', 06:04:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:49 INFO - 'PWD': '/builds/slave/test', 06:04:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:49 INFO - 'SHELL': '/bin/bash', 06:04:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRzu43jRcK/Listeners', 06:04:49 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:04:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:49 INFO - 'USER': 'cltbld', 06:04:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:49 INFO - 'XPC_FLAGS': '0x0', 06:04:49 INFO - 'XPC_SERVICE_NAME': '0', 06:04:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:49 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 06:04:49 INFO - Cleaning up... 06:04:49 INFO - Return code: 0 06:04:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:49 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 0x10d7c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7c84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa7bd9b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664d30>, '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 0x10d488db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d65bb20>, '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.wTODBySpX6/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.eRzu43jRcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:04:49 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 06:04:49 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 06:04:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTODBySpX6/Render', 06:04:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:49 INFO - 'HOME': '/Users/cltbld', 06:04:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:49 INFO - 'LOGNAME': 'cltbld', 06:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:49 INFO - 'MOZ_NO_REMOTE': '1', 06:04:49 INFO - 'NO_EM_RESTART': '1', 06:04:49 INFO - 'PAGER': '/bin/cat', 06:04:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:49 INFO - 'PWD': '/builds/slave/test', 06:04:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:49 INFO - 'SHELL': '/bin/bash', 06:04:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRzu43jRcK/Listeners', 06:04:49 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:04:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:49 INFO - 'USER': 'cltbld', 06:04:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:49 INFO - 'XPC_FLAGS': '0x0', 06:04:49 INFO - 'XPC_SERVICE_NAME': '0', 06:04:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:49 INFO - Downloading/unpacking psutil>=0.7.1 06:04:49 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 06:04:49 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 06:04:49 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 06:04:49 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 06:04:49 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 06:04:49 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 06:04:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:04:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:04:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:04:52 INFO - Installing collected packages: psutil 06:04:52 INFO - Running setup.py install for psutil 06:04:52 INFO - building 'psutil._psutil_osx' extension 06:04:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:04:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:04:52 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:04:52 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:04:53 INFO - building 'psutil._psutil_posix' extension 06:04:53 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 06:04:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:04:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:04:53 INFO - ^ 06:04:53 INFO - 1 warning generated. 06:04:53 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 06:04:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:04:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:04:53 INFO - Successfully installed psutil 06:04:53 INFO - Cleaning up... 06:04:53 INFO - Return code: 0 06:04:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:53 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 0x10d7c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7c84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa7bd9b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664d30>, '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 0x10d488db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d65bb20>, '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.wTODBySpX6/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.eRzu43jRcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:04:53 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 06:04:53 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 06:04:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTODBySpX6/Render', 06:04:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:53 INFO - 'HOME': '/Users/cltbld', 06:04:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:53 INFO - 'LOGNAME': 'cltbld', 06:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:53 INFO - 'MOZ_NO_REMOTE': '1', 06:04:53 INFO - 'NO_EM_RESTART': '1', 06:04:53 INFO - 'PAGER': '/bin/cat', 06:04:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:53 INFO - 'PWD': '/builds/slave/test', 06:04:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:53 INFO - 'SHELL': '/bin/bash', 06:04:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRzu43jRcK/Listeners', 06:04:53 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:04:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:53 INFO - 'USER': 'cltbld', 06:04:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:53 INFO - 'XPC_FLAGS': '0x0', 06:04:53 INFO - 'XPC_SERVICE_NAME': '0', 06:04:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:04:53 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 06:04:53 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 06:04:53 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 06:04:53 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 06:04:53 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 06:04:53 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 06:04:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:04:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:04:56 INFO - Installing collected packages: mozsystemmonitor 06:04:56 INFO - Running setup.py install for mozsystemmonitor 06:04:56 INFO - Successfully installed mozsystemmonitor 06:04:56 INFO - Cleaning up... 06:04:56 INFO - Return code: 0 06:04:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:04:56 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')]} 06:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:56 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')]} 06:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:04:56 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 0x10d7c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7c84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa7bd9b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664d30>, '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 0x10d488db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d65bb20>, '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.wTODBySpX6/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.eRzu43jRcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:04:56 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 06:04:56 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 06:04:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTODBySpX6/Render', 06:04:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:04:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:04:56 INFO - 'HOME': '/Users/cltbld', 06:04:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:04:56 INFO - 'LOGNAME': 'cltbld', 06:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:04:56 INFO - 'MOZ_NO_REMOTE': '1', 06:04:56 INFO - 'NO_EM_RESTART': '1', 06:04:56 INFO - 'PAGER': '/bin/cat', 06:04:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:04:56 INFO - 'PWD': '/builds/slave/test', 06:04:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:04:56 INFO - 'SHELL': '/bin/bash', 06:04:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRzu43jRcK/Listeners', 06:04:56 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:04:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:04:56 INFO - 'USER': 'cltbld', 06:04:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:04:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:04:56 INFO - 'XPC_FLAGS': '0x0', 06:04:56 INFO - 'XPC_SERVICE_NAME': '0', 06:04:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:04:56 INFO - Downloading/unpacking blobuploader==1.2.4 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:04:58 INFO - Downloading blobuploader-1.2.4.tar.gz 06:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:04:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:04:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:04:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:04: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 06:05:00 INFO - Downloading docopt-0.6.1.tar.gz 06:05:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:05:00 INFO - Installing collected packages: blobuploader, requests, docopt 06:05:00 INFO - Running setup.py install for blobuploader 06:05:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:05:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:05:00 INFO - Running setup.py install for requests 06:05:00 INFO - Running setup.py install for docopt 06:05:00 INFO - Successfully installed blobuploader requests docopt 06:05:00 INFO - Cleaning up... 06:05:01 INFO - Return code: 0 06:05:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:01 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')]} 06:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:01 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')]} 06:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:01 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 0x10d7c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7c84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa7bd9b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664d30>, '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 0x10d488db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d65bb20>, '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.wTODBySpX6/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.eRzu43jRcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:05:01 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 06:05:01 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 06:05:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTODBySpX6/Render', 06:05:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:01 INFO - 'HOME': '/Users/cltbld', 06:05:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:01 INFO - 'LOGNAME': 'cltbld', 06:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:01 INFO - 'MOZ_NO_REMOTE': '1', 06:05:01 INFO - 'NO_EM_RESTART': '1', 06:05:01 INFO - 'PAGER': '/bin/cat', 06:05:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:01 INFO - 'PWD': '/builds/slave/test', 06:05:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:01 INFO - 'SHELL': '/bin/bash', 06:05:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRzu43jRcK/Listeners', 06:05:01 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:05:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:01 INFO - 'USER': 'cltbld', 06:05:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:01 INFO - 'XPC_FLAGS': '0x0', 06:05:01 INFO - 'XPC_SERVICE_NAME': '0', 06:05:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:01 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-bIgPjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:01 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-jGn17W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:01 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-1VwPvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:01 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-IMubhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:01 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-T_8MQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:01 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-fIaw2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:01 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-DDnPi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:02 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Ihcg8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:02 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-1N1Y2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:02 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Bu35l4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:02 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-zRvEfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:02 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-KtowW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:02 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-qWiXvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:02 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-HqLItM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:02 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-kWRoML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:02 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-qr0rDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:02 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-mfJfjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:05:03 INFO - Running setup.py install for manifestparser 06:05:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:05:03 INFO - Running setup.py install for mozcrash 06:05:03 INFO - Running setup.py install for mozdebug 06:05:03 INFO - Running setup.py install for mozdevice 06:05:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:05:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:05:03 INFO - Running setup.py install for mozfile 06:05:03 INFO - Running setup.py install for mozhttpd 06:05:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:05:03 INFO - Running setup.py install for mozinfo 06:05:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:05:04 INFO - Running setup.py install for mozInstall 06:05:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:05:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:05:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:05:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:05:04 INFO - Running setup.py install for mozleak 06:05:04 INFO - Running setup.py install for mozlog 06:05:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:05:04 INFO - Running setup.py install for moznetwork 06:05:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:05:04 INFO - Running setup.py install for mozprocess 06:05:04 INFO - Running setup.py install for mozprofile 06:05:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:05:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:05:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:05:05 INFO - Running setup.py install for mozrunner 06:05:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:05:05 INFO - Running setup.py install for mozscreenshot 06:05:05 INFO - Running setup.py install for moztest 06:05:05 INFO - Running setup.py install for mozversion 06:05:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:05:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:05:05 INFO - Cleaning up... 06:05:05 INFO - Return code: 0 06:05:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:05 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')]} 06:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:05 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')]} 06:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:05 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 0x10d7c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7c84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa7bd9b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664d30>, '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 0x10d488db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d65bb20>, '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.wTODBySpX6/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.eRzu43jRcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:05:05 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 06:05:05 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 06:05:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTODBySpX6/Render', 06:05:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:05 INFO - 'HOME': '/Users/cltbld', 06:05:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:05 INFO - 'LOGNAME': 'cltbld', 06:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:05 INFO - 'MOZ_NO_REMOTE': '1', 06:05:05 INFO - 'NO_EM_RESTART': '1', 06:05:05 INFO - 'PAGER': '/bin/cat', 06:05:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:05 INFO - 'PWD': '/builds/slave/test', 06:05:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:05 INFO - 'SHELL': '/bin/bash', 06:05:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRzu43jRcK/Listeners', 06:05:05 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:05:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:05 INFO - 'USER': 'cltbld', 06:05:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:05 INFO - 'XPC_FLAGS': '0x0', 06:05:05 INFO - 'XPC_SERVICE_NAME': '0', 06:05:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:05 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-SFgLKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:06 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)) 06:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:06 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ZbM5Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:06 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)) 06:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:06 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Cl9ZFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:06 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)) 06:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:06 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-rk_ZHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:06 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)) 06:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:06 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-4WzDkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:06 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)) 06:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:06 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-kMXXK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:06 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)) 06:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:06 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Lg_p7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:06 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)) 06:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:06 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-XIGYE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:06 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)) 06:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:06 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-9cvma0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:06 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)) 06:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:06 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-hrXIEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:06 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-y_Q310-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:07 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)) 06:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:07 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Wy3XJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:07 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)) 06:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:07 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-aenNlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:07 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)) 06:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:07 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-pqWOju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:07 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)) 06:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:07 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-v8TO5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:07 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)) 06:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:07 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-2LKH7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:07 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)) 06:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:07 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-8yiiHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:07 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)) 06:05:07 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)) 06:05:07 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)) 06:05:07 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)) 06:05:07 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)) 06:05:07 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)) 06:05:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:09 INFO - Downloading blessings-1.6.tar.gz 06:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:05:10 INFO - Installing collected packages: blessings 06:05:10 INFO - Running setup.py install for blessings 06:05:10 INFO - Successfully installed blessings 06:05:10 INFO - Cleaning up... 06:05:10 INFO - Return code: 0 06:05:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:10 INFO - Reading from file tmpfile_stdout 06:05:10 INFO - Current package versions: 06:05:10 INFO - blessings == 1.6 06:05:10 INFO - blobuploader == 1.2.4 06:05:10 INFO - docopt == 0.6.1 06:05:10 INFO - manifestparser == 1.1 06:05:10 INFO - mozInstall == 1.12 06:05:10 INFO - mozcrash == 0.16 06:05:10 INFO - mozdebug == 0.1 06:05:10 INFO - mozdevice == 0.48 06:05:10 INFO - mozfile == 1.2 06:05:10 INFO - mozhttpd == 0.7 06:05:10 INFO - mozinfo == 0.9 06:05:10 INFO - mozleak == 0.1 06:05:10 INFO - mozlog == 3.1 06:05:10 INFO - moznetwork == 0.27 06:05:10 INFO - mozprocess == 0.22 06:05:10 INFO - mozprofile == 0.28 06:05:10 INFO - mozrunner == 6.11 06:05:10 INFO - mozscreenshot == 0.1 06:05:10 INFO - mozsystemmonitor == 0.0 06:05:10 INFO - moztest == 0.7 06:05:10 INFO - mozversion == 1.4 06:05:10 INFO - psutil == 3.1.1 06:05:10 INFO - requests == 1.2.3 06:05:10 INFO - wsgiref == 0.1.2 06:05:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:10 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 0x10d7c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7c84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa7bd9b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664d30>, '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 0x10d488db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d65bb20>, '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.wTODBySpX6/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.eRzu43jRcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:05:10 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 06:05:10 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 06:05:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTODBySpX6/Render', 06:05:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:10 INFO - 'HOME': '/Users/cltbld', 06:05:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:10 INFO - 'LOGNAME': 'cltbld', 06:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:10 INFO - 'MOZ_NO_REMOTE': '1', 06:05:10 INFO - 'NO_EM_RESTART': '1', 06:05:10 INFO - 'PAGER': '/bin/cat', 06:05:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:10 INFO - 'PWD': '/builds/slave/test', 06:05:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:10 INFO - 'SHELL': '/bin/bash', 06:05:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRzu43jRcK/Listeners', 06:05:10 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:05:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:10 INFO - 'USER': 'cltbld', 06:05:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:10 INFO - 'XPC_FLAGS': '0x0', 06:05:10 INFO - 'XPC_SERVICE_NAME': '0', 06:05:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:05:10 INFO - Cleaning up... 06:05:10 INFO - Return code: 0 06:05:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d7c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7c84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa7bd9b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664d30>, '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 0x10d488db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d65bb20>, '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.wTODBySpX6/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.eRzu43jRcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:05:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTODBySpX6/Render', 06:05:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:10 INFO - 'HOME': '/Users/cltbld', 06:05:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:10 INFO - 'LOGNAME': 'cltbld', 06:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:10 INFO - 'MOZ_NO_REMOTE': '1', 06:05:10 INFO - 'NO_EM_RESTART': '1', 06:05:10 INFO - 'PAGER': '/bin/cat', 06:05:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:10 INFO - 'PWD': '/builds/slave/test', 06:05:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:10 INFO - 'SHELL': '/bin/bash', 06:05:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRzu43jRcK/Listeners', 06:05:10 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:05:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:10 INFO - 'USER': 'cltbld', 06:05:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:10 INFO - 'XPC_FLAGS': '0x0', 06:05:10 INFO - 'XPC_SERVICE_NAME': '0', 06:05:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:11 INFO - Downloading/unpacking jsonschema 06:05:11 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 06:05:11 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 06:05:11 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 06:05:11 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 06:05:11 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 06:05:11 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 06:05:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:05:13 INFO - Downloading/unpacking functools32 (from jsonschema) 06:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:13 INFO - Downloading functools32-3.2.3-2.tar.gz 06:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:05:13 INFO - warning: no files found matching '*.txt' 06:05:13 INFO - no previously-included directories found matching 'build' 06:05:13 INFO - no previously-included directories found matching 'dist' 06:05:13 INFO - no previously-included directories found matching '.git*' 06:05:13 INFO - Installing collected packages: jsonschema, functools32 06:05:13 INFO - Running setup.py install for functools32 06:05:14 INFO - warning: no files found matching '*.txt' 06:05:14 INFO - no previously-included directories found matching 'build' 06:05:14 INFO - no previously-included directories found matching 'dist' 06:05:14 INFO - no previously-included directories found matching '.git*' 06:05:14 INFO - Successfully installed jsonschema functools32 06:05:14 INFO - Cleaning up... 06:05:14 INFO - Return code: 0 06:05:14 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:14 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 0x10d7c0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d7c84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa7bd9b640>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664d30>, '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 0x10d488db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d65bb20>, '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.wTODBySpX6/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.eRzu43jRcK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 06:05:14 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 06:05:14 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 06:05:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTODBySpX6/Render', 06:05:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:14 INFO - 'HOME': '/Users/cltbld', 06:05:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:14 INFO - 'LOGNAME': 'cltbld', 06:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:14 INFO - 'MOZ_NO_REMOTE': '1', 06:05:14 INFO - 'NO_EM_RESTART': '1', 06:05:14 INFO - 'PAGER': '/bin/cat', 06:05:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:14 INFO - 'PWD': '/builds/slave/test', 06:05:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:14 INFO - 'SHELL': '/bin/bash', 06:05:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRzu43jRcK/Listeners', 06:05:14 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:05:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:14 INFO - 'USER': 'cltbld', 06:05:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:14 INFO - 'XPC_FLAGS': '0x0', 06:05:14 INFO - 'XPC_SERVICE_NAME': '0', 06:05:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:14 INFO - Downloading/unpacking flake8 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:05:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:05:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05: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 06:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:17 INFO - no previously-included directories found matching 'docs/_build' 06:05:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:05:18 INFO - Running setup.py install for pep8 06:05:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:05:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:05:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:05:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:05:18 INFO - no previously-included directories found matching 'docs/_build' 06:05:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:05:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:05:18 INFO - Cleaning up... 06:05:18 INFO - Return code: 0 06:05:18 INFO - Running post-action listener: _resource_record_post_action 06:05:18 INFO - Running post-action listener: _start_resource_monitoring 06:05:18 INFO - Starting resource monitoring. 06:05:18 INFO - ##### 06:05:18 INFO - ##### Running install step. 06:05:18 INFO - ##### 06:05:18 INFO - Running pre-action listener: _resource_record_pre_action 06:05:18 INFO - Running main action method: install 06:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:18 INFO - Reading from file tmpfile_stdout 06:05:18 INFO - Detecting whether we're running mozinstall >=1.0... 06:05:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:05:18 INFO - Reading from file tmpfile_stdout 06:05:18 INFO - Output received: 06:05:18 INFO - Usage: mozinstall [options] installer 06:05:18 INFO - Options: 06:05:18 INFO - -h, --help show this help message and exit 06:05:18 INFO - -d DEST, --destination=DEST 06:05:18 INFO - Directory to install application into. [default: 06:05:18 INFO - "/builds/slave/test"] 06:05:18 INFO - --app=APP Application being installed. [default: firefox] 06:05:18 INFO - mkdir: /builds/slave/test/build/application 06:05:18 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'] 06:05:18 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 06:05:52 INFO - Reading from file tmpfile_stdout 06:05:52 INFO - Output received: 06:05:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:05:52 INFO - Running post-action listener: _resource_record_post_action 06:05:52 INFO - ##### 06:05:52 INFO - ##### Running run-tests step. 06:05:52 INFO - ##### 06:05:52 INFO - Running pre-action listener: _resource_record_pre_action 06:05:52 INFO - Running main action method: run_tests 06:05:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:05:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:05:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:05:52 INFO - 2016-02-24 06:05:52.874 screenresolution[1653:7588] starting screenresolution argv=screenresolution get 06:05:52 INFO - 2016-02-24 06:05:52.877 screenresolution[1653:7588] Display 0: 1600x1200x32@60 06:05:52 INFO - 2016-02-24 06:05:52.883 screenresolution[1654:7590] starting screenresolution argv=screenresolution list 06:05:52 INFO - Available Modes on Display 0 06:05:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:05:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:05:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:05:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:05:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:05:53 INFO - Intel Iris: 06:05:53 INFO - Chipset Model: Intel Iris 06:05:53 INFO - Type: GPU 06:05:53 INFO - Bus: Built-In 06:05:53 INFO - VRAM (Dynamic, Max): 1536 MB 06:05:53 INFO - Vendor: Intel (0x8086) 06:05:53 INFO - Device ID: 0x0a2e 06:05:53 INFO - Revision ID: 0x0009 06:05:53 INFO - Displays: 06:05:53 INFO - Display: 06:05:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:05:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:05:53 INFO - Display Serial Number: 1600x1200 60 06:05:53 INFO - Main Display: Yes 06:05:53 INFO - Mirror: Off 06:05:53 INFO - Online: Yes 06:05:53 INFO - Rotation: Supported 06:05:53 INFO - Return code: 0 06:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:05:53 INFO - Python 2.7.3 06:05:53 INFO - Return code: 0 06:05:53 INFO - grabbing minidump binary from tooltool 06:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:05:53 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664d30>, '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 0x10d488db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d65bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:05:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:05:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:05:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:05:53 INFO - Return code: 0 06:05:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:05:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:05:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:05:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:05:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:05:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:05:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:05:54 INFO - Return code: 0 06:05:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:05:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:05:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTODBySpX6/Render', 06:05:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:05:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:05:54 INFO - 'HOME': '/Users/cltbld', 06:05:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:05:54 INFO - 'LOGNAME': 'cltbld', 06:05:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:05:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:54 INFO - 'MOZ_NO_REMOTE': '1', 06:05:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:05:54 INFO - 'NO_EM_RESTART': '1', 06:05:54 INFO - 'PAGER': '/bin/cat', 06:05:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:54 INFO - 'PWD': '/builds/slave/test', 06:05:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:05:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:05:54 INFO - 'SHELL': '/bin/bash', 06:05:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eRzu43jRcK/Listeners', 06:05:54 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 06:05:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:05:54 INFO - 'USER': 'cltbld', 06:05:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:05:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:54 INFO - 'XPC_FLAGS': '0x0', 06:05:54 INFO - 'XPC_SERVICE_NAME': '0', 06:05:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:05:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:05:54 INFO - mozversion application_buildid: 20160224043249 06:05:54 INFO - mozversion application_changeset: d785fddce4c1c3c0f45e31acba243037292324eb 06:05:54 INFO - mozversion application_display_name: Nightly 06:05:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:05:54 INFO - mozversion application_name: Firefox 06:05:54 INFO - mozversion application_remotingname: firefox 06:05:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:05:54 INFO - mozversion application_vendor: Mozilla 06:05:54 INFO - mozversion application_version: 47.0a1 06:05:54 INFO - mozversion platform_buildid: 20160224043249 06:05:54 INFO - mozversion platform_changeset: d785fddce4c1c3c0f45e31acba243037292324eb 06:05:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:05:54 INFO - mozversion platform_version: 47.0a1 06:05:54 INFO - using testdate: 1456322754 06:05:54 INFO - actual date: 1456322754 06:05:55 INFO - starting webserver on 'localhost:49274' 06:05:55 INFO - SUITE-START | Running 2 tests 06:05:55 INFO - TEST-START | dromaeo_css 06:05:55 INFO - operating with platform_type : mac_ 06:05:55 INFO - Initialising browser for dromaeo_css test... 06:05:55 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpJSu__R/profile http://localhost:49274/getInfo.html) 06:05:57 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 06:05:57 INFO - PROCESS | 1672 | colorDepth:24 06:05:57 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 06:05:57 INFO - PROCESS | 1672 | __metrics 06:05:57 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:05:57 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:58 INFO - TEST-INFO | 1672: exit 0 06:05:58 INFO - Browser initialized. 06:05:58 INFO - Running cycle 1/1 for dromaeo_css test... 06:05:58 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpJSu__R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:10 INFO - PROCESS | 1675 | RSS: Main: 244625408 06:06:10 INFO - PROCESS | 1675 | 06:07:01 INFO - PROCESS | 1675 | 1456322821005 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] 06:09:11 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 06:09:12 INFO - PROCESS | 1675 | RSS: Main: 346435584 06:09:12 INFO - PROCESS | 1675 | 06:12:14 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 06:12:15 INFO - PROCESS | 1675 | RSS: Main: 377315328 06:12:15 INFO - PROCESS | 1675 | 06:15:17 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 06:15:18 INFO - PROCESS | 1675 | RSS: Main: 375095296 06:15:18 INFO - PROCESS | 1675 | 06:18:20 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 06:18:20 INFO - PROCESS | 1675 | RSS: Main: 331698176 06:18:20 INFO - PROCESS | 1675 | 06:21:24 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 06:21:24 INFO - PROCESS | 1675 | RSS: Main: 337555456 06:21:24 INFO - PROCESS | 1675 | 06:24:27 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 06:24:27 INFO - PROCESS | 1675 | RSS: Main: 383877120 06:24:27 INFO - PROCESS | 1675 | 06:24:27 INFO - PROCESS | 1675 | __start_tp_report 06:24:27 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 06:24:27 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 06:24:27 INFO - PROCESS | 1675 | |i|pagename|runs| 06:24:27 INFO - PROCESS | 1675 | |0;dojo.html;2813.5076361636716;3439.29494453637;3477.2350082981734;3482.4950382194597;3512.560929883763;5532.889342213163;5586.10622300432;5591.608587398879;5596.860078498029;5598.832035038945;5640.915386269209;5657.010023245925;5660.9716951415285;5797.536197104232;5807.912881306773;5035.546800787928;5048.469910659373;5052.368453943257;5098.107831129556;5212.50481204285;4241.27898257297;5180.948190518103;5239.947600523984;5248.580113590903;5287.682739035651;4974.030064137494;5017.147084995541;5104.744762761884;5106.463821298785;5114.514121158521;5100.566451851597;5101.846944591631;5102.846914592568;5143.177091665353;5150.381954165487;5006.424261209934;5058;5082.79668813247;5094.465081166498;5107.157319042353;5406.54044406226;5493.615446918718;5580.748866300985;5583.497485226349;5587.05020146576;6129.662868542228;6130.233720784902;6150.692465376714;6150.846228844314;6163.2604087509335;6040.848978775566;6158.414950579688;6231;6249.0626406039;6253.249610046823;5679.574031947621;5737.913931291076;5745.540356771448;5748.971255143698;5790.957627627025;6298.0552917062805;6305.369463053658;6312.5581209314905;6319.24169099711;6333.683315834282;5831.008728516163;5880.353161152269;5900.0264956281735;6034.5172386209;6037.486813620892;6124.846878828065;6142.692865356715;6151.108089327112;6207;6208.099825525273;6039.456448919618;6084.574079814459;6093.512518998469;6095.299040610298;6108.389161083945;5970.850728731816;6081.300650425169;6083.482903953213;6084.5436592255755;6152.846178845564;4843.467218605951;4853.587445067138;4874.0495603357;4874.780634871439;4904.411470623477;4361.105973275471;4361.454818147731;4364.585364390377;4383.342498625232;4408.4930233023615;5563.693996830132;5598.300212473441;5625.46558076982;5644.350899646511;5701;6175.752969881244;6197.907031394533;6214.627122372672;6222.439980401786;6223.222097237845;5526.115821468546;5651.8304450866535;5654.46282603152;5660.575456840754;5679.148127780783;5284;5304.098303288451;5343.919841202385;5356.973215133899;5385.8114965976;6279.058141278845;6280.623162610166;6282.623042617458;6286.465650419766;6294.748210071546;6124.5406594506485;6148.678034222664;6260.68696565179;6270.2475702915945;6277.1525844010475;6232.626042437469;6279.058141278845;6281.560290779602;6311.621302721668;6317.684115794284;6036.6679832609625;6085.756569737161;6086.847828804315;6100.786472473442;6108.664023478751;6034.969825150846;6146.477549408351;6218.657973811303;6233.844153896008;6234.127222188807;4105.548389677074;5268.473152684701;5931.584789064724;5970.582059255984;5995.520358371407;5920.674362910081;5937.703114844327;5941.792037278848;5945.91081133792;5949;5713.628614140068;5812.709364531841;5818.4763371296785;5849.707514624167;5960.642361458326;6011.7595296187665;6042.879142417215;6044.365341639064;6086.117512960507;6090.390960903874;5738.397468265772;5858.121281807763;5859.707014649165;5872.794452194153;5873.618214816023 06:24:27 INFO - PROCESS | 1675 | |1;ext.html;487.072127596928;565.0140504819088;587.9353271140175;593.6467801658014;596.7881402102254;38022.429663555034;38344.42483362748;38370.99999999996;38396.61603383965;38410.23179536415;41019;41426;41440.17119657613;41447.79276103615;41468.792656036676;8954.149355811203;9227.492487913161;9230.16928476437;9243.537823108818;9263.397879137869;9641.13229809317;9804.264680148981;9812.067853553937;9814.018598140165;9846.261530385214;9757.609695612167;9847.901520984806;9851.50742462874;9854.40873547586;9855.457949812757;9757.951210243938;9833.31166818323;9835.409875407498;9850.9507452463;9851.605935762562;8198.877016844752;9677.564509597085;9691.563879625433;9695.90304096964;9714.22286217108;39130.02174945621;39367.818965431085;39445;39477.60522394797;39488.21023579541;2002.975073585591;3013.89451369201;3097.938041239185;3596.4605309203566;3974.3641017437362;26598;27411;28062.579061314096;28116.297092572644;28129.156125316273;2698.5277576424046;2763.1848604661673;2885.5960165576626;2887.754540864029;2976.687447817991;356332;356518;356929.43070569483;357414;357881;62300;62985.37014629887;63158;63461.68269158625;63568;65950.34049659538;66085.00872486917;66103.33896661068;66109;66142.66928665421;16205.10871902033;16382.918085409736;16955.23701433414;16972.49082527526;17033.659326813395;11538.134639901873;12988.220706757626;13004;13019.544315948897;13032.674183145496;19336.323228686928;20029.699554506693;20050.799492005186;20087.698684519743;20146.496337591383;7199.244079371695;8376.706815261437;8442.366822488339;8555.230029297392;8564.61459234336;802.3180296747835;952.3286631960864;1063.4363787192801;1118.4910865556153;1177.652592485219;28584.285392865346;28920;29451.705482944897;29517.409651806844;29645.703542964726;1007.1741172238841;1035.316690983947;1036.8911264317137;1060.8302671572512;1061.5594528270835;13915.512957046454;13966.952478564148;14006.879449644004;14201.715965680629;14293.356798944073;524519;527878;533476.3326183421;536882;540416;55966;55970;56155.43844561584;56328.18359082029;56482;1424.501424501437;1439.5321520505877;1460.3720400228003;1461.6784307452344;1462.7293950618957;27720.8613956937;28208.85895570591;31531;31733.36533269368;31900.68099318977;46468.83827904194;54898.62753431196;55749;55819;56005.31984040485;403979;411674;412421;412788;412886;36938.8153059233;37176.81411592925;41437.171256574096;44338;45671;43605.56394436015;43907.78046109749;44152.33771493495;45353.31970020518;45367;37521.62478375181;38058.42912356372;38761;38906.6109338903;38923.2215355697;30536;34991.12522186965;37865.05337366478;38512;39166.608333916294;35983.460248096824;36484;37003;37811.62188378081;38204.23591528209;32982.34035319328;33413.79000807938;34006.3198736019;34036.82981585076;34091.82954085214;19864.90067549653;22702.659460108443;25024.124155654466;25199;25759.613605795552 06:24:27 INFO - PROCESS | 1675 | |2;jquery.html;362.9183433727411;366.1742770053529;366.7744337232602;371.9665230129288;372.88254199927036;15119.092854428742;15681.451149209779;19199;19631.018449077543;20771.480712982182;15000.174990375524;16437.753433698505;19708.605827883435;19752.40742777719;19760.20959161632;5034.622403319748;5184.015037142931;5266.289050978126;5270.077736396115;5276.498732620415;3972.165845172503;5180.896382072357;5238.371395432553;5239.004589128053;5810.82567522975;6028.788992385267;6061.302950160722;6063.272407311107;6066.393360663942;6069.089636554508;6040.546958978094;6048.939510604903;6058.091286307045;6544.214694236722;6550.475961923034;5738.569607279429;5756.424357564252;5756.827295181151;5764.07774756037;5767.509761670263;12926.224426534343;22125.557488850132;24625.753742462704;24810;24869.5026099477;1687.2503901517189;1884.8397886179691;1951.1219951022097;2042.28520017994;2103.4215590712524;10071.647492337734;10438.895611043945;11510.942445287803;14100.012999090068;15017.924910375377;1756.739905728603;1760.375066851262;1783.3758184635403;1789.33794496036;1808.9547761305942;98010;99302.50348748283;100335.99328013399;109215.90784092137;110307.44846275798;10987.285826421257;11316.321020738782;11319.207655464203;11322.094232461382;11427.885721142848;13439.932800335935;13534.984876134133;13534.98487613433;13556.525521606894;13576.321183940763;7481.663325150382;8072.354211663052;8432.283255923316;8549.401541892008;8589.8711519326;8591.183837535424;8620.956895215484;8622.568871556397;8669.436486628349;8708.608112634947;4400.141972315368;4465.12929978651;4466.6203372713035;4518;4530.79611417487;1842.861785366076;1912.913918873654;1926.3450426854936;1927.7301177835113;1934.3423236099793;878.7056336127469;884.7390019944132;904.3624244907325;958.3291695812959;983.5082458770614;19493.610127797365;19872.60254794896;20244.493887652927;20262.392128236177;20775.168993240102;902.7562558109274;940.3887473142375;950.2208189284859;982.8673129127476;997.4295100189452;10527.368357898551;10751.892481075089;10799.622013229498;10863.67408977732;10936.507857146447;474726;477481;568266;599025;603027;84588.57705711432;86561.56719216364;101401.49299253603;110166;127172;1010.4190090697878;1034.8758149022015;1050.6742909698019;1055.3245922609535;1056.5773690523852;13333.599992000256;16407.571046746267;17274.740878887078;18348.26606935761;18356.72464913054;49375.753121235604;52711.94576108533;52830;53464.46535534751;53919.73040134774;66216;68935.31064689289;69284;72248.94257401931;72394;7932.524048557105;8024.719134830487;8140.552269625227;8179.713710020359;8301.29438997692;9352.438853668802;12419.75160496803;13084.887784538421;13309;13319.93440524775;11145.161048426919;11423.314601123959;11513.963743263146;11591.536338546364;11677.357745324089;9110.453372797654;11002.009819116318;11085.667429977113;11253.887461125283;11468.483918223867;11604.709882253012;11736.237144585575;11969.94015029954;11982.460789264678;12003.819942700691;8072.233137851895;8171.468854524437;8201.630926608435;8219.95890020546;8282.958585207276;9208.861867072133;11916.702082448008;11941.820872686743;11978.46096925623;12003.399830008639 06:24:27 INFO - PROCESS | 1675 | |3;mootools.html;1352.7767918293482;1430.8783753380962;1585.3975489314062;1775.9467215983516;1961.8234358907696;7816.218378162188;8388.07731149573;8556;8570.314374850013;8582.013068497117;8265.710700125497;8563.657453701844;8564.657413703444;8571.928508936382;8581.313494920407;2125.203048856679;2351.2240960483;2390.713114426271;2412.0472413396787;2421.636754486832;2435.2329016359877;2436.427439551704;2438.5244877248942;2443.4135807406274;2444.2178502879087;2243.5288589396164;2264.8449290861613;2351.44740985869;2416.32342943976;2430.44099857033;2111.3032699209225;2342.9062837486567;2397.880105994693;2399.3401814500976;2400.9519809603885;2337.4273303040864;2370.952580948371;2380.297812145404;2381.833271670984;2405.230326295586;8448.028476725194;8538.70114545988;8545.034642032306;8554.914450855475;8563.100874408223;5197.740112994373;5380.166074258496;5386.730663466811;5402.108652072403;5460.6177567570285;3525.2244506208594;3550.1834578046937;3638;3657.2319812839337;3663.835127419246;1025.635899255761;1035.5250950228958;1045.268312181476;1053.3574519543072;1058.5130839813694;9940.950295248622;11732.120090993125;11738.06095512357;11763.058955283643;11775;4690.249560070372;4800.543948324904;4852.417709874838;4861.29511220871;4873.878153046202;9985.700428987142;9994.950025249827;10001.949990250003;10005.349652272724;10009.199264058858;4931.3589233399425;5404.756785944642;5428.4028756836715;5435.1303791393975;5438.782448702008;4519.480259770168;4736.976315118402;4836.347093142381;4898.387701537308;4899.485554016848;3866.0721426857353;3888.5528164260904;3898.1813819098306;3930.9606903931167;3942.743721658083;1154.9133814963911;1297.4810075969688;1308.5093090091216;1316.059017802276;1318.0114913814639;1305.0473154597007;1338.9866101338862;1341.8121462995189;1345.1391109689612;1360.5782207515701;8046.114927357986;8046.994125734283;8204.958975205085;8221.095679475253;8250.752477425687;1007.4912169354576;1118.6588090632436;1197.7245233596148;1205.5263236420478;1224.577520755338;5929.525637948954;6322;6351.809445716636;6364.49084073273;6370.267419246846;10212.795744085077;10744.838827417596;10767.89232107669;10856.860029696925;10868.728281793019;10272.383656980604;10601.310914790514;10670.73323166927;10743.462826858626;10767.138628909668;8054.959725201454;8236.711715089943;8269.09040005599;8280.8343833123;8313.542755148404;7709.9614501927135;7752.224777522202;7801.29788319054;7802.219778022152;7866.960665196638;9307.72076837696;9428.62285508572;9445.433274003306;9575.329726919328;9670.56482458305;9598.42409455407;9892.653757118467;9935.354201976848;9941.950290248502;10053;6324.30432652417;6516.152900122954;6612.636305003271;6931.029655848286;7024.719011239493;8040.437169398086;8051.51690898548;8086.6361013755695;8115.4319197655595;8115.837683246184;7107.680154393168;7196;7228.168760592599;7334.376577990931;7340.632968351454;7102.289771022856;7130.2869713028285;7158.713651453883;7223.783286501413;7227.674754635948;7279.927200727925;7553.169151393233;7557.244275572399;7563.73526926577;7580.469367144247;6808.557443766139;6901.447884169354;6908.792736217922;6915.550489218386;6916.965415173093;6876.656167191521;6994.2656021117045;6996.19543752475;6996.685149168198;7001.649917504003 06:24:27 INFO - PROCESS | 1675 | |4;prototype.html;317.56017915187465;321.91147434455524;324.155574727834;330.04123022619297;331.3770112189084;6598.472122230216;6641.136652235203;6654.26803051664;6655.367740064692;6671.399574038335;6600.801975940717;6617.9669101654545;6626.933730662692;6634.5024123190715;6660.800175994728;4919.80320787169;4939.530744579277;4940.209566469365;4942.332785074005;4958.132326842788;4922.21244600864;4940.838902857826;4950.727709975949;4954.950450495503;4977.3529441172595;3949.0502882209867;4668.556487133734;4757.167495688258;4873.122837889178;4879.097366987101;3983.24318379507;4663.090697314025;4899.8040078396825;4919.065377578248;4927.137750893579;4169.1661667666585;4194.266003449384;4199.454070970754;4205.411242426032;4212.136512015029;6092.5430592705725;6311.810645680637;6393.7442502299855;6407.967960160216;6410.102585637967;5709.714514274311;5713.971430142823;5720.914186287209;5723.370429252779;5737.053386191274;5814.215080964101;7082.752103676346;7093.467989900778;7094.92905070953;7100.857982840366;4678.485366609671;4682.601978831769;4688.038952014863;4690.319903613991;4695.88260293492;7119.9288007119785;7327.413806895489;7358;7498.437617178679;7499;4596.862094137181;4616.3537104805355;4639.837605683785;4714.127886341038;4715.811367545329;4385.254506733863;4453.597116908163;4824.638152138604;4848.539388758062;4851.175300198975;5675.517581005661;5682.062459694187;5684.289463817023;5686.9715651421475;5709.172170035322;7058.082449281663;7075.823104422328;7077.363037326562;7091.92908070923;7097.751578694721;1561.9062856228663;1626.4957863062489;1630.885837991353;1636.378176293001;1654.5119189839027;1033.5968972100886;1042.08296698906;1050.333038520545;1059.6503153959175;1060.3319908457622;6415.941369674045;6582.76960306387;6695.497837662195;6697.531172817856;6705.932940670628;6341.904871426932;7349;7349.77950661481;7358.632068396666;7367.152777430557;6657.400833924873;6659.600423974577;6666.533342665967;6674.699638516278;6680.5991640501725;3847.1343947611563;3877.689784817208;3882.3400021996326;3882.96117038826;3895.337792575269;7424.331810137113;7748.380129589619;7757.534547927143;7759;7776.727814526577;6155;7630.7710768677025;7639.656215470317;7644.6942122315595;7666.425018123663;7728.381729461629;7730.188330225358;7730.690772369042;7737.92262077372;7745.0318710162355;7110.182329032227;7394.519356241827;7411.184769675439;7418.146913105062;7424.851502970018;7203.459740519586;7288.416926645961;7288.489805713762;7291.635418229173;7384.966104745233;7702.653380597774;7714.3442807362;7719.6140192989005;7726.652300646372;7734.419918506247;4407.405000324915;4496.460424748921;4540.273556230987;4542.250528662734;4614.1694494991225;7191.065161528968;7213.783586492414;7221.711131554889;7286.599237042014;7408;5901.852453688693;7142.678579463833;7165.176004759311;7173.820654483471;7181.102362204724;7098.43212542985;7118.537295075804;7122.216556178712;7123.074000380125;7130;6756.831079223059;7003.159620845531;7019.298070193144;7026.156861176692;7032.191298000591;7111.111111111111;7168.856622867409;7178.569285842657;7179.712811487482;7195.316444937723;7017.929820701932;7021.368076872902;7029.683664235019;7035.542689725152;7044.260352662896 06:24:27 INFO - PROCESS | 1675 | |5;yui.html;671.4158681946705;684.1209046375409;708.189123453646;728.1953441447201;747.7233423633253;14659.780103298446;14835.777463338032;14835.92582037091;14855.331510082045;14864.108153510797;13330.533431329904;13373.665658358546;13412.128211666235;13420.993425493078;13462.798058029137;682.7985744205447;846.5809424334932;858.1375717404001;858.1547176031604;859.6131740716703;839.0309192882231;850.1795767084762;850.2008112374348;850.8383407152652;857.1214505132258;726.9454790890678;901.5266984832982;903.5121034641286;903.941243819153;909.2044461096541;894.0210469535848;894.821035792844;897.2821742605922;898.2185498616245;911.7036962987023;667.9131712877295;669.6685140855308;671.1308855032744;675.6385333846417;680.9727610895558;14167.929160354235;14238.857611423857;14252.928735356361;14253;14255.714885702331;12482.625521234377;12572.874271257262;12600.117991740583;12731.936340318332;12829.486820527167;10030.699079027641;10075.087354100096;10084.798304033951;10086.787946618204;10087.848682269772;3475.6871881530783;3494.0391392367046;3500.43992961125;3509.3332266869215;3524.312759011994;60342.094868577005;76293.61853190699;76586;78533.21466785374;81074.18925810784;9354.766130846783;9578.377405468622;9622.663206787869;9732.95133524342;10075.244356673278;20435.795642043686;20858.582828343348;20877.89561052185;20882.686759698616;21111.68332475014;7308.6711098000715;7377.5204611700065;7478.401727861758;7495.250474952571;7642.312191902755;4038.9394159087637;4058.2086493133556;4061.2283666103344;4071.9796401017807;4077;3220.8228547430117;3459.1870910336556;3495.7378196635354;3500.212452198235;3525.206828463575;593.2288025566746;614.8708771158107;665.8535122273092;667.0394631730293;668.5520701130255;502.3720349563046;522.8745101175766;529.3912001198576;596.716559634179;602.3705228036712;7130.893036604455;8017.719379821679;8238.958805205935;8394.202550757791;8464.32285417165;542.1109380615793;545.4954167395143;578.5082679722202;589.6373730156009;619.6375120554436;3586.8923932282073;4170.04089059518;4177.895552611209;4224.831006759695;4248.596383343577;77567.50946207435;79107;86132;87323.56338218268;87327.25345493054;77350.61324693453;77822.6108869452;79003.20996789959;79874.6006269965;79998.80004799743;64181.679091605176;64873.67563162154;65986.34013659802;70374.64812676006;71461.2853871465;8340.207680270365;8625.137486251575;8766.386352955233;8904.109589041303;8956.328275379243;49585;52458.47541524536;53097.4690253108;53340.73329633327;53482.732586338374;70275;72449.63775181091;72820.17949551092;73486.26513735008;73580.63209683917;11359.716007099558;11388.829167562659;11645.708857278636;11661.591844285409;11894.940525297317;9694.75763105928;10248.735936202414;11961.760764784829;12080.879191207976;12662.986961043278;11196.66410007701;11356.26184298018;11358;12033.45849436795;12324.767523247603;10976.890231097907;11291.661250162508;11313.321200727984;11554.711132221762;11935;9264.490453025148;10789.298695584763;11297.774044519228;11316.26444281119;12028.15802893789;8009.519428834288;8881.777955551162;8912;9151.450912945245;9681.854772178282;8134.349252059939;8999;9539.427634341962;9702.466364350028;9805.411675299505 06:24:27 INFO - PROCESS | 1675 | __end_tp_report 06:24:27 INFO - PROCESS | 1675 | __start_cc_report 06:24:27 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1028 06:24:27 INFO - PROCESS | 1675 | __end_cc_report 06:24:27 INFO - PROCESS | 1675 | __startTimestamp1456323867699__endTimestamp 06:24:27 INFO - PROCESS | 1675 | 06:24:27 INFO - PROCESS | 1675 | ------- Summary: start ------- 06:24:27 INFO - PROCESS | 1675 | Number of tests: 6 06:24:27 INFO - PROCESS | 1675 | 06:24:27 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5648.82 Median:5849.71 stddev:655.64 (11.2%) stddev-sans-first:618.77 06:24:27 INFO - PROCESS | 1675 | Values: 2813.5 3439.3 3477.2 3482.5 3512.6 5532.9 5586.1 5591.6 5596.9 5598.8 5640.9 5657.0 5661.0 5797.5 5807.9 5035.5 5048.5 5052.4 5098.1 5212.5 4241.3 5180.9 5239.9 5248.6 5287.7 4974.0 5017.1 5104.7 5106.5 5114.5 5100.6 5101.8 5102.8 5143.2 5150.4 5006.4 5058.0 5082.8 5094.5 5107.2 5406.5 5493.6 5580.7 5583.5 5587.1 6129.7 6130.2 6150.7 6150.8 6163.3 6040.8 6158.4 6231.0 6249.1 6253.2 5679.6 5737.9 5745.5 5749.0 5791.0 6298.1 6305.4 6312.6 6319.2 6333.7 5831.0 5880.4 5900.0 6034.5 6037.5 6124.8 6142.7 6151.1 6207.0 6208.1 6039.5 6084.6 6093.5 6095.3 6108.4 5970.9 6081.3 6083.5 6084.5 6152.8 4843.5 4853.6 4874.0 4874.8 4904.4 4361.1 4361.5 4364.6 4383.3 4408.5 5563.7 5598.3 5625.5 5644.4 5701.0 6175.8 6197.9 6214.6 6222.4 6223.2 5526.1 5651.8 5654.5 5660.6 5679.1 5284.0 5304.1 5343.9 5357.0 5385.8 6279.1 6280.6 6282.6 6286.5 6294.7 6124.5 6148.7 6260.7 6270.2 6277.2 6232.6 6279.1 6281.6 6311.6 6317.7 6036.7 6085.8 6086.8 6100.8 6108.7 6035.0 6146.5 6218.7 6233.8 6234.1 4105.5 5268.5 5931.6 5970.6 5995.5 5920.7 5937.7 5941.8 5945.9 5949.0 5713.6 5812.7 5818.5 5849.7 5960.6 6011.8 6042.9 6044.4 6086.1 6090.4 5738.4 5858.1 5859.7 5872.8 5873.6 06:24:27 INFO - PROCESS | 1675 | 06:24:27 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:59171.95 Median:38833.81 stddev:116597.36 (300.2%) stddev-sans-first:116841.19 06:24:27 INFO - PROCESS | 1675 | Values: 487.1 565.0 587.9 593.6 596.8 38022.4 38344.4 38371.0 38396.6 38410.2 41019.0 41426.0 41440.2 41447.8 41468.8 8954.1 9227.5 9230.2 9243.5 9263.4 9641.1 9804.3 9812.1 9814.0 9846.3 9757.6 9847.9 9851.5 9854.4 9855.5 9758.0 9833.3 9835.4 9851.0 9851.6 8198.9 9677.6 9691.6 9695.9 9714.2 39130.0 39367.8 39445.0 39477.6 39488.2 2003.0 3013.9 3097.9 3596.5 3974.4 26598.0 27411.0 28062.6 28116.3 28129.2 2698.5 2763.2 2885.6 2887.8 2976.7 356332.0 356518.0 356929.4 357414.0 357881.0 62300.0 62985.4 63158.0 63461.7 63568.0 65950.3 66085.0 66103.3 66109.0 66142.7 16205.1 16382.9 16955.2 16972.5 17033.7 11538.1 12988.2 13004.0 13019.5 13032.7 19336.3 20029.7 20050.8 20087.7 20146.5 7199.2 8376.7 8442.4 8555.2 8564.6 802.3 952.3 1063.4 1118.5 1177.7 28584.3 28920.0 29451.7 29517.4 29645.7 1007.2 1035.3 1036.9 1060.8 1061.6 13915.5 13967.0 14006.9 14201.7 14293.4 524519.0 527878.0 533476.3 536882.0 540416.0 55966.0 55970.0 56155.4 56328.2 56482.0 1424.5 1439.5 1460.4 1461.7 1462.7 27720.9 28208.9 31531.0 31733.4 31900.7 46468.8 54898.6 55749.0 55819.0 56005.3 403979.0 411674.0 412421.0 412788.0 412886.0 36938.8 37176.8 41437.2 44338.0 45671.0 43605.6 43907.8 44152.3 45353.3 45367.0 37521.6 38058.4 38761.0 38906.6 38923.2 30536.0 34991.1 37865.1 38512.0 39166.6 35983.5 36484.0 37003.0 37811.6 38204.2 32982.3 33413.8 34006.3 34036.8 34091.8 19864.9 22702.7 25024.1 25199.0 25759.6 06:24:27 INFO - PROCESS | 1675 | 06:24:27 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:31880.39 Median:24717.88 stddev:90890.74 (367.7%) stddev-sans-first:91114.90 06:24:27 INFO - PROCESS | 1675 | Values: 362.9 366.2 366.8 372.0 372.9 15119.1 15681.5 19199.0 19631.0 20771.5 15000.2 16437.8 19708.6 19752.4 19760.2 5034.6 5184.0 5266.3 5270.1 5276.5 3972.2 5180.9 5238.4 5239.0 5810.8 6028.8 6061.3 6063.3 6066.4 6069.1 6040.5 6048.9 6058.1 6544.2 6550.5 5738.6 5756.4 5756.8 5764.1 5767.5 12926.2 22125.6 24625.8 24810.0 24869.5 1687.3 1884.8 1951.1 2042.3 2103.4 10071.6 10438.9 11510.9 14100.0 15017.9 1756.7 1760.4 1783.4 1789.3 1809.0 98010.0 99302.5 100336.0 109215.9 110307.4 10987.3 11316.3 11319.2 11322.1 11427.9 13439.9 13535.0 13535.0 13556.5 13576.3 7481.7 8072.4 8432.3 8549.4 8589.9 8591.2 8621.0 8622.6 8669.4 8708.6 4400.1 4465.1 4466.6 4518.0 4530.8 1842.9 1912.9 1926.3 1927.7 1934.3 878.7 884.7 904.4 958.3 983.5 19493.6 19872.6 20244.5 20262.4 20775.2 902.8 940.4 950.2 982.9 997.4 10527.4 10751.9 10799.6 10863.7 10936.5 474726.0 477481.0 568266.0 599025.0 603027.0 84588.6 86561.6 101401.5 110166.0 127172.0 1010.4 1034.9 1050.7 1055.3 1056.6 13333.6 16407.6 17274.7 18348.3 18356.7 49375.8 52711.9 52830.0 53464.5 53919.7 66216.0 68935.3 69284.0 72248.9 72394.0 7932.5 8024.7 8140.6 8179.7 8301.3 9352.4 12419.8 13084.9 13309.0 13319.9 11145.2 11423.3 11514.0 11591.5 11677.4 9110.5 11002.0 11085.7 11253.9 11468.5 11604.7 11736.2 11969.9 11982.5 12003.8 8072.2 8171.5 8201.6 8220.0 8283.0 9208.9 11916.7 11941.8 11978.5 12003.4 06:24:27 INFO - PROCESS | 1675 | 06:24:27 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:5959.01 Median:5383.45 stddev:3129.96 (58.1%) stddev-sans-first:3119.59 06:24:27 INFO - PROCESS | 1675 | Values: 1352.8 1430.9 1585.4 1775.9 1961.8 7816.2 8388.1 8556.0 8570.3 8582.0 8265.7 8563.7 8564.7 8571.9 8581.3 2125.2 2351.2 2390.7 2412.0 2421.6 2435.2 2436.4 2438.5 2443.4 2444.2 2243.5 2264.8 2351.4 2416.3 2430.4 2111.3 2342.9 2397.9 2399.3 2401.0 2337.4 2371.0 2380.3 2381.8 2405.2 8448.0 8538.7 8545.0 8554.9 8563.1 5197.7 5380.2 5386.7 5402.1 5460.6 3525.2 3550.2 3638.0 3657.2 3663.8 1025.6 1035.5 1045.3 1053.4 1058.5 9941.0 11732.1 11738.1 11763.1 11775.0 4690.2 4800.5 4852.4 4861.3 4873.9 9985.7 9995.0 10001.9 10005.3 10009.2 4931.4 5404.8 5428.4 5435.1 5438.8 4519.5 4737.0 4836.3 4898.4 4899.5 3866.1 3888.6 3898.2 3931.0 3942.7 1154.9 1297.5 1308.5 1316.1 1318.0 1305.0 1339.0 1341.8 1345.1 1360.6 8046.1 8047.0 8205.0 8221.1 8250.8 1007.5 1118.7 1197.7 1205.5 1224.6 5929.5 6322.0 6351.8 6364.5 6370.3 10212.8 10744.8 10767.9 10856.9 10868.7 10272.4 10601.3 10670.7 10743.5 10767.1 8055.0 8236.7 8269.1 8280.8 8313.5 7710.0 7752.2 7801.3 7802.2 7867.0 9307.7 9428.6 9445.4 9575.3 9670.6 9598.4 9892.7 9935.4 9942.0 10053.0 6324.3 6516.2 6612.6 6931.0 7024.7 8040.4 8051.5 8086.6 8115.4 8115.8 7107.7 7196.0 7228.2 7334.4 7340.6 7102.3 7130.3 7158.7 7223.8 7227.7 7279.9 7553.2 7557.2 7563.7 7580.5 6808.6 6901.4 6908.8 6915.6 6917.0 6876.7 6994.3 6996.2 6996.7 7001.6 06:24:27 INFO - PROCESS | 1675 | 06:24:27 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:5808.86 Median:6637.82 stddev:1870.58 (28.2%) stddev-sans-first:1829.86 06:24:27 INFO - PROCESS | 1675 | Values: 317.6 321.9 324.2 330.0 331.4 6598.5 6641.1 6654.3 6655.4 6671.4 6600.8 6618.0 6626.9 6634.5 6660.8 4919.8 4939.5 4940.2 4942.3 4958.1 4922.2 4940.8 4950.7 4955.0 4977.4 3949.1 4668.6 4757.2 4873.1 4879.1 3983.2 4663.1 4899.8 4919.1 4927.1 4169.2 4194.3 4199.5 4205.4 4212.1 6092.5 6311.8 6393.7 6408.0 6410.1 5709.7 5714.0 5720.9 5723.4 5737.1 5814.2 7082.8 7093.5 7094.9 7100.9 4678.5 4682.6 4688.0 4690.3 4695.9 7119.9 7327.4 7358.0 7498.4 7499.0 4596.9 4616.4 4639.8 4714.1 4715.8 4385.3 4453.6 4824.6 4848.5 4851.2 5675.5 5682.1 5684.3 5687.0 5709.2 7058.1 7075.8 7077.4 7091.9 7097.8 1561.9 1626.5 1630.9 1636.4 1654.5 1033.6 1042.1 1050.3 1059.7 1060.3 6415.9 6582.8 6695.5 6697.5 6705.9 6341.9 7349.0 7349.8 7358.6 7367.2 6657.4 6659.6 6666.5 6674.7 6680.6 3847.1 3877.7 3882.3 3883.0 3895.3 7424.3 7748.4 7757.5 7759.0 7776.7 6155.0 7630.8 7639.7 7644.7 7666.4 7728.4 7730.2 7730.7 7737.9 7745.0 7110.2 7394.5 7411.2 7418.1 7424.9 7203.5 7288.4 7288.5 7291.6 7385.0 7702.7 7714.3 7719.6 7726.7 7734.4 4407.4 4496.5 4540.3 4542.3 4614.2 7191.1 7213.8 7221.7 7286.6 7408.0 5901.9 7142.7 7165.2 7173.8 7181.1 7098.4 7118.5 7122.2 7123.1 7130.0 6756.8 7003.2 7019.3 7026.2 7032.2 7111.1 7168.9 7178.6 7179.7 7195.3 7017.9 7021.4 7029.7 7035.5 7044.3 06:24:27 INFO - PROCESS | 1675 | 06:24:27 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:17939.30 Median:617.25 stddev:24931.05 (4039.0%) stddev-sans-first:24967.27 06:24:27 INFO - PROCESS | 1675 | Values: 671.4 684.1 708.2 728.2 747.7 14659.8 14835.8 14835.9 14855.3 14864.1 13330.5 13373.7 13412.1 13421.0 13462.8 682.8 846.6 858.1 858.2 859.6 839.0 850.2 850.2 850.8 857.1 726.9 901.5 903.5 903.9 909.2 894.0 894.8 897.3 898.2 911.7 667.9 669.7 671.1 675.6 681.0 14167.9 14238.9 14252.9 14253.0 14255.7 12482.6 12572.9 12600.1 12731.9 12829.5 10030.7 10075.1 10084.8 10086.8 10087.8 3475.7 3494.0 3500.4 3509.3 3524.3 60342.1 76293.6 76586.0 78533.2 81074.2 9354.8 9578.4 9622.7 9733.0 10075.2 20435.8 20858.6 20877.9 20882.7 21111.7 7308.7 7377.5 7478.4 7495.3 7642.3 4038.9 4058.2 4061.2 4072.0 4077.0 3220.8 3459.2 3495.7 3500.2 3525.2 593.2 614.9 665.9 667.0 668.6 502.4 522.9 529.4 596.7 602.4 7130.9 8017.7 8239.0 8394.2 8464.3 542.1 545.5 578.5 589.6 619.6 3586.9 4170.0 4177.9 4224.8 4248.6 77567.5 79107.0 86132.0 87323.6 87327.3 77350.6 77822.6 79003.2 79874.6 79998.8 64181.7 64873.7 65986.3 70374.6 71461.3 8340.2 8625.1 8766.4 8904.1 8956.3 49585.0 52458.5 53097.5 53340.7 53482.7 70275.0 72449.6 72820.2 73486.3 73580.6 11359.7 11388.8 11645.7 11661.6 11894.9 9694.8 10248.7 11961.8 12080.9 12663.0 11196.7 11356.3 11358.0 12033.5 12324.8 10976.9 11291.7 11313.3 11554.7 11935.0 9264.5 10789.3 11297.8 11316.3 12028.2 8009.5 8881.8 8912.0 9151.5 9681.9 8134.3 8999.0 9539.4 9702.5 9805.4 06:24:27 INFO - PROCESS | 1675 | -------- Summary: end -------- 06:24:27 INFO - PROCESS | 1675 | 06:24:28 INFO - TEST-INFO | 1675: exit 0 06:24:28 INFO - TEST-OK | dromaeo_css | took 1113154ms 06:24:28 INFO - TEST-START | kraken 06:24:28 INFO - operating with platform_type : mac_ 06:24:28 INFO - Initialising browser for kraken test... 06:24:28 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpeDY77s/profile http://localhost:49274/getInfo.html) 06:24:30 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 06:24:30 INFO - PROCESS | 1682 | colorDepth:24 06:24:30 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 06:24:30 INFO - PROCESS | 1682 | __metrics 06:24:30 INFO - PROCESS | 1682 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:24:30 INFO - PROCESS | 1682 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:24:31 INFO - TEST-INFO | 1682: exit 0 06:24:31 INFO - Browser initialized. 06:24:31 INFO - Running cycle 1/1 for kraken test... 06:24:31 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpeDY77s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:42 INFO - PROCESS | 1684 | RSS: Main: 244580352 06:24:42 INFO - PROCESS | 1684 | 06:24:45 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 06:24:46 INFO - PROCESS | 1684 | RSS: Main: 290603008 06:24:46 INFO - PROCESS | 1684 | 06:24:48 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 06:24:49 INFO - PROCESS | 1684 | RSS: Main: 299651072 06:24:49 INFO - PROCESS | 1684 | 06:24:52 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 06:24:53 INFO - PROCESS | 1684 | RSS: Main: 285175808 06:24:53 INFO - PROCESS | 1684 | 06:24:54 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 06:24:55 INFO - PROCESS | 1684 | RSS: Main: 287973376 06:24:55 INFO - PROCESS | 1684 | 06:24:57 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:24:58 INFO - PROCESS | 1684 | RSS: Main: 288022528 06:24:58 INFO - PROCESS | 1684 | 06:25:00 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 06:25:01 INFO - PROCESS | 1684 | RSS: Main: 289271808 06:25:01 INFO - PROCESS | 1684 | 06:25:04 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 06:25:05 INFO - PROCESS | 1684 | RSS: Main: 290545664 06:25:05 INFO - PROCESS | 1684 | 06:25:07 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 06:25:08 INFO - PROCESS | 1684 | RSS: Main: 289832960 06:25:08 INFO - PROCESS | 1684 | 06:25:10 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:25:10 INFO - PROCESS | 1684 | RSS: Main: 325668864 06:25:10 INFO - PROCESS | 1684 | 06:25:12 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:25:13 INFO - PROCESS | 1684 | RSS: Main: 323731456 06:25:13 INFO - PROCESS | 1684 | 06:25:15 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:25:15 INFO - PROCESS | 1684 | RSS: Main: 332779520 06:25:15 INFO - PROCESS | 1684 | 06:25:18 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:25:18 INFO - PROCESS | 1684 | RSS: Main: 333783040 06:25:18 INFO - PROCESS | 1684 | 06:25:21 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:25:21 INFO - PROCESS | 1684 | RSS: Main: 333148160 06:25:21 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 06:25:23 INFO - PROCESS | 1684 | RSS: Main: 393891840 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | __start_tp_report 06:25:23 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 06:25:23 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 06:25:23 INFO - PROCESS | 1684 | |i|pagename|runs| 06:25:23 INFO - PROCESS | 1684 | |0;ai-astar;111;110;110;111;111;111;119;111;110;111 06:25:23 INFO - PROCESS | 1684 | |1;audio-beat-detection;158;120;143;158;120;144;137;123;158;119 06:25:23 INFO - PROCESS | 1684 | |2;audio-dft;186;185;187;185;186;184;187;185;181;184 06:25:23 INFO - PROCESS | 1684 | |3;audio-fft;79;72;85;78;57;56;60;77;75;57 06:25:23 INFO - PROCESS | 1684 | |4;audio-oscillator;92;94;123;81;79;82;98;73;112;145 06:25:23 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;85;90;82;90;86;90;84;90;85;90 06:25:23 INFO - PROCESS | 1684 | |6;imaging-darkroom;94;113;150;112;93;93;95;95;94;94 06:25:23 INFO - PROCESS | 1684 | |7;imaging-desaturate;123;135;85;87;84;94;132;87;86;86 06:25:23 INFO - PROCESS | 1684 | |8;json-parse-financial;54;52;54;53;53;53;52;62;51;53 06:25:23 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;62;63;68;79;73;69;66;66;67;67 06:25:23 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;85;81;81;80;82;82;83;83;84;84 06:25:23 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;107;125;122;125;119;122;124;123;127;128 06:25:23 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;138;128;138;137;161;129;139;138;137;138 06:25:23 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;67;67;65;66;67;68;67;67;67;66 06:25:23 INFO - PROCESS | 1684 | __end_tp_report 06:25:23 INFO - PROCESS | 1684 | __start_cc_report 06:25:23 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1108 06:25:23 INFO - PROCESS | 1684 | __end_cc_report 06:25:23 INFO - PROCESS | 1684 | __startTimestamp1456323923805__endTimestamp 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | ------- Summary: start ------- 06:25:23 INFO - PROCESS | 1684 | Number of tests: 14 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:111.50 Median:111.00 stddev:2.68 (2.4%) stddev-sans-first:2.83 06:25:23 INFO - PROCESS | 1684 | Values: 111.0 110.0 110.0 111.0 111.0 111.0 119.0 111.0 110.0 111.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:143.50 stddev:16.65 (11.6%) stddev-sans-first:16.01 06:25:23 INFO - PROCESS | 1684 | Values: 158.0 120.0 143.0 158.0 120.0 144.0 137.0 123.0 158.0 119.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:185.00 Median:185.50 stddev:1.76 (1.0%) stddev-sans-first:1.83 06:25:23 INFO - PROCESS | 1684 | Values: 186.0 185.0 187.0 185.0 186.0 184.0 187.0 185.0 181.0 184.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:69.60 Median:76.00 stddev:10.96 (14.4%) stddev-sans-first:11.08 06:25:23 INFO - PROCESS | 1684 | Values: 79.0 72.0 85.0 78.0 57.0 56.0 60.0 77.0 75.0 57.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:81.50 stddev:22.64 (27.8%) stddev-sans-first:23.91 06:25:23 INFO - PROCESS | 1684 | Values: 92.0 94.0 123.0 81.0 79.0 82.0 98.0 73.0 112.0 145.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:90.00 stddev:3.12 (3.5%) stddev-sans-first:3.21 06:25:23 INFO - PROCESS | 1684 | Values: 85.0 90.0 82.0 90.0 86.0 90.0 84.0 90.0 85.0 90.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:103.30 Median:94.00 stddev:18.14 (19.3%) stddev-sans-first:18.92 06:25:23 INFO - PROCESS | 1684 | Values: 94.0 113.0 150.0 112.0 93.0 93.0 95.0 95.0 94.0 94.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:99.90 Median:86.00 stddev:21.15 (24.6%) stddev-sans-first:20.71 06:25:23 INFO - PROCESS | 1684 | Values: 123.0 135.0 85.0 87.0 84.0 94.0 132.0 87.0 86.0 86.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:53.00 stddev:3.06 (5.8%) stddev-sans-first:3.24 06:25:23 INFO - PROCESS | 1684 | Values: 54.0 52.0 54.0 53.0 53.0 53.0 52.0 62.0 51.0 53.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:67.50 stddev:4.92 (7.3%) stddev-sans-first:4.72 06:25:23 INFO - PROCESS | 1684 | Values: 62.0 63.0 68.0 79.0 73.0 69.0 66.0 66.0 67.0 67.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:1.58 (1.9%) stddev-sans-first:1.39 06:25:23 INFO - PROCESS | 1684 | Values: 85.0 81.0 81.0 80.0 82.0 82.0 83.0 83.0 84.0 84.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:122.20 Median:124.50 stddev:5.94 (4.8%) stddev-sans-first:2.76 06:25:23 INFO - PROCESS | 1684 | Values: 107.0 125.0 122.0 125.0 119.0 122.0 124.0 123.0 127.0 128.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.30 Median:138.00 stddev:8.90 (6.4%) stddev-sans-first:9.43 06:25:23 INFO - PROCESS | 1684 | Values: 138.0 128.0 138.0 137.0 161.0 129.0 139.0 138.0 137.0 138.0 06:25:23 INFO - PROCESS | 1684 | 06:25:23 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 06:25:23 INFO - PROCESS | 1684 | Values: 67.0 67.0 65.0 66.0 67.0 68.0 67.0 67.0 67.0 66.0 06:25:23 INFO - PROCESS | 1684 | -------- Summary: end -------- 06:25:23 INFO - PROCESS | 1684 | 06:25:24 INFO - TEST-INFO | 1684: exit 0 06:25:24 INFO - TEST-OK | kraken | took 56474ms 06:25:24 INFO - SUITE-END | took 1169s 06:25:24 INFO - Completed test suite (00:19:29) 06:25:24 INFO - Working with test: dromaeo_css 06:25:24 INFO - Generating results file: dromaeo_css 06:25:24 INFO - Working with test: kraken 06:25:24 INFO - Generating results file: kraken 06:25:24 INFO - javascript benchmark 06:25:24 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:25:25 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 06:25:25 INFO - process_Request line: dromaeo_css 7468.67 graph.html#tests=[[72,64,59]] 06:25:25 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:25:25 INFO - process_Request line: kraken 1423.80 graph.html#tests=[[232,64,59]] 06:25:25 INFO - RETURN: dromaeo_css: 7468.67 06:25:25 INFO - RETURN: kraken: 1423.80 06:25:25 INFO - javascript benchmark 06:25:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2813.5076361636716, 3439.29494453637, 3477.2350082981734, 3482.4950382194597, 3512.560929883763, 5532.889342213163, 5586.10622300432, 5591.608587398879, 5596.860078498029, 5598.832035038945, 5640.915386269209, 5657.010023245925, 5660.9716951415285, 5797.536197104232, 5807.912881306773, 5035.546800787928, 5048.469910659373, 5052.368453943257, 5098.107831129556, 5212.50481204285, 4241.27898257297, 5180.948190518103, 5239.947600523984, 5248.580113590903, 5287.682739035651, 4974.030064137494, 5017.147084995541, 5104.744762761884, 5106.463821298785, 5114.514121158521, 5100.566451851597, 5101.846944591631, 5102.846914592568, 5143.177091665353, 5150.381954165487, 5006.424261209934, 5058.0, 5082.79668813247, 5094.465081166498, 5107.157319042353, 5406.54044406226, 5493.615446918718, 5580.748866300985, 5583.497485226349, 5587.05020146576, 6129.662868542228, 6130.233720784902, 6150.692465376714, 6150.846228844314, 6163.2604087509335, 6040.848978775566, 6158.414950579688, 6231.0, 6249.0626406039, 6253.249610046823, 5679.574031947621, 5737.913931291076, 5745.540356771448, 5748.971255143698, 5790.957627627025, 6298.0552917062805, 6305.369463053658, 6312.5581209314905, 6319.24169099711, 6333.683315834282, 5831.008728516163, 5880.353161152269, 5900.0264956281735, 6034.5172386209, 6037.486813620892, 6124.846878828065, 6142.692865356715, 6151.108089327112, 6207.0, 6208.099825525273, 6039.456448919618, 6084.574079814459, 6093.512518998469, 6095.299040610298, 6108.389161083945, 5970.850728731816, 6081.300650425169, 6083.482903953213, 6084.5436592255755, 6152.846178845564, 4843.467218605951, 4853.587445067138, 4874.0495603357, 4874.780634871439, 4904.411470623477, 4361.105973275471, 4361.454818147731, 4364.585364390377, 4383.342498625232, 4408.4930233023615, 5563.693996830132, 5598.300212473441, 5625.46558076982, 5644.350899646511, 5701.0, 6175.752969881244, 6197.907031394533, 6214.627122372672, 6222.439980401786, 6223.222097237845, 5526.115821468546, 5651.8304450866535, 5654.46282603152, 5660.575456840754, 5679.148127780783, 5284.0, 5304.098303288451, 5343.919841202385, 5356.973215133899, 5385.8114965976, 6279.058141278845, 6280.623162610166, 6282.623042617458, 6286.465650419766, 6294.748210071546, 6124.5406594506485, 6148.678034222664, 6260.68696565179, 6270.2475702915945, 6277.1525844010475, 6232.626042437469, 6279.058141278845, 6281.560290779602, 6311.621302721668, 6317.684115794284, 6036.6679832609625, 6085.756569737161, 6086.847828804315, 6100.786472473442, 6108.664023478751, 6034.969825150846, 6146.477549408351, 6218.657973811303, 6233.844153896008, 6234.127222188807, 4105.548389677074, 5268.473152684701, 5931.584789064724, 5970.582059255984, 5995.520358371407, 5920.674362910081, 5937.703114844327, 5941.792037278848, 5945.91081133792, 5949.0, 5713.628614140068, 5812.709364531841, 5818.4763371296785, 5849.707514624167, 5960.642361458326, 6011.7595296187665, 6042.879142417215, 6044.365341639064, 6086.117512960507, 6090.390960903874, 5738.397468265772, 5858.121281807763, 5859.707014649165, 5872.794452194153, 5873.618214816023], "unit": "score", "name": "dojo.html", "value": 5607.072444958533}, {"lowerIsBetter": false, "replicates": [487.072127596928, 565.0140504819088, 587.9353271140175, 593.6467801658014, 596.7881402102254, 38022.429663555034, 38344.42483362748, 38370.99999999996, 38396.61603383965, 38410.23179536415, 41019.0, 41426.0, 41440.17119657613, 41447.79276103615, 41468.792656036676, 8954.149355811203, 9227.492487913161, 9230.16928476437, 9243.537823108818, 9263.397879137869, 9641.13229809317, 9804.264680148981, 9812.067853553937, 9814.018598140165, 9846.261530385214, 9757.609695612167, 9847.901520984806, 9851.50742462874, 9854.40873547586, 9855.457949812757, 9757.951210243938, 9833.31166818323, 9835.409875407498, 9850.9507452463, 9851.605935762562, 8198.877016844752, 9677.564509597085, 9691.563879625433, 9695.90304096964, 9714.22286217108, 39130.02174945621, 39367.818965431085, 39445.0, 39477.60522394797, 39488.21023579541, 2002.975073585591, 3013.89451369201, 3097.938041239185, 3596.4605309203566, 3974.3641017437362, 26598.0, 27411.0, 28062.579061314096, 28116.297092572644, 28129.156125316273, 2698.5277576424046, 2763.1848604661673, 2885.5960165576626, 2887.754540864029, 2976.687447817991, 356332.0, 356518.0, 356929.43070569483, 357414.0, 357881.0, 62300.0, 62985.37014629887, 63158.0, 63461.68269158625, 63568.0, 65950.34049659538, 66085.00872486917, 66103.33896661068, 66109.0, 66142.66928665421, 16205.10871902033, 16382.918085409736, 16955.23701433414, 16972.49082527526, 17033.659326813395, 11538.134639901873, 12988.220706757626, 13004.0, 13019.544315948897, 13032.674183145496, 19336.323228686928, 20029.699554506693, 20050.799492005186, 20087.698684519743, 20146.496337591383, 7199.244079371695, 8376.706815261437, 8442.366822488339, 8555.230029297392, 8564.61459234336, 802.3180296747835, 952.3286631960864, 1063.4363787192801, 1118.4910865556153, 1177.652592485219, 28584.285392865346, 28920.0, 29451.705482944897, 29517.409651806844, 29645.703542964726, 1007.1741172238841, 1035.316690983947, 1036.8911264317137, 1060.8302671572512, 1061.5594528270835, 13915.512957046454, 13966.952478564148, 14006.879449644004, 14201.715965680629, 14293.356798944073, 524519.0, 527878.0, 533476.3326183421, 536882.0, 540416.0, 55966.0, 55970.0, 56155.43844561584, 56328.18359082029, 56482.0, 1424.501424501437, 1439.5321520505877, 1460.3720400228003, 1461.6784307452344, 1462.7293950618957, 27720.8613956937, 28208.85895570591, 31531.0, 31733.36533269368, 31900.68099318977, 46468.83827904194, 54898.62753431196, 55749.0, 55819.0, 56005.31984040485, 403979.0, 411674.0, 412421.0, 412788.0, 412886.0, 36938.8153059233, 37176.81411592925, 41437.171256574096, 44338.0, 45671.0, 43605.56394436015, 43907.78046109749, 44152.33771493495, 45353.31970020518, 45367.0, 37521.62478375181, 38058.42912356372, 38761.0, 38906.6109338903, 38923.2215355697, 30536.0, 34991.12522186965, 37865.05337366478, 38512.0, 39166.608333916294, 35983.460248096824, 36484.0, 37003.0, 37811.62188378081, 38204.23591528209, 32982.34035319328, 33413.79000807938, 34006.3198736019, 34036.82981585076, 34091.82954085214, 19864.90067549653, 22702.659460108443, 25024.124155654466, 25199.0, 25759.613605795552], "unit": "score", "name": "ext.html", "value": 19635.272403702067}, {"lowerIsBetter": false, "replicates": [362.9183433727411, 366.1742770053529, 366.7744337232602, 371.9665230129288, 372.88254199927036, 15119.092854428742, 15681.451149209779, 19199.0, 19631.018449077543, 20771.480712982182, 15000.174990375524, 16437.753433698505, 19708.605827883435, 19752.40742777719, 19760.20959161632, 5034.622403319748, 5184.015037142931, 5266.289050978126, 5270.077736396115, 5276.498732620415, 3972.165845172503, 5180.896382072357, 5238.371395432553, 5239.004589128053, 5810.82567522975, 6028.788992385267, 6061.302950160722, 6063.272407311107, 6066.393360663942, 6069.089636554508, 6040.546958978094, 6048.939510604903, 6058.091286307045, 6544.214694236722, 6550.475961923034, 5738.569607279429, 5756.424357564252, 5756.827295181151, 5764.07774756037, 5767.509761670263, 12926.224426534343, 22125.557488850132, 24625.753742462704, 24810.0, 24869.5026099477, 1687.2503901517189, 1884.8397886179691, 1951.1219951022097, 2042.28520017994, 2103.4215590712524, 10071.647492337734, 10438.895611043945, 11510.942445287803, 14100.012999090068, 15017.924910375377, 1756.739905728603, 1760.375066851262, 1783.3758184635403, 1789.33794496036, 1808.9547761305942, 98010.0, 99302.50348748283, 100335.99328013399, 109215.90784092137, 110307.44846275798, 10987.285826421257, 11316.321020738782, 11319.207655464203, 11322.094232461382, 11427.885721142848, 13439.932800335935, 13534.984876134133, 13534.98487613433, 13556.525521606894, 13576.321183940763, 7481.663325150382, 8072.354211663052, 8432.283255923316, 8549.401541892008, 8589.8711519326, 8591.183837535424, 8620.956895215484, 8622.568871556397, 8669.436486628349, 8708.608112634947, 4400.141972315368, 4465.12929978651, 4466.6203372713035, 4518.0, 4530.79611417487, 1842.861785366076, 1912.913918873654, 1926.3450426854936, 1927.7301177835113, 1934.3423236099793, 878.7056336127469, 884.7390019944132, 904.3624244907325, 958.3291695812959, 983.5082458770614, 19493.610127797365, 19872.60254794896, 20244.493887652927, 20262.392128236177, 20775.168993240102, 902.7562558109274, 940.3887473142375, 950.2208189284859, 982.8673129127476, 997.4295100189452, 10527.368357898551, 10751.892481075089, 10799.622013229498, 10863.67408977732, 10936.507857146447, 474726.0, 477481.0, 568266.0, 599025.0, 603027.0, 84588.57705711432, 86561.56719216364, 101401.49299253603, 110166.0, 127172.0, 1010.4190090697878, 1034.8758149022015, 1050.6742909698019, 1055.3245922609535, 1056.5773690523852, 13333.599992000256, 16407.571046746267, 17274.740878887078, 18348.26606935761, 18356.72464913054, 49375.753121235604, 52711.94576108533, 52830.0, 53464.46535534751, 53919.73040134774, 66216.0, 68935.31064689289, 69284.0, 72248.94257401931, 72394.0, 7932.524048557105, 8024.719134830487, 8140.552269625227, 8179.713710020359, 8301.29438997692, 9352.438853668802, 12419.75160496803, 13084.887784538421, 13309.0, 13319.93440524775, 11145.161048426919, 11423.314601123959, 11513.963743263146, 11591.536338546364, 11677.357745324089, 9110.453372797654, 11002.009819116318, 11085.667429977113, 11253.887461125283, 11468.483918223867, 11604.709882253012, 11736.237144585575, 11969.94015029954, 11982.460789264678, 12003.819942700691, 8072.233137851895, 8171.468854524437, 8201.630926608435, 8219.95890020546, 8282.958585207276, 9208.861867072133, 11916.702082448008, 11941.820872686743, 11978.46096925623, 12003.399830008639], "unit": "score", "name": "jquery.html", "value": 9236.338506871738}, {"lowerIsBetter": false, "replicates": [1352.7767918293482, 1430.8783753380962, 1585.3975489314062, 1775.9467215983516, 1961.8234358907696, 7816.218378162188, 8388.07731149573, 8556.0, 8570.314374850013, 8582.013068497117, 8265.710700125497, 8563.657453701844, 8564.657413703444, 8571.928508936382, 8581.313494920407, 2125.203048856679, 2351.2240960483, 2390.713114426271, 2412.0472413396787, 2421.636754486832, 2435.2329016359877, 2436.427439551704, 2438.5244877248942, 2443.4135807406274, 2444.2178502879087, 2243.5288589396164, 2264.8449290861613, 2351.44740985869, 2416.32342943976, 2430.44099857033, 2111.3032699209225, 2342.9062837486567, 2397.880105994693, 2399.3401814500976, 2400.9519809603885, 2337.4273303040864, 2370.952580948371, 2380.297812145404, 2381.833271670984, 2405.230326295586, 8448.028476725194, 8538.70114545988, 8545.034642032306, 8554.914450855475, 8563.100874408223, 5197.740112994373, 5380.166074258496, 5386.730663466811, 5402.108652072403, 5460.6177567570285, 3525.2244506208594, 3550.1834578046937, 3638.0, 3657.2319812839337, 3663.835127419246, 1025.635899255761, 1035.5250950228958, 1045.268312181476, 1053.3574519543072, 1058.5130839813694, 9940.950295248622, 11732.120090993125, 11738.06095512357, 11763.058955283643, 11775.0, 4690.249560070372, 4800.543948324904, 4852.417709874838, 4861.29511220871, 4873.878153046202, 9985.700428987142, 9994.950025249827, 10001.949990250003, 10005.349652272724, 10009.199264058858, 4931.3589233399425, 5404.756785944642, 5428.4028756836715, 5435.1303791393975, 5438.782448702008, 4519.480259770168, 4736.976315118402, 4836.347093142381, 4898.387701537308, 4899.485554016848, 3866.0721426857353, 3888.5528164260904, 3898.1813819098306, 3930.9606903931167, 3942.743721658083, 1154.9133814963911, 1297.4810075969688, 1308.5093090091216, 1316.059017802276, 1318.0114913814639, 1305.0473154597007, 1338.9866101338862, 1341.8121462995189, 1345.1391109689612, 1360.5782207515701, 8046.114927357986, 8046.994125734283, 8204.958975205085, 8221.095679475253, 8250.752477425687, 1007.4912169354576, 1118.6588090632436, 1197.7245233596148, 1205.5263236420478, 1224.577520755338, 5929.525637948954, 6322.0, 6351.809445716636, 6364.49084073273, 6370.267419246846, 10212.795744085077, 10744.838827417596, 10767.89232107669, 10856.860029696925, 10868.728281793019, 10272.383656980604, 10601.310914790514, 10670.73323166927, 10743.462826858626, 10767.138628909668, 8054.959725201454, 8236.711715089943, 8269.09040005599, 8280.8343833123, 8313.542755148404, 7709.9614501927135, 7752.224777522202, 7801.29788319054, 7802.219778022152, 7866.960665196638, 9307.72076837696, 9428.62285508572, 9445.433274003306, 9575.329726919328, 9670.56482458305, 9598.42409455407, 9892.653757118467, 9935.354201976848, 9941.950290248502, 10053.0, 6324.30432652417, 6516.152900122954, 6612.636305003271, 6931.029655848286, 7024.719011239493, 8040.437169398086, 8051.51690898548, 8086.6361013755695, 8115.4319197655595, 8115.837683246184, 7107.680154393168, 7196.0, 7228.168760592599, 7334.376577990931, 7340.632968351454, 7102.289771022856, 7130.2869713028285, 7158.713651453883, 7223.783286501413, 7227.674754635948, 7279.927200727925, 7553.169151393233, 7557.244275572399, 7563.73526926577, 7580.469367144247, 6808.557443766139, 6901.447884169354, 6908.792736217922, 6915.550489218386, 6916.965415173093, 6876.656167191521, 6994.2656021117045, 6996.19543752475, 6996.685149168198, 7001.649917504003], "unit": "score", "name": "mootools.html", "value": 4868.882968555741}, {"lowerIsBetter": false, "replicates": [317.56017915187465, 321.91147434455524, 324.155574727834, 330.04123022619297, 331.3770112189084, 6598.472122230216, 6641.136652235203, 6654.26803051664, 6655.367740064692, 6671.399574038335, 6600.801975940717, 6617.9669101654545, 6626.933730662692, 6634.5024123190715, 6660.800175994728, 4919.80320787169, 4939.530744579277, 4940.209566469365, 4942.332785074005, 4958.132326842788, 4922.21244600864, 4940.838902857826, 4950.727709975949, 4954.950450495503, 4977.3529441172595, 3949.0502882209867, 4668.556487133734, 4757.167495688258, 4873.122837889178, 4879.097366987101, 3983.24318379507, 4663.090697314025, 4899.8040078396825, 4919.065377578248, 4927.137750893579, 4169.1661667666585, 4194.266003449384, 4199.454070970754, 4205.411242426032, 4212.136512015029, 6092.5430592705725, 6311.810645680637, 6393.7442502299855, 6407.967960160216, 6410.102585637967, 5709.714514274311, 5713.971430142823, 5720.914186287209, 5723.370429252779, 5737.053386191274, 5814.215080964101, 7082.752103676346, 7093.467989900778, 7094.92905070953, 7100.857982840366, 4678.485366609671, 4682.601978831769, 4688.038952014863, 4690.319903613991, 4695.88260293492, 7119.9288007119785, 7327.413806895489, 7358.0, 7498.437617178679, 7499.0, 4596.862094137181, 4616.3537104805355, 4639.837605683785, 4714.127886341038, 4715.811367545329, 4385.254506733863, 4453.597116908163, 4824.638152138604, 4848.539388758062, 4851.175300198975, 5675.517581005661, 5682.062459694187, 5684.289463817023, 5686.9715651421475, 5709.172170035322, 7058.082449281663, 7075.823104422328, 7077.363037326562, 7091.92908070923, 7097.751578694721, 1561.9062856228663, 1626.4957863062489, 1630.885837991353, 1636.378176293001, 1654.5119189839027, 1033.5968972100886, 1042.08296698906, 1050.333038520545, 1059.6503153959175, 1060.3319908457622, 6415.941369674045, 6582.76960306387, 6695.497837662195, 6697.531172817856, 6705.932940670628, 6341.904871426932, 7349.0, 7349.77950661481, 7358.632068396666, 7367.152777430557, 6657.400833924873, 6659.600423974577, 6666.533342665967, 6674.699638516278, 6680.5991640501725, 3847.1343947611563, 3877.689784817208, 3882.3400021996326, 3882.96117038826, 3895.337792575269, 7424.331810137113, 7748.380129589619, 7757.534547927143, 7759.0, 7776.727814526577, 6155.0, 7630.7710768677025, 7639.656215470317, 7644.6942122315595, 7666.425018123663, 7728.381729461629, 7730.188330225358, 7730.690772369042, 7737.92262077372, 7745.0318710162355, 7110.182329032227, 7394.519356241827, 7411.184769675439, 7418.146913105062, 7424.851502970018, 7203.459740519586, 7288.416926645961, 7288.489805713762, 7291.635418229173, 7384.966104745233, 7702.653380597774, 7714.3442807362, 7719.6140192989005, 7726.652300646372, 7734.419918506247, 4407.405000324915, 4496.460424748921, 4540.273556230987, 4542.250528662734, 4614.1694494991225, 7191.065161528968, 7213.783586492414, 7221.711131554889, 7286.599237042014, 7408.0, 5901.852453688693, 7142.678579463833, 7165.176004759311, 7173.820654483471, 7181.102362204724, 7098.43212542985, 7118.537295075804, 7122.216556178712, 7123.074000380125, 7130.0, 6756.831079223059, 7003.159620845531, 7019.298070193144, 7026.156861176692, 7032.191298000591, 7111.111111111111, 7168.856622867409, 7178.569285842657, 7179.712811487482, 7195.316444937723, 7017.929820701932, 7021.368076872902, 7029.683664235019, 7035.542689725152, 7044.260352662896], "unit": "score", "name": "prototype.html", "value": 5177.098825436458}, {"lowerIsBetter": false, "replicates": [671.4158681946705, 684.1209046375409, 708.189123453646, 728.1953441447201, 747.7233423633253, 14659.780103298446, 14835.777463338032, 14835.92582037091, 14855.331510082045, 14864.108153510797, 13330.533431329904, 13373.665658358546, 13412.128211666235, 13420.993425493078, 13462.798058029137, 682.7985744205447, 846.5809424334932, 858.1375717404001, 858.1547176031604, 859.6131740716703, 839.0309192882231, 850.1795767084762, 850.2008112374348, 850.8383407152652, 857.1214505132258, 726.9454790890678, 901.5266984832982, 903.5121034641286, 903.941243819153, 909.2044461096541, 894.0210469535848, 894.821035792844, 897.2821742605922, 898.2185498616245, 911.7036962987023, 667.9131712877295, 669.6685140855308, 671.1308855032744, 675.6385333846417, 680.9727610895558, 14167.929160354235, 14238.857611423857, 14252.928735356361, 14253.0, 14255.714885702331, 12482.625521234377, 12572.874271257262, 12600.117991740583, 12731.936340318332, 12829.486820527167, 10030.699079027641, 10075.087354100096, 10084.798304033951, 10086.787946618204, 10087.848682269772, 3475.6871881530783, 3494.0391392367046, 3500.43992961125, 3509.3332266869215, 3524.312759011994, 60342.094868577005, 76293.61853190699, 76586.0, 78533.21466785374, 81074.18925810784, 9354.766130846783, 9578.377405468622, 9622.663206787869, 9732.95133524342, 10075.244356673278, 20435.795642043686, 20858.582828343348, 20877.89561052185, 20882.686759698616, 21111.68332475014, 7308.6711098000715, 7377.5204611700065, 7478.401727861758, 7495.250474952571, 7642.312191902755, 4038.9394159087637, 4058.2086493133556, 4061.2283666103344, 4071.9796401017807, 4077.0, 3220.8228547430117, 3459.1870910336556, 3495.7378196635354, 3500.212452198235, 3525.206828463575, 593.2288025566746, 614.8708771158107, 665.8535122273092, 667.0394631730293, 668.5520701130255, 502.3720349563046, 522.8745101175766, 529.3912001198576, 596.716559634179, 602.3705228036712, 7130.893036604455, 8017.719379821679, 8238.958805205935, 8394.202550757791, 8464.32285417165, 542.1109380615793, 545.4954167395143, 578.5082679722202, 589.6373730156009, 619.6375120554436, 3586.8923932282073, 4170.04089059518, 4177.895552611209, 4224.831006759695, 4248.596383343577, 77567.50946207435, 79107.0, 86132.0, 87323.56338218268, 87327.25345493054, 77350.61324693453, 77822.6108869452, 79003.20996789959, 79874.6006269965, 79998.80004799743, 64181.679091605176, 64873.67563162154, 65986.34013659802, 70374.64812676006, 71461.2853871465, 8340.207680270365, 8625.137486251575, 8766.386352955233, 8904.109589041303, 8956.328275379243, 49585.0, 52458.47541524536, 53097.4690253108, 53340.73329633327, 53482.732586338374, 70275.0, 72449.63775181091, 72820.17949551092, 73486.26513735008, 73580.63209683917, 11359.716007099558, 11388.829167562659, 11645.708857278636, 11661.591844285409, 11894.940525297317, 9694.75763105928, 10248.735936202414, 11961.760764784829, 12080.879191207976, 12662.986961043278, 11196.66410007701, 11356.26184298018, 11358.0, 12033.45849436795, 12324.767523247603, 10976.890231097907, 11291.661250162508, 11313.321200727984, 11554.711132221762, 11935.0, 9264.490453025148, 10789.298695584763, 11297.774044519228, 11316.26444281119, 12028.15802893789, 8009.519428834288, 8881.777955551162, 8912.0, 9151.450912945245, 9681.854772178282, 8134.349252059939, 8999.0, 9539.427634341962, 9702.466364350028, 9805.411675299505], "unit": "score", "name": "yui.html", "value": 6770.770027209544}], "name": "dromaeo_css", "value": 7468.675986191873}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 111.0, 111.0, 111.0, 119.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [158.0, 120.0, 143.0, 158.0, 120.0, 144.0, 137.0, 123.0, 158.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 138.0}, {"lowerIsBetter": true, "replicates": [186.0, 185.0, 187.0, 185.0, 186.0, 184.0, 187.0, 185.0, 181.0, 184.0], "unit": "score", "name": "audio-dft", "value": 185.0}, {"lowerIsBetter": true, "replicates": [79.0, 72.0, 85.0, 78.0, 57.0, 56.0, 60.0, 77.0, 75.0, 57.0], "unit": "score", "name": "audio-fft", "value": 69.6}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 123.0, 81.0, 79.0, 82.0, 98.0, 73.0, 112.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 97.9}, {"lowerIsBetter": true, "replicates": [85.0, 90.0, 82.0, 90.0, 86.0, 90.0, 84.0, 90.0, 85.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.2}, {"lowerIsBetter": true, "replicates": [94.0, 113.0, 150.0, 112.0, 93.0, 93.0, 95.0, 95.0, 94.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 103.3}, {"lowerIsBetter": true, "replicates": [123.0, 135.0, 85.0, 87.0, 84.0, 94.0, 132.0, 87.0, 86.0, 86.0], "unit": "score", "name": "imaging-desaturate", "value": 99.9}, {"lowerIsBetter": true, "replicates": [54.0, 52.0, 54.0, 53.0, 53.0, 53.0, 52.0, 62.0, 51.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 53.7}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 68.0, 79.0, 73.0, 69.0, 66.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [85.0, 81.0, 81.0, 80.0, 82.0, 82.0, 83.0, 83.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [107.0, 125.0, 122.0, 125.0, 119.0, 122.0, 124.0, 123.0, 127.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.2}, {"lowerIsBetter": true, "replicates": [138.0, 128.0, 138.0, 137.0, 161.0, 129.0, 139.0, 138.0, 137.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 65.0, 66.0, 67.0, 68.0, 67.0, 67.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1423.8}]} 06:25:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1423.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7468.67"}}} 06:25:25 INFO - Return code: 0 06:25:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:25:25 INFO - # TBPL SUCCESS # 06:25:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:25:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:25:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:25:25 INFO - 2016-02-24 06:25:25.351 screenresolution[1688:9737] starting screenresolution argv=screenresolution get 06:25:25 INFO - 2016-02-24 06:25:25.354 screenresolution[1688:9737] Display 0: 1600x1200x32@60 06:25:25 INFO - 2016-02-24 06:25:25.360 screenresolution[1689:9740] starting screenresolution argv=screenresolution list 06:25:25 INFO - Available Modes on Display 0 06:25:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:25:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:25:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:25:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:25:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:25:25 INFO - Intel Iris: 06:25:25 INFO - Chipset Model: Intel Iris 06:25:25 INFO - Type: GPU 06:25:25 INFO - Bus: Built-In 06:25:25 INFO - VRAM (Dynamic, Max): 1536 MB 06:25:25 INFO - Vendor: Intel (0x8086) 06:25:25 INFO - Device ID: 0x0a2e 06:25:25 INFO - Revision ID: 0x0009 06:25:25 INFO - Displays: 06:25:25 INFO - Display: 06:25:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:25:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:25:25 INFO - Display Serial Number: 1600x1200 60 06:25:25 INFO - Main Display: Yes 06:25:25 INFO - Mirror: Off 06:25:25 INFO - Online: Yes 06:25:25 INFO - Rotation: Supported 06:25:25 INFO - Return code: 0 06:25:25 INFO - Running post-action listener: _resource_record_post_action 06:25:25 INFO - Running post-run listener: _resource_record_post_run 06:25:26 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39560704; Write bytes: 709611008; Read time: 421; Write time: 2156 06:25:26 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 400734720; Write bytes: 390608384; Read time: 29432; Write time: 753 06:25:26 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 32448000; Write bytes: 301152256; Read time: 333; Write time: 1359 06:25:26 INFO - Running post-run listener: _upload_blobber_files 06:25:26 INFO - Blob upload gear active. 06:25:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:25:26 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 06:25:26 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'] 06:25:26 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 06:25:27 INFO - (blobuploader) - INFO - Open directory for files ... 06:25:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:25:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:25:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:28 INFO - (blobuploader) - INFO - Done attempting. 06:25:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:25:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:25:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:29 INFO - (blobuploader) - INFO - Done attempting. 06:25:29 INFO - (blobuploader) - INFO - Iteration through files over. 06:25:29 INFO - Return code: 0 06:25:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:25:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:25:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6822fb60f2cf28310dabddf54d0f53658e2f65f2753fd41dcae0b89c4874add96bb2edc121bf796226cef3cc56fc32603eb3dd6c40f224ac5dc91b18dacbe5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13a1941bc765cf38e68d84197c8dfe711b759a68be24ffb2bc133067fe6dee800084bf2e10567a3c3e0b03d58b5d49cf30764d4d17e48a96fbe0cee49ac4b85b"} 06:25:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:25:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:25:29 INFO - Contents: 06:25:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6822fb60f2cf28310dabddf54d0f53658e2f65f2753fd41dcae0b89c4874add96bb2edc121bf796226cef3cc56fc32603eb3dd6c40f224ac5dc91b18dacbe5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13a1941bc765cf38e68d84197c8dfe711b759a68be24ffb2bc133067fe6dee800084bf2e10567a3c3e0b03d58b5d49cf30764d4d17e48a96fbe0cee49ac4b85b"} 06:25:29 INFO - Running post-run listener: copy_logs_to_upload_dir 06:25:29 INFO - Copying logs to upload dir... 06:25:29 INFO - mkdir: /builds/slave/test/build/upload/logs 06:25:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.573906 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-02-24 06:25:29.602177) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 06:25:29.605287) ========= 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.wTODBySpX6/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.eRzu43jRcK/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6822fb60f2cf28310dabddf54d0f53658e2f65f2753fd41dcae0b89c4874add96bb2edc121bf796226cef3cc56fc32603eb3dd6c40f224ac5dc91b18dacbe5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13a1941bc765cf38e68d84197c8dfe711b759a68be24ffb2bc133067fe6dee800084bf2e10567a3c3e0b03d58b5d49cf30764d4d17e48a96fbe0cee49ac4b85b"} build_url:https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011630 build_url: 'https://queue.taskcluster.net/v1/task/dQRvHBCPSlureB-W6hto4A/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c6822fb60f2cf28310dabddf54d0f53658e2f65f2753fd41dcae0b89c4874add96bb2edc121bf796226cef3cc56fc32603eb3dd6c40f224ac5dc91b18dacbe5f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13a1941bc765cf38e68d84197c8dfe711b759a68be24ffb2bc133067fe6dee800084bf2e10567a3c3e0b03d58b5d49cf30764d4d17e48a96fbe0cee49ac4b85b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 06:25:29.633472) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 06:25:29.633833) ========= 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.wTODBySpX6/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.eRzu43jRcK/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005489 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 06:25:29.682962) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 06:25:29.683313) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 06:25:29.683721) ========= ========= Total master_lag: 0.28 =========