http://d-jenkins.ubuntu-ci:8080/view/Vivid/view/BootTest/job/vivid-boottest-unity-scopes-api/1/console
 looks similar but I have a traceback (running with -d helps ?):
        
FailedConsole Output

Started by remote host 10.100.0.2
Building remotely on krillin-09 in workspace 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api
[vivid-boottest-unity-scopes-api] $ /bin/bash -x 
/tmp/hudson5448376527591332470.sh
+ set +e
+ rm -Rf '*'
+ rm -r test-runner
rm: cannot remove 'test-runner': No such file or directory
+ true
+ setup_branch='lp:~canonical-ci-engineering/ubuntu-test-cases/boottest'
+ bzr_cmd='bzr branch lp:~canonical-ci-engineering/ubuntu-test-cases/boottest 
test-runner'
+ bzr branch 'lp:~canonical-ci-engineering/ubuntu-test-cases/boottest' 
test-runner
Branched 405 revisions.
+ annotate-output test-runner/scripts/boottest.sh vivid unity-scopes-api 
krillin-09
12:36:28 I: Started test-runner/scripts/boottest.sh vivid unity-scopes-api 
krillin-09
12:36:28 E: +++ readlink -f test-runner/scripts/boottest.sh
12:36:28 E: ++ dirname 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/boottest.sh
12:36:28 E: + 
BASEDIR=/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/..
12:36:28 E: + export RELEASE=vivid
12:36:28 E: + RELEASE=vivid
12:36:28 E: + export SRC_PKG_NAME=unity-scopes-api
12:36:28 E: + SRC_PKG_NAME=unity-scopes-api
12:36:28 E: + export NODE_NAME=krillin-09
12:36:28 E: + NODE_NAME=krillin-09
12:36:28 E: + export ADT_TIMEOUT=600
12:36:28 E: + ADT_TIMEOUT=600
12:36:28 E: + export RSYNC_DEST=rsync://tachash.ubuntu-ci/boottest/
12:36:28 E: + RSYNC_DEST=rsync://tachash.ubuntu-ci/boottest/
12:36:28 E: + '[' -z krillin-09 ']'
12:36:28 E: ++ 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../scripts/get-adb-id
 krillin-09
12:36:28 E: + export ANDROID_SERIAL=JW010053
12:36:28 E: + ANDROID_SERIAL=JW010053
12:36:28 E: + export VERSION=1.2.51-0ubuntu3
12:36:28 E: + VERSION=1.2.51-0ubuntu3
12:36:28 E: + BOOTTESTRC=/var/lib/jenkins/.ubuntu-ci/boottest.rc
12:36:28 E: + '[' -f /var/lib/jenkins/.ubuntu-ci/boottest.rc ']'
12:36:28 E: + ARCH=krillin
12:36:28 E: + PHABLET_PASSWORD=0000
12:36:28 E: + export SKIP_CLICK=1
12:36:28 E: + SKIP_CLICK=1
12:36:28 E: + export SKIP_TESTCONFIG=1
12:36:28 E: + SKIP_TESTCONFIG=1
12:36:28 E: + '[' -z krillin-09 ']'
12:36:28 E: + 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../scripts/recover.py
 krillin-09
12:36:28 O: /home/phablet
12:36:28 O: 0
12:36:28 E: + 
TESTS=/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../tests
12:36:28 E: + REVISION=0
12:36:28 E: + 
PROV_CMD='/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../scripts/provision.sh
     -r 0     -n /var/lib/jenkins/.ubuntu-ci/wifi.conf -w'
12:36:28 E: + '[' -z krillin-09 ']'
12:36:28 E: + 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../scripts/provision.sh
 -r 0 -n /var/lib/jenkins/.ubuntu-ci/wifi.conf -w -s JW010053
12:36:28 E: + '[' -d 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/clientlogs
 ']'
