builder: comm-esr38-linux64-periodicupdate
slave: bld-linux64-spot-1092
starttime: 1448708625.66
results: success (0)

========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:45.656604) =========
master: http://buildbot-master73.bb.releng.usw2.mozilla.com:8001/
========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:45.657021) =========

========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:45.657305) =========
bash -c pwd
 in dir /builds/slave/c-esr38-l64-periodicupdate-000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'pwd']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-1092.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
  PWD=/builds/slave/c-esr38-l64-periodicupdate-000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
/builds/slave/c-esr38-l64-periodicupdate-000
program finished with exit code 0
elapsedTime=0.004146
basedir: '/builds/slave/c-esr38-l64-periodicupdate-000'
========= master_lag: 0.02 =========
========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:45.678602) =========

========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:45.678872) =========
========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:45.700982) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:45.701260) =========
rm -rf properties
 in dir /builds/slave/c-esr38-l64-periodicupdate-000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'properties']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-1092.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
  PWD=/builds/slave/c-esr38-l64-periodicupdate-000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
program finished with exit code 0
elapsedTime=0.002626
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:45.748557) =========

========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:45.748853) =========
script_repo_url: https://hg.mozilla.org/build/tools
========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:45.749192) =========

========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:45.749461) =========
rm -rf scripts
 in dir /builds/slave/c-esr38-l64-periodicupdate-000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['rm', '-rf', 'scripts']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-1092.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
  PWD=/builds/slave/c-esr38-l64-periodicupdate-000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
program finished with exit code 0
elapsedTime=0.002563
========= master_lag: 0.04 =========
========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:45.796288) =========

========= Started 'hg clone ...' (results: 0, elapsed: 2 secs) (at 2015-11-28 03:03:45.796599) =========
hg clone https://hg.mozilla.org/build/tools scripts
 in dir /builds/slave/c-esr38-l64-periodicupdate-000/. (timeout 1320 secs)
 watching logfiles {}
 argv: ['hg', 'clone', 'https://hg.mozilla.org/build/tools', 'scripts']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-1092.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
  PWD=/builds/slave/c-esr38-l64-periodicupdate-000
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
(ignoring URL on server that requires SNI)
(your Python is older than 2.7.9 and does not support modern and secure SSL/TLS; please consider upgrading your Python to a secure version)
warning: s3-us-west-2.amazonaws.com certificate with fingerprint ad:ab:0d:1e:fe:1c:78:5b:94:f9:76:b2:5a:12:51:9a:12:7b:66:a2 not verified (check hostfingerprints or web.cacerts config setting)
downloading bundle https://s3-us-west-2.amazonaws.com/moz-hg-bundles-us-west-2/build/tools/e2810fde2a2747b424472aef4941b8eb0fe266b7.stream-legacy.hg
streaming all changes
1920 files to transfer, 25.8 MB of data
transferred 25.8 MB in 0.5 seconds (49.2 MB/sec)
finishing applying bundle; pulling
searching for changes
adding changesets
adding manifests
adding file changes
added 4 changesets with 9 changes to 8 files
updating to branch default
1125 files updated, 0 files merged, 0 files removed, 0 files unresolved
program finished with exit code 0
elapsedTime=2.222149
========= master_lag: 0.02 =========
========= Finished 'hg clone ...' (results: 0, elapsed: 2 secs) (at 2015-11-28 03:03:48.034641) =========

========= Started 'hg update ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:48.034980) =========
hg update -C -r default
 in dir /builds/slave/c-esr38-l64-periodicupdate-000/scripts (timeout 1200 secs)
 watching logfiles {}
 argv: ['hg', 'update', '-C', '-r', 'default']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-1092.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
  PWD=/builds/slave/c-esr38-l64-periodicupdate-000/scripts
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
0 files updated, 0 files merged, 0 files removed, 0 files unresolved
program finished with exit code 0
elapsedTime=0.475500
========= master_lag: 0.01 =========
========= Finished 'hg update ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:48.523225) =========

