builder: release-comm-esr45-macosx64_build
slave: bld-lion-r5-076
starttime: 1480475477.61
results: retry (5)
buildid: 20161129191112
builduid: 0874c5a2d26e490ab8fff1f44b443af3
revision: None

========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:17.606444) =========
bash -c pwd
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'pwd']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
/builds/slave/tb-rel-c-esr45-m64_bld-0000000
program finished with exit code 0
elapsedTime=0.006219
basedir: '/builds/slave/tb-rel-c-esr45-m64_bld-0000000'
========= master_lag: 0.02 =========
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:17.628180) =========

========= Started set props: hashType (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:17.628574) =========
hashType: sha512
========= Finished set props: hashType (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:17.628947) =========

========= Started set props: builddir (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:17.629246) =========
bash -c 'basename "$PWD"'
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'basename "$PWD"']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
tb-rel-c-esr45-m64_bld-0000000
program finished with exit code 0
elapsedTime=0.007838
builddir: 'tb-rel-c-esr45-m64_bld-0000000'
========= master_lag: 0.05 =========
========= Finished set props: builddir (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:17.683464) =========

========= Started clobber build tools (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:17.683827) =========
rm -rf tools
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'tools']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
program finished with exit code 0
elapsedTime=0.006379
========= master_lag: 0.05 =========
========= Finished clobber build tools (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:17.736084) =========

========= Started clone build tools (results: 0, elapsed: 12 secs) (at 2016-11-29 19:11:17.736408) =========
hg clone https://hg.mozilla.org/build/tools tools
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/. (timeout 1320 secs)
 watching logfiles {}
 argv: ['hg', 'clone', 'https://hg.mozilla.org/build/tools', 'tools']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
warning: connecting to hg.mozilla.org using legacy security technology (TLS 1.0); see https://mercurial-scm.org/wiki/SecureConnections for more info
applying clone bundle from https://s3-us-west-2.amazonaws.com/moz-hg-bundles-us-west-2/build/tools/1334d527cafbc9648a5fbc42fd6b638edea5fceb.gzip.hg
warning: connecting to s3-us-west-2.amazonaws.com using legacy security technology (TLS 1.0); see https://mercurial-scm.org/wiki/SecureConnections for more info
adding changesets
adding manifests
adding file changes
added 7169 changesets with 15400 changes to 2027 files (+1 heads)
finished applying clone bundle
searching for changes
adding changesets
adding manifests
adding file changes
added 5 changesets with 4 changes to 2 files (+1 heads)
updating to branch default
937 files updated, 0 files merged, 0 files removed, 0 files unresolved
program finished with exit code 0
elapsedTime=12.577671
========= master_lag: 0.01 =========
========= Finished clone build tools (results: 0, elapsed: 12 secs) (at 2016-11-29 19:11:30.326277) =========

========= Started set props: toolsdir (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:30.326652) =========
bash -c pwd
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/tools (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'pwd']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000/tools
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
/builds/slave/tb-rel-c-esr45-m64_bld-0000000/tools
program finished with exit code 0
elapsedTime=0.006870
toolsdir: '/builds/slave/tb-rel-c-esr45-m64_bld-0000000/tools'
========= master_lag: 0.01 =========
========= Finished set props: toolsdir (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:30.347882) =========

========= Started no change (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:30.348294) =========
python tools/buildfarm/maintenance/get_instance_metadata.py
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['python', 'tools/buildfarm/maintenance/get_instance_metadata.py']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
{}
program finished with exit code 0
elapsedTime=0.086380

========= master_lag: 0.01 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:30.449614) =========

========= Started checking clobber times (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:30.449998) =========
python tb-rel-c-esr45-m64_bld-0000000/tools/clobberer/clobberer.py -s tools https://api.pub.build.mozilla.org/clobberer/forceclobber release-comm-esr45 release-comm-esr45-macosx64_build tb-rel-c-esr45-m64_bld-0000000 bld-lion-r5-076 http://buildbot-master84.bb.releng.scl3.mozilla.com:8001/
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/.. (timeout 3600 secs)
 watching logfiles {}
 argv: ['python', 'tb-rel-c-esr45-m64_bld-0000000/tools/clobberer/clobberer.py', '-s', 'tools', 'https://api.pub.build.mozilla.org/clobberer/forceclobber', 'release-comm-esr45', 'release-comm-esr45-macosx64_build', 'tb-rel-c-esr45-m64_bld-0000000', 'bld-lion-r5-076', u'http://buildbot-master84.bb.releng.scl3.mozilla.com:8001/']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