12:36:28 E: + mkdir -p 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/clientlogs
12:36:28 E: + '[' -z ']'
12:36:28 O: = Wed Feb 11 12:36:28 UTC 2015: FLASHING DEVICE
12:36:28 E: + full_flash
12:36:28 E: + log 'FLASHING DEVICE'
12:36:28 E: ++ date
12:36:28 E: + echo = Wed Feb 11 12:36:28 UTC 2015: FLASHING DEVICE
12:36:28 E: ++ get-device-type
12:36:29 E: + DEVICE_TYPE=krillin
12:36:29 E: + retry 60 3 reboot_bootloader
12:36:29 O: = Wed Feb 11 12:36:29 UTC 2015: Attempting adb reboot bootloader
12:36:29 E: + timeout=60
12:36:29 E: + shift
12:36:29 E: + loops=3
12:36:29 E: + shift
12:36:29 E: + cmd=reboot_bootloader
12:36:29 E: + loopcnt=0
12:36:29 E: + true
12:36:29 E: + reboot_bootloader
12:36:29 E: + log 'Attempting adb reboot bootloader'
12:36:29 E: ++ date
12:36:29 E: + echo = Wed Feb 11 12:36:29 UTC 2015: Attempting adb reboot 
bootloader
12:36:29 E: + adb reboot bootloader
12:36:29 E: + '[' -n JW010053 ']'
12:36:29 E: + sleep 30
12:36:59 E: + fastboot devices
12:36:59 E: + grep -q JW010053
12:36:59 E: + return 0
12:36:59 E: + break
12:36:59 E: + RECOVERY=
12:36:59 O: = Wed Feb 11 12:36:59 UTC 2015: The following wget is only needed 
for some devices. If it fails, it's probably safe to ignore
12:36:59 E: + mkdir -p recovery
12:36:59 E: + log 'The following wget is only needed for some devices. If it 
fails, it'\''s probably safe to ignore'
12:36:59 E: ++ date
12:36:59 E: + echo = Wed Feb 11 12:36:59 UTC 2015: The following wget is only 
needed for some devices. If it fails, 'it'\''s' probably safe to ignore
12:36:59 E: + wget -P recovery 
http://people.canonical.com/~plars/touch/recovery-krillin.img
12:36:59 E: --2015-02-11 12:36:59--  
http://people.canonical.com/~plars/touch/recovery-krillin.img
12:36:59 E: Resolving people.canonical.com (people.canonical.com)... 
91.189.89.62
12:36:59 E: Connecting to people.canonical.com 
(people.canonical.com)|91.189.89.62|:80... connected.
12:36:59 E: HTTP request sent, awaiting response... 200 OK
12:36:59 E: Length: 8595456 (8.2M)
12:36:59 E: Saving to: 'recovery/recovery-krillin.img'
12:36:59 E: 
12:37:00 E:      0K .......... .......... .......... .......... ..........  0%  
312K 27s
12:37:00 E:     50K .......... .......... .......... .......... ..........  1%  
312K 27s
12:37:00 E:    100K .......... .......... .......... .......... ..........  1%  
315K 26s
12:37:00 E:    150K .......... .......... .......... .......... ..........  2%  
624K 23s
12:37:00 E:    200K .......... .......... .......... .......... ..........  2%  
611K 21s
12:37:00 E:    250K .......... .......... .......... .......... ..........  3%  
622K 19s
12:37:00 E:    300K .......... .......... .......... .......... ..........  4%  
623K 18s
12:37:00 E:    350K .......... .......... .......... .......... ..........  4%  
622K 18s
12:37:00 E:    400K .......... .......... .......... .......... ..........  5%  
619K 17s
12:37:01 E:    450K .......... .......... .......... .......... ..........  5%  
623K 16s
12:37:01 E:    500K .......... .......... .......... .......... ..........  6%  
623K 16s
12:37:01 E:    550K .......... .......... .......... .......... ..........  7%  
624K 16s
12:37:01 E:    600K .......... .......... .......... .......... ..........  7%  
624K 15s
12:37:01 E:    650K .......... .......... .......... .......... ..........  8% 
52.4M 14s
12:37:01 E:    700K .......... .......... .......... .......... ..........  8%  
623K 14s
12:37:01 E:    750K .......... .......... .......... .......... ..........  9%  
624K 14s
12:37:01 E:    800K .......... .......... .......... .......... .......... 10%  
622K 14s
12:37:01 E:    850K .......... .......... .......... .......... .......... 10% 
80.6M 13s
12:37:01 E:    900K .......... .......... .......... .......... .......... 11%  
623K 13s
12:37:01 E:    950K .......... .......... .......... .......... .......... 11%  
624K 12s
12:37:01 E:   1000K .......... .......... .......... .......... .......... 12%  
631K 12s
12:37:01 E:   1050K .......... .......... .......... .......... .......... 13% 
1.63M 12s
12:37:01 E:   1100K .......... .......... .......... .......... .......... 13%  
976K 12s
12:37:01 E:   1150K .......... .......... .......... .......... .......... 14%  
629K 12s
12:37:01 E:   1200K .......... .......... .......... .......... .......... 14% 
1.64M 11s
12:37:02 E:   1250K .......... .......... .......... .......... .......... 15%  
622K 11s
12:37:02 E:   1300K .......... .......... .......... .......... .......... 16% 
72.3M 11s
12:37:02 E:   1350K .......... .......... .......... .......... .......... 16%  
625K 11s
12:37:02 E:   1400K .......... .......... .......... .......... .......... 17%  
627K 11s
12:37:02 E:   1450K .......... .......... .......... .......... .......... 17% 
46.2M 10s
12:37:02 E:   1500K .......... .......... .......... .......... .......... 18%  
632K 10s
12:37:02 E:   1550K .......... .......... .......... .......... .......... 19% 
47.6M 10s
12:37:02 E:   1600K .......... .......... .......... .......... .......... 19%  
636K 10s
12:37:02 E:   1650K .......... .......... .......... .......... .......... 20% 
31.7M 9s
12:37:02 E:   1700K .......... .......... .......... .......... .......... 20%  
636K 9s
12:37:02 E:   1750K .......... .......... .......... .......... .......... 21% 
22.8M 9s
12:37:02 E:   1800K .......... .......... .......... .......... .......... 22%  
644K 9s
12:37:02 E:   1850K .......... .......... .......... .......... .......... 22% 
20.0M 9s
12:37:02 E:   1900K .......... .......... .......... .......... .......... 23% 
32.0M 8s
12:37:02 E:   1950K .......... .......... .......... .......... .......... 23%  
631K 8s
12:37:02 E:   2000K .......... .......... .......... .......... .......... 24% 
42.8M 8s
12:37:02 E:   2050K .......... .......... .......... .......... .......... 25%  
635K 8s
12:37:02 E:   2100K .......... .......... .......... .......... .......... 25% 
38.9M 8s
12:37:02 E:   2150K .......... .......... .......... .......... .......... 26%  
633K 8s
12:37:02 E:   2200K .......... .......... .......... .......... .......... 26% 
52.4M 8s
12:37:02 E:   2250K .......... .......... .......... .......... .......... 27% 
45.6M 7s
12:37:02 E:   2300K .......... .......... .......... .......... .......... 27%  
631K 7s
12:37:02 E:   2350K .......... .......... .......... .......... .......... 28%  
612K 7s
12:37:02 E:   2400K .......... .......... .......... .......... .......... 29%  
131M 7s
12:37:02 E:   2450K .......... .......... .......... .......... .......... 29%  
241M 7s
12:37:02 E:   2500K .......... .......... .......... .......... .......... 30%  
637K 7s
12:37:02 E:   2550K .......... .......... .......... .......... .......... 30% 
42.6M 7s
12:37:03 E:   2600K .......... .......... .......... .......... .......... 31%  
427K 7s
12:37:03 E:   2650K .......... .......... .......... .......... .......... 32%  
626K 7s
12:37:03 E:   2700K .......... .......... .......... .......... .......... 32% 
1.14M 7s
12:37:03 E:   2750K .......... .......... .......... .......... .......... 33%  
625K 7s
12:37:03 E:   2800K .......... .......... .......... .......... .......... 33%  
640K 7s
12:37:03 E:   2850K .......... .......... .......... .......... .......... 34% 
1.24M 7s
12:37:03 E:   2900K .......... .......... .......... .......... .......... 35% 
1.14M 6s
12:37:03 E:   2950K .......... .......... .......... .......... .......... 35% 
1.30M 6s
12:37:03 E:   3000K .......... .......... .......... .......... .......... 36% 
1.14M 6s
12:37:03 E:   3050K .......... .......... .......... .......... .......... 36% 
1.02M 6s
12:37:03 E:   3100K .......... .......... .......... .......... .......... 37% 
1.51M 6s
12:37:03 E:   3150K .......... .......... .......... .......... .......... 38% 
1.10M 6s
12:37:03 E:   3200K .......... .......... .......... .......... .......... 38% 
1.37M 6s
12:37:03 E:   3250K .......... .......... .......... .......... .......... 39% 
1.11M 6s
12:37:03 E:   3300K .......... .......... .......... .......... .......... 39% 
1.34M 6s
12:37:03 E:   3350K .......... .......... .......... .......... .......... 40% 
1.11M 6s
12:37:03 E:   3400K .......... .......... .......... .......... .......... 41% 
1.35M 6s
12:37:03 E:   3450K .......... .......... .......... .......... .......... 41% 
1.12M 5s
12:37:03 E:   3500K .......... .......... .......... .......... .......... 42%  
687K 5s
12:37:04 E:   3550K .......... .......... .......... .......... .......... 42% 
6.63M 5s
12:37:04 E:   3600K .......... .......... .......... .......... .......... 43%  
686K 5s
12:37:04 E:   3650K .......... .......... .......... .......... .......... 44% 
6.71M 5s
12:37:04 E:   3700K .......... .......... .......... .......... .......... 44%  
688K 5s
12:37:04 E:   3750K .......... .......... .......... .......... .......... 45% 
1.11M 5s
12:37:04 E:   3800K .......... .......... .......... .......... .......... 45% 
1.32M 5s
12:37:04 E:   3850K .......... .......... .......... .......... .......... 46% 
1.13M 5s
12:37:04 E:   3900K .......... .......... .......... .......... .......... 47% 
1.32M 5s
12:37:04 E:   3950K .......... .......... .......... .......... .......... 47% 
7.82M 5s
12:37:04 E:   4000K .......... .......... .......... .......... .......... 48%  
672K 5s
12:37:04 E:   4050K .......... .......... .......... .......... .......... 48% 
1.13M 5s
12:37:04 E:   4100K .......... .......... .......... .......... .......... 49% 
1.34M 5s
12:37:04 E:   4150K .......... .......... .......... .......... .......... 50% 
7.82M 4s
12:37:04 E:   4200K .......... .......... .......... .......... .......... 50% 
1.26M 4s
12:37:04 E:   4250K .......... .......... .......... .......... .......... 51% 
1.16M 4s
12:37:04 E:   4300K .......... .......... .......... .......... .......... 51% 
1.27M 4s
12:37:04 E:   4350K .......... .......... .......... .......... .......... 52% 
1.40M 4s
12:37:04 E:   4400K .......... .......... .......... .......... .......... 53% 
5.90M 4s
12:37:04 E:   4450K .......... .......... .......... .......... .......... 53% 
1.28M 4s
12:37:04 E:   4500K .......... .......... .......... .......... .......... 54% 
1.16M 4s
12:37:04 E:   4550K .......... .......... .......... .......... .......... 54% 
11.9M 4s
12:37:04 E:   4600K .......... .......... .......... .......... .......... 55% 
1.40M 4s
12:37:04 E:   4650K .......... .......... .......... .......... .......... 55% 
1.16M 4s
12:37:04 E:   4700K .......... .......... .......... .......... .......... 56% 
1.26M 4s
12:37:04 E:   4750K .......... .......... .......... .......... .......... 57% 
1.17M 4s
12:37:04 E:   4800K .......... .......... .......... .......... .......... 57% 
1.30M 4s
12:37:04 E:   4850K .......... .......... .......... .......... .......... 58% 
24.6M 4s
12:37:04 E:   4900K .......... .......... .......... .......... .......... 58% 
1.16M 3s
12:37:05 E:   4950K .......... .......... .......... .......... .......... 59% 
1.27M 3s
12:37:05 E:   5000K .......... .......... .......... .......... .......... 60% 
1.58M 3s
12:37:05 E:   5050K .......... .......... .......... .......... .......... 60% 
4.33M 3s
12:37:05 E:   5100K .......... .......... .......... .......... .......... 61% 
1.24M 3s
12:37:05 E:   5150K .......... .......... .......... .......... .......... 61% 
1.20M 3s
12:37:05 E:   5200K .......... .......... .......... .......... .......... 62% 
1.24M 3s
12:37:05 E:   5250K .......... .......... .......... .......... .......... 63% 
1.67M 3s
12:37:05 E:   5300K .......... .......... .......... .......... .......... 63% 
3.90M 3s
12:37:05 E:   5350K .......... .......... .......... .......... .......... 64% 
1.25M 3s
12:37:05 E:   5400K .......... .......... .......... .......... .......... 64% 
1.22M 3s
12:37:05 E:   5450K .......... .......... .......... .......... .......... 65% 
1.37M 3s
12:37:05 E:   5500K .......... .......... .......... .......... .......... 66% 
1.46M 3s
12:37:05 E:   5550K .......... .......... .......... .......... .......... 66% 
4.01M 3s
12:37:05 E:   5600K .......... .......... .......... .......... .......... 67% 
1.22M 3s
12:37:05 E:   5650K .......... .......... .......... .......... .......... 67% 
1.73M 3s
12:37:05 E:   5700K .......... .......... .......... .......... .......... 68% 
1.05M 3s
12:37:05 E:   5750K .......... .......... .......... .......... .......... 69% 
7.43M 2s
12:37:05 E:   5800K .......... .......... .......... .......... .......... 69% 
1.25M 2s
12:37:05 E:   5850K .......... .......... .......... .......... .......... 70% 
1.19M 2s
12:37:05 E:   5900K .......... .......... .......... .......... .......... 70% 
1.75M 2s
12:37:05 E:   5950K .......... .......... .......... .......... .......... 71% 
1.07M 2s
12:37:05 E:   6000K .......... .......... .......... .......... .......... 72% 
6.49M 2s
12:37:05 E:   6050K .......... .......... .......... .......... .......... 72% 
1.32M 2s
12:37:05 E:   6100K .......... .......... .......... .......... .......... 73% 
1.18M 2s
12:37:05 E:   6150K .......... .......... .......... .......... .......... 73% 
1.69M 2s
12:37:05 E:   6200K .......... .......... .......... .......... .......... 74% 
1.09M 2s
12:37:05 E:   6250K .......... .......... .......... .......... .......... 75% 
6.95M 2s
12:37:05 E:   6300K .......... .......... .......... .......... .......... 75% 
1.27M 2s
12:37:05 E:   6350K .......... .......... .......... .......... .......... 76% 
1.19M 2s
12:37:05 E:   6400K .......... .......... .......... .......... .......... 76% 
1.68M 2s
12:37:05 E:   6450K .......... .......... .......... .......... .......... 77% 
4.68M 2s
12:37:05 E:   6500K .......... .......... .......... .......... .......... 78% 
1.20M 2s
12:37:06 E:   6550K .......... .......... .......... .......... .......... 78% 
1.26M 2s
12:37:06 E:   6600K .......... .......... .......... .......... .......... 79% 
1.40M 2s
12:37:06 E:   6650K .......... .......... .......... .......... .......... 79% 
1.40M 2s
12:37:06 E:   6700K .......... .......... .......... .......... .......... 80% 
4.44M 1s
12:37:06 E:   6750K .......... .......... .......... .......... .......... 81% 
1.21M 1s
12:37:06 E:   6800K .......... .......... .......... .......... .......... 81% 
1.23M 1s
12:37:06 E:   6850K .......... .......... .......... .......... .......... 82% 
1.42M 1s
12:37:06 E:   6900K .......... .......... .......... .......... .......... 82% 
1.38M 1s
12:37:06 E:   6950K .......... .......... .......... .......... .......... 83% 
4.57M 1s
12:37:06 E:   7000K .......... .......... .......... .......... .......... 83% 
1.21M 1s
12:37:06 E:   7050K .......... .......... .......... .......... .......... 84% 
1.65M 1s
12:37:06 E:   7100K .......... .......... .......... .......... .......... 85% 
1.10M 1s
12:37:06 E:   7150K .......... .......... .......... .......... .......... 85% 
7.80M 1s
12:37:06 E:   7200K .......... .......... .......... .......... .......... 86% 
1.22M 1s
12:37:06 E:   7250K .......... .......... .......... .......... .......... 86% 
1.20M 1s
12:37:06 E:   7300K .......... .......... .......... .......... .......... 87% 
1.63M 1s
12:37:06 E:   7350K .......... .......... .......... .......... .......... 88% 
1.13M 1s
12:37:06 E:   7400K .......... .......... .......... .......... .......... 88% 
6.63M 1s
12:37:06 E:   7450K .......... .......... .......... .......... .......... 89% 
1.27M 1s
12:37:06 E:   7500K .......... .......... .......... .......... .......... 89% 
1.40M 1s
12:37:06 E:   7550K .......... .......... .......... .......... .......... 90% 
1.31M 1s
12:37:06 E:   7600K .......... .......... .......... .......... .......... 91% 
1.15M 1s
12:37:06 E:   7650K .......... .......... .......... .......... .......... 91% 
6.55M 1s
12:37:06 E:   7700K .......... .......... .......... .......... .......... 92% 
1.28M 1s
12:37:06 E:   7750K .......... .......... .......... .......... .......... 92% 
1.40M 1s
12:37:06 E:   7800K .......... .......... .......... .......... .......... 93% 
1.33M 0s
12:37:06 E:   7850K .......... .......... .......... .......... .......... 94% 
5.19M 0s
12:37:06 E:   7900K .......... .......... .......... .......... .......... 94% 
1.16M 0s
12:37:06 E:   7950K .......... .......... .......... .......... .......... 95% 
1.29M 0s
12:37:06 E:   8000K .......... .......... .......... .......... .......... 95% 
1.41M 0s
12:37:06 E:   8050K .......... .......... .......... .......... .......... 96% 
1.36M 0s
12:37:06 E:   8100K .......... .......... .......... .......... .......... 97% 
4.90M 0s
12:37:07 E:   8150K .......... .......... .......... .......... .......... 97% 
1.16M 0s
12:37:07 E:   8200K .......... .......... .......... .......... .......... 98% 
1.29M 0s
12:37:07 E:   8250K .......... .......... .......... .......... .......... 98% 
1.39M 0s
12:37:07 E:   8300K .......... .......... .......... .......... .......... 99% 
1.37M 0s
12:37:07 E:   8350K .......... .......... .......... .......... ....      100%  
995K=7.2s
12:37:07 E: 
12:37:07 E: 2015-02-11 12:37:07 (1.14 MB/s) - 'recovery/recovery-krillin.img' 
saved [8595456/8595456]
12:37:07 E: 
12:37:07 E: + '[' -f recovery/recovery-krillin.img ']'
12:37:07 O: WARNING --developer-mode and --password are dangerous as they 
remove security features from your device
12:37:07 E: + RECOVERY=--recovery-image=recovery/recovery-krillin.img
12:37:07 E: + retry 10 3 timeout 1800 ubuntu-device-flash --revision=0 touch 
--recovery-image=recovery/recovery-krillin.img --password 0000 --bootstrap 
--developer-mode --channel ubuntu-touch/devel-proposed
12:37:07 E: + timeout=10
12:37:07 E: + shift
12:37:07 E: + loops=3
12:37:07 E: + shift
12:37:07 E: + cmd='timeout 1800 ubuntu-device-flash --revision=0 touch 
--recovery-image=recovery/recovery-krillin.img --password 0000 --bootstrap 
--developer-mode --channel ubuntu-touch/devel-proposed'
12:37:07 E: + loopcnt=0
12:37:07 E: + true
12:37:07 E: + timeout 1800 ubuntu-device-flash --revision=0 touch 
--recovery-image=recovery/recovery-krillin.img --password 0000 --bootstrap 
--developer-mode --channel ubuntu-touch/devel-proposed
12:37:07 E: 2015/02/11 12:37:07 Expecting the device to be in the bootloader... 
waiting
12:37:08 E: 2015/02/11 12:37:08 Device is |krillin|
12:37:08 E: 2015/02/11 12:37:08 Flashing version 106 from 
ubuntu-touch/devel-proposed channel and server https://system-image.ubuntu.com 
to device krillin
12:37:27 E: 2015/02/11 12:37:27 Start pushing 
/var/lib/jenkins/.cache/ubuntuimages/ubuntu-touch/devel-proposed/krillin/version-106.tar.xz
 to device
