builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0032 starttime: 1456937562.23 results: success (0) buildid: 20160302053632 builduid: b0613b10680a4bdcb5edb01b98a834fc revision: 1db864e863ed710a3e51ef795b32e070fd9cc145 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.231914) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.232444) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.232793) ========= 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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005869 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.257537) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.257938) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.274614) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.275073) ========= 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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005218 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.324026) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.324377) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.324794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.325157) ========= 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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-03-02 08:52:42-- 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% 12.6M=0.001s 2016-03-02 08:52:42 (12.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150605 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.491710) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.492095) ========= 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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.027108 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.541323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:42.541723) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1db864e863ed710a3e51ef795b32e070fd9cc145 --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 1db864e863ed710a3e51ef795b32e070fd9cc145 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tOFmX0Eopj/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.mbHFlaaT2R/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-03-02 08:52:42,618 truncating revision to first 12 chars 2016-03-02 08:52:42,618 Setting DEBUG logging. 2016-03-02 08:52:42,618 attempt 1/10 2016-03-02 08:52:42,618 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1db864e863ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-02 08:52:43,244 unpacking tar archive at: fx-team-1db864e863ed/testing/mozharness/ program finished with exit code 0 elapsedTime=0.878281 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:43.437519) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:43.438295) ========= echo 1db864e863ed710a3e51ef795b32e070fd9cc145 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1db864e863ed710a3e51ef795b32e070fd9cc145'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tOFmX0Eopj/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.mbHFlaaT2R/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 1db864e863ed710a3e51ef795b32e070fd9cc145 program finished with exit code 0 elapsedTime=0.006098 script_repo_revision: '1db864e863ed710a3e51ef795b32e070fd9cc145' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:43.489495) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:43.489874) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-02 08:52:43.503582) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-02 08:52:43.503985) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tOFmX0Eopj/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.mbHFlaaT2R/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:52:43 INFO - MultiFileLogger online at 20160302 08:52:43 in /builds/slave/test 08:52:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:52:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:43 INFO - {'append_to_log': False, 08:52:43 INFO - 'base_work_dir': '/builds/slave/test', 08:52:43 INFO - 'blob_upload_branch': 'Fx-Team', 08:52:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:43 INFO - 'branch': 'Fx-Team', 08:52:43 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:43 INFO - 'config_files': ('talos/mac_config.py',), 08:52:43 INFO - 'default_actions': ('clobber', 08:52:43 INFO - 'read-buildbot-config', 08:52:43 INFO - 'download-and-extract', 08:52:43 INFO - 'populate-webroot', 08:52:43 INFO - 'create-virtualenv', 08:52:43 INFO - 'install', 08:52:43 INFO - 'run-tests'), 08:52:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:43 INFO - 'download_minidump_stackwalk': True, 08:52:43 INFO - 'download_symbols': 'ondemand', 08:52:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:43 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:43 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:43 INFO - 'installer_path': 'installer.exe', 08:52:43 INFO - 'log_level': 'info', 08:52:43 INFO - 'log_name': 'talos', 08:52:43 INFO - 'log_to_console': True, 08:52:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:52:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:52:43 INFO - 'opt_config_files': (), 08:52:43 INFO - 'pip_index': False, 08:52:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:43 INFO - 'cmd': ('bash', 08:52:43 INFO - '-c', 08:52:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:43 INFO - 'enabled': True, 08:52:43 INFO - 'halt_on_failure': False, 08:52:43 INFO - 'name': 'check_screen_resolution'},), 08:52:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:43 INFO - 'cmd': ('bash', 08:52:43 INFO - '-c', 08:52:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:43 INFO - 'enabled': True, 08:52:43 INFO - 'halt_on_failure': False, 08:52:43 INFO - 'name': 'check_screen_resolution'},), 08:52:43 INFO - 'run_cmd_checks_enabled': True, 08:52:43 INFO - 'sps_profile': False, 08:52:43 INFO - 'sps_profile_interval': 0, 08:52:43 INFO - 'suite': 'dromaeojs', 08:52:43 INFO - 'system_bits': '32', 08:52:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:43 INFO - 'title': 't-yosemite-r7-0032', 08:52:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:43 INFO - 'use_talos_json': True, 08:52:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:43 INFO - 'work_dir': 'build'} 08:52:43 INFO - ##### 08:52:43 INFO - ##### Running clobber step. 08:52:43 INFO - ##### 08:52:43 INFO - Running pre-action listener: _resource_record_pre_action 08:52:43 INFO - Running main action method: clobber 08:52:43 INFO - rmtree: /builds/slave/test/build 08:52:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:52:45 INFO - Running post-action listener: _resource_record_post_action 08:52:45 INFO - ##### 08:52:45 INFO - ##### Running read-buildbot-config step. 08:52:45 INFO - ##### 08:52:45 INFO - Running pre-action listener: _resource_record_pre_action 08:52:45 INFO - Running main action method: read_buildbot_config 08:52:45 INFO - Using buildbot properties: 08:52:45 INFO - { 08:52:45 INFO - "project": "", 08:52:45 INFO - "product": "firefox", 08:52:45 INFO - "script_repo_revision": "production", 08:52:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 08:52:45 INFO - "repository": "", 08:52:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 08:52:45 INFO - "buildid": "20160302053632", 08:52:45 INFO - "pgo_build": "False", 08:52:45 INFO - "basedir": "/builds/slave/test", 08:52:45 INFO - "buildnumber": 433, 08:52:45 INFO - "slavename": "t-yosemite-r7-0032", 08:52:45 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:52:45 INFO - "platform": "yosemite_r7", 08:52:45 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:52:45 INFO - "branch": "fx-team", 08:52:45 INFO - "repo_path": "integration/fx-team", 08:52:45 INFO - "revision": "1db864e863ed710a3e51ef795b32e070fd9cc145", 08:52:45 INFO - "stage_platform": "macosx64", 08:52:45 INFO - "builduid": "b0613b10680a4bdcb5edb01b98a834fc", 08:52:45 INFO - "slavebuilddir": "test" 08:52:45 INFO - } 08:52:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 08:52:45 INFO - Running post-action listener: _resource_record_post_action 08:52:45 INFO - ##### 08:52:45 INFO - ##### Running download-and-extract step. 08:52:45 INFO - ##### 08:52:45 INFO - Running pre-action listener: _resource_record_pre_action 08:52:45 INFO - Running main action method: download_and_extract 08:52:45 INFO - mkdir: /builds/slave/test/build/tests 08:52:45 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')]} 08:52:45 INFO - https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:52:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 08:52:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 08:52:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 08:52:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 08:52:47 INFO - Downloaded 1277 bytes. 08:52:47 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 08:52:47 INFO - Using the following test package requirements: 08:52:47 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:52:47 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:52:47 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 08:52:47 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:52:47 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 08:52:47 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:52:47 INFO - u'jsshell-mac.zip'], 08:52:47 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:52:47 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 08:52:47 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:52:47 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:52:47 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 08:52:47 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:52:47 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 08:52:47 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:52:47 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 08:52:47 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 08:52:47 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 08:52:47 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 08:52:47 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:52:47 INFO - https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:52:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:52:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:52:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:52:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:52:48 INFO - Downloaded 17851861 bytes. 08:52:48 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'] 08:52:48 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 08:52:51 INFO - Return code: 0 08:52:51 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 08:52:51 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')]} 08:52:51 INFO - https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:52:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:52:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 08:52:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:52:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:52:52 INFO - Downloaded 17851861 bytes. 08:52:52 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'] 08:52:52 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 08:52:55 INFO - Return code: 0 08:52: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')]} 08:52:55 INFO - https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:52:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:52:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 08:52:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:52:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:52:56 INFO - Downloaded 10808456 bytes. 08:52:56 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'] 08:52:56 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 08:52:57 INFO - Return code: 0 08:52:57 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')]} 08:52:57 INFO - https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:52:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:52:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:52:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 08:52:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N5EfFlSOTKmfWdOGb_fbUg/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 08:53:01 INFO - Downloaded 110968976 bytes. 08:53:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:53:01 INFO - mkdir: /builds/slave/test/properties 08:53:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:01 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:01 INFO - Contents: 08:53:01 INFO - build_url:https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 08:53:03 INFO - Running post-action listener: _resource_record_post_action 08:53:03 INFO - Running post-action listener: set_extra_try_arguments 08:53:03 INFO - ##### 08:53:03 INFO - ##### Running populate-webroot step. 08:53:03 INFO - ##### 08:53:03 INFO - Running pre-action listener: _resource_record_pre_action 08:53:03 INFO - Running main action method: populate_webroot 08:53:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:03 INFO - '--tppagecycles', 08:53:03 INFO - '7'], 08:53:03 INFO - 'tests': ['tsvgm']}}, 08:53:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:53:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:53:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:53:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:53:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:03 INFO - 'talos_options': ['--e10s'], 08:53:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:03 INFO - 'tests': ['damp', 'tps']}, 08:53:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:03 INFO - 'talos_options': ['--e10s'], 08:53:03 INFO - 'tests': ['damp', 'tps']}, 08:53:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:53:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:03 INFO - 'other': {'tests': ['a11yr', 08:53:03 INFO - 'ts_paint', 08:53:03 INFO - 'tpaint', 08:53:03 INFO - 'sessionrestore', 08:53:03 INFO - 'sessionrestore_no_auto_restore']}, 08:53:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:53:03 INFO - 'tests': ['a11yr', 08:53:03 INFO - 'ts_paint', 08:53:03 INFO - 'tpaint', 08:53:03 INFO - 'sessionrestore', 08:53:03 INFO - 'sessionrestore_no_auto_restore']}, 08:53:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:53:03 INFO - 'tests': ['a11yr', 08:53:03 INFO - 'ts_paint', 08:53:03 INFO - 'tpaint', 08:53:03 INFO - 'sessionrestore', 08:53:03 INFO - 'sessionrestore_no_auto_restore']}, 08:53:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:53:03 INFO - 'tests': ['a11yr', 08:53:03 INFO - 'ts_paint', 08:53:03 INFO - 'tpaint', 08:53:03 INFO - 'sessionrestore', 08:53:03 INFO - 'sessionrestore_no_auto_restore']}, 08:53:03 INFO - 'other_l64': {'tests': ['a11yr', 08:53:03 INFO - 'ts_paint', 08:53:03 INFO - 'tpaint', 08:53:03 INFO - 'sessionrestore', 08:53:03 INFO - 'sessionrestore_no_auto_restore']}, 08:53:03 INFO - 'other_nol64': {'tests': ['a11yr', 08:53:03 INFO - 'ts_paint', 08:53:03 INFO - 'tpaint', 08:53:03 INFO - 'sessionrestore', 08:53:03 INFO - 'sessionrestore_no_auto_restore']}, 08:53:03 INFO - 'svgr': {'tests': ['tsvgx', 08:53:03 INFO - 'tsvgr_opacity', 08:53:03 INFO - 'tart', 08:53:03 INFO - 'tscrollx', 08:53:03 INFO - 'cart']}, 08:53:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:53:03 INFO - 'tests': ['tsvgx', 08:53:03 INFO - 'tsvgr_opacity', 08:53:03 INFO - 'tart', 08:53:03 INFO - 'tscrollx', 08:53:03 INFO - 'cart']}, 08:53:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:03 INFO - 'tests': ['tp5o']}, 08:53:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:03 INFO - 'talos_options': ['--e10s'], 08:53:03 INFO - 'tests': ['tp5o']}, 08:53:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:03 INFO - 'talos_options': ['--xperf_path', 08:53:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:03 INFO - 'tests': ['tp5n']}, 08:53:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:03 INFO - 'talos_options': ['--e10s', 08:53:03 INFO - '--xperf_path', 08:53:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:03 INFO - 'tests': ['tp5n']}}, 08:53:03 INFO - 'talos.zip': {'path': '', 08:53:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:03 INFO - Running post-action listener: _resource_record_post_action 08:53:03 INFO - ##### 08:53:03 INFO - ##### Running create-virtualenv step. 08:53:03 INFO - ##### 08:53:03 INFO - Running pre-action listener: _resource_record_pre_action 08:53:03 INFO - Running main action method: create_virtualenv 08:53:03 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:03 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 08:53:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:03 INFO - Using real prefix '/tools/python27' 08:53:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:03 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:06 INFO - Installing pip.................done. 08:53:06 INFO - Return code: 0 08:53:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53:06 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')]} 08:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:06 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')]} 08:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:06 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 0x104e70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0ea485680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d14d30>, '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 0x104b38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d0bb20>, '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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:53:06 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 08:53:06 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 08:53:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tOFmX0Eopj/Render', 08:53:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:06 INFO - 'HOME': '/Users/cltbld', 08:53:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:06 INFO - 'LOGNAME': 'cltbld', 08:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:06 INFO - 'MOZ_NO_REMOTE': '1', 08:53:06 INFO - 'NO_EM_RESTART': '1', 08:53:06 INFO - 'PAGER': '/bin/cat', 08:53:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:06 INFO - 'PWD': '/builds/slave/test', 08:53:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:06 INFO - 'SHELL': '/bin/bash', 08:53:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbHFlaaT2R/Listeners', 08:53:06 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:53:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:06 INFO - 'USER': 'cltbld', 08:53:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:06 INFO - 'XPC_FLAGS': '0x0', 08:53:06 INFO - 'XPC_SERVICE_NAME': '0', 08:53:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:07 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 08:53:07 INFO - Cleaning up... 08:53:07 INFO - Return code: 0 08:53:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08: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')]} 08:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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', '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 0x104e70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0ea485680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d14d30>, '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 0x104b38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d0bb20>, '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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:53: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', 'psutil>=0.7.1'] in /builds/slave/test/build 08:53: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 psutil>=0.7.1 08:53:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tOFmX0Eopj/Render', 08:53:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:07 INFO - 'HOME': '/Users/cltbld', 08:53:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:07 INFO - 'LOGNAME': 'cltbld', 08:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:07 INFO - 'MOZ_NO_REMOTE': '1', 08:53:07 INFO - 'NO_EM_RESTART': '1', 08:53:07 INFO - 'PAGER': '/bin/cat', 08:53:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:07 INFO - 'PWD': '/builds/slave/test', 08:53:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:07 INFO - 'SHELL': '/bin/bash', 08:53:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbHFlaaT2R/Listeners', 08:53:07 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:53:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:07 INFO - 'USER': 'cltbld', 08:53:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:07 INFO - 'XPC_FLAGS': '0x0', 08:53:07 INFO - 'XPC_SERVICE_NAME': '0', 08:53:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:07 INFO - Downloading/unpacking psutil>=0.7.1 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:09 INFO - Installing collected packages: psutil 08:53:09 INFO - Running setup.py install for psutil 08:53:09 INFO - building 'psutil._psutil_osx' extension 08:53:09 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 08:53:10 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 08:53:10 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 08:53:10 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 08:53:10 INFO - building 'psutil._psutil_posix' extension 08:53:10 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 08:53:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:53:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:53:10 INFO - ^ 08:53:10 INFO - 1 warning generated. 08:53:10 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 08:53:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:10 INFO - Successfully installed psutil 08:53:10 INFO - Cleaning up... 08:53:11 INFO - Return code: 0 08:53:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:11 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 0x104e70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0ea485680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d14d30>, '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 0x104b38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d0bb20>, '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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:53:11 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 08:53:11 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 08:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tOFmX0Eopj/Render', 08:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:11 INFO - 'HOME': '/Users/cltbld', 08:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:11 INFO - 'LOGNAME': 'cltbld', 08:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:11 INFO - 'MOZ_NO_REMOTE': '1', 08:53:11 INFO - 'NO_EM_RESTART': '1', 08:53:11 INFO - 'PAGER': '/bin/cat', 08:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:11 INFO - 'PWD': '/builds/slave/test', 08:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:11 INFO - 'SHELL': '/bin/bash', 08:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbHFlaaT2R/Listeners', 08:53:11 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:11 INFO - 'USER': 'cltbld', 08:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:11 INFO - 'XPC_FLAGS': '0x0', 08:53:11 INFO - 'XPC_SERVICE_NAME': '0', 08:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:53:13 INFO - Installing collected packages: mozsystemmonitor 08:53:13 INFO - Running setup.py install for mozsystemmonitor 08:53:13 INFO - Successfully installed mozsystemmonitor 08:53:13 INFO - Cleaning up... 08:53:13 INFO - Return code: 0 08:53:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104e70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0ea485680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d14d30>, '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 0x104b38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d0bb20>, '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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:53:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:53:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tOFmX0Eopj/Render', 08:53:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:13 INFO - 'HOME': '/Users/cltbld', 08:53:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:13 INFO - 'LOGNAME': 'cltbld', 08:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:13 INFO - 'MOZ_NO_REMOTE': '1', 08:53:13 INFO - 'NO_EM_RESTART': '1', 08:53:13 INFO - 'PAGER': '/bin/cat', 08:53:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:13 INFO - 'PWD': '/builds/slave/test', 08:53:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:13 INFO - 'SHELL': '/bin/bash', 08:53:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbHFlaaT2R/Listeners', 08:53:13 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:53:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:13 INFO - 'USER': 'cltbld', 08:53:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:13 INFO - 'XPC_FLAGS': '0x0', 08:53:13 INFO - 'XPC_SERVICE_NAME': '0', 08:53:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:14 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:16 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:17 INFO - Downloading docopt-0.6.1.tar.gz 08:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:17 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:17 INFO - Running setup.py install for blobuploader 08:53:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:17 INFO - Running setup.py install for requests 08:53:18 INFO - Running setup.py install for docopt 08:53:18 INFO - Successfully installed blobuploader requests docopt 08:53:18 INFO - Cleaning up... 08:53:18 INFO - Return code: 0 08:53:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:18 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 0x104e70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0ea485680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d14d30>, '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 0x104b38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d0bb20>, '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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:53:18 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 08:53:18 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 08:53:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tOFmX0Eopj/Render', 08:53:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:18 INFO - 'HOME': '/Users/cltbld', 08:53:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:18 INFO - 'LOGNAME': 'cltbld', 08:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:18 INFO - 'MOZ_NO_REMOTE': '1', 08:53:18 INFO - 'NO_EM_RESTART': '1', 08:53:18 INFO - 'PAGER': '/bin/cat', 08:53:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:18 INFO - 'PWD': '/builds/slave/test', 08:53:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:18 INFO - 'SHELL': '/bin/bash', 08:53:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbHFlaaT2R/Listeners', 08:53:18 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:53:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:18 INFO - 'USER': 'cltbld', 08:53:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:18 INFO - 'XPC_FLAGS': '0x0', 08:53:18 INFO - 'XPC_SERVICE_NAME': '0', 08:53:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:18 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-yTOgA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:18 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-SBCcsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-lRz7ye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-1jDfRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-d9DPCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-3m37Gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-doahg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-ZbmKqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-gRqsWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-r2iT8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-vLjO4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:20 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-yrtnxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:20 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-zbV5ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:20 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-qiyBVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:20 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-VdPDHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:20 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-jVNlW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:20 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-G4ScB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:20 INFO - Running setup.py install for manifestparser 08:53:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:20 INFO - Running setup.py install for mozcrash 08:53:20 INFO - Running setup.py install for mozdebug 08:53:21 INFO - Running setup.py install for mozdevice 08:53:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Running setup.py install for mozfile 08:53:21 INFO - Running setup.py install for mozhttpd 08:53:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Running setup.py install for mozinfo 08:53:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Running setup.py install for mozInstall 08:53:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:21 INFO - Running setup.py install for mozleak 08:53:21 INFO - Running setup.py install for mozlog 08:53:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Running setup.py install for moznetwork 08:53:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Running setup.py install for mozprocess 08:53:22 INFO - Running setup.py install for mozprofile 08:53:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Running setup.py install for mozrunner 08:53:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:22 INFO - Running setup.py install for mozscreenshot 08:53:22 INFO - Running setup.py install for moztest 08:53:23 INFO - Running setup.py install for mozversion 08:53:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:23 INFO - Cleaning up... 08:53:23 INFO - Return code: 0 08:53:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:23 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 0x104e70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0ea485680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d14d30>, '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 0x104b38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d0bb20>, '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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:53:23 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 08:53:23 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 08:53:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tOFmX0Eopj/Render', 08:53:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:23 INFO - 'HOME': '/Users/cltbld', 08:53:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:23 INFO - 'LOGNAME': 'cltbld', 08:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:23 INFO - 'MOZ_NO_REMOTE': '1', 08:53:23 INFO - 'NO_EM_RESTART': '1', 08:53:23 INFO - 'PAGER': '/bin/cat', 08:53:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:23 INFO - 'PWD': '/builds/slave/test', 08:53:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:23 INFO - 'SHELL': '/bin/bash', 08:53:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbHFlaaT2R/Listeners', 08:53:23 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:53:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:23 INFO - 'USER': 'cltbld', 08:53:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:23 INFO - 'XPC_FLAGS': '0x0', 08:53:23 INFO - 'XPC_SERVICE_NAME': '0', 08:53:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-D_wm7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:23 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)) 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-gnHhCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:23 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)) 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-9KLYQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:23 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)) 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-7gc5_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:23 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)) 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-5D4EvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:23 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)) 08:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-06sZqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-EaeJ21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-3t1BhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-U6XDx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-WUxiZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-Ahip8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-iVFpqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-HsRalR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-mF_6x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:24 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)) 08:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-o8qf0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:25 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)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-91mDWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:25 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)) 08:53:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:25 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-uJoPJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:25 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)) 08:53:25 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)) 08:53:25 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)) 08:53:25 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)) 08:53:25 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)) 08:53:25 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)) 08:53:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:27 INFO - Downloading blessings-1.6.tar.gz 08:53:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:27 INFO - Installing collected packages: blessings 08:53:27 INFO - Running setup.py install for blessings 08:53:27 INFO - Successfully installed blessings 08:53:27 INFO - Cleaning up... 08:53:27 INFO - Return code: 0 08:53:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:28 INFO - Reading from file tmpfile_stdout 08:53:28 INFO - Current package versions: 08:53:28 INFO - blessings == 1.6 08:53:28 INFO - blobuploader == 1.2.4 08:53:28 INFO - docopt == 0.6.1 08:53:28 INFO - manifestparser == 1.1 08:53:28 INFO - mozInstall == 1.12 08:53:28 INFO - mozcrash == 0.16 08:53:28 INFO - mozdebug == 0.1 08:53:28 INFO - mozdevice == 0.48 08:53:28 INFO - mozfile == 1.2 08:53:28 INFO - mozhttpd == 0.7 08:53:28 INFO - mozinfo == 0.9 08:53:28 INFO - mozleak == 0.1 08:53:28 INFO - mozlog == 3.1 08:53:28 INFO - moznetwork == 0.27 08:53:28 INFO - mozprocess == 0.22 08:53:28 INFO - mozprofile == 0.28 08:53:28 INFO - mozrunner == 6.11 08:53:28 INFO - mozscreenshot == 0.1 08:53:28 INFO - mozsystemmonitor == 0.0 08:53:28 INFO - moztest == 0.7 08:53:28 INFO - mozversion == 1.4 08:53:28 INFO - psutil == 3.1.1 08:53:28 INFO - requests == 1.2.3 08:53:28 INFO - wsgiref == 0.1.2 08:53:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:28 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 0x104e70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0ea485680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d14d30>, '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 0x104b38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d0bb20>, '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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:53:28 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 08:53:28 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 08:53:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tOFmX0Eopj/Render', 08:53:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:28 INFO - 'HOME': '/Users/cltbld', 08:53:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:28 INFO - 'LOGNAME': 'cltbld', 08:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:28 INFO - 'MOZ_NO_REMOTE': '1', 08:53:28 INFO - 'NO_EM_RESTART': '1', 08:53:28 INFO - 'PAGER': '/bin/cat', 08:53:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:28 INFO - 'PWD': '/builds/slave/test', 08:53:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:28 INFO - 'SHELL': '/bin/bash', 08:53:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbHFlaaT2R/Listeners', 08:53:28 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:53:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:28 INFO - 'USER': 'cltbld', 08:53:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:28 INFO - 'XPC_FLAGS': '0x0', 08:53:28 INFO - 'XPC_SERVICE_NAME': '0', 08:53:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:28 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)) 08:53:28 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)) 08:53:28 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)) 08:53:28 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)) 08:53:28 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)) 08:53:28 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)) 08:53:28 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)) 08:53:28 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)) 08:53:28 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)) 08:53:28 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)) 08:53:28 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)) 08:53:28 INFO - Cleaning up... 08:53:28 INFO - Return code: 0 08:53:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0ea485680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d14d30>, '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 0x104b38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d0bb20>, '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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:53: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', 'jsonschema'] in /builds/slave/test/build 08:53: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 jsonschema 08:53:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tOFmX0Eopj/Render', 08:53:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:28 INFO - 'HOME': '/Users/cltbld', 08:53:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:28 INFO - 'LOGNAME': 'cltbld', 08:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:28 INFO - 'MOZ_NO_REMOTE': '1', 08:53:28 INFO - 'NO_EM_RESTART': '1', 08:53:28 INFO - 'PAGER': '/bin/cat', 08:53:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:28 INFO - 'PWD': '/builds/slave/test', 08:53:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:28 INFO - 'SHELL': '/bin/bash', 08:53:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbHFlaaT2R/Listeners', 08:53:28 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:53:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:28 INFO - 'USER': 'cltbld', 08:53:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:28 INFO - 'XPC_FLAGS': '0x0', 08:53:28 INFO - 'XPC_SERVICE_NAME': '0', 08:53:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:28 INFO - Downloading/unpacking jsonschema 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:31 INFO - Downloading/unpacking functools32 (from jsonschema) 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:31 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:31 INFO - warning: no files found matching '*.txt' 08:53:31 INFO - no previously-included directories found matching 'build' 08:53:31 INFO - no previously-included directories found matching 'dist' 08:53:31 INFO - no previously-included directories found matching '.git*' 08:53:31 INFO - Installing collected packages: jsonschema, functools32 08:53:31 INFO - Running setup.py install for functools32 08:53:31 INFO - warning: no files found matching '*.txt' 08:53:31 INFO - no previously-included directories found matching 'build' 08:53:31 INFO - no previously-included directories found matching 'dist' 08:53:31 INFO - no previously-included directories found matching '.git*' 08:53:31 INFO - Successfully installed jsonschema functools32 08:53:31 INFO - Cleaning up... 08:53:31 INFO - Return code: 0 08:53:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:31 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 0x104e70a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e784c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff0ea485680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d14d30>, '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 0x104b38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d0bb20>, '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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 08:53:31 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 08:53:31 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 08:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tOFmX0Eopj/Render', 08:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:31 INFO - 'HOME': '/Users/cltbld', 08:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:31 INFO - 'LOGNAME': 'cltbld', 08:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:31 INFO - 'MOZ_NO_REMOTE': '1', 08:53:31 INFO - 'NO_EM_RESTART': '1', 08:53:31 INFO - 'PAGER': '/bin/cat', 08:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:31 INFO - 'PWD': '/builds/slave/test', 08:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:31 INFO - 'SHELL': '/bin/bash', 08:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbHFlaaT2R/Listeners', 08:53:31 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:31 INFO - 'USER': 'cltbld', 08:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:31 INFO - 'XPC_FLAGS': '0x0', 08:53:31 INFO - 'XPC_SERVICE_NAME': '0', 08:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:32 INFO - Downloading/unpacking flake8 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 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 08:53:32 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 08:53:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:53:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:53:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:53:35 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 08:53:35 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 08:53:35 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 08:53:35 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 08:53:35 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 08:53:35 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 08:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:53:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:53:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:53:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:53:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:53:35 INFO - no previously-included directories found matching 'docs/_build' 08:53:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:53:35 INFO - Running setup.py install for pep8 08:53:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:53:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:53:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:53:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:53:35 INFO - no previously-included directories found matching 'docs/_build' 08:53:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:53:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:53:36 INFO - Cleaning up... 08:53:36 INFO - Return code: 0 08:53:36 INFO - Running post-action listener: _resource_record_post_action 08:53:36 INFO - Running post-action listener: _start_resource_monitoring 08:53:36 INFO - Starting resource monitoring. 08:53:36 INFO - ##### 08:53:36 INFO - ##### Running install step. 08:53:36 INFO - ##### 08:53:36 INFO - Running pre-action listener: _resource_record_pre_action 08:53:36 INFO - Running main action method: install 08:53:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:36 INFO - Reading from file tmpfile_stdout 08:53:36 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:36 INFO - Reading from file tmpfile_stdout 08:53:36 INFO - Output received: 08:53:36 INFO - Usage: mozinstall [options] installer 08:53:36 INFO - Options: 08:53:36 INFO - -h, --help show this help message and exit 08:53:36 INFO - -d DEST, --destination=DEST 08:53:36 INFO - Directory to install application into. [default: 08:53:36 INFO - "/builds/slave/test"] 08:53:36 INFO - --app=APP Application being installed. [default: firefox] 08:53:36 INFO - mkdir: /builds/slave/test/build/application 08:53:36 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'] 08:53:36 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 08:54:10 INFO - Reading from file tmpfile_stdout 08:54:10 INFO - Output received: 08:54:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:54:10 INFO - Running post-action listener: _resource_record_post_action 08:54:10 INFO - ##### 08:54:10 INFO - ##### Running run-tests step. 08:54:10 INFO - ##### 08:54:10 INFO - Running pre-action listener: _resource_record_pre_action 08:54:10 INFO - Running main action method: run_tests 08:54:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:54:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:54:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:54:10 INFO - 2016-03-02 08:54:10.251 screenresolution[1649:7405] starting screenresolution argv=screenresolution get 08:54:10 INFO - 2016-03-02 08:54:10.254 screenresolution[1649:7405] Display 0: 1600x1200x32@60 08:54:10 INFO - 2016-03-02 08:54:10.260 screenresolution[1650:7407] starting screenresolution argv=screenresolution list 08:54:10 INFO - Available Modes on Display 0 08:54:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:54:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:54:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:54:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:54:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:54:10 INFO - Intel Iris: 08:54:10 INFO - Chipset Model: Intel Iris 08:54:10 INFO - Type: GPU 08:54:10 INFO - Bus: Built-In 08:54:10 INFO - VRAM (Dynamic, Max): 1536 MB 08:54:10 INFO - Vendor: Intel (0x8086) 08:54:10 INFO - Device ID: 0x0a2e 08:54:10 INFO - Revision ID: 0x0009 08:54:10 INFO - Displays: 08:54:10 INFO - Display: 08:54:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:54:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:54:10 INFO - Display Serial Number: 1600x1200 60 08:54:10 INFO - Main Display: Yes 08:54:10 INFO - Mirror: Off 08:54:10 INFO - Online: Yes 08:54:10 INFO - Rotation: Supported 08:54:10 INFO - Return code: 0 08:54:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:10 INFO - Python 2.7.3 08:54:10 INFO - Return code: 0 08:54:10 INFO - grabbing minidump binary from tooltool 08:54: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')]} 08:54:10 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 0x104d14d30>, '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 0x104b38db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d0bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:10 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 08:54:10 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 08:54:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:10 INFO - Return code: 0 08:54:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:54:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:54:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:54:11 INFO - Return code: 0 08:54:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:54:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:54:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tOFmX0Eopj/Render', 08:54:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:11 INFO - 'HOME': '/Users/cltbld', 08:54:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:11 INFO - 'LOGNAME': 'cltbld', 08:54:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:54:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:11 INFO - 'MOZ_NO_REMOTE': '1', 08:54:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:11 INFO - 'NO_EM_RESTART': '1', 08:54:11 INFO - 'PAGER': '/bin/cat', 08:54:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:11 INFO - 'PWD': '/builds/slave/test', 08:54:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:11 INFO - 'SHELL': '/bin/bash', 08:54:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mbHFlaaT2R/Listeners', 08:54:11 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 08:54:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:11 INFO - 'USER': 'cltbld', 08:54:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:11 INFO - 'XPC_FLAGS': '0x0', 08:54:11 INFO - 'XPC_SERVICE_NAME': '0', 08:54:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:54:12 INFO - mozversion application_buildid: 20160302053632 08:54:12 INFO - mozversion application_changeset: 1db864e863ed710a3e51ef795b32e070fd9cc145 08:54:12 INFO - mozversion application_display_name: Nightly 08:54:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:12 INFO - mozversion application_name: Firefox 08:54:12 INFO - mozversion application_remotingname: firefox 08:54:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:54:12 INFO - mozversion application_vendor: Mozilla 08:54:12 INFO - mozversion application_version: 47.0a1 08:54:12 INFO - mozversion platform_buildid: 20160302053632 08:54:12 INFO - mozversion platform_changeset: 1db864e863ed710a3e51ef795b32e070fd9cc145 08:54:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:54:12 INFO - mozversion platform_version: 47.0a1 08:54:12 INFO - using testdate: 1456937652 08:54:12 INFO - actual date: 1456937652 08:54:12 INFO - starting webserver on 'localhost:49274' 08:54:12 INFO - SUITE-START | Running 2 tests 08:54:12 INFO - TEST-START | dromaeo_css 08:54:12 INFO - operating with platform_type : mac_ 08:54:12 INFO - Initialising browser for dromaeo_css test... 08:54:12 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpSnlIUR/profile http://localhost:49274/getInfo.html) 08:54:14 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 08:54:14 INFO - PROCESS | 1670 | colorDepth:24 08:54:14 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 08:54:14 INFO - PROCESS | 1670 | __metrics 08:54:14 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:54:14 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:15 INFO - TEST-INFO | 1670: exit 0 08:54:15 INFO - Browser initialized. 08:54:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:15 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpSnlIUR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:27 INFO - PROCESS | 1674 | RSS: Main: 243666944 08:54:27 INFO - PROCESS | 1674 | 08:55:18 INFO - PROCESS | 1674 | 1456937718431 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] 08:57:28 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 08:57:30 INFO - PROCESS | 1674 | RSS: Main: 406478848 08:57:30 INFO - PROCESS | 1674 | 09:00:32 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 09:00:33 INFO - PROCESS | 1674 | RSS: Main: 374353920 09:00:33 INFO - PROCESS | 1674 | 09:03:35 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 09:03:35 INFO - PROCESS | 1674 | RSS: Main: 376918016 09:03:35 INFO - PROCESS | 1674 | 09:06:38 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 09:06:38 INFO - PROCESS | 1674 | RSS: Main: 333058048 09:06:38 INFO - PROCESS | 1674 | 09:09:41 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 09:09:42 INFO - PROCESS | 1674 | RSS: Main: 336998400 09:09:42 INFO - PROCESS | 1674 | 09:12:45 INFO - PROCESS | 1674 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 09:12:45 INFO - PROCESS | 1674 | RSS: Main: 398225408 09:12:45 INFO - PROCESS | 1674 | 09:12:45 INFO - PROCESS | 1674 | __start_tp_report 09:12:45 INFO - PROCESS | 1674 | _x_x_mozilla_page_load 09:12:45 INFO - PROCESS | 1674 | _x_x_mozilla_page_load_details 09:12:45 INFO - PROCESS | 1674 | |i|pagename|runs| 09:12:45 INFO - PROCESS | 1674 | |0;dojo.html;2904.941901161976;3394.321135772846;3395.2869897321552;3396.269801992573;3450.534177885986;5461.18082287656;5541.861453463665;5574.888502229953;5604.243427137335;5604.523615492683;4654.8370807021765;5545.833624991256;5584.329880414346;5586.301712285965;5606.523445507137;4221.873343799675;4998.82504112357;5025.246213068032;5103.897922041576;5124.308218390507;5078.771455284503;5155;5155.278261043457;5168.147255702805;5171.663841850286;5059.772310246048;5105.132127538327;5112.079825631385;5122.8207012754565;5144.4083930348115;5101.566366858803;5154.896902061938;5162.586993040548;5170.305157926529;5218.269442278084;4185.434966279544;4985.252212168168;5062.417821950449;5079.466656001141;5083.847484575469;5461.017016936949;5502.0921547944545;5534.529564986981;5536.501714845643;5588.077967135418;6071.605345652519;6073.51411887048;6096.055111457731;6108.480779133779;6113.296970848365;4693.48371679115;6069.635821850703;6150.169727086831;6209.627422354628;6216.502679785652;5686.630369026083;5692.316921969349;5705.087186050212;5712.086066229425;5723.255976723;6238.6880655967925;6257.186565746515;6265.028920517236;6301.14934483848;6313.873722525524;5858.443447872445;5897.852553686193;5978.1929439525975;6015.3383127855905;6024.909626355608;6132.724027418777;6147;6174.073888916699;6177.567570270038;6184.845378865564;6010.519158467399;6061.515078793686;6066.726997285133;6071.453569178795;6077.301110372364;5963.761449542057;6062.272527296753;6110.103144028831;6130.856783744145;6161.137440758297;4811.158047341702;4820.469748327681;4829.372181616367;4843.564079232886;4860.416749990024;4263.978680106579;4320.546342633978;4336.154449882306;4354.869353919387;4379.934300985487;5464.617476776667;5514.944850551443;5527.751251193706;5531.1426728857095;5532.170174473861;6055.788047418319;6070.726817293233;6071.605345652519;6079.878402431927;6080.483158931452;5506.366767821752;5524.116141417354;5526.198701188305;5541.667499950016;5605.019121653694;5322.414534401213;5334.279872217201;5346.278252435949;5369.6509726867625;5373.2746079278795;6245.594036387621;6280.811575652738;6285.937140628535;6298.7480500780375;6304.684765761694;6027.789027384196;6104.7926496150985;6209.130721699056;6219.689015549295;6219.813405597839;6242.563020588515;6310.1796766420075;6316.494680425647;6322.0200868865395;6336.7465301389275;6038.5772995889865;6061.909071363845;6073.14975903365;6078.848028799315;6100.328963814066;5069.442361340323;6053.213082299273;6100.403717774465;6109.989783459207;6161.4146656067605;4940.407151141886;5877.500412464989;5890.440408161217;5891.204687367151;5900.43945825146;5873.324567674772;5929.436703513159;5987.6108052976415;5989.970050149721;5996.760129594942;5754.2519472469985;5757.913631295618;5792.884142317046;5794.275715535558;5794.797182098607;5840.094785308284;5907.645541267538;5935.198748168942;5975.073863551156;5990.101484777144;5710.857228569319;5805.361410244954;5819.15622234782;5912.083627037816;5933.1396947443245 09:12:45 INFO - PROCESS | 1674 | |1;ext.html;486.57667828988787;530.8885134121834;576.0035139209166;622.5704264057802;636.7293900092462;26246.606300905503;37144.69993550226;37409.625903740955;37510.62489375105;37736.62263377365;39644.8106556803;40124.398134028015;40158.799206004005;40179.79910100446;40304.59695403045;9297.953510232457;9529.190018848372;9530.857037144448;9531.38046027006;9568.80389951256;9298.256139508856;9444.291678124135;9455.432674039545;9459.952700236488;9588.664396746115;9438.716838494822;9491.003444638283;9496.857547136764;9505.809883802354;9571.473568953705;8076.798080047987;9571.18644915183;9588.66439674608;9590.9520452398;9607.327487075907;9454;9567.995360487119;9585.329026968046;9592;9594.760130996781;38689.03277418059;38911.805440972894;38929.248183831514;38946.221075578615;38980.41529377062;3135.81185128893;3182.7612929030183;3209.646938836726;3355.8825441109443;3589.8025608591515;27721.306967325778;27948.441031179467;28016.879324826983;28234.576481352797;28795.28011799701;2765.764909982654;2784.651918510186;2800.2719292983766;2854.728800763924;2899.5505696617056;441848.07063505566;492253;492828;493170.53414733056;493412;43555.78222108933;60300.095498567556;60348.69825650844;60823.08765368523;61034.694826525585;43196.784016080346;43429;43433.13133737307;43556.56443435588;43576;15170.848291517164;15426.922865385826;15484.92257538705;15502.992305500107;15512.379504819906;12431.191972521758;12510.499580016698;12521.060920431004;12524.81212781809;12535.310557919402;13954.720905582035;13974.58076257714;14264.928675356558;14326.355314010894;14375.78436323456;6200.255969283715;6250.124982502453;6277.183966084471;6310.5898116622275;6323;903.846346121161;919.6229545886155;959.3811991265594;966.7969726357403;994.5226291380178;27810.443791124064;28156.85921570379;28343.15389993001;28742.425151496853;28825.279368015967;1013.1995723378595;1036.6319956415514;1054.7185170018465;1056.7727938493108;1057.4606950455322;14345.354459049368;14403.279836008158;14416.783748243784;14766.630834229016;14872.256387180598;499981;506456;506556;506640;507958;54747;56344.718276408355;56345.43654563484;56422;56445.43554564402;1278.386374540226;1302.1275745250705;1387.6253411578816;1399.90200685951;1418.21997901156;27130.864345678146;27202.775875085274;27586.448271034868;27717.029903953266;27746;45181;45512;45983.3102503456;46109.53890461053;46186.84532886705;369727;372324;372866;373165;373950;25464.47213167216;27192.048278310165;27824.860875695493;32128;32227.677723222467;38795.03012424712;39037.609623903394;39256.21487570176;40033.599664002984;40143;33090.33819323648;33322.5001624971;33778.021594395024;34064.31871362608;34296.65703342934;31634;32969.516371762846;33161.66838331682;33396.66413343536;34007;34088;34159.829200853834;34893.127671808405;34960.80470343575;35088;25286;32126.518102228954;33901.81343652961;34358.31283374268;34427.82786086053;19953.700694489304;23658.52682946297;23781.643275350536;23883.52232955366;24099.879500602387 09:12:45 INFO - PROCESS | 1674 | |2;jquery.html;348.41118509718575;351.948967399727;351.98768043118497;359.48772998477165;360.72945291031726;15268.236588170603;19072.713909291353;19243.807561924375;19949;20147.395578132644;18720;19337.323193688222;19385.612287754237;19404.51488712783;19411.22355105794;5414.052540805363;5675.744591493372;5704.572157088214;5743.282089738783;5745.109508026263;4138.213739389522;4318.481782186126;5675.602707810455;6105.603135796181;6299.905501417483;6255.093011513328;6257.249130104394;6267.874642507147;6268.874622507547;6275.341089185638;6013.308469525995;6297.1184034235475;6299.433051025384;6301.275353334334;6311.558190926637;3671.5777685566236;4454.48773391061;5383.730813459311;5393;5402.405735369106;23980.7601923982;24028.879855600786;24220.515589688108;24427.755722442726;24479.38801529958;1987.9900600497049;2096.276784509357;2138.176801931252;2148.5488047510044;2187.649976003832;7695.807604809868;10861.509035484452;13548.93225533876;14381.568552943429;14976.026558273677;1670.1732642341997;1706.7439884017372;1727.1795896948975;1768.5490199999047;1809.3848091648772;95236;98357.01642983622;99232;100247.9975200246;105155;9295;10449.425281609585;10620.362778233331;10633.46832658364;10789.352638841694;13133.146345487512;13256.40346184424;13271.668208294677;13298.268595227162;13301.66745831362;8391.202835730595;8454.365922555833;8454.704085357105;8527.744167674855;8543.658253669908;8679.869801952977;8686.305095592337;8705.303575714055;8793.252573531321;8817.338699597427;4238.830446782156;4313.3098704207805;4360.149770794665;4373.497047839539;4448.065906159743;1524.908505489674;1721.8364255395718;1789.2127463915836;1819.1722766141374;1856.4059500959834;829.9170082991652;833.6748668019477;878.8637761147032;884.746030492139;976.6679329028165;19074.809251907303;19423.125959331865;19749.901250493942;19965.401037968884;19981.700274495895;900.7838118851429;921.318224513855;943.9008904065112;944.5324564340696;1069.540097757956;8607.698730544402;8624.266937310398;10348.430836303925;10471.476426178813;10635.793170186707;624551;628251;628353;639358;642865;116362.41818790852;120109.39945300392;122575.38712306382;126277;127662;939.3377668743519;995.9053889880449;1023.5445226873969;1041.6874937518864;1071.924965252425;17095.401660941807;17321.56696082608;17575.648487029932;17757.02336371512;17893.284268629628;50593;51488.97022059463;52293.50918153539;53087.203691943876;54027.72986135044;76621;78574;79176;81392.18607813846;82187;9134.5432728362;11325.980661740483;11808.822867657163;11812.3503207321;11872.881271187178;8164.795880102807;13251.204927704368;13360.064795464225;13782.173069615856;13824.239666818019;11425.2002359834;11664.008559272217;11801.232919860182;11851.52593896269;11914.10644201671;11236.606718764804;11395.430228488376;11648.242864213798;11688.590899318484;11775.882241177478;11481.770364592494;11488.827667584826;11893.286402815858;12046.216995895238;12093;11495.712607184552;11747.588834390755;11788.115891308014;11848.348340840992;12019.519219231483;10311.278210525192;11859.229150105215;11894.640657900005;11908.40457977115;11989.880101199225 09:12:45 INFO - PROCESS | 1674 | |3;mootools.html;1407.6410515318591;1541.9922900385495;1567.7961864957558;1800.1359347513194;1961.4213806926955;7721.536707797536;8327.042390125138;8498.830023399529;8527.658893644248;8529.573521323924;8154.551499667516;8364.623591938362;8377.162283771635;8394.874076888851;8395.45429547079;2133.839962002848;2363.409147713072;2410.445597512569;2437.7805997460223;2439.000009995902;2398.568257713611;2437.9390515237083;2447.4737931344757;2448.081969261527;2448.608222684371;2381.4879800842814;2402.8318017738766;2412.4089598048504;2439.7682220189054;2440.170342083691;2396.9041238350446;2416.915407960722;2436.500517393939;2438.426969662128;2446.7308596054418;2415.7946574541184;2418.5767490689236;2445.596476581362;2447.290285817111;2449.3998970252223;8371.497710137412;8449.155084491564;8477.491350518989;8479.06730259671;8491.575421228976;5289.153735402356;5395.730213489349;5398.73006349681;5449.373322067973;5449.937262233866;3438.432658611326;3507.8421471033867;3582.3551760683067;3593.8562457501666;3593.9101522462147;1015.6140666546739;1043.1394099867564;1046.6284469013467;1047.0158051431706;1051.2588625019343;11227.494762735696;11387.715307117305;11394.60118895843;11417.885821141848;11459.36973466459;4810.6151507879285;4812.614990800727;4828.7875771451045;4869.123557759637;4884;8535.359848011423;8586;9820.017998200123;9835.655752048644;9851.014898510091;5351.491608297206;5371.892562148735;5376.4085950545405;5386.353637563518;5391.05656510117;4071.796410179479;4296.312589985588;4461;4627.6529260305615;4747.169245382044;3812.199438118026;3835.0795809006195;3877.127646279621;3907.4138879168354;3911.882643520699;1249.9187552809037;1279.181323952671;1281.1032277405852;1285.4151361130664;1297.3967105296083;1309.4369421148806;1331.8801307882336;1335.1988806716088;1347.3263368315843;1366.2007725480507;7782.766517004386;7875.684972601146;7992.5204487730925;8011.559364234907;8016.31861291785;1175.1773758369177;1184.236167671864;1187.1808452167977;1190.910681698876;1205.8492688413949;6137.693115344215;6192.938070619236;6232.189815323979;6239.064140378889;6249.187605611241;9942.254330925209;10137.239707022003;10139.442330671736;10147.949260253652;10266.948665256627;10009.349392289478;10091.243156763272;10142.645007424704;10150.695479135638;10326.845097323547;7964.920350796534;8162.918370816215;8195.95902020498;8207.974003249594;8209.179082091863;7455.589942552995;7664.386849052174;7704.075510938723;7734.187910269341;7763.961180194289;7619.276168763959;9168.633254669738;9168.770780730536;9223.538823058954;9361.438313700928;7994.800129996564;8677.652893884426;9447.905520944978;9522.714318570454;9564.56959436841;6619.7683081093855;6841;7031.542949708252;7200.315969982843;7317.5609463432365;7971.601419929097;8005.079415867017;8013.719519816778;8018.278354948083;8031.237032481905;6986.406155476841;7133.750318738819;7138.500304978602;7182.17404998411;7295.4528410368375;6343.667829755618;6975.651217439209;6993.0908981832035;7096.112985876765;7117.359437650636;7261.164966028763;7365.2634736525915;7430.219826918312;7551.848963020819;7570.735024274124;6835.965820170867;6852.931470685428;6901.62041087745;6902.102726645504;6912.758053468105;6620.337966203341;6905.75829845953;6919.8962015568795;6968.825779355557;7020.543664661781 09:12:45 INFO - PROCESS | 1674 | |4;prototype.html;315.5204089783529;319.8001249219238;324.68181182441214;326.45319090523367;332.0519915640847;5429.782808687648;6566;6586.571872828269;6630.535862489628;6682.665866706658;6550.951847704357;6553.311902250267;6600.1089852869845;6603.7028333724975;6611.074449577051;4573.49691533931;4693.953060469403;4706.411698537683;4772.713637181763;4822.71063736177;4793.890688097244;4827.662063655545;4858.246971719372;4883.413990321166;4884;4779.211430114027;4789.036495037036;4802.135615589193;4804.543568361;4808.956193617716;4569.314602809589;4617.953820461786;4666.859994200146;4691.29630555416;4718.905621887578;4024.195160967818;4057.57395473474;4058.3303754880408;4072.8981775455554;4075.347944328923;6052.757889684407;6124.448799608057;6179.752809887599;6187.07193920911;6209.441150296449;5574.331080270353;5588.329400471969;5591.692456914868;5595.440455954413;5598.880223955225;6801.013852991338;6851.897221541681;6869.381755641966;6870.072540207058;6871.518993670445;3932.292187406266;4310.849120280806;4413.801378937956;4513.7066090704;4514.300283456037;7175.641217939135;7335.193128755833;7335.449841261873;7338.41292696583;7351.117865856131;4493.7977790999485;4513.526079761577;4515.616172625364;4529.456465224194;4535.501094879561;4572.108438854391;4578.862634120982;4580.519045500241;4584.174848527297;4592.334111553806;5462.918056229159;5472.972635136799;5473.06957817164;5475.178723191473;5479.958807826501;6483.578567393104;6706.463482921452;6961.756338528127;6980.616066116311;6984.825379365557;1577.6371434569883;1577.9053256804627;1587.769773382853;1591.4509494224474;1592.283472437408;952.9666461673946;1014.8731408573929;1020.6631811502186;1032.4734385463319;1044.4882007816116;6233.937660623335;6471.482281417475;6787.5588086774205;6817.113775209191;6840.076589660432;7362.44781641379;7372.115346158388;7379.594122323324;7380.77857664271;7404.148522919933;5625.493705566519;6483.4164925156965;6608.173978252718;6642.236142843635;6645.900311495331;3822.10180607557;3867.690584753213;3872.7482713623526;3878.825452854628;3880.7283490155983;7353.338199562065;7683.577403242875;7747.961260193663;7753.53478791263;7780.18308077655;7337.449691273176;7531.924680753232;7544.434167437465;7544.735934242275;7545.245475452521;7599.582022988789;7621.971033910462;7624.237576242443;7629.54222746637;7629.656665450179;7085.114360704912;7300.269973002657;7314.4514161439165;7316.524425912298;7432.293932076444;7232.42140628759;7275.8181045472165;7296.160941491797;7300.926990730025;7304.890426643711;7724.0731112266885;7728.3430908371165;7742.883856742041;7744.535327880345;7745.535267883945;4053.4730485036757;4736.076465089274;4794.664373493822;4816.012717392996;4831.661783675109;7029.9648501757165;7225.24134965821;7232.42140628759;7247.275272472711;7255.274472552914;7057.611831349325;7112.644367781487;7139.928600713926;7148.67830947619;7158.248383919614;5823.7379317929945;7096.396806271318;7120.537165084253;7126.109236345457;7135.714571417086;6321.494280457644;6376;6941.132358455193;6960;6996.055532503047;6857.245702972768;7062.929370706227;7112.110986126734;7119.2168861426235;7149;5519.254900588529;6669.933300666931;6889.827754305982;6925.965370173117;7001.194862590867 09:12:45 INFO - PROCESS | 1674 | |5;yui.html;665.4543274514897;713.21546299071;731.451411441419;752.4431920378921;781.8709912864374;14678.706425871476;14905;14931.925340373311;14944.850551494495;14948.626284342898;12492.875071249286;13518.59444216675;13534;13593.524226652069;13621.387037583308;842.2588122452249;845.7462761171655;856.9271611912994;857.8284343131398;860.5181098584782;846.196113691992;847.4068152293388;847.8304339132168;848.4654667559429;851.7359618518249;893.1158153428092;894.7136916186823;894.8568229083348;896.7982204004112;905.597009330848;885.9911400885973;887.0863011098579;889.4974339498195;889.7375274294067;898.371140201858;662.5130529061137;664.5215444879678;664.7905909638497;670.6512613440983;673.8854394752904;12697.809532857014;12752.426140823685;12780.744385112339;12787;12837.29394883281;10843.132549396028;11161.218714689974;11253;11936.761264774656;12134.393280336037;9664.226861851035;10082.495875206283;10493.947530262376;10759.677209683721;11253.71865703364;3402.1494626343415;3439.518467414564;3486.4421692529327;3507.8596856125723;3723.5717892442176;64208.3687446882;80446.5977670108;80516;80780.38439231183;83017;9270.072992700676;9291.303152263607;9293.535323233811;9365.906340936639;9591.328606997582;19942.00289985495;19952.20191192365;19953.800461995193;19968.90015549942;20000;7380.372668323145;7384.778456646309;7397.778066658009;7477.252274772479;7479;3838.098046958962;3839.2705385977133;3846.288436639231;3848.1726428817938;3857.72995890285;3399.7450191235757;3448.896533103961;3451.2234747181683;3459.5502584664337;3467.7225821934185;601.8856417280703;605.1135087097423;621.9626822390671;640.5740182778493;645.5061877663591;517.6738654647548;582.0076769108659;584.929808422992;613.6594190224379;618.245740196959;7975.122736498981;8055.476394034369;8097.716579919675;8147.226013528823;8258.298044666271;512.9871753206126;515.2142981952552;522.3522831688679;574.3585666872051;596.8985272503598;3731.7574357666663;3746.887593372149;3760.2103558253075;3877;3899.7855117968215;95688;95927;96683;96811;98994;68568;72791.2720872795;80160;86350;87584;72313;72500;72852.27147728455;73307;73396.63301683564;8290.2124298194;8314;8432.957835210786;8452.830943381221;8569.742907712529;42661.36007959945;42678.78660606677;42693.573064270204;46915;47041.52958470371;55313.72343138258;56599.434005659416;66543.66728166328;66772.66454670977;68534.65732671504;10427.68716938493;10443.477826108816;10658.73353166146;10977.780444390908;11618.419079046183;9731.513424328898;11830.11274154459;11966.341851198267;12060.75878482443;12468.06489513272;10687;10888.61889833852;11092.889071109508;11242.744456020177;11408.087353011904;11003.559857605605;11176.385298808318;11186.496607652512;11373.260738052;11382.829257560978;10836.458177091272;11206.43967801623;11302.43487825589;11322.660320190407;11556.653300401002;8668;8797.692080777142;8847.557622118997;9192.912704417613;9541.713748587554;8672.392932494664;8809.471431714117;8812.91187088121;9298.01020586322;9384.436933783994 09:12:45 INFO - PROCESS | 1674 | __end_tp_report 09:12:45 INFO - PROCESS | 1674 | __start_cc_report 09:12:45 INFO - PROCESS | 1674 | _x_x_mozilla_cycle_collect,1432 09:12:45 INFO - PROCESS | 1674 | __end_cc_report 09:12:45 INFO - PROCESS | 1674 | __startTimestamp1456938765352__endTimestamp 09:12:45 INFO - PROCESS | 1674 | 09:12:45 INFO - PROCESS | 1674 | ------- Summary: start ------- 09:12:45 INFO - PROCESS | 1674 | Number of tests: 6 09:12:45 INFO - PROCESS | 1674 | 09:12:45 INFO - PROCESS | 1674 | [#0] dojo.html Cycles:165 Average:5597.91 Median:5794.28 stddev:657.12 (11.3%) stddev-sans-first:624.25 09:12:45 INFO - PROCESS | 1674 | Values: 2904.9 3394.3 3395.3 3396.3 3450.5 5461.2 5541.9 5574.9 5604.2 5604.5 4654.8 5545.8 5584.3 5586.3 5606.5 4221.9 4998.8 5025.2 5103.9 5124.3 5078.8 5155.0 5155.3 5168.1 5171.7 5059.8 5105.1 5112.1 5122.8 5144.4 5101.6 5154.9 5162.6 5170.3 5218.3 4185.4 4985.3 5062.4 5079.5 5083.8 5461.0 5502.1 5534.5 5536.5 5588.1 6071.6 6073.5 6096.1 6108.5 6113.3 4693.5 6069.6 6150.2 6209.6 6216.5 5686.6 5692.3 5705.1 5712.1 5723.3 6238.7 6257.2 6265.0 6301.1 6313.9 5858.4 5897.9 5978.2 6015.3 6024.9 6132.7 6147.0 6174.1 6177.6 6184.8 6010.5 6061.5 6066.7 6071.5 6077.3 5963.8 6062.3 6110.1 6130.9 6161.1 4811.2 4820.5 4829.4 4843.6 4860.4 4264.0 4320.5 4336.2 4354.9 4379.9 5464.6 5514.9 5527.8 5531.1 5532.2 6055.8 6070.7 6071.6 6079.9 6080.5 5506.4 5524.1 5526.2 5541.7 5605.0 5322.4 5334.3 5346.3 5369.7 5373.3 6245.6 6280.8 6285.9 6298.7 6304.7 6027.8 6104.8 6209.1 6219.7 6219.8 6242.6 6310.2 6316.5 6322.0 6336.7 6038.6 6061.9 6073.1 6078.8 6100.3 5069.4 6053.2 6100.4 6110.0 6161.4 4940.4 5877.5 5890.4 5891.2 5900.4 5873.3 5929.4 5987.6 5990.0 5996.8 5754.3 5757.9 5792.9 5794.3 5794.8 5840.1 5907.6 5935.2 5975.1 5990.1 5710.9 5805.4 5819.2 5912.1 5933.1 09:12:45 INFO - PROCESS | 1674 | 09:12:45 INFO - PROCESS | 1674 | [#1] ext.html Cycles:180 Average:58513.07 Median:373557.50 stddev:121709.02 (32.6%) stddev-sans-first:121972.47 09:12:45 INFO - PROCESS | 1674 | Values: 486.6 530.9 576.0 622.6 636.7 26246.6 37144.7 37409.6 37510.6 37736.6 39644.8 40124.4 40158.8 40179.8 40304.6 9298.0 9529.2 9530.9 9531.4 9568.8 9298.3 9444.3 9455.4 9460.0 9588.7 9438.7 9491.0 9496.9 9505.8 9571.5 8076.8 9571.2 9588.7 9591.0 9607.3 9454.0 9568.0 9585.3 9592.0 9594.8 38689.0 38911.8 38929.2 38946.2 38980.4 3135.8 3182.8 3209.6 3355.9 3589.8 27721.3 27948.4 28016.9 28234.6 28795.3 2765.8 2784.7 2800.3 2854.7 2899.6 441848.1 492253.0 492828.0 493170.5 493412.0 43555.8 60300.1 60348.7 60823.1 61034.7 43196.8 43429.0 43433.1 43556.6 43576.0 15170.8 15426.9 15484.9 15503.0 15512.4 12431.2 12510.5 12521.1 12524.8 12535.3 13954.7 13974.6 14264.9 14326.4 14375.8 6200.3 6250.1 6277.2 6310.6 6323.0 903.8 919.6 959.4 966.8 994.5 27810.4 28156.9 28343.2 28742.4 28825.3 1013.2 1036.6 1054.7 1056.8 1057.5 14345.4 14403.3 14416.8 14766.6 14872.3 499981.0 506456.0 506556.0 506640.0 507958.0 54747.0 56344.7 56345.4 56422.0 56445.4 1278.4 1302.1 1387.6 1399.9 1418.2 27130.9 27202.8 27586.4 27717.0 27746.0 45181.0 45512.0 45983.3 46109.5 46186.8 369727.0 372324.0 372866.0 373165.0 373950.0 25464.5 27192.0 27824.9 32128.0 32227.7 38795.0 39037.6 39256.2 40033.6 40143.0 33090.3 33322.5 33778.0 34064.3 34296.7 31634.0 32969.5 33161.7 33396.7 34007.0 34088.0 34159.8 34893.1 34960.8 35088.0 25286.0 32126.5 33901.8 34358.3 34427.8 19953.7 23658.5 23781.6 23883.5 24099.9 09:12:45 INFO - PROCESS | 1674 | 09:12:45 INFO - PROCESS | 1674 | [#2] jquery.html Cycles:180 Average:35351.07 Median:11121.84 stddev:104808.73 (942.4%) stddev-sans-first:105069.79 09:12:45 INFO - PROCESS | 1674 | Values: 348.4 351.9 352.0 359.5 360.7 15268.2 19072.7 19243.8 19949.0 20147.4 18720.0 19337.3 19385.6 19404.5 19411.2 5414.1 5675.7 5704.6 5743.3 5745.1 4138.2 4318.5 5675.6 6105.6 6299.9 6255.1 6257.2 6267.9 6268.9 6275.3 6013.3 6297.1 6299.4 6301.3 6311.6 3671.6 4454.5 5383.7 5393.0 5402.4 23980.8 24028.9 24220.5 24427.8 24479.4 1988.0 2096.3 2138.2 2148.5 2187.6 7695.8 10861.5 13548.9 14381.6 14976.0 1670.2 1706.7 1727.2 1768.5 1809.4 95236.0 98357.0 99232.0 100248.0 105155.0 9295.0 10449.4 10620.4 10633.5 10789.4 13133.1 13256.4 13271.7 13298.3 13301.7 8391.2 8454.4 8454.7 8527.7 8543.7 8679.9 8686.3 8705.3 8793.3 8817.3 4238.8 4313.3 4360.1 4373.5 4448.1 1524.9 1721.8 1789.2 1819.2 1856.4 829.9 833.7 878.9 884.7 976.7 19074.8 19423.1 19749.9 19965.4 19981.7 900.8 921.3 943.9 944.5 1069.5 8607.7 8624.3 10348.4 10471.5 10635.8 624551.0 628251.0 628353.0 639358.0 642865.0 116362.4 120109.4 122575.4 126277.0 127662.0 939.3 995.9 1023.5 1041.7 1071.9 17095.4 17321.6 17575.6 17757.0 17893.3 50593.0 51489.0 52293.5 53087.2 54027.7 76621.0 78574.0 79176.0 81392.2 82187.0 9134.5 11326.0 11808.8 11812.4 11872.9 8164.8 13251.2 13360.1 13782.2 13824.2 11425.2 11664.0 11801.2 11851.5 11914.1 11236.6 11395.4 11648.2 11688.6 11775.9 11481.8 11488.8 11893.3 12046.2 12093.0 11495.7 11747.6 11788.1 11848.3 12019.5 10311.3 11859.2 11894.6 11908.4 11989.9 09:12:45 INFO - PROCESS | 1674 | 09:12:45 INFO - PROCESS | 1674 | [#3] mootools.html Cycles:180 Average:5841.65 Median:5397.23 stddev:2996.92 (55.5%) stddev-sans-first:2986.79 09:12:45 INFO - PROCESS | 1674 | Values: 1407.6 1542.0 1567.8 1800.1 1961.4 7721.5 8327.0 8498.8 8527.7 8529.6 8154.6 8364.6 8377.2 8394.9 8395.5 2133.8 2363.4 2410.4 2437.8 2439.0 2398.6 2437.9 2447.5 2448.1 2448.6 2381.5 2402.8 2412.4 2439.8 2440.2 2396.9 2416.9 2436.5 2438.4 2446.7 2415.8 2418.6 2445.6 2447.3 2449.4 8371.5 8449.2 8477.5 8479.1 8491.6 5289.2 5395.7 5398.7 5449.4 5449.9 3438.4 3507.8 3582.4 3593.9 3593.9 1015.6 1043.1 1046.6 1047.0 1051.3 11227.5 11387.7 11394.6 11417.9 11459.4 4810.6 4812.6 4828.8 4869.1 4884.0 8535.4 8586.0 9820.0 9835.7 9851.0 5351.5 5371.9 5376.4 5386.4 5391.1 4071.8 4296.3 4461.0 4627.7 4747.2 3812.2 3835.1 3877.1 3907.4 3911.9 1249.9 1279.2 1281.1 1285.4 1297.4 1309.4 1331.9 1335.2 1347.3 1366.2 7782.8 7875.7 7992.5 8011.6 8016.3 1175.2 1184.2 1187.2 1190.9 1205.8 6137.7 6192.9 6232.2 6239.1 6249.2 9942.3 10137.2 10139.4 10147.9 10266.9 10009.3 10091.2 10142.6 10150.7 10326.8 7964.9 8162.9 8196.0 8208.0 8209.2 7455.6 7664.4 7704.1 7734.2 7764.0 7619.3 9168.6 9168.8 9223.5 9361.4 7994.8 8677.7 9447.9 9522.7 9564.6 6619.8 6841.0 7031.5 7200.3 7317.6 7971.6 8005.1 8013.7 8018.3 8031.2 6986.4 7133.8 7138.5 7182.2 7295.5 6343.7 6975.7 6993.1 7096.1 7117.4 7261.2 7365.3 7430.2 7551.8 7570.7 6836.0 6852.9 6901.6 6902.1 6912.8 6620.3 6905.8 6919.9 6968.8 7020.5 09:12:45 INFO - PROCESS | 1674 | 09:12:45 INFO - PROCESS | 1674 | [#4] prototype.html Cycles:180 Average:5726.86 Median:6559.66 stddev:1865.46 (28.4%) stddev-sans-first:1825.94 09:12:45 INFO - PROCESS | 1674 | Values: 315.5 319.8 324.7 326.5 332.1 5429.8 6566.0 6586.6 6630.5 6682.7 6551.0 6553.3 6600.1 6603.7 6611.1 4573.5 4694.0 4706.4 4772.7 4822.7 4793.9 4827.7 4858.2 4883.4 4884.0 4779.2 4789.0 4802.1 4804.5 4809.0 4569.3 4618.0 4666.9 4691.3 4718.9 4024.2 4057.6 4058.3 4072.9 4075.3 6052.8 6124.4 6179.8 6187.1 6209.4 5574.3 5588.3 5591.7 5595.4 5598.9 6801.0 6851.9 6869.4 6870.1 6871.5 3932.3 4310.8 4413.8 4513.7 4514.3 7175.6 7335.2 7335.4 7338.4 7351.1 4493.8 4513.5 4515.6 4529.5 4535.5 4572.1 4578.9 4580.5 4584.2 4592.3 5462.9 5473.0 5473.1 5475.2 5480.0 6483.6 6706.5 6961.8 6980.6 6984.8 1577.6 1577.9 1587.8 1591.5 1592.3 953.0 1014.9 1020.7 1032.5 1044.5 6233.9 6471.5 6787.6 6817.1 6840.1 7362.4 7372.1 7379.6 7380.8 7404.1 5625.5 6483.4 6608.2 6642.2 6645.9 3822.1 3867.7 3872.7 3878.8 3880.7 7353.3 7683.6 7748.0 7753.5 7780.2 7337.4 7531.9 7544.4 7544.7 7545.2 7599.6 7622.0 7624.2 7629.5 7629.7 7085.1 7300.3 7314.5 7316.5 7432.3 7232.4 7275.8 7296.2 7300.9 7304.9 7724.1 7728.3 7742.9 7744.5 7745.5 4053.5 4736.1 4794.7 4816.0 4831.7 7030.0 7225.2 7232.4 7247.3 7255.3 7057.6 7112.6 7139.9 7148.7 7158.2 5823.7 7096.4 7120.5 7126.1 7135.7 6321.5 6376.0 6941.1 6960.0 6996.1 6857.2 7062.9 7112.1 7119.2 7149.0 5519.3 6669.9 6889.8 6926.0 7001.2 09:12:45 INFO - PROCESS | 1674 | 09:12:45 INFO - PROCESS | 1674 | [#5] yui.html Cycles:180 Average:17920.44 Median:615.95 stddev:25789.62 (4186.9%) stddev-sans-first:25829.42 09:12:45 INFO - PROCESS | 1674 | Values: 665.5 713.2 731.5 752.4 781.9 14678.7 14905.0 14931.9 14944.9 14948.6 12492.9 13518.6 13534.0 13593.5 13621.4 842.3 845.7 856.9 857.8 860.5 846.2 847.4 847.8 848.5 851.7 893.1 894.7 894.9 896.8 905.6 886.0 887.1 889.5 889.7 898.4 662.5 664.5 664.8 670.7 673.9 12697.8 12752.4 12780.7 12787.0 12837.3 10843.1 11161.2 11253.0 11936.8 12134.4 9664.2 10082.5 10493.9 10759.7 11253.7 3402.1 3439.5 3486.4 3507.9 3723.6 64208.4 80446.6 80516.0 80780.4 83017.0 9270.1 9291.3 9293.5 9365.9 9591.3 19942.0 19952.2 19953.8 19968.9 20000.0 7380.4 7384.8 7397.8 7477.3 7479.0 3838.1 3839.3 3846.3 3848.2 3857.7 3399.7 3448.9 3451.2 3459.6 3467.7 601.9 605.1 622.0 640.6 645.5 517.7 582.0 584.9 613.7 618.2 7975.1 8055.5 8097.7 8147.2 8258.3 513.0 515.2 522.4 574.4 596.9 3731.8 3746.9 3760.2 3877.0 3899.8 95688.0 95927.0 96683.0 96811.0 98994.0 68568.0 72791.3 80160.0 86350.0 87584.0 72313.0 72500.0 72852.3 73307.0 73396.6 8290.2 8314.0 8433.0 8452.8 8569.7 42661.4 42678.8 42693.6 46915.0 47041.5 55313.7 56599.4 66543.7 66772.7 68534.7 10427.7 10443.5 10658.7 10977.8 11618.4 9731.5 11830.1 11966.3 12060.8 12468.1 10687.0 10888.6 11092.9 11242.7 11408.1 11003.6 11176.4 11186.5 11373.3 11382.8 10836.5 11206.4 11302.4 11322.7 11556.7 8668.0 8797.7 8847.6 9192.9 9541.7 8672.4 8809.5 8812.9 9298.0 9384.4 09:12:45 INFO - PROCESS | 1674 | -------- Summary: end -------- 09:12:45 INFO - PROCESS | 1674 | 09:12:45 INFO - TEST-INFO | 1674: exit 0 09:12:45 INFO - TEST-OK | dromaeo_css | took 1113459ms 09:12:45 INFO - TEST-START | kraken 09:12:45 INFO - operating with platform_type : mac_ 09:12:45 INFO - Initialising browser for kraken test... 09:12:45 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp06B7oN/profile http://localhost:49274/getInfo.html) 09:12:47 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 09:12:47 INFO - PROCESS | 1680 | colorDepth:24 09:12:47 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 09:12:47 INFO - PROCESS | 1680 | __metrics 09:12:48 INFO - PROCESS | 1680 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:12:48 INFO - PROCESS | 1680 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:12:48 INFO - TEST-INFO | 1680: exit 0 09:12:48 INFO - Browser initialized. 09:12:48 INFO - Running cycle 1/1 for kraken test... 09:12:48 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmp06B7oN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:00 INFO - PROCESS | 1682 | RSS: Main: 242577408 09:13:00 INFO - PROCESS | 1682 | 09:13:03 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:03 INFO - PROCESS | 1682 | RSS: Main: 289218560 09:13:03 INFO - PROCESS | 1682 | 09:13:06 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 09:13:07 INFO - PROCESS | 1682 | RSS: Main: 299397120 09:13:07 INFO - PROCESS | 1682 | 09:13:10 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 09:13:10 INFO - PROCESS | 1682 | RSS: Main: 284356608 09:13:10 INFO - PROCESS | 1682 | 09:13:12 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 09:13:13 INFO - PROCESS | 1682 | RSS: Main: 288030720 09:13:13 INFO - PROCESS | 1682 | 09:13:15 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:16 INFO - PROCESS | 1682 | RSS: Main: 288665600 09:13:16 INFO - PROCESS | 1682 | 09:13:18 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:19 INFO - PROCESS | 1682 | RSS: Main: 290025472 09:13:19 INFO - PROCESS | 1682 | 09:13:22 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:22 INFO - PROCESS | 1682 | RSS: Main: 289513472 09:13:22 INFO - PROCESS | 1682 | 09:13:25 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 09:13:25 INFO - PROCESS | 1682 | RSS: Main: 289067008 09:13:25 INFO - PROCESS | 1682 | 09:13:27 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:28 INFO - PROCESS | 1682 | RSS: Main: 323784704 09:13:28 INFO - PROCESS | 1682 | 09:13:29 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:30 INFO - PROCESS | 1682 | RSS: Main: 323407872 09:13:30 INFO - PROCESS | 1682 | 09:13:32 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:33 INFO - PROCESS | 1682 | RSS: Main: 332288000 09:13:33 INFO - PROCESS | 1682 | 09:13:35 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:36 INFO - PROCESS | 1682 | RSS: Main: 334360576 09:13:36 INFO - PROCESS | 1682 | 09:13:38 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:39 INFO - PROCESS | 1682 | RSS: Main: 334008320 09:13:39 INFO - PROCESS | 1682 | 09:13:40 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 09:13:41 INFO - PROCESS | 1682 | RSS: Main: 393981952 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | __start_tp_report 09:13:41 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 09:13:41 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 09:13:41 INFO - PROCESS | 1682 | |i|pagename|runs| 09:13:41 INFO - PROCESS | 1682 | |0;ai-astar;110;108;110;109;111;112;116;111;111;111 09:13:41 INFO - PROCESS | 1682 | |1;audio-beat-detection;156;122;145;161;118;138;142;118;159;119 09:13:41 INFO - PROCESS | 1682 | |2;audio-dft;186;193;259;185;186;185;183;183;182;181 09:13:41 INFO - PROCESS | 1682 | |3;audio-fft;71;70;87;76;56;56;56;72;74;55 09:13:41 INFO - PROCESS | 1682 | |4;audio-oscillator;92;92;124;81;80;84;114;75;81;112 09:13:41 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;88;84;87;85;86;83;87;84;87;85 09:13:41 INFO - PROCESS | 1682 | |6;imaging-darkroom;92;93;93;92;93;92;93;94;93;92 09:13:41 INFO - PROCESS | 1682 | |7;imaging-desaturate;83;85;86;86;85;88;87;86;85;84 09:13:41 INFO - PROCESS | 1682 | |8;json-parse-financial;56;54;56;53;53;52;56;65;56;51 09:13:41 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;62;71;64;73;69;66;65;66;67;66 09:13:41 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;83;82;83;85;83;82;79;83;84;83 09:13:41 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;119;125;125;124;135;132;124;125;122;123 09:13:41 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;139;123;140;137;135;123;138;138;134;132 09:13:41 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;67;67;67;66;68;67;68;66;66;67 09:13:41 INFO - PROCESS | 1682 | __end_tp_report 09:13:41 INFO - PROCESS | 1682 | __start_cc_report 09:13:41 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1194 09:13:41 INFO - PROCESS | 1682 | __end_cc_report 09:13:41 INFO - PROCESS | 1682 | __startTimestamp1456938821242__endTimestamp 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | ------- Summary: start ------- 09:13:41 INFO - PROCESS | 1682 | Number of tests: 14 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:2.13 (1.9%) stddev-sans-first:2.24 09:13:41 INFO - PROCESS | 1682 | Values: 110.0 108.0 110.0 109.0 111.0 112.0 116.0 111.0 111.0 111.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:143.50 stddev:17.56 (12.2%) stddev-sans-first:17.35 09:13:41 INFO - PROCESS | 1682 | Values: 156.0 122.0 145.0 161.0 118.0 138.0 142.0 118.0 159.0 119.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:192.30 Median:185.50 stddev:23.67 (12.8%) stddev-sans-first:24.99 09:13:41 INFO - PROCESS | 1682 | Values: 186.0 193.0 259.0 185.0 186.0 185.0 183.0 183.0 182.0 181.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:67.30 Median:71.50 stddev:10.99 (15.4%) stddev-sans-first:11.57 09:13:41 INFO - PROCESS | 1682 | Values: 71.0 70.0 87.0 76.0 56.0 56.0 56.0 72.0 74.0 55.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:81.00 stddev:17.08 (21.1%) stddev-sans-first:18.10 09:13:41 INFO - PROCESS | 1682 | Values: 92.0 92.0 124.0 81.0 80.0 84.0 114.0 75.0 81.0 112.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:85.60 Median:86.50 stddev:1.65 (1.9%) stddev-sans-first:1.50 09:13:41 INFO - PROCESS | 1682 | Values: 88.0 84.0 87.0 85.0 86.0 83.0 87.0 84.0 87.0 85.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:92.70 Median:93.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 09:13:41 INFO - PROCESS | 1682 | Values: 92.0 93.0 93.0 92.0 93.0 92.0 93.0 94.0 93.0 92.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:1.43 (1.7%) stddev-sans-first:1.20 09:13:41 INFO - PROCESS | 1682 | Values: 83.0 85.0 86.0 86.0 85.0 88.0 87.0 86.0 85.0 84.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:3.91 (7.0%) stddev-sans-first:4.14 09:13:41 INFO - PROCESS | 1682 | Values: 56.0 54.0 56.0 53.0 53.0 52.0 56.0 65.0 56.0 51.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:66.50 stddev:3.28 (4.9%) stddev-sans-first:2.96 09:13:41 INFO - PROCESS | 1682 | Values: 62.0 71.0 64.0 73.0 69.0 66.0 65.0 66.0 67.0 66.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.57 (1.9%) stddev-sans-first:1.66 09:13:41 INFO - PROCESS | 1682 | Values: 83.0 82.0 83.0 85.0 83.0 82.0 79.0 83.0 84.0 83.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:125.00 stddev:4.70 (3.8%) stddev-sans-first:4.37 09:13:41 INFO - PROCESS | 1682 | Values: 119.0 125.0 125.0 124.0 135.0 132.0 124.0 125.0 122.0 123.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.90 Median:137.50 stddev:6.23 (4.5%) stddev-sans-first:6.32 09:13:41 INFO - PROCESS | 1682 | Values: 139.0 123.0 140.0 137.0 135.0 123.0 138.0 138.0 134.0 132.0 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 09:13:41 INFO - PROCESS | 1682 | Values: 67.0 67.0 67.0 66.0 68.0 67.0 68.0 66.0 66.0 67.0 09:13:41 INFO - PROCESS | 1682 | -------- Summary: end -------- 09:13:41 INFO - PROCESS | 1682 | 09:13:41 INFO - TEST-INFO | 1682: exit 0 09:13:41 INFO - TEST-OK | kraken | took 56133ms 09:13:41 INFO - SUITE-END | took 1169s 09:13:42 INFO - Completed test suite (00:19:29) 09:13:42 INFO - Working with test: dromaeo_css 09:13:42 INFO - Generating results file: dromaeo_css 09:13:42 INFO - Working with test: kraken 09:13:42 INFO - Generating results file: kraken 09:13:42 INFO - javascript benchmark 09:13:42 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:13:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 09:13:42 INFO - process_Request line: dromaeo_css 7362.54 graph.html#tests=[[72,64,59]] 09:13:42 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:13:42 INFO - process_Request line: kraken 1396.60 graph.html#tests=[[232,64,59]] 09:13:42 INFO - RETURN: dromaeo_css: 7362.54 09:13:42 INFO - RETURN: kraken: 1396.60 09:13:42 INFO - javascript benchmark 09:13:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2904.941901161976, 3394.321135772846, 3395.2869897321552, 3396.269801992573, 3450.534177885986, 5461.18082287656, 5541.861453463665, 5574.888502229953, 5604.243427137335, 5604.523615492683, 4654.8370807021765, 5545.833624991256, 5584.329880414346, 5586.301712285965, 5606.523445507137, 4221.873343799675, 4998.82504112357, 5025.246213068032, 5103.897922041576, 5124.308218390507, 5078.771455284503, 5155.0, 5155.278261043457, 5168.147255702805, 5171.663841850286, 5059.772310246048, 5105.132127538327, 5112.079825631385, 5122.8207012754565, 5144.4083930348115, 5101.566366858803, 5154.896902061938, 5162.586993040548, 5170.305157926529, 5218.269442278084, 4185.434966279544, 4985.252212168168, 5062.417821950449, 5079.466656001141, 5083.847484575469, 5461.017016936949, 5502.0921547944545, 5534.529564986981, 5536.501714845643, 5588.077967135418, 6071.605345652519, 6073.51411887048, 6096.055111457731, 6108.480779133779, 6113.296970848365, 4693.48371679115, 6069.635821850703, 6150.169727086831, 6209.627422354628, 6216.502679785652, 5686.630369026083, 5692.316921969349, 5705.087186050212, 5712.086066229425, 5723.255976723, 6238.6880655967925, 6257.186565746515, 6265.028920517236, 6301.14934483848, 6313.873722525524, 5858.443447872445, 5897.852553686193, 5978.1929439525975, 6015.3383127855905, 6024.909626355608, 6132.724027418777, 6147.0, 6174.073888916699, 6177.567570270038, 6184.845378865564, 6010.519158467399, 6061.515078793686, 6066.726997285133, 6071.453569178795, 6077.301110372364, 5963.761449542057, 6062.272527296753, 6110.103144028831, 6130.856783744145, 6161.137440758297, 4811.158047341702, 4820.469748327681, 4829.372181616367, 4843.564079232886, 4860.416749990024, 4263.978680106579, 4320.546342633978, 4336.154449882306, 4354.869353919387, 4379.934300985487, 5464.617476776667, 5514.944850551443, 5527.751251193706, 5531.1426728857095, 5532.170174473861, 6055.788047418319, 6070.726817293233, 6071.605345652519, 6079.878402431927, 6080.483158931452, 5506.366767821752, 5524.116141417354, 5526.198701188305, 5541.667499950016, 5605.019121653694, 5322.414534401213, 5334.279872217201, 5346.278252435949, 5369.6509726867625, 5373.2746079278795, 6245.594036387621, 6280.811575652738, 6285.937140628535, 6298.7480500780375, 6304.684765761694, 6027.789027384196, 6104.7926496150985, 6209.130721699056, 6219.689015549295, 6219.813405597839, 6242.563020588515, 6310.1796766420075, 6316.494680425647, 6322.0200868865395, 6336.7465301389275, 6038.5772995889865, 6061.909071363845, 6073.14975903365, 6078.848028799315, 6100.328963814066, 5069.442361340323, 6053.213082299273, 6100.403717774465, 6109.989783459207, 6161.4146656067605, 4940.407151141886, 5877.500412464989, 5890.440408161217, 5891.204687367151, 5900.43945825146, 5873.324567674772, 5929.436703513159, 5987.6108052976415, 5989.970050149721, 5996.760129594942, 5754.2519472469985, 5757.913631295618, 5792.884142317046, 5794.275715535558, 5794.797182098607, 5840.094785308284, 5907.645541267538, 5935.198748168942, 5975.073863551156, 5990.101484777144, 5710.857228569319, 5805.361410244954, 5819.15622234782, 5912.083627037816, 5933.1396947443245], "unit": "score", "name": "dojo.html", "value": 5556.4349805570955}, {"lowerIsBetter": false, "replicates": [486.57667828988787, 530.8885134121834, 576.0035139209166, 622.5704264057802, 636.7293900092462, 26246.606300905503, 37144.69993550226, 37409.625903740955, 37510.62489375105, 37736.62263377365, 39644.8106556803, 40124.398134028015, 40158.799206004005, 40179.79910100446, 40304.59695403045, 9297.953510232457, 9529.190018848372, 9530.857037144448, 9531.38046027006, 9568.80389951256, 9298.256139508856, 9444.291678124135, 9455.432674039545, 9459.952700236488, 9588.664396746115, 9438.716838494822, 9491.003444638283, 9496.857547136764, 9505.809883802354, 9571.473568953705, 8076.798080047987, 9571.18644915183, 9588.66439674608, 9590.9520452398, 9607.327487075907, 9454.0, 9567.995360487119, 9585.329026968046, 9592.0, 9594.760130996781, 38689.03277418059, 38911.805440972894, 38929.248183831514, 38946.221075578615, 38980.41529377062, 3135.81185128893, 3182.7612929030183, 3209.646938836726, 3355.8825441109443, 3589.8025608591515, 27721.306967325778, 27948.441031179467, 28016.879324826983, 28234.576481352797, 28795.28011799701, 2765.764909982654, 2784.651918510186, 2800.2719292983766, 2854.728800763924, 2899.5505696617056, 441848.07063505566, 492253.0, 492828.0, 493170.53414733056, 493412.0, 43555.78222108933, 60300.095498567556, 60348.69825650844, 60823.08765368523, 61034.694826525585, 43196.784016080346, 43429.0, 43433.13133737307, 43556.56443435588, 43576.0, 15170.848291517164, 15426.922865385826, 15484.92257538705, 15502.992305500107, 15512.379504819906, 12431.191972521758, 12510.499580016698, 12521.060920431004, 12524.81212781809, 12535.310557919402, 13954.720905582035, 13974.58076257714, 14264.928675356558, 14326.355314010894, 14375.78436323456, 6200.255969283715, 6250.124982502453, 6277.183966084471, 6310.5898116622275, 6323.0, 903.846346121161, 919.6229545886155, 959.3811991265594, 966.7969726357403, 994.5226291380178, 27810.443791124064, 28156.85921570379, 28343.15389993001, 28742.425151496853, 28825.279368015967, 1013.1995723378595, 1036.6319956415514, 1054.7185170018465, 1056.7727938493108, 1057.4606950455322, 14345.354459049368, 14403.279836008158, 14416.783748243784, 14766.630834229016, 14872.256387180598, 499981.0, 506456.0, 506556.0, 506640.0, 507958.0, 54747.0, 56344.718276408355, 56345.43654563484, 56422.0, 56445.43554564402, 1278.386374540226, 1302.1275745250705, 1387.6253411578816, 1399.90200685951, 1418.21997901156, 27130.864345678146, 27202.775875085274, 27586.448271034868, 27717.029903953266, 27746.0, 45181.0, 45512.0, 45983.3102503456, 46109.53890461053, 46186.84532886705, 369727.0, 372324.0, 372866.0, 373165.0, 373950.0, 25464.47213167216, 27192.048278310165, 27824.860875695493, 32128.0, 32227.677723222467, 38795.03012424712, 39037.609623903394, 39256.21487570176, 40033.599664002984, 40143.0, 33090.33819323648, 33322.5001624971, 33778.021594395024, 34064.31871362608, 34296.65703342934, 31634.0, 32969.516371762846, 33161.66838331682, 33396.66413343536, 34007.0, 34088.0, 34159.829200853834, 34893.127671808405, 34960.80470343575, 35088.0, 25286.0, 32126.518102228954, 33901.81343652961, 34358.31283374268, 34427.82786086053, 19953.700694489304, 23658.52682946297, 23781.643275350536, 23883.52232955366, 24099.879500602387], "unit": "score", "name": "ext.html", "value": 18346.652957362916}, {"lowerIsBetter": false, "replicates": [348.41118509718575, 351.948967399727, 351.98768043118497, 359.48772998477165, 360.72945291031726, 15268.236588170603, 19072.713909291353, 19243.807561924375, 19949.0, 20147.395578132644, 18720.0, 19337.323193688222, 19385.612287754237, 19404.51488712783, 19411.22355105794, 5414.052540805363, 5675.744591493372, 5704.572157088214, 5743.282089738783, 5745.109508026263, 4138.213739389522, 4318.481782186126, 5675.602707810455, 6105.603135796181, 6299.905501417483, 6255.093011513328, 6257.249130104394, 6267.874642507147, 6268.874622507547, 6275.341089185638, 6013.308469525995, 6297.1184034235475, 6299.433051025384, 6301.275353334334, 6311.558190926637, 3671.5777685566236, 4454.48773391061, 5383.730813459311, 5393.0, 5402.405735369106, 23980.7601923982, 24028.879855600786, 24220.515589688108, 24427.755722442726, 24479.38801529958, 1987.9900600497049, 2096.276784509357, 2138.176801931252, 2148.5488047510044, 2187.649976003832, 7695.807604809868, 10861.509035484452, 13548.93225533876, 14381.568552943429, 14976.026558273677, 1670.1732642341997, 1706.7439884017372, 1727.1795896948975, 1768.5490199999047, 1809.3848091648772, 95236.0, 98357.01642983622, 99232.0, 100247.9975200246, 105155.0, 9295.0, 10449.425281609585, 10620.362778233331, 10633.46832658364, 10789.352638841694, 13133.146345487512, 13256.40346184424, 13271.668208294677, 13298.268595227162, 13301.66745831362, 8391.202835730595, 8454.365922555833, 8454.704085357105, 8527.744167674855, 8543.658253669908, 8679.869801952977, 8686.305095592337, 8705.303575714055, 8793.252573531321, 8817.338699597427, 4238.830446782156, 4313.3098704207805, 4360.149770794665, 4373.497047839539, 4448.065906159743, 1524.908505489674, 1721.8364255395718, 1789.2127463915836, 1819.1722766141374, 1856.4059500959834, 829.9170082991652, 833.6748668019477, 878.8637761147032, 884.746030492139, 976.6679329028165, 19074.809251907303, 19423.125959331865, 19749.901250493942, 19965.401037968884, 19981.700274495895, 900.7838118851429, 921.318224513855, 943.9008904065112, 944.5324564340696, 1069.540097757956, 8607.698730544402, 8624.266937310398, 10348.430836303925, 10471.476426178813, 10635.793170186707, 624551.0, 628251.0, 628353.0, 639358.0, 642865.0, 116362.41818790852, 120109.39945300392, 122575.38712306382, 126277.0, 127662.0, 939.3377668743519, 995.9053889880449, 1023.5445226873969, 1041.6874937518864, 1071.924965252425, 17095.401660941807, 17321.56696082608, 17575.648487029932, 17757.02336371512, 17893.284268629628, 50593.0, 51488.97022059463, 52293.50918153539, 53087.203691943876, 54027.72986135044, 76621.0, 78574.0, 79176.0, 81392.18607813846, 82187.0, 9134.5432728362, 11325.980661740483, 11808.822867657163, 11812.3503207321, 11872.881271187178, 8164.795880102807, 13251.204927704368, 13360.064795464225, 13782.173069615856, 13824.239666818019, 11425.2002359834, 11664.008559272217, 11801.232919860182, 11851.52593896269, 11914.10644201671, 11236.606718764804, 11395.430228488376, 11648.242864213798, 11688.590899318484, 11775.882241177478, 11481.770364592494, 11488.827667584826, 11893.286402815858, 12046.216995895238, 12093.0, 11495.712607184552, 11747.588834390755, 11788.115891308014, 11848.348340840992, 12019.519219231483, 10311.278210525192, 11859.229150105215, 11894.640657900005, 11908.40457977115, 11989.880101199225], "unit": "score", "name": "jquery.html", "value": 9524.986190654905}, {"lowerIsBetter": false, "replicates": [1407.6410515318591, 1541.9922900385495, 1567.7961864957558, 1800.1359347513194, 1961.4213806926955, 7721.536707797536, 8327.042390125138, 8498.830023399529, 8527.658893644248, 8529.573521323924, 8154.551499667516, 8364.623591938362, 8377.162283771635, 8394.874076888851, 8395.45429547079, 2133.839962002848, 2363.409147713072, 2410.445597512569, 2437.7805997460223, 2439.000009995902, 2398.568257713611, 2437.9390515237083, 2447.4737931344757, 2448.081969261527, 2448.608222684371, 2381.4879800842814, 2402.8318017738766, 2412.4089598048504, 2439.7682220189054, 2440.170342083691, 2396.9041238350446, 2416.915407960722, 2436.500517393939, 2438.426969662128, 2446.7308596054418, 2415.7946574541184, 2418.5767490689236, 2445.596476581362, 2447.290285817111, 2449.3998970252223, 8371.497710137412, 8449.155084491564, 8477.491350518989, 8479.06730259671, 8491.575421228976, 5289.153735402356, 5395.730213489349, 5398.73006349681, 5449.373322067973, 5449.937262233866, 3438.432658611326, 3507.8421471033867, 3582.3551760683067, 3593.8562457501666, 3593.9101522462147, 1015.6140666546739, 1043.1394099867564, 1046.6284469013467, 1047.0158051431706, 1051.2588625019343, 11227.494762735696, 11387.715307117305, 11394.60118895843, 11417.885821141848, 11459.36973466459, 4810.6151507879285, 4812.614990800727, 4828.7875771451045, 4869.123557759637, 4884.0, 8535.359848011423, 8586.0, 9820.017998200123, 9835.655752048644, 9851.014898510091, 5351.491608297206, 5371.892562148735, 5376.4085950545405, 5386.353637563518, 5391.05656510117, 4071.796410179479, 4296.312589985588, 4461.0, 4627.6529260305615, 4747.169245382044, 3812.199438118026, 3835.0795809006195, 3877.127646279621, 3907.4138879168354, 3911.882643520699, 1249.9187552809037, 1279.181323952671, 1281.1032277405852, 1285.4151361130664, 1297.3967105296083, 1309.4369421148806, 1331.8801307882336, 1335.1988806716088, 1347.3263368315843, 1366.2007725480507, 7782.766517004386, 7875.684972601146, 7992.5204487730925, 8011.559364234907, 8016.31861291785, 1175.1773758369177, 1184.236167671864, 1187.1808452167977, 1190.910681698876, 1205.8492688413949, 6137.693115344215, 6192.938070619236, 6232.189815323979, 6239.064140378889, 6249.187605611241, 9942.254330925209, 10137.239707022003, 10139.442330671736, 10147.949260253652, 10266.948665256627, 10009.349392289478, 10091.243156763272, 10142.645007424704, 10150.695479135638, 10326.845097323547, 7964.920350796534, 8162.918370816215, 8195.95902020498, 8207.974003249594, 8209.179082091863, 7455.589942552995, 7664.386849052174, 7704.075510938723, 7734.187910269341, 7763.961180194289, 7619.276168763959, 9168.633254669738, 9168.770780730536, 9223.538823058954, 9361.438313700928, 7994.800129996564, 8677.652893884426, 9447.905520944978, 9522.714318570454, 9564.56959436841, 6619.7683081093855, 6841.0, 7031.542949708252, 7200.315969982843, 7317.5609463432365, 7971.601419929097, 8005.079415867017, 8013.719519816778, 8018.278354948083, 8031.237032481905, 6986.406155476841, 7133.750318738819, 7138.500304978602, 7182.17404998411, 7295.4528410368375, 6343.667829755618, 6975.651217439209, 6993.0908981832035, 7096.112985876765, 7117.359437650636, 7261.164966028763, 7365.2634736525915, 7430.219826918312, 7551.848963020819, 7570.735024274124, 6835.965820170867, 6852.931470685428, 6901.62041087745, 6902.102726645504, 6912.758053468105, 6620.337966203341, 6905.75829845953, 6919.8962015568795, 6968.825779355557, 7020.543664661781], "unit": "score", "name": "mootools.html", "value": 4817.078516826983}, {"lowerIsBetter": false, "replicates": [315.5204089783529, 319.8001249219238, 324.68181182441214, 326.45319090523367, 332.0519915640847, 5429.782808687648, 6566.0, 6586.571872828269, 6630.535862489628, 6682.665866706658, 6550.951847704357, 6553.311902250267, 6600.1089852869845, 6603.7028333724975, 6611.074449577051, 4573.49691533931, 4693.953060469403, 4706.411698537683, 4772.713637181763, 4822.71063736177, 4793.890688097244, 4827.662063655545, 4858.246971719372, 4883.413990321166, 4884.0, 4779.211430114027, 4789.036495037036, 4802.135615589193, 4804.543568361, 4808.956193617716, 4569.314602809589, 4617.953820461786, 4666.859994200146, 4691.29630555416, 4718.905621887578, 4024.195160967818, 4057.57395473474, 4058.3303754880408, 4072.8981775455554, 4075.347944328923, 6052.757889684407, 6124.448799608057, 6179.752809887599, 6187.07193920911, 6209.441150296449, 5574.331080270353, 5588.329400471969, 5591.692456914868, 5595.440455954413, 5598.880223955225, 6801.013852991338, 6851.897221541681, 6869.381755641966, 6870.072540207058, 6871.518993670445, 3932.292187406266, 4310.849120280806, 4413.801378937956, 4513.7066090704, 4514.300283456037, 7175.641217939135, 7335.193128755833, 7335.449841261873, 7338.41292696583, 7351.117865856131, 4493.7977790999485, 4513.526079761577, 4515.616172625364, 4529.456465224194, 4535.501094879561, 4572.108438854391, 4578.862634120982, 4580.519045500241, 4584.174848527297, 4592.334111553806, 5462.918056229159, 5472.972635136799, 5473.06957817164, 5475.178723191473, 5479.958807826501, 6483.578567393104, 6706.463482921452, 6961.756338528127, 6980.616066116311, 6984.825379365557, 1577.6371434569883, 1577.9053256804627, 1587.769773382853, 1591.4509494224474, 1592.283472437408, 952.9666461673946, 1014.8731408573929, 1020.6631811502186, 1032.4734385463319, 1044.4882007816116, 6233.937660623335, 6471.482281417475, 6787.5588086774205, 6817.113775209191, 6840.076589660432, 7362.44781641379, 7372.115346158388, 7379.594122323324, 7380.77857664271, 7404.148522919933, 5625.493705566519, 6483.4164925156965, 6608.173978252718, 6642.236142843635, 6645.900311495331, 3822.10180607557, 3867.690584753213, 3872.7482713623526, 3878.825452854628, 3880.7283490155983, 7353.338199562065, 7683.577403242875, 7747.961260193663, 7753.53478791263, 7780.18308077655, 7337.449691273176, 7531.924680753232, 7544.434167437465, 7544.735934242275, 7545.245475452521, 7599.582022988789, 7621.971033910462, 7624.237576242443, 7629.54222746637, 7629.656665450179, 7085.114360704912, 7300.269973002657, 7314.4514161439165, 7316.524425912298, 7432.293932076444, 7232.42140628759, 7275.8181045472165, 7296.160941491797, 7300.926990730025, 7304.890426643711, 7724.0731112266885, 7728.3430908371165, 7742.883856742041, 7744.535327880345, 7745.535267883945, 4053.4730485036757, 4736.076465089274, 4794.664373493822, 4816.012717392996, 4831.661783675109, 7029.9648501757165, 7225.24134965821, 7232.42140628759, 7247.275272472711, 7255.274472552914, 7057.611831349325, 7112.644367781487, 7139.928600713926, 7148.67830947619, 7158.248383919614, 5823.7379317929945, 7096.396806271318, 7120.537165084253, 7126.109236345457, 7135.714571417086, 6321.494280457644, 6376.0, 6941.132358455193, 6960.0, 6996.055532503047, 6857.245702972768, 7062.929370706227, 7112.110986126734, 7119.2168861426235, 7149.0, 5519.254900588529, 6669.933300666931, 6889.827754305982, 6925.965370173117, 7001.194862590867], "unit": "score", "name": "prototype.html", "value": 5097.531949985017}, {"lowerIsBetter": false, "replicates": [665.4543274514897, 713.21546299071, 731.451411441419, 752.4431920378921, 781.8709912864374, 14678.706425871476, 14905.0, 14931.925340373311, 14944.850551494495, 14948.626284342898, 12492.875071249286, 13518.59444216675, 13534.0, 13593.524226652069, 13621.387037583308, 842.2588122452249, 845.7462761171655, 856.9271611912994, 857.8284343131398, 860.5181098584782, 846.196113691992, 847.4068152293388, 847.8304339132168, 848.4654667559429, 851.7359618518249, 893.1158153428092, 894.7136916186823, 894.8568229083348, 896.7982204004112, 905.597009330848, 885.9911400885973, 887.0863011098579, 889.4974339498195, 889.7375274294067, 898.371140201858, 662.5130529061137, 664.5215444879678, 664.7905909638497, 670.6512613440983, 673.8854394752904, 12697.809532857014, 12752.426140823685, 12780.744385112339, 12787.0, 12837.29394883281, 10843.132549396028, 11161.218714689974, 11253.0, 11936.761264774656, 12134.393280336037, 9664.226861851035, 10082.495875206283, 10493.947530262376, 10759.677209683721, 11253.71865703364, 3402.1494626343415, 3439.518467414564, 3486.4421692529327, 3507.8596856125723, 3723.5717892442176, 64208.3687446882, 80446.5977670108, 80516.0, 80780.38439231183, 83017.0, 9270.072992700676, 9291.303152263607, 9293.535323233811, 9365.906340936639, 9591.328606997582, 19942.00289985495, 19952.20191192365, 19953.800461995193, 19968.90015549942, 20000.0, 7380.372668323145, 7384.778456646309, 7397.778066658009, 7477.252274772479, 7479.0, 3838.098046958962, 3839.2705385977133, 3846.288436639231, 3848.1726428817938, 3857.72995890285, 3399.7450191235757, 3448.896533103961, 3451.2234747181683, 3459.5502584664337, 3467.7225821934185, 601.8856417280703, 605.1135087097423, 621.9626822390671, 640.5740182778493, 645.5061877663591, 517.6738654647548, 582.0076769108659, 584.929808422992, 613.6594190224379, 618.245740196959, 7975.122736498981, 8055.476394034369, 8097.716579919675, 8147.226013528823, 8258.298044666271, 512.9871753206126, 515.2142981952552, 522.3522831688679, 574.3585666872051, 596.8985272503598, 3731.7574357666663, 3746.887593372149, 3760.2103558253075, 3877.0, 3899.7855117968215, 95688.0, 95927.0, 96683.0, 96811.0, 98994.0, 68568.0, 72791.2720872795, 80160.0, 86350.0, 87584.0, 72313.0, 72500.0, 72852.27147728455, 73307.0, 73396.63301683564, 8290.2124298194, 8314.0, 8432.957835210786, 8452.830943381221, 8569.742907712529, 42661.36007959945, 42678.78660606677, 42693.573064270204, 46915.0, 47041.52958470371, 55313.72343138258, 56599.434005659416, 66543.66728166328, 66772.66454670977, 68534.65732671504, 10427.68716938493, 10443.477826108816, 10658.73353166146, 10977.780444390908, 11618.419079046183, 9731.513424328898, 11830.11274154459, 11966.341851198267, 12060.75878482443, 12468.06489513272, 10687.0, 10888.61889833852, 11092.889071109508, 11242.744456020177, 11408.087353011904, 11003.559857605605, 11176.385298808318, 11186.496607652512, 11373.260738052, 11382.829257560978, 10836.458177091272, 11206.43967801623, 11302.43487825589, 11322.660320190407, 11556.653300401002, 8668.0, 8797.692080777142, 8847.557622118997, 9192.912704417613, 9541.713748587554, 8672.392932494664, 8809.471431714117, 8812.91187088121, 9298.01020586322, 9384.436933783994], "unit": "score", "name": "yui.html", "value": 6679.921577110493}], "name": "dromaeo_css", "value": 7362.540975223056}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 110.0, 109.0, 111.0, 112.0, 116.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [156.0, 122.0, 145.0, 161.0, 118.0, 138.0, 142.0, 118.0, 159.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 137.8}, {"lowerIsBetter": true, "replicates": [186.0, 193.0, 259.0, 185.0, 186.0, 185.0, 183.0, 183.0, 182.0, 181.0], "unit": "score", "name": "audio-dft", "value": 192.3}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 87.0, 76.0, 56.0, 56.0, 56.0, 72.0, 74.0, 55.0], "unit": "score", "name": "audio-fft", "value": 67.3}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 124.0, 81.0, 80.0, 84.0, 114.0, 75.0, 81.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 93.5}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 87.0, 85.0, 86.0, 83.0, 87.0, 84.0, 87.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 92.0, 93.0, 92.0, 93.0, 94.0, 93.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.7}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 86.0, 86.0, 85.0, 88.0, 87.0, 86.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.5}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 56.0, 53.0, 53.0, 52.0, 56.0, 65.0, 56.0, 51.0], "unit": "score", "name": "json-parse-financial", "value": 55.2}, {"lowerIsBetter": true, "replicates": [62.0, 71.0, 64.0, 73.0, 69.0, 66.0, 65.0, 66.0, 67.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.9}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 85.0, 83.0, 82.0, 79.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [119.0, 125.0, 125.0, 124.0, 135.0, 132.0, 124.0, 125.0, 122.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [139.0, 123.0, 140.0, 137.0, 135.0, 123.0, 138.0, 138.0, 134.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 68.0, 67.0, 68.0, 66.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1396.6000000000004}]} 09:13:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1396.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7362.54"}}} 09:13:42 INFO - Return code: 0 09:13:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:13:42 INFO - # TBPL SUCCESS # 09:13:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:13:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:13:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:13:42 INFO - 2016-03-02 09:13:42.634 screenresolution[1686:9623] starting screenresolution argv=screenresolution get 09:13:42 INFO - 2016-03-02 09:13:42.637 screenresolution[1686:9623] Display 0: 1600x1200x32@60 09:13:42 INFO - 2016-03-02 09:13:42.642 screenresolution[1687:9627] starting screenresolution argv=screenresolution list 09:13:42 INFO - Available Modes on Display 0 09:13:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:13:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:13:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:13:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:13:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:13:42 INFO - Intel Iris: 09:13:42 INFO - Chipset Model: Intel Iris 09:13:42 INFO - Type: GPU 09:13:42 INFO - Bus: Built-In 09:13:42 INFO - VRAM (Dynamic, Max): 1536 MB 09:13:42 INFO - Vendor: Intel (0x8086) 09:13:42 INFO - Device ID: 0x0a2e 09:13:42 INFO - Revision ID: 0x0009 09:13:42 INFO - Displays: 09:13:42 INFO - Display: 09:13:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:13:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:13:42 INFO - Display Serial Number: 1600x1200 60 09:13:42 INFO - Main Display: Yes 09:13:42 INFO - Mirror: Off 09:13:42 INFO - Online: Yes 09:13:42 INFO - Rotation: Supported 09:13:42 INFO - Return code: 0 09:13:42 INFO - Running post-action listener: _resource_record_post_action 09:13:42 INFO - Running post-run listener: _resource_record_post_run 09:13:43 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 39564800; Write bytes: 704559616; Read time: 426; Write time: 2166 09:13:43 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 402024960; Write bytes: 404379648; Read time: 30003; Write time: 729 09:13:43 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 37701120; Write bytes: 298889728; Read time: 405; Write time: 1434 09:13:43 INFO - Running post-run listener: _upload_blobber_files 09:13:43 INFO - Blob upload gear active. 09:13:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:13:43 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 09:13:43 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'] 09:13:43 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 09:13:44 INFO - (blobuploader) - INFO - Open directory for files ... 09:13:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:13:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:13:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:45 INFO - (blobuploader) - INFO - Done attempting. 09:13:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:13:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:13:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:46 INFO - (blobuploader) - INFO - Done attempting. 09:13:46 INFO - (blobuploader) - INFO - Iteration through files over. 09:13:46 INFO - Return code: 0 09:13:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:13:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:13:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e91fbcf3a31206fbcb2434673c516526bebe43abf212765ed78ff05f6a77f52b5b494a481828d3b1c8f7e7724d0607c0205232f499dce7db93753a0d92d9967", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f969765937494f444082844bc57b3ecadabeeb5c909b10eb6ea4abfaa88c5112df170fa773c80f7f351989a99cdcdb7c6b89415325ac49c2584c3f59dc36b92"} 09:13:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:13:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:13:46 INFO - Contents: 09:13:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e91fbcf3a31206fbcb2434673c516526bebe43abf212765ed78ff05f6a77f52b5b494a481828d3b1c8f7e7724d0607c0205232f499dce7db93753a0d92d9967", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f969765937494f444082844bc57b3ecadabeeb5c909b10eb6ea4abfaa88c5112df170fa773c80f7f351989a99cdcdb7c6b89415325ac49c2584c3f59dc36b92"} 09:13:46 INFO - Running post-run listener: copy_logs_to_upload_dir 09:13:46 INFO - Copying logs to upload dir... 09:13:46 INFO - mkdir: /builds/slave/test/build/upload/logs 09:13:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.271520 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-02 09:13:46.812779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 09:13:46.816505) ========= 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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e91fbcf3a31206fbcb2434673c516526bebe43abf212765ed78ff05f6a77f52b5b494a481828d3b1c8f7e7724d0607c0205232f499dce7db93753a0d92d9967", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f969765937494f444082844bc57b3ecadabeeb5c909b10eb6ea4abfaa88c5112df170fa773c80f7f351989a99cdcdb7c6b89415325ac49c2584c3f59dc36b92"} build_url:https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010485 build_url: 'https://queue.taskcluster.net/v1/task/N5EfFlSOTKmfWdOGb_fbUg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7e91fbcf3a31206fbcb2434673c516526bebe43abf212765ed78ff05f6a77f52b5b494a481828d3b1c8f7e7724d0607c0205232f499dce7db93753a0d92d9967", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f969765937494f444082844bc57b3ecadabeeb5c909b10eb6ea4abfaa88c5112df170fa773c80f7f351989a99cdcdb7c6b89415325ac49c2584c3f59dc36b92"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-02 09:13:46.843061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 09:13:46.843412) ========= 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.tOFmX0Eopj/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.mbHFlaaT2R/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005074 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-02 09:13:46.892152) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 09:13:46.892480) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-02 09:13:46.892948) ========= ========= Total master_lag: 0.26 =========