builder: mozilla-aurora-linux64-asan-debug slave: bld-linux64-spot-276 starttime: 1457392964.89 results: exception (4) buildid: 20160307152238 builduid: 2a9ccb62bcad4529a38346460a0cc034 revision: 9a446438d3a4e9279b776d3e296e7a7209acab77 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 15:22:44.887195) ========= master: http://buildbot-master77.bb.releng.use1.mozilla.com:8001/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 15:22:44.887631) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 15:22:44.887920) ========= bash -c pwd in dir /builds/slave/m-aurora-l64-asan-d-0000000000/. (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-276.build.releng.use1.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/m-aurora-l64-asan-d-0000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False /builds/slave/m-aurora-l64-asan-d-0000000000 program finished with exit code 0 elapsedTime=0.004356 basedir: '/builds/slave/m-aurora-l64-asan-d-0000000000' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 15:22:44.907290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 15:22:44.907582) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 15:22:44.921380) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 15:22:44.921708) ========= rm -rf properties in dir /builds/slave/m-aurora-l64-asan-d-0000000000/. (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-276.build.releng.use1.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/m-aurora-l64-asan-d-0000000000 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.002717 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 15:22:44.969351) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 15:22:44.969650) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 15:22:44.969991) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 15:22:44.970288) ========= rm -rf scripts in dir /builds/slave/m-aurora-l64-asan-d-0000000000/. (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-276.build.releng.use1.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/m-aurora-l64-asan-d-0000000000 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.002799 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 15:22:45.018414) ========= ========= Started 'bash -c ...' exception (results: 4, elapsed: 11 mins, 45 secs) (at 2016-03-07 15:22:45.018760) ========= bash -c 'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a446438d3a4e9279b776d3e296e7a7209acab77 --destination scripts --debug' in dir /builds/slave/m-aurora-l64-asan-d-0000000000/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python /tools/checkouts/build-tools/buildfarm/utils/archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a446438d3a4e9279b776d3e296e7a7209acab77 --destination scripts --debug'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-276.build.releng.use1.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/m-aurora-l64-asan-d-0000000000 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld _=/tools/buildbot/bin/python using PTY: False 2016-03-07 15:22:45,068 truncating revision to first 12 chars 2016-03-07 15:22:45,068 Setting DEBUG logging. 2016-03-07 15:22:45,068 attempt 1/10 2016-03-07 15:22:45,069 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a446438d3a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 15:22:45,536 attempt 1/10 2016-03-07 15:22:46,116 current task status: no status available at this point. state: PENDING 2016-03-07 15:22:46,116 sleeping for 9.00s (attempt 1/10) 2016-03-07 15:22:55,125 attempt 2/10 2016-03-07 15:22:55,709 current task status: no status available at this point. state: PENDING 2016-03-07 15:22:55,709 sleeping for 12.50s (attempt 2/10) 2016-03-07 15:23:08,222 attempt 3/10 2016-03-07 15:23:08,816 current task status: no status available at this point. state: PENDING 2016-03-07 15:23:08,816 sleeping for 18.75s (attempt 3/10) 2016-03-07 15:23:27,585 attempt 4/10 2016-03-07 15:23:28,179 current task status: no status available at this point. state: PENDING 2016-03-07 15:23:28,180 sleeping for 28.12s (attempt 4/10) 2016-03-07 15:23:56,333 attempt 5/10 2016-03-07 15:23:56,912 current task status: no status available at this point. state: PENDING 2016-03-07 15:23:56,913 sleeping for 43.19s (attempt 5/10) 2016-03-07 15:24:40,144 attempt 6/10 2016-03-07 15:24:40,733 current task status: no status available at this point. state: PENDING 2016-03-07 15:24:40,733 sleeping for 65.78s (attempt 6/10) 2016-03-07 15:25:46,581 attempt 7/10 2016-03-07 15:25:46,969 sleeping for 10.00s (attempt 1/10) 2016-03-07 15:25:56,980 attempt 2/10 2016-03-07 15:25:56,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a446438d3a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 15:25:57,366 sleeping for 16.00s (attempt 2/10) 2016-03-07 15:26:13,382 attempt 3/10 2016-03-07 15:26:13,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a446438d3a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 15:26:13,769 sleeping for 24.00s (attempt 3/10) 2016-03-07 15:26:37,794 attempt 4/10 2016-03-07 15:26:37,794 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a446438d3a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 15:26:38,181 sleeping for 35.00s (attempt 4/10) 2016-03-07 15:27:13,216 attempt 5/10 2016-03-07 15:27:13,216 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a446438d3a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 15:27:13,599 sleeping for 53.50s (attempt 5/10) 2016-03-07 15:28:07,153 attempt 6/10 2016-03-07 15:28:07,153 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a446438d3a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 15:28:07,535 sleeping for 80.25s (attempt 6/10) 2016-03-07 15:29:27,866 attempt 7/10 2016-03-07 15:29:27,866 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a446438d3a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 15:29:28,254 sleeping for 101.00s (attempt 7/10) 2016-03-07 15:31:09,261 attempt 8/10 2016-03-07 15:31:09,262 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a446438d3a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 15:31:09,647 sleeping for 99.00s (attempt 8/10) 2016-03-07 15:32:48,746 attempt 9/10 2016-03-07 15:32:48,746 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a446438d3a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 15:32:49,128 sleeping for 101.00s (attempt 9/10) 2016-03-07 15:34:30,228 attempt 10/10 2016-03-07 15:34:30,229 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a446438d3a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 15:34:30,615 Automation Error: could not determine a valid url response. Traceback (most recent call last): File "/tools/checkouts/build-tools/buildfarm/utils/archiver_client.py", line 127, in get_url_response response = urllib2.urlopen(api_url, timeout=60) File "/usr/lib64/python2.6/urllib2.py", line 126, in urlopen return _opener.open(url, data, timeout) File "/usr/lib64/python2.6/urllib2.py", line 397, in open response = meth(req, response) File "/usr/lib64/python2.6/urllib2.py", line 510, in http_response 'http', request, response, code, msg, hdrs) File "/usr/lib64/python2.6/urllib2.py", line 435, in error return self._call_chain(*args) File "/usr/lib64/python2.6/urllib2.py", line 369, in _call_chain result = func(*args) File "/usr/lib64/python2.6/urllib2.py", line 518, in http_error_default raise HTTPError(req.get_full_url(), code, msg, hdrs, fp) HTTPError: HTTP Error 500: Internal Server Error program finished with exit code 3 elapsedTime=705.597735 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' exception (results: 4, elapsed: 11 mins, 45 secs) (at 2016-03-07 15:34:30.629171) ========= ========= Skipped (results: not started, elapsed: not started) ========= ========= Skipped (results: not started, elapsed: not started) ========= ========= Skipped (results: not started, elapsed: not started) ========= ========= Started no change (results: 0, elapsed: 0 secs) (at 2016-03-07 15:34:30.630876) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/m-aurora-l64-asan-d-0000000000/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-276.build.releng.use1.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/m-aurora-l64-asan-d-0000000000/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.005149 ========= master_lag: 0.05 ========= ========= Finished no change (results: 0, elapsed: 0 secs) (at 2016-03-07 15:34:30.682371) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 15:34:30.682687) ========= rm -f oauth.txt in dir /builds/slave/m-aurora-l64-asan-d-0000000000/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: CCACHE_HASHDIR= G_BROKEN_FILENAMES=1 HISTCONTROL=ignoredups HISTSIZE=1000 HOME=/home/cltbld HOSTNAME=bld-linux64-spot-276.build.releng.use1.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/m-aurora-l64-asan-d-0000000000 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.002790 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 15:34:30.730442) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 15:34:30.730747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 15:34:30.731023) ========= ========= Total master_lag: 0.21 =========