12:37:27 E: 2015/02/11 12:37:27 Start pushing 
/var/lib/jenkins/.cache/ubuntuimages/pool/custom-67e3700ec668b34a70913a23e935f72fdba164abc4098ff155ecefc9ff0c5e2e.tar.xz
 to device
12:37:27 E: 2015/02/11 12:37:27 Start pushing 
/var/lib/jenkins/.cache/ubuntuimages/pool/device-12f1e7fabd46b2e69d76bf15e9fb55f7d27c7cea6556888d62693f37aaa49364.tar.xz
 to device
12:37:27 E: 2015/02/11 12:37:27 Start pushing 
/var/lib/jenkins/.cache/ubuntuimages/pool/ubuntu-5426adf8d980cedf0b749a835ce1cf1ba64ad24f876cc069e1bc70d4336bce09.tar.xz
 to device
12:37:27 E: 2015/02/11 12:37:27 Start pushing 
/var/lib/jenkins/.cache/ubuntuimages/gpg/image-signing.tar.xz to device
12:37:27 E: 2015/02/11 12:37:27 Start pushing 
/var/lib/jenkins/.cache/ubuntuimages/gpg/image-master.tar.xz to device
12:37:27 E: 2015/02/11 12:37:27 Done pushing 
/var/lib/jenkins/.cache/ubuntuimages/ubuntu-touch/devel-proposed/krillin/version-106.tar.xz
 to device
12:37:27 E: 2015/02/11 12:37:27 Done pushing 
/var/lib/jenkins/.cache/ubuntuimages/gpg/image-signing.tar.xz to device
12:37:27 E: 2015/02/11 12:37:27 Done pushing 
/var/lib/jenkins/.cache/ubuntuimages/gpg/image-master.tar.xz to device
12:37:30 E: 2015/02/11 12:37:30 Done pushing 
/var/lib/jenkins/.cache/ubuntuimages/pool/custom-67e3700ec668b34a70913a23e935f72fdba164abc4098ff155ecefc9ff0c5e2e.tar.xz
 to device