========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:48.523555) =========
hg id -i
 in dir /builds/slave/c-esr38-l64-periodicupdate-000/scripts (timeout 1200 secs)
 watching logfiles {}
 argv: ['hg', 'id', '-i']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-1092.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
  PWD=/builds/slave/c-esr38-l64-periodicupdate-000/scripts
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
c2fe57603c09
program finished with exit code 0
elapsedTime=0.359333
script_repo_revision: 'c2fe57603c09'
========= master_lag: 0.01 =========
========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:48.895848) =========

========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:48.896149) =========
TinderboxPrint: script_revlink: https://hg.mozilla.org/build/tools/rev/c2fe57603c09
========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-28 03:03:48.896505) =========

========= Started 'bash scripts/scripts/periodic_file_updates/periodic_file_updates.sh ...' (results: 0, elapsed: 1 mins, 6 secs) (at 2015-11-28 03:03:48.896796) =========
bash scripts/scripts/periodic_file_updates/periodic_file_updates.sh -b releases/comm-esr38 --bundle https://ftp-ssl.mozilla.org/pub/mozilla.org/thunderbird/bundles/comm-esr38.hg -p thunderbird -u tbirdbld -k '~cltbld/.ssh/tbirdbld_dsa' -a --blocklist
 in dir /builds/slave/c-esr38-l64-periodicupdate-000/. (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', 'scripts/scripts/periodic_file_updates/periodic_file_updates.sh', '-b', 'releases/comm-esr38', '--bundle', 'https://ftp-ssl.mozilla.org/pub/mozilla.org/thunderbird/bundles/comm-esr38.hg', '-p', 'thunderbird', '-u', 'tbirdbld', '-k', '~cltbld/.ssh/tbirdbld_dsa', '-a', '--blocklist']
 environment:
  CCACHE_COMPRESS=1
  CCACHE_DIR=/builds/ccache
  CCACHE_HASHDIR=
  CCACHE_UMASK=002
  DISPLAY=:2
  G_BROKEN_FILENAMES=1
  HG_SHARE_BASE_DIR=/builds/hg-shared
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-1092.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LC_ALL=C
  LD_LIBRARY_PATH=/tools/gcc-4.3.3/installed/lib64
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  MOZ_AUTOMATION=1
  MOZ_CRASHREPORTER_NO_REPORT=1
  MOZ_OBJDIR=objdir-tb
  MOZ_SYMBOLS_EXTRA_BUILDID=linux64
  PATH=/tools/buildbot/bin:/usr/local/bin:/usr/lib64/ccache:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/tools/git/bin:/tools/python27/bin:/tools/python27-mercurial/bin:/home/cltbld/bin
  POST_SYMBOL_UPLOAD_CMD=/usr/local/bin/post-symbol-upload.py
  PROPERTIES_FILE=/builds/slave/c-esr38-l64-periodicupdate-000/buildprops.json
  PWD=/builds/slave/c-esr38-l64-periodicupdate-000
  SHELL=/bin/bash
  SHLVL=1
  SYMBOL_SERVER_HOST=symbolpush.mozilla.org
  SYMBOL_SERVER_PATH=/mnt/netapp/breakpad/symbols_tbrd/
  SYMBOL_SERVER_SSH_KEY=/home/mock_mozilla/.ssh/tbirdbld_dsa
  SYMBOL_SERVER_USER=tbirdbld
  TERM=linux
  TINDERBOX_OUTPUT=1
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
2015-11-28 03:03:49 URL:http://hg.mozilla.org/releases/comm-esr38/raw-file/default/mail/config/version.txt [7/7] -> "version.txt" [1]
INFO: parsed version is 38.4.0
INFO: wget -nv --no-check-certificate -O blocklist_amo.xml https://blocklist.addons.mozilla.org/blocklist/3/%7B3550f703-e582-4d05-9a08-453d09bdfdc6%7D/38.4.0/Thunderbird/20090105024647/blocklist-sync/en-US/nightly/blocklist-sync/default/default/
2015-11-28 03:03:49 URL:https://blocklist.addons.mozilla.org/blocklist/3/%7B3550f703-e582-4d05-9a08-453d09bdfdc6%7D/38.4.0/Thunderbird/20090105024647/blocklist-sync/en-US/nightly/blocklist-sync/default/default/ [148263] -> "blocklist_amo.xml" [1]
INFO: wget -nv -O blocklist_hg.xml http://hg.mozilla.org/releases/comm-esr38/raw-file/default/mail/app/blocklist.xml
2015-11-28 03:03:50 URL:http://hg.mozilla.org/releases/comm-esr38/raw-file/default/mail/app/blocklist.xml [148009/148009] -> "blocklist_hg.xml" [1]
INFO: diffing in-tree blocklist against the blocklist from AMO...
INFO: AMO blocklist differs from the one in-tree.
INFO: cloning from hg: scripts/scripts/periodic_file_updates/../../buildfarm/utils/hgtool.py --branch default --bundle https://ftp-ssl.mozilla.org/pub/mozilla.org/thunderbird/bundles/comm-esr38.hg http://hg.mozilla.org/releases/comm-esr38 comm-esr38
Reporting hg version in use
command: START
command: hg -q version
command: cwd: .
command: output:
Mercurial Distributed SCM (version 3.2.1)
command: END (0.29s elapsed)

Checking if share extension works
command: START
command: hg help share
command: cwd: /builds/slave/c-esr38-l64-periodicupdate-000
command: env: {'HGPLAIN': '1'}
command: END (0.50s elapsed)

Updating shared repo
Reporting hg version in use
command: START
command: hg -q version
command: cwd: .
command: output:
Mercurial Distributed SCM (version 3.2.1)
command: END (0.29s elapsed)

Attempting to initialize clone with bundles
command: START
command: hg init /builds/hg-shared/releases/comm-esr38
command: cwd: /builds/slave/c-esr38-l64-periodicupdate-000
command: output:
command: END (0.31s elapsed)

Trying to use bundle https://ftp-ssl.mozilla.org/pub/mozilla.org/thunderbird/bundles/comm-esr38.hg
command: START
command: hg unbundle --traceback https://ftp-ssl.mozilla.org/pub/mozilla.org/thunderbird/bundles/comm-esr38.hg
command: cwd: /builds/hg-shared/releases/comm-esr38
command: env: {'HGPLAIN': '1'}
Hit exception running hg:
Traceback (most recent call last):
  File "scripts/scripts/periodic_file_updates/../../buildfarm/utils/../../lib/python/util/hg.py", line 99, in get_hg_output
    return get_output(['hg'] + cmd, timeout=timeout, env=env, **kwargs)
  File "scripts/scripts/periodic_file_updates/../../buildfarm/utils/../../lib/python/util/commands.py", line 207, in get_output
    raise error
CalledProcessError: Command '['hg', 'unbundle', '--traceback', 'https://ftp-ssl.mozilla.org/pub/mozilla.org/thunderbird/bundles/comm-esr38.hg']' returned non-zero exit status 255
Using bundles failed; falling back to clone
command: START
command: hg clone --traceback -U http://hg.mozilla.org/releases/comm-esr38 /builds/hg-shared/releases/comm-esr38
command: cwd: /builds/slave/c-esr38-l64-periodicupdate-000
command: env: {'HGPLAIN': '1'}
command: END (51.08s elapsed)

command: output:
requesting all changes
adding changesets
adding manifests
adding file changes
added 22212 changesets with 80476 changes to 14461 files (+255 heads)

Trying to share /builds/hg-shared/releases/comm-esr38 to /builds/slave/c-esr38-l64-periodicupdate-000/comm-esr38
command: START
command: hg share -U /builds/hg-shared/releases/comm-esr38 /builds/slave/c-esr38-l64-periodicupdate-000/comm-esr38
command: cwd: /builds/slave/c-esr38-l64-periodicupdate-000
command: output:
command: END (0.31s elapsed)

command: START
command: hg branch
command: cwd: /builds/slave/c-esr38-l64-periodicupdate-000/comm-esr38
command: env: {'HGPLAIN': '1'}
command: END (0.50s elapsed)

command: output:
default

command: START
command: hg update -C
command: cwd: /builds/slave/c-esr38-l64-periodicupdate-000/comm-esr38
command: output:
8771 files updated, 0 files merged, 0 files removed, 0 files unresolved
command: END (3.52s elapsed)

command: START
command: hg parent --template {node|short}
command: cwd: /builds/slave/c-esr38-l64-periodicupdate-000/comm-esr38
command: env: {'HGPLAIN': '1'}
command: END (0.50s elapsed)

command: output:
1d9d1f73cca6
Got revision 1d9d1f73cca6
INFO: pulling from hg: hg -R comm-esr38 pull
pulling from http://hg.mozilla.org/releases/comm-esr38
searching for changes
no changes found
INFO: updating to default: hg -R comm-esr38 update -C default
0 files updated, 0 files merged, 0 files removed, 0 files unresolved
INFO: committing blocklist changes: hg -R comm-esr38 commit -u "tbirdbld" -m "No bug, Automated blocklist update from host bld-linux64-spot-1092 - a=blocklist-update"
INFO: hg commit succeeded for blocklist files.
hg -R comm-esr38 push -e "ssh -l tbirdbld -i ~cltbld/.ssh/tbirdbld_dsa" ssh://hg.mozilla.org/releases/comm-esr38
pushing to ssh://hg.mozilla.org/releases/comm-esr38
searching for changes
remote: adding changesets
remote: adding manifests
remote: adding file changes
remote: added 1 changesets with 1 changes to 1 files
remote: recorded push in pushlog
remote: replication of changegroup data completed successfully in 1.5s
remote: 
remote: View your change here:
remote:   https://hg.mozilla.org/releases/comm-esr38/rev/16263412f56b
remote: 
remote: Follow the progress of your build on Treeherder:
remote:   https://treeherder.mozilla.org/#/jobs?repo=comm-esr38&revision=16263412f56b
INFO: hg push succeeded.
program finished with exit code 0
elapsedTime=66.300205
========= master_lag: 0.02 =========
========= Finished 'bash scripts/scripts/periodic_file_updates/periodic_file_updates.sh ...' (results: 0, elapsed: 1 mins, 6 secs) (at 2015-11-28 03:04:55.220774) =========

========= Started no change (results: 0, elapsed: 0 secs) (at 2015-11-28 03:04:55.221764) =========
bash -c 'for file in `ls -1`; do cat $file; done'
 in dir /builds/slave/c-esr38-l64-periodicupdate-000/properties (timeout 1200 secs)
 watching logfiles {}
 argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done']
 environment:
  CCACHE_HASHDIR=
  G_BROKEN_FILENAMES=1
  HISTCONTROL=ignoredups
  HISTSIZE=1000
  HOME=/home/cltbld
  HOSTNAME=bld-linux64-spot-1092.build.releng.usw2.mozilla.com
  LANG=en_US.UTF-8
  LESSOPEN=|/usr/bin/lesspipe.sh %s
  LOGNAME=cltbld
  MAIL=/var/spool/mail/cltbld
  PATH=/usr/local/bin:/usr/lib64/ccache:/usr/local/bin:/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/sbin:/home/cltbld/bin
  PWD=/builds/slave/c-esr38-l64-periodicupdate-000/properties
  SHELL=/bin/bash
  SHLVL=1
  TERM=linux
  TMOUT=86400
  USER=cltbld
  _=/tools/buildbot/bin/python
 using PTY: False
program finished with exit code 0
elapsedTime=0.004905

========= master_lag: 0.04 =========
========= Finished no change (results: 0, elapsed: 0 secs) (at 2015-11-28 03:04:55.270101) =========

========= Total master_lag: 0.21 =========