2016-11-29 19:11:30,675 - Entering legacy mode.
2016-11-29 19:11:31,063 - tb-rel-c-esr45-m64_bld-0000000:Our last clobber date: 1969-12-31 16:00:00
2016-11-29 19:11:31,063 - tb-rel-c-esr45-m64_bld-0000000:Server clobber date:   2016-11-29 20:11:31
2016-11-29 19:11:31,063 - tb-rel-c-esr45-m64_bld-0000000:Server is forcing a clobber, initiated by forceclobber
2016-11-29 19:11:31,063 - tb-rel-c-esr45-m64_bld-0000000:Clobbering...
2016-11-29 19:11:31,063 - Skipping tools
program finished with exit code 0
elapsedTime=0.612208
========= master_lag: 0.01 =========
========= Finished checking clobber times (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:31.076781) =========

========= Started set props: purge_actual purge_target (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:31.077418) =========
python tools/buildfarm/maintenance/purge_builds.py -s 12 -n info -n 'rel-*:10d' -n 'tb-rel-*:10d' .. /mock/users/cltbld/home/cltbld/build
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/. (timeout 3600 secs)
 watching logfiles {}
 argv: ['python', 'tools/buildfarm/maintenance/purge_builds.py', '-s', '12', '-n', 'info', '-n', 'rel-*:10d', '-n', 'tb-rel-*:10d', '..', '/mock/users/cltbld/home/cltbld/build']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CCACHE_COMPRESS=1
  CCACHE_DIR=/builds/ccache
  CCACHE_UMASK=002
  CHOWN_REVERT=~/bin/chown_revert
  CHOWN_ROOT=~/bin/chown_root
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  COMM_REV=THUNDERBIRD_45_5_1_RELEASE
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LC_ALL=C
  LOGNAME=cltbld
  MOZILLA_REV=THUNDERBIRD_45_5_1_RELEASE
  MOZ_AUTOMATION=1
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_OBJDIR=/builds/slave/tb-rel-c-esr45-m64_bld-0000000/build/objdir-tb
  MOZ_PKG_PRETTYNAMES=1
  MOZ_SIGN_CMD=python /builds/slave/tb-rel-c-esr45-m64_bld-0000000/tools/release/signing/signtool.py --cachedir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/signing_cache -t /builds/slave/tb-rel-c-esr45-m64_bld-0000000/token -n /builds/slave/tb-rel-c-esr45-m64_bld-0000000/nonce -c /builds/slave/tb-rel-c-esr45-m64_bld-0000000/tools/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120
  MOZ_UPDATE_CHANNEL=release
  PATH=/tools/python/bin:/tools/buildbot/bin:/opt/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/X11/bin
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TINDERBOX_OUTPUT=1
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
Ignored directory 'rel-c-beta-tb_beta_ut-00000000' exceeds cutoff time
Ignored directory 'rel-c-esr45-tb_rel_ut-00000000' exceeds cutoff time
Ignored directory 'rel-jamun_fx_m64_u_v-000000000' exceeds cutoff time
Ignored directory 'rel-m-beta-fennec_beta_ut-0000' exceeds cutoff time
Ignored directory 'rel-m-beta-fx-m64_pner_repacks' exceeds cutoff time
Ignored directory 'rel-m-beta_fx_m64_l10n_rpk-000' exceeds cutoff time
Ignored directory 'rel-m-esr45_fx_m64_l10n_rpk-00' exceeds cutoff time
Ignored directory 'rel-m-esr45_fx_m64_u_v-0000000' exceeds cutoff time
Ignored directory 'rel-m-rel-fennec_rel_ut-000000' exceeds cutoff time
Ignored directory 'rel-m-rel-fx-l64_pner_repacks-' exceeds cutoff time
Ignored directory 'rel-m-rel-fx-m64_pner_repacks-' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_beta_u_v_2-0' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_beta_u_v_3-0' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_beta_u_v_4-0' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_beta_u_v_5-0' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_beta_u_v_6-0' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_bld-00000000' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_rpk_1-000000' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_rpk_4-000000' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_rpk_5-000000' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_rpk_6-000000' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_rpk_8-000000' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_rpk_9-000000' exceeds cutoff time
Ignored directory 'tb-rel-c-beta-m64_sa_rpk-00000' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rel_u_v_1-0' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rel_u_v_2-0' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rel_u_v_3-0' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rel_u_v_4-0' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rel_u_v_5-0' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rel_u_v_6-0' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rpk_1-00000' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rpk_10-0000' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rpk_2-00000' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rpk_3-00000' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rpk_4-00000' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rpk_5-00000' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rpk_6-00000' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rpk_7-00000' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rpk_8-00000' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_rpk_9-00000' exceeds cutoff time
Ignored directory 'tb-rel-c-esr45-m64_sa_rpk-0000' exceeds cutoff time
639.30 GB of space available
program finished with exit code 0
elapsedTime=0.055491
purge_actual: '639.30GB'
purge_target: '12GB'
========= master_lag: 0.02 =========
========= Finished set props: purge_actual purge_target (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:31.150499) =========

