builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0063 starttime: 1456516299.82 results: success (0) buildid: 20160226071248 builduid: c7c315dd81cc48079f15dd2b9801df57 revision: 48d839aa329bff5d22f47b394aeb03cb3e2533e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:39.823775) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:39.824259) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:39.824578) ========= 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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.005728 basedir: '/builds/slave/test' ========= master_lag: 0.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:39.926194) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:39.926511) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:39.947217) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:39.947595) ========= 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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.005385 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:39.995955) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:39.996843) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:39.997244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:39.997551) ========= 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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-26 11:51:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 214M=0s 2016-02-26 11:51:40 (214 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108005 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:40.120873) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:40.124313) ========= 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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.020308 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:40.314531) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 11:51:40.314897) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 48d839aa329bff5d22f47b394aeb03cb3e2533e7 --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 48d839aa329bff5d22f47b394aeb03cb3e2533e7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rCxXFpYXmc/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.ODIqJziRQ4/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-26 11:51:40,393 truncating revision to first 12 chars 2016-02-26 11:51:40,393 Setting DEBUG logging. 2016-02-26 11:51:40,393 attempt 1/10 2016-02-26 11:51:40,393 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/48d839aa329b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 11:51:41,248 unpacking tar archive at: fx-team-48d839aa329b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.100328 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 11:51:41.437343) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:41.437702) ========= echo 48d839aa329bff5d22f47b394aeb03cb3e2533e7 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'48d839aa329bff5d22f47b394aeb03cb3e2533e7'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rCxXFpYXmc/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.ODIqJziRQ4/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 48d839aa329bff5d22f47b394aeb03cb3e2533e7 program finished with exit code 0 elapsedTime=0.005048 script_repo_revision: '48d839aa329bff5d22f47b394aeb03cb3e2533e7' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:41.493856) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:41.494192) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 11:51:41.507519) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-26 11:51:41.507874) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rCxXFpYXmc/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.ODIqJziRQ4/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 11:51:41 INFO - MultiFileLogger online at 20160226 11:51:41 in /builds/slave/test 11:51:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:51:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:51:41 INFO - {'append_to_log': False, 11:51:41 INFO - 'base_work_dir': '/builds/slave/test', 11:51:41 INFO - 'blob_upload_branch': 'Fx-Team', 11:51:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:51:41 INFO - 'branch': 'Fx-Team', 11:51:41 INFO - 'buildbot_json_path': 'buildprops.json', 11:51:41 INFO - 'config_files': ('talos/mac_config.py',), 11:51:41 INFO - 'default_actions': ('clobber', 11:51:41 INFO - 'read-buildbot-config', 11:51:41 INFO - 'download-and-extract', 11:51:41 INFO - 'populate-webroot', 11:51:41 INFO - 'create-virtualenv', 11:51:41 INFO - 'install', 11:51:41 INFO - 'run-tests'), 11:51:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:51:41 INFO - 'download_minidump_stackwalk': True, 11:51:41 INFO - 'download_symbols': 'ondemand', 11:51:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:51:41 INFO - 'tooltool.py': '/tools/tooltool.py', 11:51:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:51:41 INFO - '/tools/misc-python/virtualenv.py')}, 11:51:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:51:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:51:41 INFO - 'installer_path': 'installer.exe', 11:51:41 INFO - 'log_level': 'info', 11:51:41 INFO - 'log_name': 'talos', 11:51:41 INFO - 'log_to_console': True, 11:51:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:51:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:51:41 INFO - 'opt_config_files': (), 11:51:41 INFO - 'pip_index': False, 11:51:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:51:41 INFO - 'cmd': ('bash', 11:51:41 INFO - '-c', 11:51:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:51:41 INFO - 'enabled': True, 11:51:41 INFO - 'halt_on_failure': False, 11:51:41 INFO - 'name': 'check_screen_resolution'},), 11:51:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:51:41 INFO - 'cmd': ('bash', 11:51:41 INFO - '-c', 11:51:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:51:41 INFO - 'enabled': True, 11:51:41 INFO - 'halt_on_failure': False, 11:51:41 INFO - 'name': 'check_screen_resolution'},), 11:51:41 INFO - 'run_cmd_checks_enabled': True, 11:51:41 INFO - 'sps_profile': False, 11:51:41 INFO - 'sps_profile_interval': 0, 11:51:41 INFO - 'suite': 'dromaeojs-e10s', 11:51:41 INFO - 'system_bits': '32', 11:51:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:51:41 INFO - 'title': 't-yosemite-r7-0063', 11:51:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:51:41 INFO - 'use_talos_json': True, 11:51:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:51:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:51:41 INFO - 'work_dir': 'build'} 11:51:41 INFO - ##### 11:51:41 INFO - ##### Running clobber step. 11:51:41 INFO - ##### 11:51:41 INFO - Running pre-action listener: _resource_record_pre_action 11:51:41 INFO - Running main action method: clobber 11:51:41 INFO - rmtree: /builds/slave/test/build 11:51:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:51:42 INFO - Running post-action listener: _resource_record_post_action 11:51:42 INFO - ##### 11:51:42 INFO - ##### Running read-buildbot-config step. 11:51:42 INFO - ##### 11:51:42 INFO - Running pre-action listener: _resource_record_pre_action 11:51:42 INFO - Running main action method: read_buildbot_config 11:51:42 INFO - Using buildbot properties: 11:51:42 INFO - { 11:51:42 INFO - "project": "", 11:51:42 INFO - "product": "firefox", 11:51:42 INFO - "script_repo_revision": "production", 11:51:42 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:51:42 INFO - "repository": "", 11:51:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:51:42 INFO - "buildid": "20160226071248", 11:51:42 INFO - "pgo_build": "False", 11:51:42 INFO - "basedir": "/builds/slave/test", 11:51:42 INFO - "buildnumber": 533, 11:51:42 INFO - "slavename": "t-yosemite-r7-0063", 11:51:42 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 11:51:42 INFO - "platform": "yosemite_r7", 11:51:42 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:51:42 INFO - "branch": "fx-team", 11:51:42 INFO - "repo_path": "integration/fx-team", 11:51:42 INFO - "revision": "48d839aa329bff5d22f47b394aeb03cb3e2533e7", 11:51:42 INFO - "stage_platform": "macosx64", 11:51:42 INFO - "builduid": "c7c315dd81cc48079f15dd2b9801df57", 11:51:42 INFO - "slavebuilddir": "test" 11:51:42 INFO - } 11:51:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 11:51:42 INFO - Running post-action listener: _resource_record_post_action 11:51:42 INFO - ##### 11:51:42 INFO - ##### Running download-and-extract step. 11:51:42 INFO - ##### 11:51:42 INFO - Running pre-action listener: _resource_record_pre_action 11:51:42 INFO - Running main action method: download_and_extract 11:51:42 INFO - mkdir: /builds/slave/test/build/tests 11:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:42 INFO - https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/test_packages.json 11:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/test_packages.json 11:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:51:43 INFO - Downloaded 1277 bytes. 11:51:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:51:43 INFO - Using the following test package requirements: 11:51:43 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:51:43 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:51:43 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 11:51:43 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:51:43 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 11:51:43 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:51:43 INFO - u'jsshell-mac.zip'], 11:51:43 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:51:43 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 11:51:43 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:51:43 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:51:43 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 11:51:43 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:51:43 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 11:51:43 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:51:43 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 11:51:43 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:51:43 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:51:43 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 11:51:43 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:51:43 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')]} 11:51:43 INFO - https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:51:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:51:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:51:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/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 11:51:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/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 11:51:45 INFO - Downloaded 17830376 bytes. 11:51:45 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'] 11:51:45 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 11:51:48 INFO - Return code: 0 11:51:48 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 11:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:48 INFO - https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:51:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:51:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:51:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/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 11:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/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 11:51:49 INFO - Downloaded 17830376 bytes. 11:51:49 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'] 11:51:49 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 11:51:52 INFO - Return code: 0 11:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:52 INFO - https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:51:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 11:51:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 11:51:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/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 11:51:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/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 11:51:54 INFO - Downloaded 10713410 bytes. 11:51:54 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'] 11:51:54 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 11:51:55 INFO - Return code: 0 11:51:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:51:55 INFO - https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:51:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:51:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:51:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 11:51:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IHN_AEdaSTmLb09xW6np6g/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 11:51:58 INFO - Downloaded 111445362 bytes. 11:51:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:51:58 INFO - mkdir: /builds/slave/test/properties 11:51:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:51:58 INFO - Writing to file /builds/slave/test/properties/build_url 11:51:58 INFO - Contents: 11:51:58 INFO - build_url:https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:51:59 INFO - Running post-action listener: _resource_record_post_action 11:51:59 INFO - Running post-action listener: set_extra_try_arguments 11:51:59 INFO - ##### 11:51:59 INFO - ##### Running populate-webroot step. 11:51:59 INFO - ##### 11:51:59 INFO - Running pre-action listener: _resource_record_pre_action 11:51:59 INFO - Running main action method: populate_webroot 11:51:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:51:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:51:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:51:59 INFO - '--tppagecycles', 11:51:59 INFO - '7'], 11:51:59 INFO - 'tests': ['tsvgm']}}, 11:51:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:51:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:51:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:51:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:51:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:51:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:51:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:59 INFO - 'talos_options': ['--e10s'], 11:51:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:51:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:59 INFO - 'tests': ['damp', 'tps']}, 11:51:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:59 INFO - 'talos_options': ['--e10s'], 11:51:59 INFO - 'tests': ['damp', 'tps']}, 11:51:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:51:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:51:59 INFO - 'other': {'tests': ['a11yr', 11:51:59 INFO - 'ts_paint', 11:51:59 INFO - 'tpaint', 11:51:59 INFO - 'sessionrestore', 11:51:59 INFO - 'sessionrestore_no_auto_restore']}, 11:51:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:51:59 INFO - 'tests': ['a11yr', 11:51:59 INFO - 'ts_paint', 11:51:59 INFO - 'tpaint', 11:51:59 INFO - 'sessionrestore', 11:51:59 INFO - 'sessionrestore_no_auto_restore']}, 11:51:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:51:59 INFO - 'tests': ['a11yr', 11:51:59 INFO - 'ts_paint', 11:51:59 INFO - 'tpaint', 11:51:59 INFO - 'sessionrestore', 11:51:59 INFO - 'sessionrestore_no_auto_restore']}, 11:51:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:51:59 INFO - 'tests': ['a11yr', 11:51:59 INFO - 'ts_paint', 11:51:59 INFO - 'tpaint', 11:51:59 INFO - 'sessionrestore', 11:51:59 INFO - 'sessionrestore_no_auto_restore']}, 11:51:59 INFO - 'other_l64': {'tests': ['a11yr', 11:51:59 INFO - 'ts_paint', 11:51:59 INFO - 'tpaint', 11:51:59 INFO - 'sessionrestore', 11:51:59 INFO - 'sessionrestore_no_auto_restore']}, 11:51:59 INFO - 'other_nol64': {'tests': ['a11yr', 11:51:59 INFO - 'ts_paint', 11:51:59 INFO - 'tpaint', 11:51:59 INFO - 'sessionrestore', 11:51:59 INFO - 'sessionrestore_no_auto_restore']}, 11:51:59 INFO - 'svgr': {'tests': ['tsvgx', 11:51:59 INFO - 'tsvgr_opacity', 11:51:59 INFO - 'tart', 11:51:59 INFO - 'tscrollx', 11:51:59 INFO - 'cart']}, 11:51:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:51:59 INFO - 'tests': ['tsvgx', 11:51:59 INFO - 'tsvgr_opacity', 11:51:59 INFO - 'tart', 11:51:59 INFO - 'tscrollx', 11:51:59 INFO - 'cart']}, 11:51:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:59 INFO - 'tests': ['tp5o']}, 11:51:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:59 INFO - 'talos_options': ['--e10s'], 11:51:59 INFO - 'tests': ['tp5o']}, 11:51:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:59 INFO - 'talos_options': ['--xperf_path', 11:51:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:59 INFO - 'tests': ['tp5n']}, 11:51:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:51:59 INFO - 'talos_options': ['--e10s', 11:51:59 INFO - '--xperf_path', 11:51:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:51:59 INFO - 'tests': ['tp5n']}}, 11:51:59 INFO - 'talos.zip': {'path': '', 11:51:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:51:59 INFO - Running post-action listener: _resource_record_post_action 11:51:59 INFO - ##### 11:51:59 INFO - ##### Running create-virtualenv step. 11:51:59 INFO - ##### 11:51:59 INFO - Running pre-action listener: _resource_record_pre_action 11:51:59 INFO - Running main action method: create_virtualenv 11:51:59 INFO - Creating virtualenv /builds/slave/test/build/venv 11:51:59 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 11:51:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:51:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:51:59 INFO - Using real prefix '/tools/python27' 11:51:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:52:00 INFO - Installing distribute.............................................................................................................................................................................................done. 11:52:03 INFO - Installing pip.................done. 11:52:03 INFO - Return code: 0 11:52:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdefa5a15b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bacd30>, '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 0x1049d0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ba3b20>, '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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 11:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:52:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rCxXFpYXmc/Render', 11:52:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:03 INFO - 'HOME': '/Users/cltbld', 11:52:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:03 INFO - 'LOGNAME': 'cltbld', 11:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:03 INFO - 'MOZ_NO_REMOTE': '1', 11:52:03 INFO - 'NO_EM_RESTART': '1', 11:52:03 INFO - 'PAGER': '/bin/cat', 11:52:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:03 INFO - 'PWD': '/builds/slave/test', 11:52:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:03 INFO - 'SHELL': '/bin/bash', 11:52:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODIqJziRQ4/Listeners', 11:52:03 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:52:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:03 INFO - 'USER': 'cltbld', 11:52:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:03 INFO - 'XPC_FLAGS': '0x0', 11:52:03 INFO - 'XPC_SERVICE_NAME': '0', 11:52:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:03 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 11:52:03 INFO - Cleaning up... 11:52:03 INFO - Return code: 0 11:52:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104d08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdefa5a15b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bacd30>, '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 0x1049d0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ba3b20>, '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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 11:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 11:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 11:52:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rCxXFpYXmc/Render', 11:52:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:03 INFO - 'HOME': '/Users/cltbld', 11:52:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:03 INFO - 'LOGNAME': 'cltbld', 11:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:03 INFO - 'MOZ_NO_REMOTE': '1', 11:52:03 INFO - 'NO_EM_RESTART': '1', 11:52:03 INFO - 'PAGER': '/bin/cat', 11:52:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:03 INFO - 'PWD': '/builds/slave/test', 11:52:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:03 INFO - 'SHELL': '/bin/bash', 11:52:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODIqJziRQ4/Listeners', 11:52:03 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:52:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:03 INFO - 'USER': 'cltbld', 11:52:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:03 INFO - 'XPC_FLAGS': '0x0', 11:52:03 INFO - 'XPC_SERVICE_NAME': '0', 11:52:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:03 INFO - Downloading/unpacking psutil>=0.7.1 11:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:52:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:52:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:52:06 INFO - Installing collected packages: psutil 11:52:06 INFO - Running setup.py install for psutil 11:52:06 INFO - building 'psutil._psutil_osx' extension 11:52:06 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 11:52:06 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 11:52:06 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 11:52:06 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 11:52:06 INFO - building 'psutil._psutil_posix' extension 11:52:06 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 11:52:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:52:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:52:07 INFO - ^ 11:52:07 INFO - 1 warning generated. 11:52:07 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 11:52:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:52:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:52:07 INFO - Successfully installed psutil 11:52:07 INFO - Cleaning up... 11:52:07 INFO - Return code: 0 11:52:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:07 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 0x104d08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdefa5a15b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bacd30>, '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 0x1049d0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ba3b20>, '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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 11:52:07 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 11:52:07 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 11:52:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rCxXFpYXmc/Render', 11:52:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:07 INFO - 'HOME': '/Users/cltbld', 11:52:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:07 INFO - 'LOGNAME': 'cltbld', 11:52:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:07 INFO - 'MOZ_NO_REMOTE': '1', 11:52:07 INFO - 'NO_EM_RESTART': '1', 11:52:07 INFO - 'PAGER': '/bin/cat', 11:52:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:07 INFO - 'PWD': '/builds/slave/test', 11:52:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:07 INFO - 'SHELL': '/bin/bash', 11:52:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODIqJziRQ4/Listeners', 11:52:07 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:52:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:07 INFO - 'USER': 'cltbld', 11:52:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:07 INFO - 'XPC_FLAGS': '0x0', 11:52:07 INFO - 'XPC_SERVICE_NAME': '0', 11:52:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:52: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 11:52: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 11:52: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 11:52: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 11:52: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 11:52: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 11:52:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:52:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:52:09 INFO - Installing collected packages: mozsystemmonitor 11:52:09 INFO - Running setup.py install for mozsystemmonitor 11:52:10 INFO - Successfully installed mozsystemmonitor 11:52:10 INFO - Cleaning up... 11:52:10 INFO - Return code: 0 11:52:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:52: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')]} 11:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52: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')]} 11:52:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52: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', '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 0x104d08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdefa5a15b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bacd30>, '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 0x1049d0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ba3b20>, '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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 11:52: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:52: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 blobuploader==1.2.4 11:52:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rCxXFpYXmc/Render', 11:52:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:10 INFO - 'HOME': '/Users/cltbld', 11:52:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:10 INFO - 'LOGNAME': 'cltbld', 11:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:10 INFO - 'MOZ_NO_REMOTE': '1', 11:52:10 INFO - 'NO_EM_RESTART': '1', 11:52:10 INFO - 'PAGER': '/bin/cat', 11:52:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:10 INFO - 'PWD': '/builds/slave/test', 11:52:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:10 INFO - 'SHELL': '/bin/bash', 11:52:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODIqJziRQ4/Listeners', 11:52:10 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:52:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:10 INFO - 'USER': 'cltbld', 11:52:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:10 INFO - 'XPC_FLAGS': '0x0', 11:52:10 INFO - 'XPC_SERVICE_NAME': '0', 11:52:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:10 INFO - Downloading/unpacking blobuploader==1.2.4 11:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:12 INFO - Downloading blobuploader-1.2.4.tar.gz 11:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:52:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:52:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:52: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 11:52: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 11:52: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 11:52: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 11:52: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 11:52: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 11:52:13 INFO - Downloading docopt-0.6.1.tar.gz 11:52:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:52:13 INFO - Installing collected packages: blobuploader, requests, docopt 11:52:13 INFO - Running setup.py install for blobuploader 11:52:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:52:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:52:14 INFO - Running setup.py install for requests 11:52:14 INFO - Running setup.py install for docopt 11:52:14 INFO - Successfully installed blobuploader requests docopt 11:52:14 INFO - Cleaning up... 11:52:14 INFO - Return code: 0 11:52:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52: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')]} 11:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52: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')]} 11:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:14 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 0x104d08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdefa5a15b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bacd30>, '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 0x1049d0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ba3b20>, '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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 11:52:14 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 11:52:14 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 11:52:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rCxXFpYXmc/Render', 11:52:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:14 INFO - 'HOME': '/Users/cltbld', 11:52:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:14 INFO - 'LOGNAME': 'cltbld', 11:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:14 INFO - 'MOZ_NO_REMOTE': '1', 11:52:14 INFO - 'NO_EM_RESTART': '1', 11:52:14 INFO - 'PAGER': '/bin/cat', 11:52:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:14 INFO - 'PWD': '/builds/slave/test', 11:52:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:14 INFO - 'SHELL': '/bin/bash', 11:52:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODIqJziRQ4/Listeners', 11:52:14 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:52:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:14 INFO - 'USER': 'cltbld', 11:52:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:14 INFO - 'XPC_FLAGS': '0x0', 11:52:14 INFO - 'XPC_SERVICE_NAME': '0', 11:52:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:52:15 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-P0ZxWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:52:15 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-m4qzWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:52:15 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-lp46bI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:52:15 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-MqPmJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:52:15 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-l5Uuqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:52:15 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-IW9gaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:52:15 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-_adKcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:52:15 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-hkV3Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:52:15 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-XCks6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:52:16 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Jj6blF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:52:16 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-CgN5cJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:52:16 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-AqZ3Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:52:16 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Pa20pY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:52:16 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-0ScCBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:16 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-bMnU2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:52:16 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Wt5qMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:52:16 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-iI8A2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:52:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:52:16 INFO - Running setup.py install for manifestparser 11:52:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:52:17 INFO - Running setup.py install for mozcrash 11:52:17 INFO - Running setup.py install for mozdebug 11:52:17 INFO - Running setup.py install for mozdevice 11:52:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:52:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:52:17 INFO - Running setup.py install for mozfile 11:52:17 INFO - Running setup.py install for mozhttpd 11:52:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:52:17 INFO - Running setup.py install for mozinfo 11:52:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:52:17 INFO - Running setup.py install for mozInstall 11:52:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:52:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:52:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:52:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:52:18 INFO - Running setup.py install for mozleak 11:52:18 INFO - Running setup.py install for mozlog 11:52:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:52:18 INFO - Running setup.py install for moznetwork 11:52:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:52:18 INFO - Running setup.py install for mozprocess 11:52:18 INFO - Running setup.py install for mozprofile 11:52:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:52:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:52:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:52:18 INFO - Running setup.py install for mozrunner 11:52:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:52:18 INFO - Running setup.py install for mozscreenshot 11:52:19 INFO - Running setup.py install for moztest 11:52:19 INFO - Running setup.py install for mozversion 11:52:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:52:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:52:19 INFO - Cleaning up... 11:52:19 INFO - Return code: 0 11:52:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:19 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 0x104d08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdefa5a15b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bacd30>, '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 0x1049d0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ba3b20>, '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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 11:52:19 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 11:52:19 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 11:52:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rCxXFpYXmc/Render', 11:52:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:19 INFO - 'HOME': '/Users/cltbld', 11:52:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:19 INFO - 'LOGNAME': 'cltbld', 11:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:19 INFO - 'MOZ_NO_REMOTE': '1', 11:52:19 INFO - 'NO_EM_RESTART': '1', 11:52:19 INFO - 'PAGER': '/bin/cat', 11:52:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:19 INFO - 'PWD': '/builds/slave/test', 11:52:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:19 INFO - 'SHELL': '/bin/bash', 11:52:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODIqJziRQ4/Listeners', 11:52:19 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:52:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:19 INFO - 'USER': 'cltbld', 11:52:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:19 INFO - 'XPC_FLAGS': '0x0', 11:52:19 INFO - 'XPC_SERVICE_NAME': '0', 11:52:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:52:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-b5wn1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:52:19 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)) 11:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:52:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-pndbJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:52:19 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)) 11:52:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:52:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-1k0plF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:52:20 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)) 11:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:52:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-RNHlgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:52:20 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)) 11:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:52:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-_jQAO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:52:20 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)) 11:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:52:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-1ZnQ9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:52:20 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)) 11:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:52:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-UZx3SW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:52:20 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)) 11:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:52:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-7nLTI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:52:20 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)) 11:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:52:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-hZsGlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:52:20 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)) 11:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:52:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Q71jml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:52:20 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)) 11:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:52:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-fxzxrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:52:20 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)) 11:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:52:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-cOA7WW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:52:20 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)) 11:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:52:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-WA66rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:52:21 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)) 11:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:52:21 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-kpuVQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:52:21 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)) 11:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:21 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-CVkyRT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:21 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)) 11:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:52:21 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ujLAQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:52:21 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)) 11:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:52:21 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-PHgUaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:52:21 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)) 11:52:21 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)) 11:52:21 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)) 11:52:21 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)) 11:52:21 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)) 11:52:21 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)) 11:52:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:52:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:52:23 INFO - Downloading blessings-1.6.tar.gz 11:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:52:23 INFO - Installing collected packages: blessings 11:52:23 INFO - Running setup.py install for blessings 11:52:24 INFO - Successfully installed blessings 11:52:24 INFO - Cleaning up... 11:52:24 INFO - Return code: 0 11:52:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:52:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:52:24 INFO - Reading from file tmpfile_stdout 11:52:24 INFO - Current package versions: 11:52:24 INFO - blessings == 1.6 11:52:24 INFO - blobuploader == 1.2.4 11:52:24 INFO - docopt == 0.6.1 11:52:24 INFO - manifestparser == 1.1 11:52:24 INFO - mozInstall == 1.12 11:52:24 INFO - mozcrash == 0.16 11:52:24 INFO - mozdebug == 0.1 11:52:24 INFO - mozdevice == 0.48 11:52:24 INFO - mozfile == 1.2 11:52:24 INFO - mozhttpd == 0.7 11:52:24 INFO - mozinfo == 0.9 11:52:24 INFO - mozleak == 0.1 11:52:24 INFO - mozlog == 3.1 11:52:24 INFO - moznetwork == 0.27 11:52:24 INFO - mozprocess == 0.22 11:52:24 INFO - mozprofile == 0.28 11:52:24 INFO - mozrunner == 6.11 11:52:24 INFO - mozscreenshot == 0.1 11:52:24 INFO - mozsystemmonitor == 0.0 11:52:24 INFO - moztest == 0.7 11:52:24 INFO - mozversion == 1.4 11:52:24 INFO - psutil == 3.1.1 11:52:24 INFO - requests == 1.2.3 11:52:24 INFO - wsgiref == 0.1.2 11:52:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52: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')]} 11:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52: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')]} 11:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:24 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 0x104d08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdefa5a15b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bacd30>, '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 0x1049d0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ba3b20>, '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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 11:52:24 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 11:52:24 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 11:52:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rCxXFpYXmc/Render', 11:52:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:24 INFO - 'HOME': '/Users/cltbld', 11:52:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:24 INFO - 'LOGNAME': 'cltbld', 11:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:24 INFO - 'MOZ_NO_REMOTE': '1', 11:52:24 INFO - 'NO_EM_RESTART': '1', 11:52:24 INFO - 'PAGER': '/bin/cat', 11:52:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:24 INFO - 'PWD': '/builds/slave/test', 11:52:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:24 INFO - 'SHELL': '/bin/bash', 11:52:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODIqJziRQ4/Listeners', 11:52:24 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:52:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:24 INFO - 'USER': 'cltbld', 11:52:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:24 INFO - 'XPC_FLAGS': '0x0', 11:52:24 INFO - 'XPC_SERVICE_NAME': '0', 11:52:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:24 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)) 11:52:24 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)) 11:52:24 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)) 11:52:24 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)) 11:52:24 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)) 11:52:24 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)) 11:52:24 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)) 11:52:24 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)) 11:52:24 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)) 11:52:24 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)) 11:52:24 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)) 11:52:24 INFO - Cleaning up... 11:52:24 INFO - Return code: 0 11:52:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:52: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')]} 11:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52: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')]} 11:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:24 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 0x104d08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdefa5a15b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bacd30>, '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 0x1049d0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ba3b20>, '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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 11:52:24 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 11:52:24 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 11:52:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rCxXFpYXmc/Render', 11:52:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:24 INFO - 'HOME': '/Users/cltbld', 11:52:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:24 INFO - 'LOGNAME': 'cltbld', 11:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:24 INFO - 'MOZ_NO_REMOTE': '1', 11:52:24 INFO - 'NO_EM_RESTART': '1', 11:52:24 INFO - 'PAGER': '/bin/cat', 11:52:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:24 INFO - 'PWD': '/builds/slave/test', 11:52:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:24 INFO - 'SHELL': '/bin/bash', 11:52:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODIqJziRQ4/Listeners', 11:52:24 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:52:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:24 INFO - 'USER': 'cltbld', 11:52:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:24 INFO - 'XPC_FLAGS': '0x0', 11:52:24 INFO - 'XPC_SERVICE_NAME': '0', 11:52:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:25 INFO - Downloading/unpacking jsonschema 11:52:25 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 11:52:25 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 11:52:25 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 11:52:25 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 11:52:25 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 11:52:25 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 11:52:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:52:27 INFO - Downloading/unpacking functools32 (from jsonschema) 11:52:27 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 11:52:27 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 11:52:27 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 11:52:27 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 11:52:27 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 11:52:27 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 11:52:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:52:27 INFO - warning: no files found matching '*.txt' 11:52:27 INFO - no previously-included directories found matching 'build' 11:52:27 INFO - no previously-included directories found matching 'dist' 11:52:27 INFO - no previously-included directories found matching '.git*' 11:52:27 INFO - Installing collected packages: jsonschema, functools32 11:52:27 INFO - Running setup.py install for functools32 11:52:28 INFO - warning: no files found matching '*.txt' 11:52:28 INFO - no previously-included directories found matching 'build' 11:52:28 INFO - no previously-included directories found matching 'dist' 11:52:28 INFO - no previously-included directories found matching '.git*' 11:52:28 INFO - Successfully installed jsonschema functools32 11:52:28 INFO - Cleaning up... 11:52:28 INFO - Return code: 0 11:52:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:52:28 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 0x104d08a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d0f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdefa5a15b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104bacd30>, '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 0x1049d0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ba3b20>, '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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 11:52:28 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 11:52:28 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 11:52:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rCxXFpYXmc/Render', 11:52:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:52:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:52:28 INFO - 'HOME': '/Users/cltbld', 11:52:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:52:28 INFO - 'LOGNAME': 'cltbld', 11:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:28 INFO - 'MOZ_NO_REMOTE': '1', 11:52:28 INFO - 'NO_EM_RESTART': '1', 11:52:28 INFO - 'PAGER': '/bin/cat', 11:52:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:28 INFO - 'PWD': '/builds/slave/test', 11:52:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:52:28 INFO - 'SHELL': '/bin/bash', 11:52:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODIqJziRQ4/Listeners', 11:52:28 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:52:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:52:28 INFO - 'USER': 'cltbld', 11:52:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:52:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:28 INFO - 'XPC_FLAGS': '0x0', 11:52:28 INFO - 'XPC_SERVICE_NAME': '0', 11:52:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:28 INFO - Downloading/unpacking flake8 11:52:28 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 11:52:28 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 11:52:28 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 11:52:28 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 11:52:28 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 11:52:28 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 11:52:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:52:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:52:30 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 11:52:30 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 11:52:30 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 11:52:30 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 11:52:30 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 11:52:30 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 11:52:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:52:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:52:31 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 11:52:31 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 11:52:31 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 11:52:31 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 11:52:31 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 11:52:31 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 11:52:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:52:31 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 11:52:31 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 11:52:31 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 11:52:31 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 11:52:31 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 11:52:31 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 11:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:52:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:52:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:52:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:52:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:52:31 INFO - no previously-included directories found matching 'docs/_build' 11:52:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:52:32 INFO - Running setup.py install for pep8 11:52:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:52:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:52:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:52:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:52:32 INFO - no previously-included directories found matching 'docs/_build' 11:52:32 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:52:32 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:52:32 INFO - Cleaning up... 11:52:32 INFO - Return code: 0 11:52:32 INFO - Running post-action listener: _resource_record_post_action 11:52:32 INFO - Running post-action listener: _start_resource_monitoring 11:52:32 INFO - Starting resource monitoring. 11:52:32 INFO - ##### 11:52:32 INFO - ##### Running install step. 11:52:32 INFO - ##### 11:52:32 INFO - Running pre-action listener: _resource_record_pre_action 11:52:32 INFO - Running main action method: install 11:52:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:52:32 INFO - Reading from file tmpfile_stdout 11:52:32 INFO - Detecting whether we're running mozinstall >=1.0... 11:52:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:52:32 INFO - Reading from file tmpfile_stdout 11:52:32 INFO - Output received: 11:52:32 INFO - Usage: mozinstall [options] installer 11:52:32 INFO - Options: 11:52:32 INFO - -h, --help show this help message and exit 11:52:32 INFO - -d DEST, --destination=DEST 11:52:32 INFO - Directory to install application into. [default: 11:52:32 INFO - "/builds/slave/test"] 11:52:32 INFO - --app=APP Application being installed. [default: firefox] 11:52:32 INFO - mkdir: /builds/slave/test/build/application 11:52:32 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'] 11:52:32 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 11:53:06 INFO - Reading from file tmpfile_stdout 11:53:06 INFO - Output received: 11:53:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:53:06 INFO - Running post-action listener: _resource_record_post_action 11:53:06 INFO - ##### 11:53:06 INFO - ##### Running run-tests step. 11:53:06 INFO - ##### 11:53:06 INFO - Running pre-action listener: _resource_record_pre_action 11:53:06 INFO - Running main action method: run_tests 11:53:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:53:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:53:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:53:06 INFO - 2016-02-26 11:53:06.980 screenresolution[2991:22707] starting screenresolution argv=screenresolution get 11:53:06 INFO - 2016-02-26 11:53:06.983 screenresolution[2991:22707] Display 0: 1600x1200x32@60 11:53:06 INFO - 2016-02-26 11:53:06.989 screenresolution[2992:22709] starting screenresolution argv=screenresolution list 11:53:06 INFO - Available Modes on Display 0 11:53:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:53:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:53:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:53:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:53:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:53:07 INFO - Intel Iris: 11:53:07 INFO - Chipset Model: Intel Iris 11:53:07 INFO - Type: GPU 11:53:07 INFO - Bus: Built-In 11:53:07 INFO - VRAM (Dynamic, Max): 1536 MB 11:53:07 INFO - Vendor: Intel (0x8086) 11:53:07 INFO - Device ID: 0x0a2e 11:53:07 INFO - Revision ID: 0x0009 11:53:07 INFO - Displays: 11:53:07 INFO - Display: 11:53:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:53:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:53:07 INFO - Display Serial Number: 1600x1200 60 11:53:07 INFO - Main Display: Yes 11:53:07 INFO - Mirror: Off 11:53:07 INFO - Online: Yes 11:53:07 INFO - Rotation: Supported 11:53:07 INFO - Return code: 0 11:53:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:53:07 INFO - Python 2.7.3 11:53:07 INFO - Return code: 0 11:53:07 INFO - grabbing minidump binary from tooltool 11:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:53:07 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 0x104bacd30>, '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 0x1049d0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ba3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:53:07 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 11:53:07 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 11:53:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:53:07 INFO - Return code: 0 11:53:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:53:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:53:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:53:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:53:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:53:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:53:08 INFO - Return code: 0 11:53:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:53:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0063 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:53:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rCxXFpYXmc/Render', 11:53:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:53:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:53:08 INFO - 'HOME': '/Users/cltbld', 11:53:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:53:08 INFO - 'LOGNAME': 'cltbld', 11:53:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:53:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:53:08 INFO - 'MOZ_NO_REMOTE': '1', 11:53:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:53:08 INFO - 'NO_EM_RESTART': '1', 11:53:08 INFO - 'PAGER': '/bin/cat', 11:53:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:53:08 INFO - 'PWD': '/builds/slave/test', 11:53:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:53:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:53:08 INFO - 'SHELL': '/bin/bash', 11:53:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ODIqJziRQ4/Listeners', 11:53:08 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 11:53:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:53:08 INFO - 'USER': 'cltbld', 11:53:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:53:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:53:08 INFO - 'XPC_FLAGS': '0x0', 11:53:08 INFO - 'XPC_SERVICE_NAME': '0', 11:53:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:53:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:53:08 INFO - mozversion application_buildid: 20160226071248 11:53:08 INFO - mozversion application_changeset: 48d839aa329bff5d22f47b394aeb03cb3e2533e7 11:53:08 INFO - mozversion application_display_name: Nightly 11:53:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:53:08 INFO - mozversion application_name: Firefox 11:53:08 INFO - mozversion application_remotingname: firefox 11:53:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:53:08 INFO - mozversion application_vendor: Mozilla 11:53:08 INFO - mozversion application_version: 47.0a1 11:53:08 INFO - mozversion platform_buildid: 20160226071248 11:53:08 INFO - mozversion platform_changeset: 48d839aa329bff5d22f47b394aeb03cb3e2533e7 11:53:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:53:08 INFO - mozversion platform_version: 47.0a1 11:53:08 INFO - using testdate: 1456516388 11:53:08 INFO - actual date: 1456516388 11:53:08 INFO - starting webserver on 'localhost:51899' 11:53:08 INFO - SUITE-START | Running 2 tests 11:53:08 INFO - TEST-START | dromaeo_css 11:53:08 INFO - operating with platform_type : mac_ 11:53:08 INFO - Initialising browser for dromaeo_css test... 11:53:08 INFO - TEST-INFO | started process 3010 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpxlwh6d/profile http://localhost:51899/getInfo.html) 11:53:11 INFO - PROCESS | 3010 | __metrics Screen width/height:1600/1200 11:53:11 INFO - PROCESS | 3010 | colorDepth:24 11:53:11 INFO - PROCESS | 3010 | Browser inner width/height: 1024/689 11:53:11 INFO - PROCESS | 3010 | __metrics 11:53:11 ERROR - PROCESS | 3010 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 11:53:12 INFO - TEST-INFO | 3010: exit 0 11:53:12 INFO - Browser initialized. 11:53:12 INFO - Running cycle 1/1 for dromaeo_css test... 11:53:12 INFO - TEST-INFO | started process 3015 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpxlwh6d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:53:24 INFO - PROCESS | 3015 | RSS: Main: 255672320 11:53:24 INFO - PROCESS | 3015 | 11:54:14 INFO - PROCESS | 3015 | 1456516454079 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] 11:56:24 INFO - PROCESS | 3015 | Cycle 1(1): loaded http://localhost:51899/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51899/tests/dromaeo/cssquery-ext.html) 11:56:25 INFO - PROCESS | 3015 | RSS: Main: 269832192 11:56:25 INFO - PROCESS | 3015 | 11:59:27 INFO - PROCESS | 3015 | Cycle 1(1): loaded http://localhost:51899/tests/dromaeo/cssquery-ext.html (next: http://localhost:51899/tests/dromaeo/cssquery-jquery.html) 11:59:28 INFO - PROCESS | 3015 | RSS: Main: 281726976 11:59:28 INFO - PROCESS | 3015 | 12:02:29 INFO - PROCESS | 3015 | Cycle 1(1): loaded http://localhost:51899/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51899/tests/dromaeo/cssquery-mootools.html) 12:02:30 INFO - PROCESS | 3015 | RSS: Main: 282710016 12:02:30 INFO - PROCESS | 3015 | 12:05:32 INFO - PROCESS | 3015 | Cycle 1(1): loaded http://localhost:51899/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51899/tests/dromaeo/cssquery-prototype.html) 12:05:32 INFO - PROCESS | 3015 | RSS: Main: 285208576 12:05:32 INFO - PROCESS | 3015 | 12:08:35 INFO - PROCESS | 3015 | Cycle 1(1): loaded http://localhost:51899/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51899/tests/dromaeo/cssquery-yui.html) 12:08:36 INFO - PROCESS | 3015 | RSS: Main: 287080448 12:08:36 INFO - PROCESS | 3015 | 12:11:38 INFO - PROCESS | 3015 | Cycle 1(1): loaded http://localhost:51899/tests/dromaeo/cssquery-yui.html (next: http://localhost:51899/tests/dromaeo/cssquery-dojo.html) 12:11:38 INFO - PROCESS | 3015 | RSS: Main: 289124352 12:11:38 INFO - PROCESS | 3015 | 12:11:38 INFO - PROCESS | 3015 | __start_tp_report 12:11:38 INFO - PROCESS | 3015 | _x_x_mozilla_page_load 12:11:38 INFO - PROCESS | 3015 | _x_x_mozilla_page_load_details 12:11:38 INFO - PROCESS | 3015 | |i|pagename|runs| 12:11:38 INFO - PROCESS | 3015 | |0;dojo.html;3490.214701692118;3496.1609213788693;3542.167590616203;3573.5533058367705;3573.5711714594254;4525.117602067598;4910.8772280693;5600.747966341514;5682.403347648499;5688.118341657045;5648.4633959773855;5710.628809127404;5744.540436765059;5783.826485205451;5851.531877449805;5055.721935293557;5130.4356520782685;5219.321488206528;5291.232771248186;5336.733163341837;5084.51697088776;5225.738713064351;5235.083860324447;5282.102042652739;5285.969235998982;4118.711690181688;4198.979005104955;4556.541906589892;4872.56146946773;5169.276301317818;3650.3976843820737;4197.370394440858;4345.196138714348;5011.924821127686;5208.479152084799;4395.296752519582;4875.512448755132;5072.72100034498;5162.3030890830005;5169.405518365398;3997.34043882759;5443.755031023614;5521.834344969658;5528.695921724304;5621.156826476021;5133.794648214104;6215.254169499689;6221.408966148254;6258.4680302174365;6276.403741644536;5575.773329867423;6014.248218972629;6176.722047507828;6273.937260627381;6290.308066112724;4994.925076123861;5762.769489220426;5783.9710801446145;5826.941730582725;5829.067349224104;6286.119943207955;6295.874082518324;6302.905456418157;6304.779332723424;6350.65071421067;6054.061620448838;6102.267727872595;6136.325004249618;6151.477124444383;6152.753889844356;5170.1727723564045;6047.092936059538;6128.662923539248;6212.658303793335;6229.190205273376;6127.711360156438;6154.630722156685;6156.994883314614;6172.166757487771;6179.227596550431;6106.21798979648;6129.572745043238;6146.354632763585;6210;6220.62676239418;4857.611391088704;4882.487338829443;4894.902101957941;4904.0191961607825;4930.2865419049895;4388.736675799462;4396.4284642996845;4417.911641767147;4429.313456414261;4456.197884380843;5334.226537152092;5702.429757024264;5808.535317174616;5866.266716660418;5903.498202652737;5008.398992120896;6256.405641464054;6273.686315684197;6288.9056664150075;6316.589421687668;5661.631993920382;5765.135229715576;5765.279340082489;5768.538516918637;5773.134029895466;5290.894182116336;5321.787128514816;5366.517013468807;5380.78476860929;5405.486478784509;6380.489560835122;6387.233531976192;6388.329225431263;6389.4888408926245;6408.839779005469;6118.326984031842;6157.722902469489;6220;6227.813165605039;6256.186695729526;6205.47253483459;6276.1213430118905;6355.396237357444;6365.586236894587;6400.55196136266;6119;6147.385261473817;6164.4143806338325;6175.722092505938;6178.783742568989;5834.94165058344;6096.012695893602;6201.193844800147;6214.471769899428;6219.657918814509;6031.819045428644;6049.18336024631;6058.515318774399;6065.848353791191;6125.571210015256;6126.754929802758;6153.169322141633;6163.137160797402;6164.075388691732;6173.32093469727;5754.798582049776;5829.358770535323;5919.052951527735;5929.2884853816095;5973.253343332083;6111.448149658432;6121.47967422774;6124.106319906264;6140.907886381798;6144.324124346408;5982.192404025575;6016.42843929826;6021.187139736079;6027.57806953509;6061.545384096122 12:11:38 INFO - PROCESS | 3015 | |1;ext.html;418.5667833792024;446.4196544492161;502.6355891978315;551.9595562364946;555.3197333266749;28842.85578572107;36960.81519592405;37034.44448333277;37039.44440833383;37050.258994820084;37587.24825503488;37931.24137517255;37957;38191.85424437265;38635.61364386355;9219.35464517484;9343.953280233589;9361.67234146805;9438.905610943906;9442.244620430383;9321.533923303841;9549.61801527938;9555.378900371488;9604.951975240114;9622.518874056304;9545.47499887506;9596.952015239915;9598.90401095987;9604.807903841955;9638.951805240999;9498.620055197784;9554.9522252389;9568.5694143763;9612.327137100407;9630.807383852354;9334.15992560666;9428.952855235748;9487.335886487948;9493.382930109521;9528.571214295303;37123.81438092819;37761.62238377636;37797.0550736231;37913.862584122246;38097.80951095227;3257.560229369052;3285.211549228192;3384.4754063120254;3387.5596172497417;3745.1198968242443;28018;28034;28259.01093461719;28308.716912830812;28915.85542072297;2746.1075150575944;2750.972490275112;2769.723027697234;2770.3766652503227;2830.150954713578;466967;469200;469292;471044;471242.99999999657;63405.68297158577;63454;63828.36171638317;64001.67999159975;64022;66564;66798;72691;74156;74582;14306.71239588442;15498.147601882005;16762.245698943578;16926.322947082226;16978.32086716542;12856.164349317265;12856.935715321364;12921.418536165895;12926.159799612995;12934.900533454762;21101.894490527447;21334;21422.464438389165;21442.78557214408;21502.56994860094;7577.318041376303;8043.477173983672;8739.825203495895;9100.317476189311;9189.816203676022;771.4599780153802;867.3798234262532;973.3575839945602;981.2983716642635;1005.2862467648051;28997.56503652447;29103.56344654832;29382.412351752846;29534.704652953194;29536.704632953824;1078.2560033576806;1083.7507373304184;1121.7644294698205;1168.2289688805517;1227.742174143422;13723.725525489634;13900.235487048309;14350.856491434952;14398.640033999234;14461;622708;624495;628637;634017;635292;57454;57528.137077943866;57830.421695782505;58221.70889145527;58487.70756146192;1247.6007677543098;1357.6537982814318;1413.7455258053649;1420.2330741399735;1439.4458133618632;19947.800521994595;26707.33231669224;27882.44235115327;28431.573526396707;28721.281967950967;44093.33859992038;44378.227850633055;47861.32485362996;48302.03395932132;48538.5146148534;485432;487331;490103;491075;491086;31840.885569004975;32949.17627059342;33164.66835331712;33212.50181247235;33824.66175338215;34662;43059.78470107629;43313.35029974616;43568.78215609028;44835.55164448314;29263.122106336843;36298.4555231677;36329.45505817362;36394.81802591076;37043.62956370402;27446.725532745215;35393;35774;36089;36174.73388431392;36275.45586816147;37228.06929826776;37715.05712357213;38293.80853095828;38414.615853842224;30141.246468838453;32194.517082243317;32582.674173257965;32628.673713262564;32743.672563274064;24669.145575947245;24724.9634775347;24861.129860454796;24870.502589947737;25024.249272521854 12:11:38 INFO - PROCESS | 3015 | |2;jquery.html;348.75761345864635;355.28587539046515;362.4762218594131;364.7975373667617;364.9562052553694;15778.289976951037;19480.707789383152;19521.902390488045;19916.50208744782;20583.176672933063;13533.796993045113;16866.746998795028;18076.63846723068;19262;19774.802251977475;5787.24765780448;6077.696115194245;6142.539309551779;6149.108379285023;6202.875942481148;4253.44705188325;5958;6353.650549219791;6655;6664.300248473914;6478.773242936498;6531.314212007742;6585.979173228157;6587.505937054716;6589.868202635945;6316.715747791361;6449.258700150956;6472.9029064564065;6484.93515064848;6490.675466226669;5288.8413347599635;5304;5605.747741351649;5610.523105536035;5649.943500564983;13136.540221092217;13320.600381988555;13324.467021319135;13328.933355333258;13452.932735336359;1943.2615606069603;2028.6044221376837;2137.476318302026;2145.420736401163;2246.2587346175724;9723.076307750753;12399.566015189424;13292.3353832308;13767.38046787897;14483.42066317346;1466.3035058347307;1523;1752.6056637256643;1770.4511601403606;1770.849477794389;93883.06116938879;100006;107345;107827.91290653154;112163.87836121616;8923.375363724477;11279.718007049889;11416;11510.53957841677;11559.76880462386;13595.388207530685;13616.114952528054;13621;13632.045756797128;13652.522161724291;8398.790030249293;8564.61459234336;8575.785605359792;8647.048824629286;8662.826743465095;8677.783055423539;8719.084496127942;8776.648934042567;8835.381523293308;8849.115088491099;4407.405000324915;4434.933475997863;4497.235469970113;4518.209313370147;4530.750808705553;1762.9823701763075;1834.779826420838;1846.9261229550668;1906.8760530565469;1936.2642195965443;905.5200743605899;912.1927094521396;939.9718008459757;1003.8996100389902;1026.8305729554688;14173.503927362493;19310.613787724447;19360.903195484214;19530.70703939442;20016.2994295199;790.3913986230685;900.4822227219375;941.1435593609782;944.6127087893931;962.9936716131659;9043.683471078612;10282.331648442976;10383;10720.571177152982;11056.502457389437;579467;622848;632944;636693;639159;98521.04436866906;109018;120904;123535;127689;898.5686870302292;967.5259123029806;1003.5534187286587;1022.1618273016055;1024.6004058417222;16304.429344972868;18178.818211817714;18269.81730182681;18353.449396518125;18429.815701843345;50185.498145018086;50235.24647130223;50642.74678626583;50881;52019.21971170511;49333.76665583389;72031.91952120827;72135.63932180306;72532;73845.89231161644;7987.281144697005;8074.1522140176785;8125.593720313843;8232.876506852283;8396.622152003296;12415.62753117408;13026;13147.73704525885;13297.867021329663;13431.462741490232;10595.47022648849;10968.561257549609;11263.436828158396;11334.546618135182;11649.417529123679;11137.665870023913;11151;11190.440477976232;11490.82763758561;11550.94224528872;11373.829392559284;11718.23831450953;11756.23584467007;12036.037117030792;12082.697932551757;7942.483738556975;8172.264496195371;8224.218699223564;8245.587720614065;8467.407281490237;8746.606402712021;8947.910520894708;11349.37578433161;11729.648110556696;11893.464794084113 12:11:38 INFO - PROCESS | 3015 | |3;mootools.html;1372.951946681866;1532.4253404973135;1728.1877517566738;1883.3314173468427;1893.25216539467;7768.689252429896;8076.475029123103;8494.277986371158;8706.347023973203;8710.695125670603;6490.513211509132;8495.532745699;8584.05575386707;8612.181842724947;8624.016476210476;2413.4087148648564;2421.842580232288;2429.514097180571;2431.671724317221;2435.305937807725;2388.904443822245;2412.19191570824;2431.57447446697;2431.8662473563945;2438.4147804526965;2000.469875482998;2421.4551725861716;2429.7327293997646;2431.902723891051;2435.1111844176926;2388.8088952883727;2398.436367453647;2411.457422080027;2419.1412048722714;2419.8427102238297;2389.665446837444;2407.9759202407927;2417.5648383291;2423.709154901423;2428.6114221724615;8561.828763424759;8629.61166747498;8651.480911145289;8652.610632521551;8690.478571285743;3940.9014774630577;4271.807768650418;4347.43483347166;5269.920951185735;5283;3480.3387356402204;3597.8380972856285;3644.380455322575;3677.797721125337;3686.594474607791;1054.9314294570904;1075;1076.8330908709163;1076.8869268726748;1079.6167360586958;11328.886711132865;11513.654590362303;11525.827112593317;11537.769244615145;11580.710482237928;4207.936880946727;4395.406620106309;4422.823087076546;4561.384213131251;4896.2655601660035;9797.363171393836;9812.313138080266;9826.4104153751;9828.606855725833;9829.901700983042;5330.067238233293;5349.465053494697;5354.759035843396;5367.114426119647;5373.382061063028;3922.4508568800393;4412.889677758082;4889.828855990023;4899.510048995072;4912.4350699669285;3801.372773492398;3865;3868.574456809749;3890.844366225376;3928.0769019280447;1276.4702648400996;1287.3305880941857;1289.4197611075053;1295.151675652449;1297.0661123990901;1346.0913883128849;1347.4340776873737;1354.106289848695;1364.6383708317105;1371.0539727587932;7859.803504912423;8040.316573091236;8047.678092876336;8060.758177254692;8061.919380806235;509.4396164219403;517.5109521502144;520.5679286192451;521.0230817217716;521.1375174086892;6140.078988151813;6140.4473597376455;6176.197094377792;6187.81436556904;6206.72069756862;10259.435731034715;10521.105706014921;10541;10595;10626.840597391045;10013.399196048114;10241.180705543538;10395.480225988671;10430.634927777643;10724.302920310154;8060.19398060201;8162.7143049992965;8178;8182.713605023915;8234.670613175525;7956.323712484272;7982.6008699565955;8023.237792409712;8058.758237252891;8125.512469251864;9139.77150571241;9378.249740020918;9459.668911588062;9538.475383853955;9611.086946740048;9153.993060763443;9488.85766713486;9598;9784.85322720174;9998.900010999796;6749.156355455568;6824.249332573314;7041.119860017498;7360.521566098187;7538.3969282458365;8111.716089936824;8138;8143.51138931666;8146.714864979697;8147.75556733299;7175.641217938978;7228.457865660202;7301.014363060919;7381;7427.702891884264;7143.6428178591905;7196.0285361475535;7209.6395180241825;7212.3148300911325;7219.747308844166;7564.394848412224;7567.508111972704;7571.659275332513;7575;7632.656530456032;6848.520603557902;6862.965685171542;6898.2756810536175;6911.274316196727;6942.271061538668;5610.691411972381;6770.781259373163;6792.456603471809;6948.583085014915;7012.544184627983 12:11:38 INFO - PROCESS | 3015 | |4;prototype.html;312.3191442655012;324.67856821746466;325.8012612306494;326.8741534509213;332.758749906318;6129.559553504922;6931.20291166516;6942.652867356631;6942.687579058942;6953.130858642669;6205.286392064914;6249.937500624992;6908.3437073477935;6920.515563910529;6941.652917354125;4611.884702882429;4823.155947709154;4918.385201849769;5034.5468907798295;5046.621503387242;5024.246363045536;5037.168867136918;5037.244413337992;5040.848774536751;5046;4153.626173644371;4840.225563909775;4952.628552858532;4963.205887058071;4974.303597496353;4353.1293741251875;4675.8831029224375;4993.975030124862;4994.55049045584;5037.168867136918;3875.6241534255214;4142.606452387018;4281.422008028907;4282.914341713148;4284.61438470536;6345.428911397997;6619;6659.4006539411685;6661.400473957318;6664.266930637626;4673.042026384617;5739.741711622987;5776.191333213354;5792.971035144839;5797.36229014808;5939.762409503614;7261.310175533369;7360.153582338046;7368.300011498899;7372.778816635509;4219.725717828332;4577.725336479789;4595.793189306489;4599.977000115012;4615.676902616819;7408.703651853865;7787.922120778833;7824.921750782476;7845.607719613997;7861.292483676497;3746.981265093657;4630.189716799614;4706.247000479907;4736.73947932867;4738.431388233434;4315.633171180422;4478.843240486567;4802.663813533089;4815.90508128965;4819.855404337875;4559.749213793273;5838.649681019152;5846.298444186725;5852.034414321589;5854.970725146347;5966.701664916737;7444.181140074587;7446.180920098785;7475.327220550176;7479.139898911695;1368.548379034916;1578.7710781936555;1637.3859802574034;1659.96680066398;1682.61299901021;1047.7485403503103;1056.1761825775907;1064.622059168984;1068.9465526723632;1071.59815069349;6831.795046148524;6840.623765692934;6844.555103918329;6862.725490980405;6891.414229790424;7612.467127301146;7639.503432276884;7644.273793989562;7681.462297639224;7690.500117492345;6207.534434917399;6248.437640612276;6922.930770692228;6961.895571566431;6998.75504357345;3750.643688849555;4003.279409706281;4062.5937406259727;4073.490813648294;4097.610726980932;7232.638368081575;8009.679612815422;8080.39397045224;8091.716789912325;8144.959275203586;8000.679972801139;8001;8033.236842499953;8059.758207253792;8087.676492940334;8107.108218096005;8115.553644549606;8142.592870356577;8144.185581441927;8152.755417337489;7453.217412171643;7724.420668449777;7759.068911730628;7767.145613982344;7795.688172473037;7585.469017168966;7610.124835643972;7613.619319033915;7633.0458692663415;7646.617669116633;7323.487355885037;7502.912077748805;8109.756097561023;8115.350771938349;8117.715879944174;4765.356676848581;4773.71357718538;4794.760261986817;4802.327674125695;4803.327534145293;6425.58233714807;7109.893351599627;7646.350060244941;7681.923180768121;7706.961465192639;5959.851003724942;7334.486585938933;7338.449616278694;7345.971563981154;7396.889046664197;7394.482386232912;7409.407247420301;7409.962950185214;7422.66598003102;7451.254874512505;5261.394939581997;7223.819404514929;7236.312550307713;7246.202917678946;7246.492745507975;6451.612903225821;6928.891377379595;7213.855722885618;7390.9260907390235;7402.222766609429;7197;7213.495055346076;7240.7465738701;7295.744648937261;7310.853782924418 12:11:38 INFO - PROCESS | 3015 | |5;yui.html;659.3604203922196;684.5447777228144;712.9733184214731;750.0661676213114;789.6486063701655;14784.704305913889;14965.925170374147;14999.925000374997;16796.16019199038;16923.661526769487;15528.5341439757;15544.611384715388;15555.688886222297;15560.299786509606;15650.373985040613;852.9061803201643;855.820277741675;874.45783614159;877.0965905117739;883.337496877342;706.7702996526124;711.2105562825286;874.8206617643368;876.4697358098355;882.8101958079012;908.4821651658557;914.3873604684877;916.7112359606735;918.3571499950028;920.2545937790378;896.000958930794;903.7650210945169;913.0549880873265;915.1900567997337;915.6932427636783;666.5234357434409;670.4502308107354;677.11298199359;679.2087218390569;680.397847904603;14872.70254594902;14938.925305373512;14970.550883473514;15098.245087745569;15270.847291527054;10767.676969690843;12429.751404971941;12634.368281585885;12645.43095560702;12902.612921612366;10048.497575121215;10079.34484258521;10085.142762865165;10120.089191972758;10147.137493313003;3473.8436770345397;3499.1077275294892;3565.4830049642655;3593.281343731238;3603.207294395229;78245;79209.20790792076;80873.59563202146;80913;81334.77997829978;7799.610019499002;8020.598970051474;9307.581158847868;9571.712848614414;9657.517124143766;21766.782332176794;21926.780732192474;21942.78057219439;21944.45138871509;21992.89003554972;7513;7619.733309334147;7648.694052237848;7685.769426917202;7776.766696999099;3413.6415676353627;4099.8360065597635;4112.568180341081;4133.07856133434;4141;2769.736874996872;3260.4294248506417;3302.4055669979634;3311.6853898879567;3315.0220684898013;634.6985182038495;635.4598591197445;638.7764282501088;640.916680831489;649.3863299182227;524.6144084098185;527.2697314219756;566.5665765689251;592.7540070870626;593.2021431175062;6639.236487803868;8052;8128.349732021424;8351.273771080077;8485.872711909326;464.46818392939895;516.9170587618933;517.4101524262344;520.5289213262004;552.1855263486326;3853.2871418787613;3901.258760835432;4000.4199391088127;4008.2785098681934;4031.7368782127546;69801.65099174471;82870.58564707258;83388.16611833803;85186.57406713051;85952;55847;71321.5037473686;74305.25694743091;76635;87576.6863497048;63497.36502634914;65081.67459162674;70416.64791676111;74658.6267068672;75036.24963750402;7376.4098872089035;8441.831163376575;8535.61589728476;8596.699115530926;8676.479411235347;43809.34285985649;46239;48560.757196213795;49694.75152624214;51174.232386514974;64779.67610161919;65356;65712.67143664251;65836;65857.67071164613;9010.774730631525;11125;11125.499352528994;11319.377434240867;11537.019353354723;11815.704607384883;11826.76346473083;11906.285622862655;12205.938970305091;12456.750864982469;9143.542822858697;11210.159238057342;11291.887081129413;11397.373144476802;11463.31220126795;11048.392338421463;11102.167337449886;11116.555337786398;11232.157588180755;11242.718932026764;10597.9470102649;10650.307729997836;10699.251052426256;10803.945980270048;10888.945555272174;9337.673181438617;9655.372400793925;9668.931273878678;9679.461299599774;9765.2676049298;9332.440053596805;9594.66418675343;9776.462294573867;9807.264455165749;9807.558659860466 12:11:38 INFO - PROCESS | 3015 | __end_tp_report 12:11:38 INFO - PROCESS | 3015 | __start_cc_report 12:11:38 INFO - PROCESS | 3015 | _x_x_mozilla_cycle_collect,347 12:11:38 INFO - PROCESS | 3015 | __end_cc_report 12:11:38 INFO - PROCESS | 3015 | __startTimestamp1456517498564__endTimestamp 12:11:38 INFO - PROCESS | 3015 | 12:11:38 INFO - PROCESS | 3015 | ------- Summary: start ------- 12:11:38 INFO - PROCESS | 3015 | Number of tests: 6 12:11:38 INFO - PROCESS | 3015 | 12:11:38 INFO - PROCESS | 3015 | [#0] dojo.html Cycles:165 Average:5643.77 Median:5919.05 stddev:715.59 (12.1%) stddev-sans-first:697.56 12:11:38 INFO - PROCESS | 3015 | Values: 3490.2 3496.2 3542.2 3573.6 3573.6 4525.1 4910.9 5600.7 5682.4 5688.1 5648.5 5710.6 5744.5 5783.8 5851.5 5055.7 5130.4 5219.3 5291.2 5336.7 5084.5 5225.7 5235.1 5282.1 5286.0 4118.7 4199.0 4556.5 4872.6 5169.3 3650.4 4197.4 4345.2 5011.9 5208.5 4395.3 4875.5 5072.7 5162.3 5169.4 3997.3 5443.8 5521.8 5528.7 5621.2 5133.8 6215.3 6221.4 6258.5 6276.4 5575.8 6014.2 6176.7 6273.9 6290.3 4994.9 5762.8 5784.0 5826.9 5829.1 6286.1 6295.9 6302.9 6304.8 6350.7 6054.1 6102.3 6136.3 6151.5 6152.8 5170.2 6047.1 6128.7 6212.7 6229.2 6127.7 6154.6 6157.0 6172.2 6179.2 6106.2 6129.6 6146.4 6210.0 6220.6 4857.6 4882.5 4894.9 4904.0 4930.3 4388.7 4396.4 4417.9 4429.3 4456.2 5334.2 5702.4 5808.5 5866.3 5903.5 5008.4 6256.4 6273.7 6288.9 6316.6 5661.6 5765.1 5765.3 5768.5 5773.1 5290.9 5321.8 5366.5 5380.8 5405.5 6380.5 6387.2 6388.3 6389.5 6408.8 6118.3 6157.7 6220.0 6227.8 6256.2 6205.5 6276.1 6355.4 6365.6 6400.6 6119.0 6147.4 6164.4 6175.7 6178.8 5834.9 6096.0 6201.2 6214.5 6219.7 6031.8 6049.2 6058.5 6065.8 6125.6 6126.8 6153.2 6163.1 6164.1 6173.3 5754.8 5829.4 5919.1 5929.3 5973.3 6111.4 6121.5 6124.1 6140.9 6144.3 5982.2 6016.4 6021.2 6027.6 6061.5 12:11:38 INFO - PROCESS | 3015 | 12:11:38 INFO - PROCESS | 3015 | [#1] ext.html Cycles:180 Average:66423.50 Median:37651.15 stddev:142561.12 (378.6%) stddev-sans-first:142874.90 12:11:38 INFO - PROCESS | 3015 | Values: 418.6 446.4 502.6 552.0 555.3 28842.9 36960.8 37034.4 37039.4 37050.3 37587.2 37931.2 37957.0 38191.9 38635.6 9219.4 9344.0 9361.7 9438.9 9442.2 9321.5 9549.6 9555.4 9605.0 9622.5 9545.5 9597.0 9598.9 9604.8 9639.0 9498.6 9555.0 9568.6 9612.3 9630.8 9334.2 9429.0 9487.3 9493.4 9528.6 37123.8 37761.6 37797.1 37913.9 38097.8 3257.6 3285.2 3384.5 3387.6 3745.1 28018.0 28034.0 28259.0 28308.7 28915.9 2746.1 2751.0 2769.7 2770.4 2830.2 466967.0 469200.0 469292.0 471044.0 471243.0 63405.7 63454.0 63828.4 64001.7 64022.0 66564.0 66798.0 72691.0 74156.0 74582.0 14306.7 15498.1 16762.2 16926.3 16978.3 12856.2 12856.9 12921.4 12926.2 12934.9 21101.9 21334.0 21422.5 21442.8 21502.6 7577.3 8043.5 8739.8 9100.3 9189.8 771.5 867.4 973.4 981.3 1005.3 28997.6 29103.6 29382.4 29534.7 29536.7 1078.3 1083.8 1121.8 1168.2 1227.7 13723.7 13900.2 14350.9 14398.6 14461.0 622708.0 624495.0 628637.0 634017.0 635292.0 57454.0 57528.1 57830.4 58221.7 58487.7 1247.6 1357.7 1413.7 1420.2 1439.4 19947.8 26707.3 27882.4 28431.6 28721.3 44093.3 44378.2 47861.3 48302.0 48538.5 485432.0 487331.0 490103.0 491075.0 491086.0 31840.9 32949.2 33164.7 33212.5 33824.7 34662.0 43059.8 43313.4 43568.8 44835.6 29263.1 36298.5 36329.5 36394.8 37043.6 27446.7 35393.0 35774.0 36089.0 36174.7 36275.5 37228.1 37715.1 38293.8 38414.6 30141.2 32194.5 32582.7 32628.7 32743.7 24669.1 24725.0 24861.1 24870.5 25024.2 12:11:38 INFO - PROCESS | 3015 | 12:11:38 INFO - PROCESS | 3015 | [#2] jquery.html Cycles:180 Average:34178.58 Median:2141.45 stddev:103111.86 (4815.1%) stddev-sans-first:103369.82 12:11:38 INFO - PROCESS | 3015 | Values: 348.8 355.3 362.5 364.8 365.0 15778.3 19480.7 19521.9 19916.5 20583.2 13533.8 16866.7 18076.6 19262.0 19774.8 5787.2 6077.7 6142.5 6149.1 6202.9 4253.4 5958.0 6353.7 6655.0 6664.3 6478.8 6531.3 6586.0 6587.5 6589.9 6316.7 6449.3 6472.9 6484.9 6490.7 5288.8 5304.0 5605.7 5610.5 5649.9 13136.5 13320.6 13324.5 13328.9 13452.9 1943.3 2028.6 2137.5 2145.4 2246.3 9723.1 12399.6 13292.3 13767.4 14483.4 1466.3 1523.0 1752.6 1770.5 1770.8 93883.1 100006.0 107345.0 107827.9 112163.9 8923.4 11279.7 11416.0 11510.5 11559.8 13595.4 13616.1 13621.0 13632.0 13652.5 8398.8 8564.6 8575.8 8647.0 8662.8 8677.8 8719.1 8776.6 8835.4 8849.1 4407.4 4434.9 4497.2 4518.2 4530.8 1763.0 1834.8 1846.9 1906.9 1936.3 905.5 912.2 940.0 1003.9 1026.8 14173.5 19310.6 19360.9 19530.7 20016.3 790.4 900.5 941.1 944.6 963.0 9043.7 10282.3 10383.0 10720.6 11056.5 579467.0 622848.0 632944.0 636693.0 639159.0 98521.0 109018.0 120904.0 123535.0 127689.0 898.6 967.5 1003.6 1022.2 1024.6 16304.4 18178.8 18269.8 18353.4 18429.8 50185.5 50235.2 50642.7 50881.0 52019.2 49333.8 72031.9 72135.6 72532.0 73845.9 7987.3 8074.2 8125.6 8232.9 8396.6 12415.6 13026.0 13147.7 13297.9 13431.5 10595.5 10968.6 11263.4 11334.5 11649.4 11137.7 11151.0 11190.4 11490.8 11550.9 11373.8 11718.2 11756.2 12036.0 12082.7 7942.5 8172.3 8224.2 8245.6 8467.4 8746.6 8947.9 11349.4 11729.6 11893.5 12:11:38 INFO - PROCESS | 3015 | 12:11:38 INFO - PROCESS | 3015 | [#3] mootools.html Cycles:180 Average:5891.24 Median:5339.77 stddev:3132.43 (58.7%) stddev-sans-first:3122.80 12:11:38 INFO - PROCESS | 3015 | Values: 1373.0 1532.4 1728.2 1883.3 1893.3 7768.7 8076.5 8494.3 8706.3 8710.7 6490.5 8495.5 8584.1 8612.2 8624.0 2413.4 2421.8 2429.5 2431.7 2435.3 2388.9 2412.2 2431.6 2431.9 2438.4 2000.5 2421.5 2429.7 2431.9 2435.1 2388.8 2398.4 2411.5 2419.1 2419.8 2389.7 2408.0 2417.6 2423.7 2428.6 8561.8 8629.6 8651.5 8652.6 8690.5 3940.9 4271.8 4347.4 5269.9 5283.0 3480.3 3597.8 3644.4 3677.8 3686.6 1054.9 1075.0 1076.8 1076.9 1079.6 11328.9 11513.7 11525.8 11537.8 11580.7 4207.9 4395.4 4422.8 4561.4 4896.3 9797.4 9812.3 9826.4 9828.6 9829.9 5330.1 5349.5 5354.8 5367.1 5373.4 3922.5 4412.9 4889.8 4899.5 4912.4 3801.4 3865.0 3868.6 3890.8 3928.1 1276.5 1287.3 1289.4 1295.2 1297.1 1346.1 1347.4 1354.1 1364.6 1371.1 7859.8 8040.3 8047.7 8060.8 8061.9 509.4 517.5 520.6 521.0 521.1 6140.1 6140.4 6176.2 6187.8 6206.7 10259.4 10521.1 10541.0 10595.0 10626.8 10013.4 10241.2 10395.5 10430.6 10724.3 8060.2 8162.7 8178.0 8182.7 8234.7 7956.3 7982.6 8023.2 8058.8 8125.5 9139.8 9378.2 9459.7 9538.5 9611.1 9154.0 9488.9 9598.0 9784.9 9998.9 6749.2 6824.2 7041.1 7360.5 7538.4 8111.7 8138.0 8143.5 8146.7 8147.8 7175.6 7228.5 7301.0 7381.0 7427.7 7143.6 7196.0 7209.6 7212.3 7219.7 7564.4 7567.5 7571.7 7575.0 7632.7 6848.5 6863.0 6898.3 6911.3 6942.3 5610.7 6770.8 6792.5 6948.6 7012.5 12:11:38 INFO - PROCESS | 3015 | 12:11:38 INFO - PROCESS | 3015 | [#4] prototype.html Cycles:180 Average:5934.41 Median:6748.03 stddev:1979.92 (29.3%) stddev-sans-first:1939.98 12:11:38 INFO - PROCESS | 3015 | Values: 312.3 324.7 325.8 326.9 332.8 6129.6 6931.2 6942.7 6942.7 6953.1 6205.3 6249.9 6908.3 6920.5 6941.7 4611.9 4823.2 4918.4 5034.5 5046.6 5024.2 5037.2 5037.2 5040.8 5046.0 4153.6 4840.2 4952.6 4963.2 4974.3 4353.1 4675.9 4994.0 4994.6 5037.2 3875.6 4142.6 4281.4 4282.9 4284.6 6345.4 6619.0 6659.4 6661.4 6664.3 4673.0 5739.7 5776.2 5793.0 5797.4 5939.8 7261.3 7360.2 7368.3 7372.8 4219.7 4577.7 4595.8 4600.0 4615.7 7408.7 7787.9 7824.9 7845.6 7861.3 3747.0 4630.2 4706.2 4736.7 4738.4 4315.6 4478.8 4802.7 4815.9 4819.9 4559.7 5838.6 5846.3 5852.0 5855.0 5966.7 7444.2 7446.2 7475.3 7479.1 1368.5 1578.8 1637.4 1660.0 1682.6 1047.7 1056.2 1064.6 1068.9 1071.6 6831.8 6840.6 6844.6 6862.7 6891.4 7612.5 7639.5 7644.3 7681.5 7690.5 6207.5 6248.4 6922.9 6961.9 6998.8 3750.6 4003.3 4062.6 4073.5 4097.6 7232.6 8009.7 8080.4 8091.7 8145.0 8000.7 8001.0 8033.2 8059.8 8087.7 8107.1 8115.6 8142.6 8144.2 8152.8 7453.2 7724.4 7759.1 7767.1 7795.7 7585.5 7610.1 7613.6 7633.0 7646.6 7323.5 7502.9 8109.8 8115.4 8117.7 4765.4 4773.7 4794.8 4802.3 4803.3 6425.6 7109.9 7646.4 7681.9 7707.0 5959.9 7334.5 7338.4 7346.0 7396.9 7394.5 7409.4 7410.0 7422.7 7451.3 5261.4 7223.8 7236.3 7246.2 7246.5 6451.6 6928.9 7213.9 7390.9 7402.2 7197.0 7213.5 7240.7 7295.7 7310.9 12:11:38 INFO - PROCESS | 3015 | 12:11:38 INFO - PROCESS | 3015 | [#5] yui.html Cycles:180 Average:17705.81 Median:32066.41 stddev:24404.14 (76.1%) stddev-sans-first:24439.03 12:11:38 INFO - PROCESS | 3015 | Values: 659.4 684.5 713.0 750.1 789.6 14784.7 14965.9 14999.9 16796.2 16923.7 15528.5 15544.6 15555.7 15560.3 15650.4 852.9 855.8 874.5 877.1 883.3 706.8 711.2 874.8 876.5 882.8 908.5 914.4 916.7 918.4 920.3 896.0 903.8 913.1 915.2 915.7 666.5 670.5 677.1 679.2 680.4 14872.7 14938.9 14970.6 15098.2 15270.8 10767.7 12429.8 12634.4 12645.4 12902.6 10048.5 10079.3 10085.1 10120.1 10147.1 3473.8 3499.1 3565.5 3593.3 3603.2 78245.0 79209.2 80873.6 80913.0 81334.8 7799.6 8020.6 9307.6 9571.7 9657.5 21766.8 21926.8 21942.8 21944.5 21992.9 7513.0 7619.7 7648.7 7685.8 7776.8 3413.6 4099.8 4112.6 4133.1 4141.0 2769.7 3260.4 3302.4 3311.7 3315.0 634.7 635.5 638.8 640.9 649.4 524.6 527.3 566.6 592.8 593.2 6639.2 8052.0 8128.3 8351.3 8485.9 464.5 516.9 517.4 520.5 552.2 3853.3 3901.3 4000.4 4008.3 4031.7 69801.7 82870.6 83388.2 85186.6 85952.0 55847.0 71321.5 74305.3 76635.0 87576.7 63497.4 65081.7 70416.6 74658.6 75036.2 7376.4 8441.8 8535.6 8596.7 8676.5 43809.3 46239.0 48560.8 49694.8 51174.2 64779.7 65356.0 65712.7 65836.0 65857.7 9010.8 11125.0 11125.5 11319.4 11537.0 11815.7 11826.8 11906.3 12205.9 12456.8 9143.5 11210.2 11291.9 11397.4 11463.3 11048.4 11102.2 11116.6 11232.2 11242.7 10597.9 10650.3 10699.3 10803.9 10888.9 9337.7 9655.4 9668.9 9679.5 9765.3 9332.4 9594.7 9776.5 9807.3 9807.6 12:11:38 INFO - PROCESS | 3015 | -------- Summary: end -------- 12:11:38 INFO - PROCESS | 3015 | 12:11:39 INFO - TEST-INFO | 3015: exit 0 12:11:39 INFO - TEST-OK | dromaeo_css | took 1110314ms 12:11:39 INFO - TEST-START | kraken 12:11:39 INFO - operating with platform_type : mac_ 12:11:39 INFO - Initialising browser for kraken test... 12:11:39 INFO - TEST-INFO | started process 3130 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmp0g7tbZ/profile http://localhost:51899/getInfo.html) 12:11:41 INFO - PROCESS | 3130 | __metrics Screen width/height:1600/1200 12:11:41 INFO - PROCESS | 3130 | colorDepth:24 12:11:41 INFO - PROCESS | 3130 | Browser inner width/height: 1024/689 12:11:41 INFO - PROCESS | 3130 | __metrics 12:11:41 ERROR - PROCESS | 3130 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 12:11:42 INFO - TEST-INFO | 3130: exit 0 12:11:42 INFO - Browser initialized. 12:11:42 INFO - Running cycle 1/1 for kraken test... 12:11:42 INFO - TEST-INFO | started process 3134 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmp0g7tbZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:11:54 INFO - PROCESS | 3134 | RSS: Main: 255660032 12:11:54 INFO - PROCESS | 3134 | 12:11:56 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51899/tests/kraken/driver.html?testName=audio-beat-detection) 12:11:57 INFO - PROCESS | 3134 | RSS: Main: 269791232 12:11:57 INFO - PROCESS | 3134 | 12:12:00 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51899/tests/kraken/driver.html?testName=audio-dft) 12:12:00 INFO - PROCESS | 3134 | RSS: Main: 276525056 12:12:00 INFO - PROCESS | 3134 | 12:12:04 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51899/tests/kraken/driver.html?testName=audio-fft) 12:12:04 INFO - PROCESS | 3134 | RSS: Main: 281280512 12:12:04 INFO - PROCESS | 3134 | 12:12:06 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51899/tests/kraken/driver.html?testName=audio-oscillator) 12:12:07 INFO - PROCESS | 3134 | RSS: Main: 282386432 12:12:07 INFO - PROCESS | 3134 | 12:12:09 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51899/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:12:10 INFO - PROCESS | 3134 | RSS: Main: 283054080 12:12:10 INFO - PROCESS | 3134 | 12:12:13 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51899/tests/kraken/driver.html?testName=imaging-darkroom) 12:12:13 INFO - PROCESS | 3134 | RSS: Main: 282652672 12:12:13 INFO - PROCESS | 3134 | 12:12:16 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51899/tests/kraken/driver.html?testName=imaging-desaturate) 12:12:17 INFO - PROCESS | 3134 | RSS: Main: 282664960 12:12:17 INFO - PROCESS | 3134 | 12:12:20 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51899/tests/kraken/driver.html?testName=json-parse-financial) 12:12:20 INFO - PROCESS | 3134 | RSS: Main: 282996736 12:12:20 INFO - PROCESS | 3134 | 12:12:22 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51899/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:12:23 INFO - PROCESS | 3134 | RSS: Main: 281808896 12:12:23 INFO - PROCESS | 3134 | 12:12:25 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51899/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:12:25 INFO - PROCESS | 3134 | RSS: Main: 282476544 12:12:25 INFO - PROCESS | 3134 | 12:12:28 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51899/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:12:28 INFO - PROCESS | 3134 | RSS: Main: 283422720 12:12:28 INFO - PROCESS | 3134 | 12:12:31 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:12:32 INFO - PROCESS | 3134 | RSS: Main: 282546176 12:12:32 INFO - PROCESS | 3134 | 12:12:34 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:12:35 INFO - PROCESS | 3134 | RSS: Main: 284286976 12:12:35 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | Cycle 1(1): loaded http://localhost:51899/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51899/tests/kraken/driver.html?testName=ai-astar) 12:12:37 INFO - PROCESS | 3134 | RSS: Main: 283942912 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | __start_tp_report 12:12:37 INFO - PROCESS | 3134 | _x_x_mozilla_page_load 12:12:37 INFO - PROCESS | 3134 | _x_x_mozilla_page_load_details 12:12:37 INFO - PROCESS | 3134 | |i|pagename|runs| 12:12:37 INFO - PROCESS | 3134 | |0;ai-astar;122;110;115;113;115;126;116;114;116;114 12:12:37 INFO - PROCESS | 3134 | |1;audio-beat-detection;152;121;145;154;121;138;173;155;195;113 12:12:37 INFO - PROCESS | 3134 | |2;audio-dft;196;201;198;203;233;292;196;199;200;202 12:12:37 INFO - PROCESS | 3134 | |3;audio-fft;78;80;91;151;88;51;70;92;150;82 12:12:37 INFO - PROCESS | 3134 | |4;audio-oscillator;81;86;118;81;80;83;123;123;124;165 12:12:37 INFO - PROCESS | 3134 | |5;imaging-gaussian-blur;90;96;91;96;90;94;90;96;89;97 12:12:37 INFO - PROCESS | 3134 | |6;imaging-darkroom;96;101;97;102;154;97;97;97;97;96 12:12:37 INFO - PROCESS | 3134 | |7;imaging-desaturate;120;151;92;77;103;109;151;153;92;133 12:12:37 INFO - PROCESS | 3134 | |8;json-parse-financial;56;57;64;66;67;50;74;100;97;91 12:12:37 INFO - PROCESS | 3134 | |9;json-stringify-tinderbox;69;71;67;81;81;66;85;92;109;104 12:12:37 INFO - PROCESS | 3134 | |10;stanford-crypto-aes;101;115;101;84;111;115;75;102;73;89 12:12:37 INFO - PROCESS | 3134 | |11;stanford-crypto-ccm;160;118;141;157;140;115;145;132;128;112 12:12:37 INFO - PROCESS | 3134 | |12;stanford-crypto-pbkdf2;156;184;140;143;148;187;140;141;148;121 12:12:37 INFO - PROCESS | 3134 | |13;stanford-crypto-sha256-iterative;67;73;65;59;101;97;98;103;99;97 12:12:37 INFO - PROCESS | 3134 | __end_tp_report 12:12:37 INFO - PROCESS | 3134 | __start_cc_report 12:12:37 INFO - PROCESS | 3134 | _x_x_mozilla_cycle_collect,900 12:12:37 INFO - PROCESS | 3134 | __end_cc_report 12:12:37 INFO - PROCESS | 3134 | __startTimestamp1456517557329__endTimestamp 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | ------- Summary: start ------- 12:12:37 INFO - PROCESS | 3134 | Number of tests: 14 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#0] ai-astar Cycles:10 Average:116.10 Median:115.50 stddev:4.61 (4.0%) stddev-sans-first:4.36 12:12:37 INFO - PROCESS | 3134 | Values: 122.0 110.0 115.0 113.0 115.0 126.0 116.0 114.0 116.0 114.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#1] audio-beat-detection Cycles:10 Average:146.70 Median:153.00 stddev:25.19 (16.5%) stddev-sans-first:26.64 12:12:37 INFO - PROCESS | 3134 | Values: 152.0 121.0 145.0 154.0 121.0 138.0 173.0 155.0 195.0 113.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#2] audio-dft Cycles:10 Average:212.00 Median:201.50 stddev:30.12 (14.9%) stddev-sans-first:31.38 12:12:37 INFO - PROCESS | 3134 | Values: 196.0 201.0 198.0 203.0 233.0 292.0 196.0 199.0 200.0 202.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#3] audio-fft Cycles:10 Average:93.30 Median:81.00 stddev:32.40 (40.0%) stddev-sans-first:33.89 12:12:37 INFO - PROCESS | 3134 | Values: 78.0 80.0 91.0 151.0 88.0 51.0 70.0 92.0 150.0 82.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:80.50 stddev:28.64 (35.6%) stddev-sans-first:28.86 12:12:37 INFO - PROCESS | 3134 | Values: 81.0 86.0 118.0 81.0 80.0 83.0 123.0 123.0 124.0 165.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#5] imaging-gaussian-blur Cycles:10 Average:92.90 Median:95.00 stddev:3.18 (3.3%) stddev-sans-first:3.19 12:12:37 INFO - PROCESS | 3134 | Values: 90.0 96.0 91.0 96.0 90.0 94.0 90.0 96.0 89.0 97.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:97.00 stddev:17.90 (18.4%) stddev-sans-first:18.78 12:12:37 INFO - PROCESS | 3134 | Values: 96.0 101.0 97.0 102.0 154.0 97.0 97.0 97.0 97.0 96.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#7] imaging-desaturate Cycles:10 Average:118.10 Median:152.00 stddev:27.83 (18.3%) stddev-sans-first:29.51 12:12:37 INFO - PROCESS | 3134 | Values: 120.0 151.0 92.0 77.0 103.0 109.0 151.0 153.0 92.0 133.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#8] json-parse-financial Cycles:10 Average:72.20 Median:66.50 stddev:17.84 (26.8%) stddev-sans-first:17.93 12:12:37 INFO - PROCESS | 3134 | Values: 56.0 57.0 64.0 66.0 67.0 50.0 74.0 100.0 97.0 91.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#9] json-stringify-tinderbox Cycles:10 Average:82.50 Median:76.00 stddev:15.25 (20.1%) stddev-sans-first:15.37 12:12:37 INFO - PROCESS | 3134 | Values: 69.0 71.0 67.0 81.0 81.0 66.0 85.0 92.0 109.0 104.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#10] stanford-crypto-aes Cycles:10 Average:96.60 Median:94.00 stddev:15.61 (16.6%) stddev-sans-first:16.47 12:12:37 INFO - PROCESS | 3134 | Values: 101.0 115.0 101.0 84.0 111.0 115.0 75.0 102.0 73.0 89.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:140.50 stddev:16.82 (12.0%) stddev-sans-first:15.17 12:12:37 INFO - PROCESS | 3134 | Values: 160.0 118.0 141.0 157.0 140.0 115.0 145.0 132.0 128.0 112.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.80 Median:148.00 stddev:20.37 (13.8%) stddev-sans-first:21.52 12:12:37 INFO - PROCESS | 3134 | Values: 156.0 184.0 140.0 143.0 148.0 187.0 140.0 141.0 148.0 121.0 12:12:37 INFO - PROCESS | 3134 | 12:12:37 INFO - PROCESS | 3134 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.90 Median:85.00 stddev:17.54 (20.6%) stddev-sans-first:17.22 12:12:37 INFO - PROCESS | 3134 | Values: 67.0 73.0 65.0 59.0 101.0 97.0 98.0 103.0 99.0 97.0 12:12:37 INFO - PROCESS | 3134 | -------- Summary: end -------- 12:12:37 INFO - PROCESS | 3134 | 12:12:38 INFO - TEST-INFO | 3134: exit 0 12:12:38 INFO - TEST-OK | kraken | took 59057ms 12:12:38 INFO - SUITE-END | took 1169s 12:12:38 INFO - Completed test suite (00:19:29) 12:12:38 INFO - Working with test: dromaeo_css 12:12:38 INFO - Generating results file: dromaeo_css 12:12:38 INFO - Working with test: kraken 12:12:38 INFO - Generating results file: kraken 12:12:38 INFO - javascript benchmark 12:12:38 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:12:38 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 12:12:38 INFO - process_Request line: dromaeo_css 7441.25 graph.html#tests=[[72,64,61]] 12:12:38 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:12:38 INFO - process_Request line: kraken 1611.70 graph.html#tests=[[232,64,61]] 12:12:38 INFO - RETURN: dromaeo_css: 7441.25 12:12:38 INFO - RETURN: kraken: 1611.70 12:12:38 INFO - javascript benchmark 12:12:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3490.214701692118, 3496.1609213788693, 3542.167590616203, 3573.5533058367705, 3573.5711714594254, 4525.117602067598, 4910.8772280693, 5600.747966341514, 5682.403347648499, 5688.118341657045, 5648.4633959773855, 5710.628809127404, 5744.540436765059, 5783.826485205451, 5851.531877449805, 5055.721935293557, 5130.4356520782685, 5219.321488206528, 5291.232771248186, 5336.733163341837, 5084.51697088776, 5225.738713064351, 5235.083860324447, 5282.102042652739, 5285.969235998982, 4118.711690181688, 4198.979005104955, 4556.541906589892, 4872.56146946773, 5169.276301317818, 3650.3976843820737, 4197.370394440858, 4345.196138714348, 5011.924821127686, 5208.479152084799, 4395.296752519582, 4875.512448755132, 5072.72100034498, 5162.3030890830005, 5169.405518365398, 3997.34043882759, 5443.755031023614, 5521.834344969658, 5528.695921724304, 5621.156826476021, 5133.794648214104, 6215.254169499689, 6221.408966148254, 6258.4680302174365, 6276.403741644536, 5575.773329867423, 6014.248218972629, 6176.722047507828, 6273.937260627381, 6290.308066112724, 4994.925076123861, 5762.769489220426, 5783.9710801446145, 5826.941730582725, 5829.067349224104, 6286.119943207955, 6295.874082518324, 6302.905456418157, 6304.779332723424, 6350.65071421067, 6054.061620448838, 6102.267727872595, 6136.325004249618, 6151.477124444383, 6152.753889844356, 5170.1727723564045, 6047.092936059538, 6128.662923539248, 6212.658303793335, 6229.190205273376, 6127.711360156438, 6154.630722156685, 6156.994883314614, 6172.166757487771, 6179.227596550431, 6106.21798979648, 6129.572745043238, 6146.354632763585, 6210.0, 6220.62676239418, 4857.611391088704, 4882.487338829443, 4894.902101957941, 4904.0191961607825, 4930.2865419049895, 4388.736675799462, 4396.4284642996845, 4417.911641767147, 4429.313456414261, 4456.197884380843, 5334.226537152092, 5702.429757024264, 5808.535317174616, 5866.266716660418, 5903.498202652737, 5008.398992120896, 6256.405641464054, 6273.686315684197, 6288.9056664150075, 6316.589421687668, 5661.631993920382, 5765.135229715576, 5765.279340082489, 5768.538516918637, 5773.134029895466, 5290.894182116336, 5321.787128514816, 5366.517013468807, 5380.78476860929, 5405.486478784509, 6380.489560835122, 6387.233531976192, 6388.329225431263, 6389.4888408926245, 6408.839779005469, 6118.326984031842, 6157.722902469489, 6220.0, 6227.813165605039, 6256.186695729526, 6205.47253483459, 6276.1213430118905, 6355.396237357444, 6365.586236894587, 6400.55196136266, 6119.0, 6147.385261473817, 6164.4143806338325, 6175.722092505938, 6178.783742568989, 5834.94165058344, 6096.012695893602, 6201.193844800147, 6214.471769899428, 6219.657918814509, 6031.819045428644, 6049.18336024631, 6058.515318774399, 6065.848353791191, 6125.571210015256, 6126.754929802758, 6153.169322141633, 6163.137160797402, 6164.075388691732, 6173.32093469727, 5754.798582049776, 5829.358770535323, 5919.052951527735, 5929.2884853816095, 5973.253343332083, 6111.448149658432, 6121.47967422774, 6124.106319906264, 6140.907886381798, 6144.324124346408, 5982.192404025575, 6016.42843929826, 6021.187139736079, 6027.57806953509, 6061.545384096122], "unit": "score", "name": "dojo.html", "value": 5598.867016161293}, {"lowerIsBetter": false, "replicates": [418.5667833792024, 446.4196544492161, 502.6355891978315, 551.9595562364946, 555.3197333266749, 28842.85578572107, 36960.81519592405, 37034.44448333277, 37039.44440833383, 37050.258994820084, 37587.24825503488, 37931.24137517255, 37957.0, 38191.85424437265, 38635.61364386355, 9219.35464517484, 9343.953280233589, 9361.67234146805, 9438.905610943906, 9442.244620430383, 9321.533923303841, 9549.61801527938, 9555.378900371488, 9604.951975240114, 9622.518874056304, 9545.47499887506, 9596.952015239915, 9598.90401095987, 9604.807903841955, 9638.951805240999, 9498.620055197784, 9554.9522252389, 9568.5694143763, 9612.327137100407, 9630.807383852354, 9334.15992560666, 9428.952855235748, 9487.335886487948, 9493.382930109521, 9528.571214295303, 37123.81438092819, 37761.62238377636, 37797.0550736231, 37913.862584122246, 38097.80951095227, 3257.560229369052, 3285.211549228192, 3384.4754063120254, 3387.5596172497417, 3745.1198968242443, 28018.0, 28034.0, 28259.01093461719, 28308.716912830812, 28915.85542072297, 2746.1075150575944, 2750.972490275112, 2769.723027697234, 2770.3766652503227, 2830.150954713578, 466967.0, 469200.0, 469292.0, 471044.0, 471242.99999999657, 63405.68297158577, 63454.0, 63828.36171638317, 64001.67999159975, 64022.0, 66564.0, 66798.0, 72691.0, 74156.0, 74582.0, 14306.71239588442, 15498.147601882005, 16762.245698943578, 16926.322947082226, 16978.32086716542, 12856.164349317265, 12856.935715321364, 12921.418536165895, 12926.159799612995, 12934.900533454762, 21101.894490527447, 21334.0, 21422.464438389165, 21442.78557214408, 21502.56994860094, 7577.318041376303, 8043.477173983672, 8739.825203495895, 9100.317476189311, 9189.816203676022, 771.4599780153802, 867.3798234262532, 973.3575839945602, 981.2983716642635, 1005.2862467648051, 28997.56503652447, 29103.56344654832, 29382.412351752846, 29534.704652953194, 29536.704632953824, 1078.2560033576806, 1083.7507373304184, 1121.7644294698205, 1168.2289688805517, 1227.742174143422, 13723.725525489634, 13900.235487048309, 14350.856491434952, 14398.640033999234, 14461.0, 622708.0, 624495.0, 628637.0, 634017.0, 635292.0, 57454.0, 57528.137077943866, 57830.421695782505, 58221.70889145527, 58487.70756146192, 1247.6007677543098, 1357.6537982814318, 1413.7455258053649, 1420.2330741399735, 1439.4458133618632, 19947.800521994595, 26707.33231669224, 27882.44235115327, 28431.573526396707, 28721.281967950967, 44093.33859992038, 44378.227850633055, 47861.32485362996, 48302.03395932132, 48538.5146148534, 485432.0, 487331.0, 490103.0, 491075.0, 491086.0, 31840.885569004975, 32949.17627059342, 33164.66835331712, 33212.50181247235, 33824.66175338215, 34662.0, 43059.78470107629, 43313.35029974616, 43568.78215609028, 44835.55164448314, 29263.122106336843, 36298.4555231677, 36329.45505817362, 36394.81802591076, 37043.62956370402, 27446.725532745215, 35393.0, 35774.0, 36089.0, 36174.73388431392, 36275.45586816147, 37228.06929826776, 37715.05712357213, 38293.80853095828, 38414.615853842224, 30141.246468838453, 32194.517082243317, 32582.674173257965, 32628.673713262564, 32743.672563274064, 24669.145575947245, 24724.9634775347, 24861.129860454796, 24870.502589947737, 25024.249272521854], "unit": "score", "name": "ext.html", "value": 19493.345016038194}, {"lowerIsBetter": false, "replicates": [348.75761345864635, 355.28587539046515, 362.4762218594131, 364.7975373667617, 364.9562052553694, 15778.289976951037, 19480.707789383152, 19521.902390488045, 19916.50208744782, 20583.176672933063, 13533.796993045113, 16866.746998795028, 18076.63846723068, 19262.0, 19774.802251977475, 5787.24765780448, 6077.696115194245, 6142.539309551779, 6149.108379285023, 6202.875942481148, 4253.44705188325, 5958.0, 6353.650549219791, 6655.0, 6664.300248473914, 6478.773242936498, 6531.314212007742, 6585.979173228157, 6587.505937054716, 6589.868202635945, 6316.715747791361, 6449.258700150956, 6472.9029064564065, 6484.93515064848, 6490.675466226669, 5288.8413347599635, 5304.0, 5605.747741351649, 5610.523105536035, 5649.943500564983, 13136.540221092217, 13320.600381988555, 13324.467021319135, 13328.933355333258, 13452.932735336359, 1943.2615606069603, 2028.6044221376837, 2137.476318302026, 2145.420736401163, 2246.2587346175724, 9723.076307750753, 12399.566015189424, 13292.3353832308, 13767.38046787897, 14483.42066317346, 1466.3035058347307, 1523.0, 1752.6056637256643, 1770.4511601403606, 1770.849477794389, 93883.06116938879, 100006.0, 107345.0, 107827.91290653154, 112163.87836121616, 8923.375363724477, 11279.718007049889, 11416.0, 11510.53957841677, 11559.76880462386, 13595.388207530685, 13616.114952528054, 13621.0, 13632.045756797128, 13652.522161724291, 8398.790030249293, 8564.61459234336, 8575.785605359792, 8647.048824629286, 8662.826743465095, 8677.783055423539, 8719.084496127942, 8776.648934042567, 8835.381523293308, 8849.115088491099, 4407.405000324915, 4434.933475997863, 4497.235469970113, 4518.209313370147, 4530.750808705553, 1762.9823701763075, 1834.779826420838, 1846.9261229550668, 1906.8760530565469, 1936.2642195965443, 905.5200743605899, 912.1927094521396, 939.9718008459757, 1003.8996100389902, 1026.8305729554688, 14173.503927362493, 19310.613787724447, 19360.903195484214, 19530.70703939442, 20016.2994295199, 790.3913986230685, 900.4822227219375, 941.1435593609782, 944.6127087893931, 962.9936716131659, 9043.683471078612, 10282.331648442976, 10383.0, 10720.571177152982, 11056.502457389437, 579467.0, 622848.0, 632944.0, 636693.0, 639159.0, 98521.04436866906, 109018.0, 120904.0, 123535.0, 127689.0, 898.5686870302292, 967.5259123029806, 1003.5534187286587, 1022.1618273016055, 1024.6004058417222, 16304.429344972868, 18178.818211817714, 18269.81730182681, 18353.449396518125, 18429.815701843345, 50185.498145018086, 50235.24647130223, 50642.74678626583, 50881.0, 52019.21971170511, 49333.76665583389, 72031.91952120827, 72135.63932180306, 72532.0, 73845.89231161644, 7987.281144697005, 8074.1522140176785, 8125.593720313843, 8232.876506852283, 8396.622152003296, 12415.62753117408, 13026.0, 13147.73704525885, 13297.867021329663, 13431.462741490232, 10595.47022648849, 10968.561257549609, 11263.436828158396, 11334.546618135182, 11649.417529123679, 11137.665870023913, 11151.0, 11190.440477976232, 11490.82763758561, 11550.94224528872, 11373.829392559284, 11718.23831450953, 11756.23584467007, 12036.037117030792, 12082.697932551757, 7942.483738556975, 8172.264496195371, 8224.218699223564, 8245.587720614065, 8467.407281490237, 8746.606402712021, 8947.910520894708, 11349.37578433161, 11729.648110556696, 11893.464794084113], "unit": "score", "name": "jquery.html", "value": 9239.070998121484}, {"lowerIsBetter": false, "replicates": [1372.951946681866, 1532.4253404973135, 1728.1877517566738, 1883.3314173468427, 1893.25216539467, 7768.689252429896, 8076.475029123103, 8494.277986371158, 8706.347023973203, 8710.695125670603, 6490.513211509132, 8495.532745699, 8584.05575386707, 8612.181842724947, 8624.016476210476, 2413.4087148648564, 2421.842580232288, 2429.514097180571, 2431.671724317221, 2435.305937807725, 2388.904443822245, 2412.19191570824, 2431.57447446697, 2431.8662473563945, 2438.4147804526965, 2000.469875482998, 2421.4551725861716, 2429.7327293997646, 2431.902723891051, 2435.1111844176926, 2388.8088952883727, 2398.436367453647, 2411.457422080027, 2419.1412048722714, 2419.8427102238297, 2389.665446837444, 2407.9759202407927, 2417.5648383291, 2423.709154901423, 2428.6114221724615, 8561.828763424759, 8629.61166747498, 8651.480911145289, 8652.610632521551, 8690.478571285743, 3940.9014774630577, 4271.807768650418, 4347.43483347166, 5269.920951185735, 5283.0, 3480.3387356402204, 3597.8380972856285, 3644.380455322575, 3677.797721125337, 3686.594474607791, 1054.9314294570904, 1075.0, 1076.8330908709163, 1076.8869268726748, 1079.6167360586958, 11328.886711132865, 11513.654590362303, 11525.827112593317, 11537.769244615145, 11580.710482237928, 4207.936880946727, 4395.406620106309, 4422.823087076546, 4561.384213131251, 4896.2655601660035, 9797.363171393836, 9812.313138080266, 9826.4104153751, 9828.606855725833, 9829.901700983042, 5330.067238233293, 5349.465053494697, 5354.759035843396, 5367.114426119647, 5373.382061063028, 3922.4508568800393, 4412.889677758082, 4889.828855990023, 4899.510048995072, 4912.4350699669285, 3801.372773492398, 3865.0, 3868.574456809749, 3890.844366225376, 3928.0769019280447, 1276.4702648400996, 1287.3305880941857, 1289.4197611075053, 1295.151675652449, 1297.0661123990901, 1346.0913883128849, 1347.4340776873737, 1354.106289848695, 1364.6383708317105, 1371.0539727587932, 7859.803504912423, 8040.316573091236, 8047.678092876336, 8060.758177254692, 8061.919380806235, 509.4396164219403, 517.5109521502144, 520.5679286192451, 521.0230817217716, 521.1375174086892, 6140.078988151813, 6140.4473597376455, 6176.197094377792, 6187.81436556904, 6206.72069756862, 10259.435731034715, 10521.105706014921, 10541.0, 10595.0, 10626.840597391045, 10013.399196048114, 10241.180705543538, 10395.480225988671, 10430.634927777643, 10724.302920310154, 8060.19398060201, 8162.7143049992965, 8178.0, 8182.713605023915, 8234.670613175525, 7956.323712484272, 7982.6008699565955, 8023.237792409712, 8058.758237252891, 8125.512469251864, 9139.77150571241, 9378.249740020918, 9459.668911588062, 9538.475383853955, 9611.086946740048, 9153.993060763443, 9488.85766713486, 9598.0, 9784.85322720174, 9998.900010999796, 6749.156355455568, 6824.249332573314, 7041.119860017498, 7360.521566098187, 7538.3969282458365, 8111.716089936824, 8138.0, 8143.51138931666, 8146.714864979697, 8147.75556733299, 7175.641217938978, 7228.457865660202, 7301.014363060919, 7381.0, 7427.702891884264, 7143.6428178591905, 7196.0285361475535, 7209.6395180241825, 7212.3148300911325, 7219.747308844166, 7564.394848412224, 7567.508111972704, 7571.659275332513, 7575.0, 7632.656530456032, 6848.520603557902, 6862.965685171542, 6898.2756810536175, 6911.274316196727, 6942.271061538668, 5610.691411972381, 6770.781259373163, 6792.456603471809, 6948.583085014915, 7012.544184627983], "unit": "score", "name": "mootools.html", "value": 4738.4695942729395}, {"lowerIsBetter": false, "replicates": [312.3191442655012, 324.67856821746466, 325.8012612306494, 326.8741534509213, 332.758749906318, 6129.559553504922, 6931.20291166516, 6942.652867356631, 6942.687579058942, 6953.130858642669, 6205.286392064914, 6249.937500624992, 6908.3437073477935, 6920.515563910529, 6941.652917354125, 4611.884702882429, 4823.155947709154, 4918.385201849769, 5034.5468907798295, 5046.621503387242, 5024.246363045536, 5037.168867136918, 5037.244413337992, 5040.848774536751, 5046.0, 4153.626173644371, 4840.225563909775, 4952.628552858532, 4963.205887058071, 4974.303597496353, 4353.1293741251875, 4675.8831029224375, 4993.975030124862, 4994.55049045584, 5037.168867136918, 3875.6241534255214, 4142.606452387018, 4281.422008028907, 4282.914341713148, 4284.61438470536, 6345.428911397997, 6619.0, 6659.4006539411685, 6661.400473957318, 6664.266930637626, 4673.042026384617, 5739.741711622987, 5776.191333213354, 5792.971035144839, 5797.36229014808, 5939.762409503614, 7261.310175533369, 7360.153582338046, 7368.300011498899, 7372.778816635509, 4219.725717828332, 4577.725336479789, 4595.793189306489, 4599.977000115012, 4615.676902616819, 7408.703651853865, 7787.922120778833, 7824.921750782476, 7845.607719613997, 7861.292483676497, 3746.981265093657, 4630.189716799614, 4706.247000479907, 4736.73947932867, 4738.431388233434, 4315.633171180422, 4478.843240486567, 4802.663813533089, 4815.90508128965, 4819.855404337875, 4559.749213793273, 5838.649681019152, 5846.298444186725, 5852.034414321589, 5854.970725146347, 5966.701664916737, 7444.181140074587, 7446.180920098785, 7475.327220550176, 7479.139898911695, 1368.548379034916, 1578.7710781936555, 1637.3859802574034, 1659.96680066398, 1682.61299901021, 1047.7485403503103, 1056.1761825775907, 1064.622059168984, 1068.9465526723632, 1071.59815069349, 6831.795046148524, 6840.623765692934, 6844.555103918329, 6862.725490980405, 6891.414229790424, 7612.467127301146, 7639.503432276884, 7644.273793989562, 7681.462297639224, 7690.500117492345, 6207.534434917399, 6248.437640612276, 6922.930770692228, 6961.895571566431, 6998.75504357345, 3750.643688849555, 4003.279409706281, 4062.5937406259727, 4073.490813648294, 4097.610726980932, 7232.638368081575, 8009.679612815422, 8080.39397045224, 8091.716789912325, 8144.959275203586, 8000.679972801139, 8001.0, 8033.236842499953, 8059.758207253792, 8087.676492940334, 8107.108218096005, 8115.553644549606, 8142.592870356577, 8144.185581441927, 8152.755417337489, 7453.217412171643, 7724.420668449777, 7759.068911730628, 7767.145613982344, 7795.688172473037, 7585.469017168966, 7610.124835643972, 7613.619319033915, 7633.0458692663415, 7646.617669116633, 7323.487355885037, 7502.912077748805, 8109.756097561023, 8115.350771938349, 8117.715879944174, 4765.356676848581, 4773.71357718538, 4794.760261986817, 4802.327674125695, 4803.327534145293, 6425.58233714807, 7109.893351599627, 7646.350060244941, 7681.923180768121, 7706.961465192639, 5959.851003724942, 7334.486585938933, 7338.449616278694, 7345.971563981154, 7396.889046664197, 7394.482386232912, 7409.407247420301, 7409.962950185214, 7422.66598003102, 7451.254874512505, 5261.394939581997, 7223.819404514929, 7236.312550307713, 7246.202917678946, 7246.492745507975, 6451.612903225821, 6928.891377379595, 7213.855722885618, 7390.9260907390235, 7402.222766609429, 7197.0, 7213.495055346076, 7240.7465738701, 7295.744648937261, 7310.853782924418], "unit": "score", "name": "prototype.html", "value": 5267.485699713515}, {"lowerIsBetter": false, "replicates": [659.3604203922196, 684.5447777228144, 712.9733184214731, 750.0661676213114, 789.6486063701655, 14784.704305913889, 14965.925170374147, 14999.925000374997, 16796.16019199038, 16923.661526769487, 15528.5341439757, 15544.611384715388, 15555.688886222297, 15560.299786509606, 15650.373985040613, 852.9061803201643, 855.820277741675, 874.45783614159, 877.0965905117739, 883.337496877342, 706.7702996526124, 711.2105562825286, 874.8206617643368, 876.4697358098355, 882.8101958079012, 908.4821651658557, 914.3873604684877, 916.7112359606735, 918.3571499950028, 920.2545937790378, 896.000958930794, 903.7650210945169, 913.0549880873265, 915.1900567997337, 915.6932427636783, 666.5234357434409, 670.4502308107354, 677.11298199359, 679.2087218390569, 680.397847904603, 14872.70254594902, 14938.925305373512, 14970.550883473514, 15098.245087745569, 15270.847291527054, 10767.676969690843, 12429.751404971941, 12634.368281585885, 12645.43095560702, 12902.612921612366, 10048.497575121215, 10079.34484258521, 10085.142762865165, 10120.089191972758, 10147.137493313003, 3473.8436770345397, 3499.1077275294892, 3565.4830049642655, 3593.281343731238, 3603.207294395229, 78245.0, 79209.20790792076, 80873.59563202146, 80913.0, 81334.77997829978, 7799.610019499002, 8020.598970051474, 9307.581158847868, 9571.712848614414, 9657.517124143766, 21766.782332176794, 21926.780732192474, 21942.78057219439, 21944.45138871509, 21992.89003554972, 7513.0, 7619.733309334147, 7648.694052237848, 7685.769426917202, 7776.766696999099, 3413.6415676353627, 4099.8360065597635, 4112.568180341081, 4133.07856133434, 4141.0, 2769.736874996872, 3260.4294248506417, 3302.4055669979634, 3311.6853898879567, 3315.0220684898013, 634.6985182038495, 635.4598591197445, 638.7764282501088, 640.916680831489, 649.3863299182227, 524.6144084098185, 527.2697314219756, 566.5665765689251, 592.7540070870626, 593.2021431175062, 6639.236487803868, 8052.0, 8128.349732021424, 8351.273771080077, 8485.872711909326, 464.46818392939895, 516.9170587618933, 517.4101524262344, 520.5289213262004, 552.1855263486326, 3853.2871418787613, 3901.258760835432, 4000.4199391088127, 4008.2785098681934, 4031.7368782127546, 69801.65099174471, 82870.58564707258, 83388.16611833803, 85186.57406713051, 85952.0, 55847.0, 71321.5037473686, 74305.25694743091, 76635.0, 87576.6863497048, 63497.36502634914, 65081.67459162674, 70416.64791676111, 74658.6267068672, 75036.24963750402, 7376.4098872089035, 8441.831163376575, 8535.61589728476, 8596.699115530926, 8676.479411235347, 43809.34285985649, 46239.0, 48560.757196213795, 49694.75152624214, 51174.232386514974, 64779.67610161919, 65356.0, 65712.67143664251, 65836.0, 65857.67071164613, 9010.774730631525, 11125.0, 11125.499352528994, 11319.377434240867, 11537.019353354723, 11815.704607384883, 11826.76346473083, 11906.285622862655, 12205.938970305091, 12456.750864982469, 9143.542822858697, 11210.159238057342, 11291.887081129413, 11397.373144476802, 11463.31220126795, 11048.392338421463, 11102.167337449886, 11116.555337786398, 11232.157588180755, 11242.718932026764, 10597.9470102649, 10650.307729997836, 10699.251052426256, 10803.945980270048, 10888.945555272174, 9337.673181438617, 9655.372400793925, 9668.931273878678, 9679.461299599774, 9765.2676049298, 9332.440053596805, 9594.66418675343, 9776.462294573867, 9807.264455165749, 9807.558659860466], "unit": "score", "name": "yui.html", "value": 6745.016976060869}], "name": "dromaeo_css", "value": 7441.247481490969}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [122.0, 110.0, 115.0, 113.0, 115.0, 126.0, 116.0, 114.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 116.1}, {"lowerIsBetter": true, "replicates": [152.0, 121.0, 145.0, 154.0, 121.0, 138.0, 173.0, 155.0, 195.0, 113.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [196.0, 201.0, 198.0, 203.0, 233.0, 292.0, 196.0, 199.0, 200.0, 202.0], "unit": "score", "name": "audio-dft", "value": 212.0}, {"lowerIsBetter": true, "replicates": [78.0, 80.0, 91.0, 151.0, 88.0, 51.0, 70.0, 92.0, 150.0, 82.0], "unit": "score", "name": "audio-fft", "value": 93.3}, {"lowerIsBetter": true, "replicates": [81.0, 86.0, 118.0, 81.0, 80.0, 83.0, 123.0, 123.0, 124.0, 165.0], "unit": "score", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [90.0, 96.0, 91.0, 96.0, 90.0, 94.0, 90.0, 96.0, 89.0, 97.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 92.9}, {"lowerIsBetter": true, "replicates": [96.0, 101.0, 97.0, 102.0, 154.0, 97.0, 97.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 103.4}, {"lowerIsBetter": true, "replicates": [120.0, 151.0, 92.0, 77.0, 103.0, 109.0, 151.0, 153.0, 92.0, 133.0], "unit": "score", "name": "imaging-desaturate", "value": 118.1}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 64.0, 66.0, 67.0, 50.0, 74.0, 100.0, 97.0, 91.0], "unit": "score", "name": "json-parse-financial", "value": 72.2}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 67.0, 81.0, 81.0, 66.0, 85.0, 92.0, 109.0, 104.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 82.5}, {"lowerIsBetter": true, "replicates": [101.0, 115.0, 101.0, 84.0, 111.0, 115.0, 75.0, 102.0, 73.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 96.6}, {"lowerIsBetter": true, "replicates": [160.0, 118.0, 141.0, 157.0, 140.0, 115.0, 145.0, 132.0, 128.0, 112.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 134.8}, {"lowerIsBetter": true, "replicates": [156.0, 184.0, 140.0, 143.0, 148.0, 187.0, 140.0, 141.0, 148.0, 121.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.8}, {"lowerIsBetter": true, "replicates": [67.0, 73.0, 65.0, 59.0, 101.0, 97.0, 98.0, 103.0, 99.0, 97.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 85.9}], "name": "kraken", "value": 1611.6999999999998}]} 12:12:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1611.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7441.25"}}} 12:12:38 INFO - Return code: 0 12:12:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:12:39 ERROR - # TBPL SUCCESS # 12:12:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:12:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:12:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:12:39 INFO - 2016-02-26 12:12:39.038 screenresolution[3144:25526] starting screenresolution argv=screenresolution get 12:12:39 INFO - 2016-02-26 12:12:39.041 screenresolution[3144:25526] Display 0: 1600x1200x32@60 12:12:39 INFO - 2016-02-26 12:12:39.047 screenresolution[3145:25529] starting screenresolution argv=screenresolution list 12:12:39 INFO - Available Modes on Display 0 12:12:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:12:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:12:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:12:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:12:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:12:39 INFO - Intel Iris: 12:12:39 INFO - Chipset Model: Intel Iris 12:12:39 INFO - Type: GPU 12:12:39 INFO - Bus: Built-In 12:12:39 INFO - VRAM (Dynamic, Max): 1536 MB 12:12:39 INFO - Vendor: Intel (0x8086) 12:12:39 INFO - Device ID: 0x0a2e 12:12:39 INFO - Revision ID: 0x0009 12:12:39 INFO - Displays: 12:12:39 INFO - Display: 12:12:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:12:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:12:39 INFO - Display Serial Number: 1600x1200 60 12:12:39 INFO - Main Display: Yes 12:12:39 INFO - Mirror: Off 12:12:39 INFO - Online: Yes 12:12:39 INFO - Rotation: Supported 12:12:39 INFO - Return code: 0 12:12:39 INFO - Running post-action listener: _resource_record_post_action 12:12:39 INFO - Running post-run listener: _resource_record_post_run 12:12:40 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 364544; Write bytes: 714685440; Read time: 4; Write time: 1964 12:12:40 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393271808; Write bytes: 390068224; Read time: 29716; Write time: 713 12:12:40 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 356352; Write bytes: 303742464; Read time: 3; Write time: 1197 12:12:40 INFO - Running post-run listener: _upload_blobber_files 12:12:40 INFO - Blob upload gear active. 12:12:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:12:40 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 12:12:40 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'] 12:12:40 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 12:12:40 INFO - (blobuploader) - INFO - Open directory for files ... 12:12:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:12:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:12:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:12:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:12:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:12:41 INFO - (blobuploader) - INFO - Done attempting. 12:12:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:12:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:12:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:12:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:12:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:12:42 INFO - (blobuploader) - INFO - Done attempting. 12:12:42 INFO - (blobuploader) - INFO - Iteration through files over. 12:12:42 INFO - Return code: 0 12:12:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:12:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:12:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c5f03b4bacb5cd6984056e7cc92d699d3b33914208ebaf3f2225028c784d762df28ef3a8a1665e940dc77e16058d173cff4ee32c06cbfd3c5fd3ced197d3aef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5de0cacb28ddd07dd9ef7114ce49c6a7f11e14b88baa1293c27b95c7c5ccae4ff7dfba22ff6780f63580c22f17c55eb93ace900533b76307baa2a05b4a5d3c12"} 12:12:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:12:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:12:42 INFO - Contents: 12:12:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c5f03b4bacb5cd6984056e7cc92d699d3b33914208ebaf3f2225028c784d762df28ef3a8a1665e940dc77e16058d173cff4ee32c06cbfd3c5fd3ced197d3aef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5de0cacb28ddd07dd9ef7114ce49c6a7f11e14b88baa1293c27b95c7c5ccae4ff7dfba22ff6780f63580c22f17c55eb93ace900533b76307baa2a05b4a5d3c12"} 12:12:42 INFO - Running post-run listener: copy_logs_to_upload_dir 12:12:42 INFO - Copying logs to upload dir... 12:12:42 INFO - mkdir: /builds/slave/test/build/upload/logs 12:12:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.111390 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-26 12:12:42.661499) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 12:12:42.665483) ========= 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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c5f03b4bacb5cd6984056e7cc92d699d3b33914208ebaf3f2225028c784d762df28ef3a8a1665e940dc77e16058d173cff4ee32c06cbfd3c5fd3ced197d3aef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5de0cacb28ddd07dd9ef7114ce49c6a7f11e14b88baa1293c27b95c7c5ccae4ff7dfba22ff6780f63580c22f17c55eb93ace900533b76307baa2a05b4a5d3c12"} build_url:https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/IHN_AEdaSTmLb09xW6np6g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0c5f03b4bacb5cd6984056e7cc92d699d3b33914208ebaf3f2225028c784d762df28ef3a8a1665e940dc77e16058d173cff4ee32c06cbfd3c5fd3ced197d3aef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5de0cacb28ddd07dd9ef7114ce49c6a7f11e14b88baa1293c27b95c7c5ccae4ff7dfba22ff6780f63580c22f17c55eb93ace900533b76307baa2a05b4a5d3c12"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 12:12:42.692683) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 12:12:42.693061) ========= 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.rCxXFpYXmc/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.ODIqJziRQ4/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.005244 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 12:12:42.743122) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 12:12:42.743507) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 12:12:42.743971) ========= ========= Total master_lag: 0.50 =========