12:38:10 E: 2015/02/11 12:38:10 Done pushing 
/var/lib/jenkins/.cache/ubuntuimages/pool/device-12f1e7fabd46b2e69d76bf15e9fb55f7d27c7cea6556888d62693f37aaa49364.tar.xz
 to device
12:39:54 E: 2015/02/11 12:39:54 Done pushing 
/var/lib/jenkins/.cache/ubuntuimages/pool/ubuntu-5426adf8d980cedf0b749a835ce1cf1ba64ad24f876cc069e1bc70d4336bce09.tar.xz
 to device
12:39:54 E: 2015/02/11 12:39:54 Created ubuntu_command: 
/var/lib/jenkins/.cache/ubuntuimages/ubuntu_commands355293066
12:39:54 E: 2015/02/11 12:39:54 Rebooting into recovery to flash
12:40:10 E: + break
12:40:10 E: + adb wait-for-device
12:44:24 E: + sleep 60
12:45:24 E: + '[' -z ']'
12:45:24 E: + log 'SETTING UP WIFI'
12:45:24 O: = Wed Feb 11 12:45:24 UTC 2015: SETTING UP WIFI
12:45:24 E: ++ date
12:45:24 E: + echo = Wed Feb 11 12:45:24 UTC 2015: SETTING UP WIFI
12:45:24 E: + retry 60 5 adb-shell 'sudo -iu phablet env |grep 
UPSTART_SESSION=unix'
12:45:24 E: + timeout=60
12:45:24 E: + shift
12:45:24 E: + loops=5
12:45:24 E: + shift
12:45:24 E: + cmd='adb-shell sudo -iu phablet env |grep UPSTART_SESSION=unix'
12:45:24 E: + loopcnt=0
12:45:24 E: + true
12:45:24 E: + adb-shell sudo -iu phablet env '|grep' UPSTART_SESSION=unix
12:45:24 O: UPSTART_SESSION=unix:abstract=/com/ubuntu/upstart-session/32011/1559
12:45:24 O: ADB_RC=0
12:45:24 E: + break
12:45:24 E: + retry 60 5 phablet-network -n 
/var/lib/jenkins/.ubuntu-ci/wifi.conf
12:45:24 E: + timeout=60
12:45:24 E: + shift
12:45:24 O: Network file is /var/lib/jenkins/.ubuntu-ci/wifi.conf
12:45:24 E: + loops=5
12:45:24 E: + shift
12:45:24 E: + cmd='phablet-network -n /var/lib/jenkins/.ubuntu-ci/wifi.conf'
12:45:24 E: + loopcnt=0
12:45:24 O: Provisioning network on device
12:45:24 E: + true
12:45:24 E: + phablet-network -n /var/lib/jenkins/.ubuntu-ci/wifi.conf
12:45:27 O: Connection with UUID '79f87c26-53f8-4952-8687-3086e3fcccd7' created 
and activated on device 'wlan0'
12:45:27 O: 
12:45:27 O: Network setup complete
12:45:37 O: PING launchpad.net (91.189.89.223) 56(84) bytes of data.
12:45:37 E: + break
12:45:37 E: + phablet-config welcome-wizard --disable
12:45:38 E: + '[' -n ' ' ']'
12:45:38 E: + log 'CUSTOMIZING IMAGE'
12:45:38 O: = Wed Feb 11 12:45:38 UTC 2015: CUSTOMIZING IMAGE
12:45:38 E: ++ date
12:45:38 E: + echo = Wed Feb 11 12:45:38 UTC 2015: CUSTOMIZING IMAGE
12:45:38 E: + phablet-config writable-image -r 0000
12:46:12 O: PING launchpad.net (91.189.89.222) 56(84) bytes of data.
12:46:13 E: + log 'SETTING UP SUDO'
12:46:13 E: ++ date
12:46:13 O: = Wed Feb 11 12:46:13 UTC 2015: SETTING UP SUDO
12:46:13 E: + echo = Wed Feb 11 12:46:13 UTC 2015: SETTING UP SUDO
12:46:13 E: + adb shell 'echo 0000 |sudo -S bash -c '\''echo phablet 
ALL=\(ALL\) NOPASSWD: ALL > /etc/sudoers.d/phablet && chmod 600 
/etc/sudoers.d/phablet'\'''
12:46:13 E: + adb shell 'sudo dbus-send --system --print-reply 
--dest=org.freedesktop.Accounts /org/freedesktop/Accounts/User32011 
org.freedesktop.DBus.Properties.Set string:com.canonical.unity.AccountsService 
string:demo-edges variant:boolean:false'
12:46:13 O: [sudo] password for phablet: method return sender=:1.9 -> 
dest=:1.71 reply_serial=2
12:46:13 E: + '[' -n 1 ']'
12:46:13 O: = Wed Feb 11 12:46:13 UTC 2015: SKIPPING CLICK PACKAGE SETUP AS 
REQUESTED
12:46:13 E: + log 'SKIPPING CLICK PACKAGE SETUP AS REQUESTED'
12:46:13 E: ++ date
12:46:13 E: + echo = Wed Feb 11 12:46:13 UTC 2015: SKIPPING CLICK PACKAGE SETUP 
AS REQUESTED
12:46:13 E: + adb push 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../utils/target
 /home/phablet/bin
12:46:14 E: push: 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../utils/target/prepare-autopilot-test.sh
 -> /home/phablet/bin/prepare-autopilot-test.sh
12:46:14 E: push: 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../utils/target/autopilot-run
 -> /home/phablet/bin/autopilot-run
12:46:14 E: push: 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../utils/target/check-clickhook-rules
 -> /home/phablet/bin/check-clickhook-rules
12:46:14 E: push: 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../utils/target/autopilot-list
 -> /home/phablet/bin/autopilot-list
12:46:14 E: 4 files pushed. 0 files skipped.
12:46:14 E: 5 KB/s (935 bytes in 0.162s)
12:46:14 E: + image_info
12:46:14 E: ++ adb shell 'sudo system-image-cli -i | sed -n -e '\''s/version 
version: \([0-9]*\)/\1/p'\'' -e '\''s/version ubuntu: \([0-9]*\)/\1/p'\'' -e 
'\''s/version device: \([0-9]*\)/\1/p'\'' | paste -s -d:'
12:46:15 E: + IMAGEVER=$'106:20150210:20150210-95b6a9f\r'
12:46:15 E: ++ adb shell 'sudo system-image-cli -i | sed -n -e '\''s/channel: 
\(.*\)/\1/p'\'' | paste -s -d:'
12:46:16 E: + CHAN=$'ubuntu-touch/devel-proposed\r'
12:46:16 E: ++ echo $'106:20150210:20150210-95b6a9f\r'
12:46:16 E: ++ cut -d: -f1
12:46:16 E: + REV=106
12:46:16 E: + echo '--bootstrap --developer-mode --channel 
ubuntu-touch/devel-proposed'
12:46:16 E: + grep -q '\-\-revision'
12:46:16 E: + REVISION=--revision=106
12:46:16 E: + echo '--bootstrap --developer-mode --channel 
ubuntu-touch/devel-proposed'
12:46:16 E: + grep -q '\-\-channel'
12:46:16 E: + adb shell 'echo '\''106:20150210:20150210-95b6a9f
'\'' > /home/phablet/.ci-version'
12:46:16 E: + echo 019d6c35-2240-4e31-8838-a83815c98166
12:46:16 E: + adb push 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/clientlogs/.ci-uuid
 /home/phablet/
12:46:16 E: 0 KB/s (37 bytes in 0.040s)
12:46:16 E: + cat
12:46:16 E: + adb push 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/clientlogs/.ci-flash-args
 /home/phablet/.ci-flash-args
12:46:17 E: 1 KB/s (67 bytes in 0.040s)
12:46:17 E: + echo
12:46:17 E: + adb push 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/clientlogs/.ci-customizations
 /home/phablet/.ci-customizations
