2020-07-21 19:11:02 Z flight 152084 intended commission-sabro branch xen-unstable 
2020-07-21 19:11:02 Z job 152084.test-amd64-amd64-xl-pvhv2-amd recipe test-debian 
2020-07-21 19:11:02 Z hostalloc_maxwait_starvation: A=1 B=1.81295229035573 C=1.3 I=3600 L=198.7 Xh=200 Xt=5 
HID host FLAGS arch-amd64 arch-xen-amd64 suite-buster purpose-test hvm-amd
HID host FLAG arch-amd64
HID host FLAG arch-xen-amd64
HID host FLAG suite-buster
HID host FLAG purpose-test
HID host FLAG hvm-amd
HID host FLAGS arch-amd64,arch-xen-amd64,hvm-amd,purpose-test,suite-buster + 0 host conditions(s)
2020-07-21 19:11:02 Z resource allocation: starting... 
2020-07-21 19:11:02 Z resource allocation: awaiting our slot... 
2020-07-21 19:12:51 Z resource allocation: obtained base plan. 
base plan = {"Events":{"host albana0":[{"Avail":0,"Type":"Start","Job":"152067.test-amd64-i386-qemut-rhel6hvm-intel","Time":-828},{"Time":1452,"Type":"End","Job":"152067.test-amd64-i386-qemut-rhel6hvm-intel","Avail":1}],"host godello1":[{"Type":"Start","Job":"152070.test-amd64-amd64-xl-credit1","Avail":0,"Time":-333},{"Time":1806,"Avail":1,"Type":"End","Job":"152070.test-amd64-amd64-xl-credit1"}],"host rochester1":[{"Time":-1685,"Avail":0,"Job":"152076.test-arm64-arm64-xl-thunderx","Type":"Start"},{"Job":"152076.test-arm64-arm64-xl-thunderx","Type":"End","Avail":1,"Time":1253}],"host baroque1":[{"Time":0,"PreviousShare":{"Type":"build-stretch-amd64 0d5a2af3e06176c2acd52b3bd16b9dd07bc713db","Shares":3,"Wear":1},"Avail":1,"Type":"Unshare"}],"host cubietruck-metzinger":[{"Time":-1685,"Avail":0,"Type":"Start","Job":"152070.test-armhf-armhf-libvirt"},{"Type":"End","Job":"152070.test-armhf-armhf-libvirt","Avail":1,"Time":4863}],"host sabro1":[{"Time":-333,"Share":{"Type":"build-buster-amd64 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":"3","Wear":1},"Type":"Start","Job":"152084.build-amd64-libvirt","Avail":2},{"Time":-121,"Share":{"Wear":2,"Shares":"3","Type":"build-buster-amd64 51beb950a48fbd5547d1e4f90ce9d78f136f4955"},"Job":"152084.build-amd64-prev","Type":"Start","Avail":1},{"Avail":0,"Job":"152084.build-armhf-pvops","Type":"Start","Share":{"Wear":3,"Type":"build-buster-amd64 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":"3"},"Time":0},{"Share":{"Shares":3,"Type":"build-buster-amd64 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Wear":3},"Time":4677,"Avail":1,"Type":"End","Job":"152084.build-amd64-libvirt"},{"Time":4889,"Share":{"Wear":3,"Type":"build-buster-amd64 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":3},"Job":"152084.build-amd64-prev","Type":"End","Avail":2},{"Share":{"Wear":3,"Shares":3,"Type":"build-buster-amd64 51beb950a48fbd5547d1e4f90ce9d78f136f4955"},"Time":5010,"Avail":3,"Type":"End","Job":"152084.build-armhf-pvops"},{"Time":5010,"Type":"Unshare","PreviousShare":{"Wear":3,"Shares":"3","Type":"build-buster-amd64 51beb950a48fbd5547d1e4f90ce9d78f136f4955"},"Avail":1},{"Time":9366,"Type":"Start","Job":"152084.test-amd64-amd64-pair","Avail":0},{"Job":"152084.test-amd64-amd64-pair","Type":"End","Avail":1,"Time":14376},{"Time":14376,"Job":"152084.test-xtf-amd64-amd64-2","Type":"Start","Avail":0},{"Avail":1,"Type":"End","Job":"152084.test-xtf-amd64-amd64-2","Time":19386},{"Avail":0,"Type":"Start","Job":"152084.test-amd64-amd64-dom0pvh-xl-intel","Time":19386},{"Time":24396,"Type":"End","Job":"152084.test-amd64-amd64-dom0pvh-xl-intel","Avail":1},{"Time":24396,"Type":"Start","Job":"152084.test-amd64-amd64-livepatch","Avail":0},{"Avail":1,"Type":"End","Job":"152084.test-amd64-amd64-livepatch","Time":29406},{"Time":29406,"Job":"152084.test-amd64-amd64-pygrub","Type":"Start","Avail":0},{"Job":"152084.test-amd64-amd64-pygrub","Type":"End","Avail":1,"Time":34416},{"Time":34416,"Avail":0,"Job":"152084.test-amd64-amd64-xl","Type":"Start"},{"Time":39426,"Job":"152084.test-amd64-amd64-xl","Type":"End","Avail":1},{"Avail":0,"Job":"152084.test-amd64-amd64-xl-pvhv2-intel","Type":"Start","Time":39426},{"Time":44436,"Job":"152084.test-amd64-amd64-xl-pvhv2-intel","Type":"End","Avail":1},{"Time":44436,"Job":"152084.test-amd64-amd64-xl-credit2","Type":"Start","Avail":0},{"Time":49446,"Avail":1,"Type":"End","Job":"152084.test-amd64-amd64-xl-credit2"}],"host cubietruck-gleizes":[{"Time":-1685,"Job":"152070.test-armhf-armhf-xl-cubietruck","Type":"Start","Avail":0},{"Avail":1,"Type":"End","Job":"152070.test-armhf-armhf-xl-cubietruck","Time":2376}],"host huxelrebe0":[{"Time":-333,"Avail":0,"Job":"152067.test-amd64-i386-xl-qemuu-debianhvm-amd64-shadow","Type":"Start"},{"Time":2508,"Avail":1,"Job":"152067.test-amd64-i386-xl-qemuu-debianhvm-amd64-shadow","Type":"End"}],"host arndale-metrocentre":[{"Avail":0,"Job":"152070.test-armhf-armhf-libvirt-raw","Type":"Start","Time":-1685},{"Job":"152070.test-armhf-armhf-libvirt-raw","Type":"End","Avail":1,"Time":2655}],"host arndale-lakeside":[{"Time":-1685,"Job":"152070.test-armhf-armhf-xl","Type":"Start","Avail":0},{"Avail":1,"Job":"152070.test-armhf-armhf-xl","Type":"End","Time":1395}],"host fiano1":[{"Time":-1685,"Type":"Start","Job":"152067.test-amd64-i386-qemuu-rhel6hvm-intel","Avail":0},{"Avail":1,"Type":"End","Job":"152067.test-amd64-i386-qemuu-rhel6hvm-intel","Time":915}],"host italia1":[{"PreviousShare":{"Type":"build-stretch-amd64 0d5a2af3e06176c2acd52b3bd16b9dd07bc713db","Shares":3,"Wear":1},"Avail":1,"Type":"Unshare","Time":0}],"host cubietruck-braque":[{"Job":"152077.test-armhf-armhf-xl","Type":"Start","Avail":0,"Time":-3876},{"Avail":1,"Job":"152077.test-armhf-armhf-xl","Type":"End","Time":485}],"host chardonnay0":[{"Time":-654,"Avail":0,"Job":"152067.test-amd64-i386-xl-qemuu-debianhvm-i386-xsm","Type":"Start"},{"Time":3079,"Avail":1,"Type":"End","Job":"152067.test-amd64-i386-xl-qemuu-debianhvm-i386-xsm"}],"host huxelrebe1":[{"Job":"152067.test-amd64-i386-xl-qemut-ws16-amd64","Type":"Start","Avail":0,"Time":-1953},{"Time":2218,"Avail":1,"Job":"152067.test-amd64-i386-xl-qemut-ws16-amd64","Type":"End"}],"host merlot0":[{"PreviousShare":{"Wear":1,"Shares":3,"Type":"build-stretch-i386 77541f2c768a763b1373fc3d4ef2614e14041ab6"},"Avail":1,"Type":"Unshare","Time":0}],"host laxton1":[{"Time":-1685,"Type":"Start","Job":"152076.test-arm64-arm64-xl-credit1","Avail":0},{"Avail":1,"Type":"End","Job":"152076.test-arm64-arm64-xl-credit1","Time":570}],"host arndale-bluewater":[{"Avail":0,"Type":"Start","Job":"152070.test-armhf-armhf-examine","Time":-1685},{"Avail":1,"Job":"152070.test-armhf-armhf-examine","Type":"End","Time":15}],"host cubietruck-picasso":[{"Type":"Start","Job":"152070.test-armhf-armhf-xl-rtds","Avail":0,"Time":-1685},{"Type":"End","Job":"152070.test-armhf-armhf-xl-rtds","Avail":1,"Time":9443}],"host chardonnay1":[{"Avail":0,"Job":"152067.test-amd64-i386-xl-pvshim","Type":"Start","Time":-608},{"Time":931,"Type":"End","Job":"152067.test-amd64-i386-xl-pvshim","Avail":1}],"host laxton0":[{"Time":-1685,"Share":{"Wear":1,"Shares":"3","Type":"build-buster-arm64 51beb950a48fbd5547d1e4f90ce9d78f136f4955"},"Job":"152081.build-arm64-xsm","Type":"Start","Avail":2},{"Share":{"Wear":2,"Shares":"3","Type":"build-buster-arm64 51beb950a48fbd5547d1e4f90ce9d78f136f4955"},"Time":-1173,"Avail":1,"Type":"Start"},{"Avail":0,"Type":"Start","Share":{"Wear":3,"Shares":"3","Type":"build-buster-arm64 51beb950a48fbd5547d1e4f90ce9d78f136f4955"},"Time":-1173},{"Type":"End","Avail":1,"Time":1000,"Share":{"Wear":3,"Type":"build-buster-arm64 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":3}},{"Avail":2,"Type":"End","Share":{"Type":"build-buster-arm64 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":3,"Wear":3},"Time":1000},{"Time":3555,"Share":{"Wear":3,"Type":"build-buster-arm64 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":3},"Type":"End","Job":"152081.build-arm64-xsm","Avail":3},{"Avail":1,"PreviousShare":{"Shares":"3","Type":"build-buster-arm64 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Wear":3},"Type":"Unshare","Time":3555}],"host rimava1":[{"Job":"152067.test-amd64-amd64-qemuu-nested-amd","Type":"Start","Avail":0,"Time":-2073},{"Time":5023,"Job":"152067.test-amd64-amd64-qemuu-nested-amd","Type":"End","Avail":1}],"host rochester0":[{"Time":-1685,"Job":"152076.test-arm64-arm64-libvirt-xsm","Type":"Start","Avail":0},{"Type":"End","Job":"152076.test-arm64-arm64-libvirt-xsm","Avail":1,"Time":1519}],"host merlot1":[{"Type":"Unshare","Avail":1,"PreviousShare":{"Wear":1,"Shares":3,"Type":"build-stretch-i386 77541f2c768a763b1373fc3d4ef2614e14041ab6"},"Time":0}],"host arndale-westfield":[{"Type":"Start","Job":"152070.test-armhf-armhf-xl-arndale","Avail":0,"Time":-1685},{"Job":"152070.test-armhf-armhf-xl-arndale","Type":"End","Avail":1,"Time":1422}],"host elbling1":[{"Job":"152067.test-amd64-i386-xl","Type":"Start","Avail":0,"Time":-2744},{"Job":"152067.test-amd64-i386-xl","Type":"End","Avail":1,"Time":211}],"host debina1":[{"Type":"Start","Avail":0,"Time":-441447},{"Avail":1,"Type":"End","Time":1977753}],"host elbling0":[{"Time":-2744,"Avail":0,"Type":"Start","Job":"152067.test-amd64-amd64-libvirt"},{"Time":250,"Avail":1,"Type":"End","Job":"152067.test-amd64-amd64-libvirt"}],"host sabro0":[{"Time":-654,"Share":{"Wear":1,"Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":"3"},"Type":"Start","Job":"152084.build-i386","Avail":2},{"Type":"Start","Avail":1,"Time":-608,"Share":{"Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":"3","Wear":2}},{"Type":"Start","Avail":0,"Time":-608,"Share":{"Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":"3","Wear":3}},{"Time":1000,"Share":{"Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":3,"Wear":3},"Type":"End","Avail":1},{"Share":{"Wear":3,"Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":3},"Time":1000,"Avail":2,"Type":"End"},{"Share":{"Wear":4,"Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":"3"},"Time":1000,"Avail":1,"Type":"Start","Job":"152084.build-i386-prev"},{"Type":"Start","Job":"152084.build-i386-pvops","Avail":0,"Time":1000,"Share":{"Wear":5,"Shares":"3","Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955"}},{"Avail":1,"Type":"End","Job":"152084.build-i386","Share":{"Wear":5,"Shares":3,"Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955"},"Time":4356},{"Time":4356,"Share":{"Wear":6,"Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":"3"},"Type":"Start","Job":"152084.build-i386-xsm","Avail":0},{"Time":6010,"Share":{"Wear":6,"Shares":3,"Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955"},"Type":"End","Job":"152084.build-i386-prev","Avail":1},{"Job":"152084.build-i386-pvops","Type":"End","Avail":2,"Time":6010,"Share":{"Wear":6,"Shares":3,"Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955"}},{"Share":{"Shares":3,"Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Wear":6},"Time":9366,"Avail":3,"Type":"End","Job":"152084.build-i386-xsm"},{"Time":9366,"PreviousShare":{"Type":"build-buster-i386 51beb950a48fbd5547d1e4f90ce9d78f136f4955","Shares":"3","Wear":6},"Avail":1,"Type":"Unshare"},{"Type":"Start","Job":"152084.test-amd64-amd64-pair","Avail":0,"Time":9366},{"Type":"End","Job":"152084.test-amd64-amd64-pair","Avail":1,"Time":14376},{"Time":14376,"Type":"Start","Job":"152084.test-xtf-amd64-amd64-5","Avail":0},{"Avail":1,"Type":"End","Job":"152084.test-xtf-amd64-amd64-5","Time":19386},{"Avail":0,"Job":"152084.test-amd64-amd64-amd64-pvgrub","Type":"Start","Time":19386},{"Time":24396,"Type":"End","Job":"152084.test-amd64-amd64-amd64-pvgrub","Avail":1},{"Time":24396,"Avail":0,"Job":"152084.test-amd64-amd64-i386-pvgrub","Type":"Start"},{"Job":"152084.test-amd64-amd64-i386-pvgrub","Type":"End","Avail":1,"Time":29406},{"Job":"152084.test-amd64-amd64-examine","Type":"Start","Avail":0,"Time":29406},{"Avail":1,"Type":"End","Job":"152084.test-amd64-amd64-examine","Time":34416},{"Time":34416,"Job":"152084.test-amd64-amd64-qemuu-nested-intel","Type":"Start","Avail":0},{"Type":"End","Job":"152084.test-amd64-amd64-qemuu-nested-intel","Avail":1,"Time":39426},{"Job":"152084.test-amd64-amd64-xl-credit1","Type":"Start","Avail":0,"Time":39426},{"Job":"152084.test-amd64-amd64-xl-credit1","Type":"End","Avail":1,"Time":44436},{"Time":44436,"Avail":0,"Job":"152084.test-amd64-amd64-xl-qemut-debianhvm-amd64","Type":"Start"},{"Time":49446,"Avail":1,"Job":"152084.test-amd64-amd64-xl-qemut-debianhvm-amd64","Type":"End"},{"Time":49446,"Avail":0,"Type":"Start","Job":"152084.test-amd64-amd64-xl-qemut-debianhvm-i386-xsm"},{"Type":"End","Job":"152084.test-amd64-amd64-xl-qemut-debianhvm-i386-xsm","Avail":1,"Time":54456}],"host godello0":[{"Type":"Start","Job":"152070.test-amd64-amd64-pygrub","Avail":0,"Time":-333},{"Type":"End","Job":"152070.test-amd64-amd64-pygrub","Avail":1,"Time":2479}],"host pinot0":[{"Avail":0,"Job":"152067.test-amd64-amd64-xl-qemuu-ovmf-amd64","Type":"Start","Time":-3466},{"Avail":1,"Type":"End","Job":"152067.test-amd64-amd64-xl-qemuu-ovmf-amd64","Time":353}],"host fiano0":[{"Avail":0,"Type":"Start","Job":"152083.test-amd64-amd64-xl-qemuu-debianhvm-i386-xsm","Time":-828},{"Time":498,"Avail":1,"Type":"End","Job":"152083.test-amd64-amd64-xl-qemuu-debianhvm-i386-xsm"}]},"ClientNotes":{"hostalloc-diverse-152084-xtf-x86":{"sabro1":"test-xtf-amd64-amd64-2 host","sabro0":"test-xtf-amd64-amd64-5 host"}},"Start":1595358757}
2020-07-21 19:12:51 Z allocating hosts: host 
HID host INTENDED commission-sabro
HID host TRY host sabro0:
HID host TRY host sabro0: NEEDFLAG suite-buster
HID host TRY host sabro0: NEEDFLAG arch-xen-amd64
HID host TRY host sabro0: NEEDFLAG purpose-test
HID host TRY host sabro0: NEEDFLAG hvm-amd
HID host TRY host sabro0: NEEDFLAG arch-amd64
HID host TRY host sabro0: FLAGS MISSINGFLAGS: hvm-amd.
HID host TRY host sabro1:
HID host TRY host sabro1: NEEDFLAG suite-buster
HID host TRY host sabro1: NEEDFLAG arch-xen-amd64
HID host TRY host sabro1: NEEDFLAG purpose-test
HID host TRY host sabro1: NEEDFLAG hvm-amd
HID host TRY host sabro1: NEEDFLAG arch-amd64
HID host TRY host sabro1: FLAGS MISSINGFLAGS: hvm-amd.
2020-07-21 19:12:51 Z no suitable host for host (out of 0) 
ORDER host
RECURSE  host...
2020-07-21 19:12:51 Z no plan is possible - no suitable hosts 
2020-07-21 19:12:51 Z resource allocation: resourcecall returned (2,...) 
2020-07-21 19:12:51 Z ---------- step 2 hosts-allocate starved ----------