========= Started set_buildids (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:31.152024) =========
========= Finished set_buildids (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:31.152276) =========

========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:31.152992) =========
bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 http://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 http://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
--2016-11-29 19:11:31--  http://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py
Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102
Connecting to hg.mozilla.org|63.245.215.25|:80... connected.
HTTP request sent, awaiting response... 200 Script output follows
Length: 12179 (12K) [text/x-python]
Saving to: 'archiver_client.py'

     0K .......... .                                          100% 77.4M=0s

2016-11-29 19:11:31 (77.4 MB/s) - 'archiver_client.py' saved [12179/12179]

program finished with exit code 0
elapsedTime=0.125978
========= master_lag: 0.02 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:31.294235) =========

========= Started remove mozharness (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:31.294591) =========
rm -rf mozharness
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'mozharness']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
program finished with exit code 0
elapsedTime=0.006588
========= master_lag: 0.05 =========
========= Finished remove mozharness (results: 0, elapsed: 0 secs) (at 2016-11-29 19:11:31.346982) =========

========= Started 'bash -c ...' (results: 0, elapsed: 2 mins, 19 secs) (at 2016-11-29 19:11:31.347452) =========
bash -c 'python archiver_client.py mozharness --repo releases/mozilla-esr45 --tag THUNDERBIRD_45_5_1_RELEASE --debug'
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-esr45 --tag THUNDERBIRD_45_5_1_RELEASE --debug']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
2016-11-29 19:11:31,647 Setting DEBUG logging.
2016-11-29 19:11:31,647 "THUNDERBIRD_45_5_1_RELEASE" was passed as the tag. Querying remote repository for corresponding rev hash.
warning: connecting to hg.mozilla.org using legacy security technology (TLS 1.0); see https://mercurial-scm.org/wiki/SecureConnections for more info
2016-11-29 19:11:32,222 revision being used: 3306f28ee218
2016-11-29 19:11:32,222 attempt 1/10
2016-11-29 19:11:32,222 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-esr45/3306f28ee218?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness
2016-11-29 19:11:32,838 attempt 1/10
2016-11-29 19:11:33,100 current task status: no status available at this point. state: PENDING
2016-11-29 19:11:33,100 sleeping for 9.00s (attempt 1/10)
2016-11-29 19:11:42,102 attempt 2/10
2016-11-29 19:11:42,347 current task status: no status available at this point. state: PENDING
2016-11-29 19:11:42,347 sleeping for 14.50s (attempt 2/10)
2016-11-29 19:11:56,849 attempt 3/10
2016-11-29 19:11:57,188 current task status: no status available at this point. state: PENDING
2016-11-29 19:11:57,188 sleeping for 22.75s (attempt 3/10)
2016-11-29 19:12:19,940 attempt 4/10
2016-11-29 19:12:20,229 current task status: no status available at this point. state: PENDING
2016-11-29 19:12:20,230 sleeping for 35.12s (attempt 4/10)
2016-11-29 19:12:55,357 attempt 5/10
2016-11-29 19:12:55,627 current task status: no status available at this point. state: PENDING
2016-11-29 19:12:55,627 sleeping for 53.69s (attempt 5/10)
2016-11-29 19:13:49,318 attempt 6/10
2016-11-29 19:13:49,421 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS
2016-11-29 19:13:50,290 unpacking tar archive at: mozilla-esr45-3306f28ee218/testing/mozharness/
program finished with exit code 0
elapsedTime=139.123933
========= master_lag: 0.01 =========
========= Finished 'bash -c ...' (results: 0, elapsed: 2 mins, 19 secs) (at 2016-11-29 19:13:50.484264) =========