12:46:17 E: 0 KB/s (1 bytes in 0.038s)
12:46:17 E: + set_hwclock
12:46:17 O: = Wed Feb 11 12:46:17 UTC 2015: SETTING HWCLOCK TO CURRENT TIME
12:46:17 E: + log 'SETTING HWCLOCK TO CURRENT TIME'
12:46:17 E: ++ date
12:46:17 E: + echo = Wed Feb 11 12:46:17 UTC 2015: SETTING HWCLOCK TO CURRENT 
TIME
12:46:17 E: + adb-shell sudo ntpdate 91.189.94.4
12:46:23 O: 11 Feb 12:46:23 ntpdate[2876]: adjust time server 91.189.94.4 
offset 0.066425 sec
12:46:23 O: ADB_RC=0
12:46:23 E: + adb-shell sudo hwclock -w
12:46:24 O: ADB_RC=0
12:46:24 E: + log 'Current date on device is:'
12:46:24 E: ++ date
12:46:24 O: = Wed Feb 11 12:46:24 UTC 2015: Current date on device is:
12:46:24 E: + echo = Wed Feb 11 12:46:24 UTC 2015: Current date on device is:
12:46:24 E: + adb shell date
12:46:24 O: Wed Feb 11 12:46:24 UTC 2015
12:46:24 E: + log 'Current hwclock on device is:'
12:46:24 E: ++ date
12:46:24 O: = Wed Feb 11 12:46:24 UTC 2015: Current hwclock on device is:
12:46:24 E: + echo = Wed Feb 11 12:46:24 UTC 2015: Current hwclock on device is:
12:46:24 E: + adb shell sudo hwclock
12:46:25 O: Wed 11 Feb 2015 12:46:25 PM UTC  -0.695535 seconds
12:46:25 E: + rm -f adt-commands
12:46:25 E: + echo '(apt-get update || (sleep 15; apt-get update))'
12:46:25 E: + ADT_CMD='timeout 600 adt-run --debug --no-built-binaries'
12:46:25 E: + ADT_VIRT='adt-virt-ssh -s /usr/share/autopkgtest/ssh-setup/adb    
 -- -s JW010053'
12:46:25 E: + ADT_OPTS='--apt-pocket=proposed    --setup-commands=adt-commands  
   --- adt-virt-ssh -s /usr/share/autopkgtest/ssh-setup/adb     -- -s JW010053'
12:46:25 E: + 
FROM=/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../tests/getpkgsrc/debian/tests/getpkgsrc.template
12:46:25 E: + 
TARGET=/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../tests/getpkgsrc/debian/tests/getpkgsrc
12:46:25 E: + sed -e 's/{{ source_package }}/unity-scopes-api/' 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../tests/getpkgsrc/debian/tests/getpkgsrc.template
12:46:25 E: + PKG_SRC_DIR=pkgsrc
12:46:25 E: + rm -fr pkgsrc
12:46:25 E: + set +e
12:46:25 E: + timeout 600 adt-run --debug --no-built-binaries --unbuilt-tree 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../tests/getpkgsrc
 -o pkgsrc --apt-pocket=proposed --setup-commands=adt-commands --- adt-virt-ssh 
-s /usr/share/autopkgtest/ssh-setup/adb -- -s JW010053
12:46:25 E: adt-run: DBG: Parsed options: Namespace(apt_pocket=['proposed'], 
copy=[], gainroot=None, gnupghome='~/.cache/autopkgtest', logfile=None, 
output_dir='pkgsrc', set_lang='C.UTF-8', setup_commands=['adt-commands'], 
shell=False, shell_fail=False, summary=None, timeout_build=100000, 
timeout_copy=300, timeout_factor=1.0, timeout_install=3000, timeout_short=100, 
timeout_test=10000, user=None, verbosity=2)
12:46:25 E: adt-run: DBG: Remaining arguments: ['--no-built-binaries', 
'--unbuilt-tree', 
'/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../tests/getpkgsrc']
12:46:25 E: adt-run: DBG: Interpreted actions: ['--no-built-binaries', 
'--unbuilt-tree', 
'/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../tests/getpkgsrc']
12:46:25 E: adt-run: DBG: Virt runner arguments: ['adt-virt-ssh', '-s', 
'/usr/share/autopkgtest/ssh-setup/adb', '--', '-s', 'JW010053']
12:46:25 E: adt-run: DBG: / tmp(specified) rmtree pkgsrc
12:46:25 E: adt-run: DBG: testbed init
12:46:25 E: adt-run [12:46:25]: version 3.9.4-0~1035~ubuntu14.04.1
12:46:25 E: adt-run: DBG: $ vserver: adt-virt-ssh -s 
/usr/share/autopkgtest/ssh-setup/adb -- -s JW010053
12:46:25 E: adt-run: DBG: got reply from testbed: ok
12:46:25 E: adt-run: DBG: testbed open, scratch=None
12:46:25 E: adt-run: DBG: sending command to testbed: open
12:46:25 E: Waiting for device ADB to appear...
12:46:26 E: Configuring Ubuntu phone for testing...
12:46:27 E: Preparing Ubuntu phone for running tests...
12:46:27 E: Waiting for desktop to boot
12:46:28 E: 9 KB/s (397 bytes in 0.040s)
12:46:28 E: 3 KB/s (143 bytes in 0.040s)
12:46:28 E: ssh_exchange_identification: read: Connection reset by peer
12:46:30 E: ssh_exchange_identification: read: Connection reset by peer
12:46:33 E: Warning: Permanently added '[localhost]:2222' (RSA) to the list of 
known hosts.
12:46:34 E: adt-run: DBG: got reply from testbed: ok /tmp/adt-run.d3o9Xe
12:46:34 E: adt-run: DBG: sending command to testbed: print-execute-command
12:46:35 E: adt-run: DBG: got reply from testbed: ok 
/tmp/adt-virt-ssh.8fnutfuj/runcmd
12:46:35 E: adt-run: DBG: sending command to testbed: capabilities
12:46:35 E: adt-run: DBG: got reply from testbed: ok isolation-machine reboot 
suggested-normal-user=phablet root-on-testbed
12:46:35 E: adt-run: DBG: testbed capabilities: ['isolation-machine', 'reboot', 
'suggested-normal-user=phablet', 'root-on-testbed']
12:46:35 E: adt-run [12:46:35]: @@@@@@@@@@@@@@@@@@@@ test bed setup
12:46:35 E: adt-run: DBG: testbed command ['sh', '-ec', 'awk \'/^deb(-src)? 
.*(ubuntu.com|debian.org|ftpmaster)/ { if ($3 !~ /-/) { $3 = $3"-proposed"; 
print }}\' /etc/apt/sources.list `ls /etc/apt/sources.list.d/*.list 
2>/dev/null|| true`  > /etc/apt/sources.list.d/proposed.list'], kind short, 
sout raw, serr pipe, env ['LANG=C.UTF-8']
12:46:35 E: adt-run: DBG: testbed command exited with code 0
12:46:35 E: adt-run: DBG: testbed command ['bash', '-ec', 'for d in /boot 
/etc/init /etc/init.d /etc/systemd/system /lib/systemd/system; do [ ! -d $d ] 
|| touch -r $d /tmp/adt-run.d3o9Xe/${d//\\//_}.stamp; done'], kind short, sout 
raw, serr pipe, env ['LANG=C.UTF-8']
12:46:36 E: adt-run: DBG: testbed command exited with code 0
12:46:36 E: adt-run: DBG: testbed command ['sh', '-ec', '(apt-get update || 
(sleep 15; apt-get update))'], kind install, sout raw, serr raw, env 
['ADT_NORMAL_USER=phablet', 'DEBIAN_FRONTEND=noninteractive', 
'APT_LISTBUGS_FRONTEND=none', 'LANG=C.UTF-8']
12:46:36 O: Ign http://ports.ubuntu.com vivid InRelease
12:46:36 O: Ign http://ports.ubuntu.com vivid-updates InRelease
12:46:36 O: Ign http://ports.ubuntu.com vivid-security InRelease
12:46:36 O: Ign http://ports.ubuntu.com vivid-proposed InRelease
12:46:36 O: Get:1 http://ports.ubuntu.com vivid Release.gpg [933 B]
12:46:36 O: Get:2 http://ports.ubuntu.com vivid-updates Release.gpg [933 B]
12:46:36 O: Get:3 http://ports.ubuntu.com vivid-security Release.gpg [933 B]
12:46:36 O: Get:4 http://ports.ubuntu.com vivid-proposed Release.gpg [933 B]
12:46:37 O: Get:5 http://ports.ubuntu.com vivid Release [215 kB]
12:46:37 O: Get:6 http://ports.ubuntu.com vivid-updates Release [59.7 kB]
12:46:37 O: Get:7 http://ports.ubuntu.com vivid-security Release [59.7 kB]
12:46:37 O: Get:8 http://ports.ubuntu.com vivid-proposed Release [215 kB]
12:46:38 O: Get:9 http://ports.ubuntu.com vivid/main Sources [1053 kB]
12:46:38 O: Get:10 http://ports.ubuntu.com vivid/restricted Sources [5888 B]
12:46:38 O: Get:11 http://ports.ubuntu.com vivid/universe Sources [7019 kB]
12:46:42 O: Get:12 http://ports.ubuntu.com vivid/main armhf Packages [1315 kB]
12:46:43 O: Get:13 http://ports.ubuntu.com vivid/restricted armhf Packages 
[5003 B]
12:46:43 O: Get:14 http://ports.ubuntu.com vivid/universe armhf Packages [6300 
kB]
12:46:46 O: Get:15 http://ports.ubuntu.com vivid/main Translation-en [779 kB]
12:46:46 O: Hit http://ports.ubuntu.com vivid/restricted Translation-en
12:46:46 O: Get:16 http://ports.ubuntu.com vivid/universe Translation-en [4457 
kB]
12:46:49 O: Get:17 http://ports.ubuntu.com vivid-updates/main Sources [14 B]
12:46:49 O: Get:18 http://ports.ubuntu.com vivid-updates/restricted Sources [14 
B]
12:46:49 O: Get:19 http://ports.ubuntu.com vivid-updates/universe Sources [14 B]
12:46:49 O: Get:20 http://ports.ubuntu.com vivid-updates/main armhf Packages 
[14 B]
12:46:49 O: Get:21 http://ports.ubuntu.com vivid-updates/restricted armhf 
Packages [14 B]
12:46:49 O: Get:22 http://ports.ubuntu.com vivid-updates/universe armhf 
Packages [14 B]
12:46:49 O: Get:23 http://ports.ubuntu.com vivid-updates/main Translation-en 
[14 B]
12:46:49 O: Get:24 http://ports.ubuntu.com vivid-updates/restricted 
Translation-en [14 B]
12:46:50 O: Get:25 http://ports.ubuntu.com vivid-updates/universe 
Translation-en [14 B]
12:46:50 O: Get:26 http://ports.ubuntu.com vivid-security/main Sources [14 B]
12:46:50 O: Get:27 http://ports.ubuntu.com vivid-security/restricted Sources 
[14 B]
12:46:50 O: Get:28 http://ports.ubuntu.com vivid-security/universe Sources [14 
B]
12:46:50 O: Get:29 http://ports.ubuntu.com vivid-security/main armhf Packages 
[14 B]
12:46:50 O: Get:30 http://ports.ubuntu.com vivid-security/restricted armhf 
Packages [14 B]
12:46:50 O: Get:31 http://ports.ubuntu.com vivid-security/universe armhf 
Packages [14 B]
12:46:50 O: Get:32 http://ports.ubuntu.com vivid-security/main Translation-en 
[14 B]
12:46:50 O: Get:33 http://ports.ubuntu.com vivid-security/restricted 
Translation-en [14 B]
12:46:50 O: Get:34 http://ports.ubuntu.com vivid-security/universe 
Translation-en [14 B]
12:46:50 O: Get:35 http://ports.ubuntu.com vivid-proposed/main Sources [24.4 kB]
12:46:50 O: Get:36 http://ports.ubuntu.com vivid-proposed/restricted Sources 
[28 B]
12:46:51 O: Get:37 http://ports.ubuntu.com vivid-proposed/universe Sources [107 
kB]
12:46:51 O: Get:38 http://ports.ubuntu.com vivid-proposed/main armhf Packages 
[37.8 kB]
12:46:51 O: Get:39 http://ports.ubuntu.com vivid-proposed/restricted armhf 
Packages [28 B]
12:46:51 O: Get:40 http://ports.ubuntu.com vivid-proposed/universe armhf 
Packages [103 kB]
12:46:51 O: Get:41 http://ports.ubuntu.com vivid-proposed/main Translation-en 
[17.2 kB]
12:46:51 O: Get:42 http://ports.ubuntu.com vivid-proposed/restricted 
Translation-en [28 B]
12:46:51 O: Get:43 http://ports.ubuntu.com vivid-proposed/universe 
Translation-en [69.0 kB]
12:47:23 O: Fetched 21.8 MB in 47s (460 kB/s)
12:47:39 O: Reading package lists...
12:47:39 E: adt-run: DBG: testbed command exited with code 0
12:47:39 E: adt-run: DBG: testbed command ['bash', '-ec', '[ ! -e 
/run/autopkgtest_no_reboot.stamp ] || exit 0;for d in /boot /etc/init 
/etc/init.d /etc/systemd/system /lib/systemd/system; do 
s=/tmp/adt-run.d3o9Xe/${d//\\//_}.stamp;  [ ! -d $d ] || [ `stat -c %Y $d` = 
`stat -c %Y $s` ]; done'], kind short, sout raw, serr raw, env ['LANG=C.UTF-8']
12:47:39 E: adt-run: DBG: testbed command exited with code 0
12:47:39 E: adt-run: DBG: testbed command ['dpkg', '--print-architecture'], 
kind short, sout pipe, serr pipe, env ['LANG=C.UTF-8']
12:47:40 E: adt-run: DBG: testbed command exited with code 0
12:47:40 E: adt-run [12:47:40]: testbed dpkg architecture: armhf
12:47:40 E: adt-run: DBG: testbed command ['sh', '-ec', "dpkg-query --show -f 
'${Package}\\t${Version}\\n' > /tmp/adt-run.d3o9Xe/testbed-packages"], kind 
short, sout raw, serr pipe, env ['LANG=C.UTF-8']
12:47:40 E: adt-run: DBG: testbed command exited with code 0
12:47:40 E: adt-run: DBG: sending command to testbed: copyup 
/tmp/adt-run.d3o9Xe/testbed-packages pkgsrc/testbed-packages
12:47:41 E: adt-run: DBG: got reply from testbed: ok
12:47:41 E: adt-run: DBG: testbed supports reboot, creating 
/tmp/autopkgtest-reboot
12:47:41 E: adt-run: DBG: testbed command ['sh', '-ecC', '[ ! -e 
/tmp/autopkgtest-reboot ] || exit 0; /bin/echo -e \'#!/bin/sh -e\\n[ -n "$1" ] 
|| { echo "Usage: $0 <mark>" >&2; exit 1; }\\necho "$1" > 
/run/autopkgtest-reboot-mark\\nkill -KILL $PPID\\n\' > 
/tmp/autopkgtest-reboot;chmod 755 /tmp/autopkgtest-reboot;[ -L 
/sbin/autopkgtest-reboot ] || ln -s   /tmp/autopkgtest-reboot 
/sbin/autopkgtest-reboot'], kind short, sout raw, serr raw, env ['LANG=C.UTF-8']
12:47:41 E: adt-run: DBG: testbed command exited with code 0
12:47:41 E: adt-run: DBG: Binaries: initialising
12:47:41 E: adt-run: DBG: Binaries: reset
12:47:41 E: adt-run: DBG: / binaries rmtree pkgsrc/binaries
12:47:41 E: adt-run [12:47:41]: @@@@@@@@@@@@@@@@@@@@ unbuilt-tree 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../tests/getpkgsrc
12:47:41 E: adt-run: DBG: blame += 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../tests/getpkgsrc
12:47:41 E: adt-run: DBG: testbed reset: modified=False, deps_installed=[](r: 
False), deps_new=[](r: False)
12:47:41 E: adt-run: DBG: testbed command ['mkdir', '-p', 
'/tmp/adt-run.d3o9Xe'], kind short, sout raw, serr pipe, env ['LANG=C.UTF-8']
12:47:41 E: adt-run: DBG: testbed command exited with code 0
12:47:41 E: adt-run: DBG: sending command to testbed: copydown 
/var/lib/jenkins/slaves/krillin-09/workspace/vivid-boottest-unity-scopes-api/test-runner/scripts/../tests/getpkgsrc/
 /tmp/adt-run.d3o9Xe/ubtree-getpkgsrc/
12:47:42 E: adt-run: DBG: got reply from testbed: ok
12:47:42 E: adt-run: DBG: testbed command ['chown', '-R', 'phablet', '--', 
'/tmp/adt-run.d3o9Xe/ubtree-getpkgsrc'], kind short, sout raw, serr pipe, env 
['LANG=C.UTF-8']
12:47:42 E: adt-run: DBG: testbed command exited with code 0
12:47:42 E: adt-run: DBG: testbed command ['sh', '-ec', 'su --shell=/bin/sh 
phablet -c \'set -e; exec 3>&1 >&2; set -x; cd .; builddir=$(mktemp -d 
/tmp/adt-run.d3o9Xe/build.XXX); cd $builddir; cp -rd --preserve=timestamps -- 
"/tmp/adt-run.d3o9Xe/ubtree-getpkgsrc" real-tree; chmod -R a+rX .; cd 
[a-z0-9]*/.; pwd >&3; sed -n "1 {s/).*//; s/ (/\\n/; p}" debian/changelog >&3; 
set +e; grep -q "^Restrictions:.*\\bbuild-needed\\b" debian/tests/control 
2>/dev/null; echo $? >&3\''], kind build, sout pipe, serr raw, env 
['LANG=C.UTF-8']
12:47:42 E: + cd .
12:47:42 E: + mktemp -d /tmp/adt-run.d3o9Xe/build.XXX
12:47:42 E: + builddir=/tmp/adt-run.d3o9Xe/build.JDt
12:47:42 E: + cd /tmp/adt-run.d3o9Xe/build.JDt
12:47:42 E: + cp -rd --preserve=timestamps -- 
/tmp/adt-run.d3o9Xe/ubtree-getpkgsrc real-tree
12:47:42 E: + chmod -R a+rX .
12:47:42 E: + cd real-tree/.
12:47:42 E: + pwd
12:47:42 E: + sed -n 1 {s/).*//; s/ (/\n/; p} debian/changelog
12:47:42 E: + set +e
12:47:42 E: + grep -q ^Restrictions:.*\bbuild-needed\b debian/tests/control
12:47:42 E: + echo 1
12:47:42 E: adt-run: DBG: testbed command exited with code 0
12:47:42 E: adt-run [12:47:42]: testing package getpkgsrc version 0.1
12:47:42 E: adt-run [12:47:42]: build not needed
12:47:42 E: adt-run: DBG: sending command to testbed: copyup 
/tmp/adt-run.d3o9Xe/build.JDt/real-tree/ pkgsrc/tests-tree/
12:47:43 E: adt-run: DBG: got reply from testbed: ok
12:47:43 E: adt-run: DBG: processing dependency dpkg-dev
12:47:43 E: adt-run: DBG: Test defined: name getpkgsrc path 
debian/tests/getpkgsrc command "None" restrictions [] features [] depends 
['dpkg-dev'] clicks [] installed clicks []
12:47:43 E: adt-run [12:47:43]: test getpkgsrc: preparing
12:47:43 E: adt-run: DBG: testbed reset: modified=False, deps_installed=[](r: 
False), deps_new=['dpkg-dev'](r: False)
12:47:43 E: adt-run: DBG: install_deps: deps_new=['dpkg-dev'], recommends=False
12:47:43 E: adt-run: DBG: Binaries: publish
12:47:43 E: adt-run: DBG: Binaries: no registered binaries, not publishing 
anything
12:47:43 E: adt-run: DBG: install-deps: satisfying dpkg-dev
12:47:43 E: adt-run: DBG: install-deps: architecture resolved: dpkg-dev
12:47:43 E: adt-run: DBG: testbed command ['test', '-w', 
'/var/lib/dpkg/status'], kind short, sout raw, serr raw, env ['LANG=C.UTF-8']
12:47:43 E: adt-run: DBG: testbed command exited with code 0
12:47:43 E: adt-run: DBG: can use apt-get on testbed: True
12:47:43 E: adt-run: DBG: testbed command ['mkdir', '-p', 
'/tmp/adt-run.d3o9Xe'], kind short, sout raw, serr pipe, env ['LANG=C.UTF-8']
12:47:44 E: adt-run: DBG: testbed command exited with code 0
12:47:44 E: adt-run: DBG: sending command to testbed: copydown 
pkgsrc/adt-satdep.deb /tmp/adt-run.d3o9Xe/adt-satdep.deb
12:47:44 E: adt-run: DBG: got reply from testbed: ok
12:47:44 E: adt-run: DBG: testbed command ['chown', '-R', 'phablet', '--', 
'/tmp/adt-run.d3o9Xe/adt-satdep.deb'], kind short, sout raw, serr pipe, env 
['LANG=C.UTF-8']
12:47:44 E: adt-run: DBG: testbed command exited with code 0
12:47:44 E: adt-run: DBG: testbed command ['dpkg', '--unpack', 
'/tmp/adt-run.d3o9Xe/adt-satdep.deb'], kind short, sout pipe, serr pipe, env 
['LANG=C.UTF-8']
12:47:45 E: adt-run: DBG: testbed command exited with code 0
12:47:45 E: adt-run: DBG: testbed command ['apt-get', 'install', '--quiet', 
'--quiet', '--assume-yes', '--fix-broken', '-o', 
'APT::Install-Recommends=False', '-o', 'Debug::pkgProblemResolver=true'], kind 
install, sout raw, serr raw, env ['DEBIAN_FRONTEND=noninteractive', 
'APT_LISTBUGS_FRONTEND=none', 'LANG=C.UTF-8']
12:47:48 E: Starting pkgProblemResolver with broken count: 0
12:47:49 E: Starting 2 pkgProblemResolver with broken count: 0
12:47:49 E: Done
12:47:49 E: Starting pkgProblemResolver with broken count: 0
12:47:49 E: Starting 2 pkgProblemResolver with broken count: 0
12:47:49 E: Done
12:47:55 O: Selecting previously unselected package perl-modules.
12:47:55 O: (Reading database ... 40767 files and directories currently 
installed.)
12:47:55 O: Preparing to unpack .../perl-modules_5.20.1-5_all.deb ...
12:47:55 O: Unpacking perl-modules (5.20.1-5) ...
12:48:00 O: Selecting previously unselected package libgdbm3:armhf.
12:48:01 O: Preparing to unpack .../libgdbm3_1.8.3-13.1_armhf.deb ...
12:48:01 O: Unpacking libgdbm3:armhf (1.8.3-13.1) ...
12:48:01 O: Selecting previously unselected package perl.
12:48:01 O: Preparing to unpack .../perl_5.20.1-5_armhf.deb ...
12:48:01 O: Unpacking perl (5.20.1-5) ...
12:48:06 O: Selecting previously unselected package libtimedate-perl.
12:48:06 O: Preparing to unpack .../libtimedate-perl_2.3000-2_all.deb ...
12:48:06 O: Unpacking libtimedate-perl (2.3000-2) ...
12:48:06 O: Selecting previously unselected package libdpkg-perl.
12:48:06 O: Preparing to unpack .../libdpkg-perl_1.17.23ubuntu1_all.deb ...
12:48:06 O: Unpacking libdpkg-perl (1.17.23ubuntu1) ...
12:48:06 O: Selecting previously unselected package patch.
12:48:06 O: Preparing to unpack .../patch_2.7.4-1_armhf.deb ...
12:48:06 O: Unpacking patch (2.7.4-1) ...
12:48:06 O: Selecting previously unselected package make.
12:48:06 O: Preparing to unpack .../make_4.0-8.1_armhf.deb ...
12:48:06 O: Unpacking make (4.0-8.1) ...
12:48:07 O: Selecting previously unselected package binutils.
12:48:07 O: Preparing to unpack .../binutils_2.25-2ubuntu2_armhf.deb ...
12:48:07 O: Unpacking binutils (2.25-2ubuntu2) ...
12:48:08 O: Selecting previously unselected package dpkg-dev.
12:48:08 O: Preparing to unpack .../dpkg-dev_1.17.23ubuntu1_all.deb ...
12:48:08 O: Unpacking dpkg-dev (1.17.23ubuntu1) ...
12:48:10 O: Setting up libgdbm3:armhf (1.8.3-13.1) ...
12:48:10 O: Setting up patch (2.7.4-1) ...
12:48:10 O: Setting up make (4.0-8.1) ...
12:48:10 O: Setting up binutils (2.25-2ubuntu2) ...
12:48:10 O: Setting up perl-modules (5.20.1-5) ...
12:48:10 O: Setting up perl (5.20.1-5) ...
12:48:10 O: update-alternatives: using /usr/bin/prename to provide 
/usr/bin/rename (rename) in auto mode
12:48:10 O: Setting up libtimedate-perl (2.3000-2) ...
12:48:10 O: Setting up libdpkg-perl (1.17.23ubuntu1) ...
12:48:10 O: Setting up dpkg-dev (1.17.23ubuntu1) ...
12:48:10 O: Setting up adt-satdep (0) ...
12:48:10 O: Processing triggers for libc-bin (2.19-13ubuntu3) ...
12:48:13 E: adt-run: DBG: testbed command exited with code 0
12:48:13 E: adt-run: DBG: testbed command ['dpkg', '--status', 'adt-satdep'], 
kind short, sout pipe, serr pipe, env ['LANG=C.UTF-8']
12:48:13 E: adt-run: DBG: testbed command exited with code 0
12:48:13 E: adt-run: DBG: testbed command ['dpkg', '--purge', 'adt-satdep'], 
kind short, sout raw, serr raw, env ['LANG=C.UTF-8']
12:48:14 O: (Reading database ... 42531 files and directories currently 
installed.)
12:48:14 O: Removing adt-satdep (0) ...
12:48:14 E: adt-run: DBG: testbed command exited with code 0
12:48:14 E: adt-run: DBG: testbed command ['sh', '-ec', "dpkg-query --show -f 
'${Package}\\t${Version}\\n' > /tmp/adt-run.d3o9Xe/getpkgsrc-packages.all"], 
kind short, sout raw, serr pipe, env ['LANG=C.UTF-8']
12:48:14 E: adt-run: DBG: testbed command exited with code 0
12:48:14 E: adt-run: DBG: sending command to testbed: copyup 
/tmp/adt-run.d3o9Xe/getpkgsrc-packages.all pkgsrc/getpkgsrc-packages.all
12:48:15 E: adt-run: DBG: got reply from testbed: ok
12:48:15 E: adt-run: DBG: testbed command ['test', '-e', 
'/tmp/adt-run.d3o9Xe/build.JDt/real-tree'], kind short, sout raw, serr raw, env 
['LANG=C.UTF-8']
12:48:15 E: adt-run: DBG: testbed command exited with code 0
12:48:15 E: adt-run: DBG: copydown: tb path 
/tmp/adt-run.d3o9Xe/build.JDt/real-tree already exists
12:48:15 E: adt-run [12:48:15]: test getpkgsrc: [-----------------------
12:48:15 E: adt-run: DBG: testbed command ['su', '-s', '/bin/bash', 'phablet', 
'-c', 'set -e; export USER=`id -nu`; . /etc/profile >/dev/null 2>&1 || true;  . 
~/.profile >/dev/null 2>&1 || true; 
buildtree="/tmp/adt-run.d3o9Xe/build.JDt/real-tree"; mkdir -p -m 1777 -- 
"/tmp/adt-run.d3o9Xe/getpkgsrc-artifacts"; export 
ADT_ARTIFACTS="/tmp/adt-run.d3o9Xe/getpkgsrc-artifacts"; export ADTTMP=$(mktemp 
-d --tmpdir adttmp.XXXXXX); trap "rm -rf $ADTTMP" EXIT INT QUIT PIPE; chmod 755 
$ADTTMP; cd "$buildtree"; export LANG=C.UTF-8; chmod +x 
/tmp/adt-run.d3o9Xe/build.JDt/real-tree/debian/tests/getpkgsrc; touch 
/tmp/adt-run.d3o9Xe/getpkgsrc-stdout /tmp/adt-run.d3o9Xe/getpkgsrc-stderr; 
/tmp/adt-run.d3o9Xe/build.JDt/real-tree/debian/tests/getpkgsrc 2> >(tee -a 
/tmp/adt-run.d3o9Xe/getpkgsrc-stderr >&2) > >(tee -a 
/tmp/adt-run.d3o9Xe/getpkgsrc-stdout); '], kind test, sout raw, serr raw, env 
['LANG=C.UTF-8']
12:48:16 O: Reading package lists...
12:48:16 O: Building dependency tree...
12:48:16 O: Reading state information...
12:48:17 O: NOTICE: 'unity-scopes-api' packaging is maintained in the 'Bzr' 
version control system at:
12:48:17 O: lp:unity-scopes-api
12:48:17 O: Please use:
12:48:17 O: bzr branch lp:unity-scopes-api
12:48:17 O: to retrieve the latest (possibly unreleased) updates to the package.
12:48:17 O: Need to get 636 kB of source archives.
12:48:17 O: Get:1 http://ports.ubuntu.com/ubuntu-ports/ vivid-proposed/universe 
unity-scopes-api 0.6.13+15.04.20150211-0ubuntu1 (dsc) [2964 B]
12:48:17 O: Get:2 http://ports.ubuntu.com/ubuntu-ports/ vivid-proposed/universe 
unity-scopes-api 0.6.13+15.04.20150211-0ubuntu1 (tar) [605 kB]
12:48:18 O: Get:3 http://ports.ubuntu.com/ubuntu-ports/ vivid-proposed/universe 
unity-scopes-api 0.6.13+15.04.20150211-0ubuntu1 (diff) [27.2 kB]
12:48:19 O: dpkg-source: info: extracting unity-scopes-api in 
unity-scopes-api-0.6.13+15.04.20150211
12:48:19 O: dpkg-source: info: unpacking 
unity-scopes-api_0.6.13+15.04.20150211.orig.tar.gz
12:48:19 O: dpkg-source: info: applying 
unity-scopes-api_0.6.13+15.04.20150211-0ubuntu1.diff.gz
12:48:19 O: Fetched 636 kB in 1s (523 kB/s)
12:48:19 E: adt-run: DBG: testbed command exited with code 0
12:48:20 E: adt-run [12:48:20]: test getpkgsrc: -----------------------]
12:48:20 E: adt-run: DBG: testbed executing test finished with exit status 0
12:48:20 E: adt-run: DBG: sending command to testbed: copyup 
/tmp/adt-run.d3o9Xe/getpkgsrc-stdout pkgsrc/getpkgsrc-stdout
12:48:20 E: adt-run: DBG: got reply from testbed: ok
12:48:20 E: adt-run: DBG: sending command to testbed: copyup 
/tmp/adt-run.d3o9Xe/getpkgsrc-stderr pkgsrc/getpkgsrc-stderr
12:48:21 E: adt-run: DBG: got reply from testbed: ok
12:48:21 E: adt-run [12:48:21]: test getpkgsrc:  - - - - - - - - - - results - 
- - - - - - - - -
12:48:21 O: getpkgsrc            PASS
12:48:21 E: adt-run: DBG: sending command to testbed: copyup 
/tmp/adt-run.d3o9Xe/getpkgsrc-artifacts/ pkgsrc/artifacts/
12:48:23 E: tar: Skipping to next header
12:48:23 E: tar: Exiting with failure status due to previous errors
12:48:24 E: Exit request sent.
12:48:24 E: Unexpected cleanup error:
12:48:24 E: Traceback (most recent call last):
12:48:24 E:   File "/usr/share/autopkgtest/python/VirtSubproc.py", line 676, in 
mainloop
12:48:24 E:     command()
12:48:24 E:   File "/usr/share/autopkgtest/python/VirtSubproc.py", line 614, in 
command
12:48:24 E:     r = f(c, ce)
12:48:24 E:   File "/usr/share/autopkgtest/python/VirtSubproc.py", line 560, in 
cmd_copyup
12:48:24 E:     copyupdown(c, ce, True)
12:48:24 E:   File "/usr/share/autopkgtest/python/VirtSubproc.py", line 447, in 
copyupdown
12:48:24 E:     copyupdown_internal(ce[0], c[1:], upp)
12:48:24 E:   File "/usr/share/autopkgtest/python/VirtSubproc.py", line 546, in 
copyupdown_internal
12:48:24 E:     (wh, ['source', 'destination'][sdn], status))
12:48:24 E:   File "/usr/share/autopkgtest/python/VirtSubproc.py", line 84, in 
bomb
12:48:24 E:     raise Quit(12, progname + ": failure: %s" % m)
12:48:24 E: VirtSubproc.Quit: (12, '<VirtSubproc>: failure: copyup destination 
failed, status 2')
12:48:24 E: 
12:48:24 E: During handling of the above exception, another exception occurred:
12:48:24 E: 
12:48:24 E: Traceback (most recent call last):
12:48:24 E:   File "/usr/share/autopkgtest/python/VirtSubproc.py", line 648, in 
error_cleanup
12:48:24 E:     cleanup()
12:48:24 E:   File "/usr/share/autopkgtest/python/VirtSubproc.py", line 639, in 
cleanup
12:48:24 E:     caller.hook_cleanup()
12:48:24 E:   File "/usr/bin/adt-virt-ssh", line 418, in hook_cleanup
12:48:24 E:     shutil.rmtree(workdir)
12:48:24 E:   File "/usr/lib/python3.4/shutil.py", line 463, in rmtree
12:48:24 E:     _rmtree_safe_fd(fd, path, onerror)
12:48:24 E:   File "/usr/lib/python3.4/shutil.py", line 421, in _rmtree_safe_fd
12:48:24 E:     onerror(os.unlink, fullname, sys.exc_info())
12:48:24 E:   File "/usr/lib/python3.4/shutil.py", line 419, in _rmtree_safe_fd
12:48:24 E:     os.unlink(name, dir_fd=topfd)
12:48:24 E: FileNotFoundError: [Errno 2] No such file or directory: 
'ssh_control-phablet@localhost:2222'
12:48:24 E: 
12:48:24 E: while cleaning up because of another error:
12:48:24 E: <VirtSubproc>: failure: copyup destination failed, status 2
12:48:24 E: adt-run: DBG: bomb unexpected eof from the testbed
12:48:24 E: adt-run: DBG: testbed stop
12:48:24 E: adt-run: DBG: testbed close, scratch=/tmp/adt-run.d3o9Xe
12:48:24 E: adt-run: DBG: sending command to testbed: close
12:48:24 E: adt-run: DBG: bomb cannot send to testbed: ['BrokenPipeError: 
[Errno 32] Broken pipe\n']
12:48:24 E: adt-run: DBG: testbed stop
12:48:24 E: adt-run [12:48:24]: ERROR: testbed failed: cannot send to testbed: 
['BrokenPipeError: [Errno 32] Broken pipe\n']
12:48:24 E: adt-run: DBG: testbed stop
12:48:24 E: adt-run: DBG: / tests-tree rmtree pkgsrc/tests-tree

-- 
You received this bug notification because you are a member of Ubuntu
Bugs, which is subscribed to Ubuntu.
https://bugs.launchpad.net/bugs/1384706

Title:
  tar: Unexpected EOF in archive in copyup()

To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/autopkgtest/+bug/1384706/+subscriptions

-- 
ubuntu-bugs mailing list
ubuntu-bugs@lists.ubuntu.com
https://lists.ubuntu.com/mailman/listinfo/ubuntu-bugs

Reply via email to