========= Started delete old package (results: 0, elapsed: 0 secs) (at 2016-11-29 19:13:50.484917) =========
rm -rf objdir-tb/i386/dist/firefox-* objdir-tb/i386/dist/fennec* objdir-tb/i386/dist/seamonkey* objdir-tb/i386/dist/thunderbird* objdir-tb/i386/dist/install/sea/*.exe 
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/build (timeout 1200 secs)
 watching logfiles {}
 argv: rm -rf objdir-tb/i386/dist/firefox-* objdir-tb/i386/dist/fennec* objdir-tb/i386/dist/seamonkey* objdir-tb/i386/dist/thunderbird* objdir-tb/i386/dist/install/sea/*.exe 
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  BUILDBOTCUSTOM=https://hg.mozilla.org/build/buildbotcustom
  BUILDBOT_CONFIGS=https://hg.mozilla.org/build/buildbot-configs
  CCACHE_COMPRESS=1
  CCACHE_DIR=/builds/ccache
  CCACHE_UMASK=002
  CHOWN_REVERT=~/bin/chown_revert
  CHOWN_ROOT=~/bin/chown_root
  CLOBBERER_URL=https://api.pub.build.mozilla.org/clobberer/forceclobber
  COMM_REV=THUNDERBIRD_45_5_1_RELEASE
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LC_ALL=C
  LOGNAME=cltbld
  MOZILLA_REV=THUNDERBIRD_45_5_1_RELEASE
  MOZ_AUTOMATION=1
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_OBJDIR=/builds/slave/tb-rel-c-esr45-m64_bld-0000000/build/objdir-tb
  MOZ_PKG_PRETTYNAMES=1
  MOZ_SIGN_CMD=python /builds/slave/tb-rel-c-esr45-m64_bld-0000000/tools/release/signing/signtool.py --cachedir /builds/slave/tb-rel-c-esr45-m64_bld-0000000/signing_cache -t /builds/slave/tb-rel-c-esr45-m64_bld-0000000/token -n /builds/slave/tb-rel-c-esr45-m64_bld-0000000/nonce -c /builds/slave/tb-rel-c-esr45-m64_bld-0000000/tools/release/signing/host.cert -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing4.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing5.srv.releng.scl3.mozilla.com:9120 -H gpg:sha2signcode:osslsigncode:signcode:mar:jar:emevoucher:signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing1.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing2.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing3.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing4.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing6.srv.releng.scl3.mozilla.com:9120 -H dmgv2:mac-v2-signing7.srv.releng.scl3.mozilla.com:9120
  MOZ_UPDATE_CHANNEL=release
  PATH=/tools/python/bin:/tools/buildbot/bin:/opt/local/bin:/usr/bin:/bin:/usr/sbin:/sbin:/usr/local/bin:/usr/X11/bin
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000/build
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TINDERBOX_OUTPUT=1
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
program finished with exit code 0
elapsedTime=0.007987
========= master_lag: 0.02 =========
========= Finished delete old package (results: 0, elapsed: 0 secs) (at 2016-11-29 19:13:50.508666) =========

========= Started update failed (results: 5, elapsed: 18 secs) (at 2016-11-29 19:13:50.509126) =========
starting mercurial operation
rm -rf /builds/slave/tb-rel-c-esr45-m64_bld-0000000/build
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000 (timeout 3600 secs)
 watching logfiles {}
 argv: ['rm', '-rf', '/builds/slave/tb-rel-c-esr45-m64_bld-0000000/build']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
elapsedTime=0.006124
/usr/local/bin/hg clone --verbose --noupdate https://hg.mozilla.org/releases/comm-esr45 build
 in dir /builds/slave/tb-rel-c-esr45-m64_bld-0000000 (timeout 3600 secs)
 watching logfiles {}
 argv: ['/usr/local/bin/hg', 'clone', '--verbose', '--noupdate', u'https://hg.mozilla.org/releases/comm-esr45', 'build']
 environment:
  Apple_PubSub_Socket_Render=/tmp/launch-qZEMfG/Render
  DISPLAY=/tmp/launch-51k8nk/org.x:0
  GIT_SHARE_BASE_DIR=/builds/git-shared
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HOME=/Users/cltbld
  IDLEIZER_DISABLE_SHUTDOWN=true
  LOGNAME=cltbld
  PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11
  PWD=/builds/slave/tb-rel-c-esr45-m64_bld-0000000
  RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg
  SHELL=/bin/bash
  SSH_AUTH_SOCK=/tmp/launch-TQa2gx/Listeners
  TMPDIR=/var/folders/rx/tshvjp893vbfj6lcs6fk4h_h00000w/T/
  TWISTD_LOG_PATH=/builds/slave/twistd.log
  USER=cltbld
  VERSIONER_PYTHON_PREFER_32_BIT=no
  VERSIONER_PYTHON_VERSION=2.7
  __CF_USER_TEXT_ENCODING=0x1C:0:0
 using PTY: False
warning: connecting to hg.mozilla.org using legacy security technology (TLS 1.0); see https://mercurial-scm.org/wiki/SecureConnections for more info
requesting all changes
adding changesets
adding manifests
adding file changes
transaction abort!
rollback completed
Traceback (most recent call last):
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/dispatch.py", line 204, in _runcatch
    return _dispatch(req)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/dispatch.py", line 880, in _dispatch
    cmdpats, cmdoptions)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/dispatch.py", line 637, in runcommand
    ret = _runcommand(ui, options, cmd, d)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/dispatch.py", line 1010, in _runcommand
    return checkargs()
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/dispatch.py", line 971, in checkargs
    return cmdfunc()
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/dispatch.py", line 877, in <lambda>
    d = lambda: util.checksignature(func)(ui, *args, **cmdoptions)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/util.py", line 1036, in check
    return func(*args, **kwargs)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/extensions.py", line 210, in closure
    return func(*(args + a), **kw)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/util.py", line 1036, in check
    return func(*args, **kwargs)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/hgext/share.py", line 134, in clone
    return orig(ui, source, *args, **opts)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/util.py", line 1036, in check
    return func(*args, **kwargs)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/commands.py", line 1608, in clone
    shareopts=opts.get('shareopts'))
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/hg.py", line 602, in clone
    streamclonerequested=stream)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/extensions.py", line 210, in closure
    return func(*(args + a), **kw)
  File "/usr/local/lib/hgext/bundleclone.py", line 590, in pull
    res = orig(repo, remote, *args, **kwargs)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/exchange.py", line 1186, in pull
    _pullbundle2(pullop)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/exchange.py", line 1327, in _pullbundle2
    op = bundle2.processbundle(pullop.repo, bundle, pullop.gettransaction)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/bundle2.py", line 357, in processbundle
    for nbpart, part in iterparts:
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/bundle2.py", line 787, in iterparts
    headerblock = self._readpartheader()
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/bundle2.py", line 794, in _readpartheader
    headersize = self._unpack(_fpartheadersize)[0]
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/bundle2.py", line 624, in _unpack
    data = self._readexact(struct.calcsize(format))
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/bundle2.py", line 629, in _readexact
    return changegroup.readexactly(self._fp, size)
  File "/tools/python27-mercurial/lib/python2.7/site-packages/mercurial/changegroup.py", line 43, in readexactly
    % (len(s), n))
Abort: stream ended unexpectedly (got 0 bytes, expected 4)
abort: stream ended unexpectedly (got 0 bytes, expected 4)
elapsedTime=18.627370
program finished with exit code 255
========= master_lag: 18.66 =========
========= Finished update failed (results: 5, elapsed: 18 secs) (at 2016-11-29 19:14:09.174016) =========

========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Skipped  (results: not started, elapsed: not started) =========
========= Total master_lag: 18.93 =========