[57.926740] Initializing watchdogs [57.926863] /dev/watchdog0 [57.933209] [001/171] (960s left) i915_module_load (load) [58.117546] Starting subtest: load [60.376791] Subtest load: SUCCESS (2.259s) [60.395652] [002/171] (958s left) core_auth (basic-auth) [60.532904] Starting subtest: basic-auth [60.534351] Subtest basic-auth: SUCCESS (0.002s) [60.616871] [003/171] (957s left) debugfs_test (read_all_entries) [60.740186] Starting subtest: read_all_entries [61.057930] Subtest read_all_entries: SUCCESS (0.317s) [61.165913] [004/171] (957s left) debugfs_test (basic-hwmon) [61.280876] Starting subtest: basic-hwmon [61.283118] Subtest basic-hwmon: SKIP (0.000s) [61.392502] [005/171] (957s left) fbdev (eof) [61.520686] Starting subtest: eof [61.522267] Subtest eof: SUCCESS (0.000s) [61.581443] [006/171] (956s left) fbdev (info) [61.676154] Starting subtest: info [61.677194] Subtest info: SUCCESS (0.000s) [61.757198] [007/171] (956s left) fbdev (nullptr) [61.879439] Starting subtest: nullptr [61.881180] Subtest nullptr: SUCCESS (0.000s) [61.938289] [008/171] (956s left) fbdev (read) [62.043997] Starting subtest: read [69.401382] Subtest read: SUCCESS (7.323s) [69.437924] [009/171] (949s left) fbdev (write) [69.514745] Starting subtest: write [73.220551] Subtest write: SUCCESS (3.670s) [73.256132] [010/171] (945s left) gem_basic (bad-close) [73.320984] Starting subtest: bad-close [73.322616] Subtest bad-close: SUCCESS (0.000s) [73.391589] [011/171] (945s left) gem_basic (create-close) [73.456328] Starting subtest: create-close [73.457915] Subtest create-close: SUCCESS (0.000s) [73.541944] [012/171] (945s left) gem_basic (create-fd-close) [73.611339] Starting subtest: create-fd-close [73.612926] Subtest create-fd-close: SUCCESS (0.000s) [73.691310] [013/171] (944s left) gem_busy (busy@all-engines) [73.767482] Starting subtest: busy [73.768420] Starting dynamic subtest: all-engines [73.797982] Dynamic subtest all-engines: SUCCESS (0.030s) [73.798841] Subtest busy: SUCCESS (0.031s) [74.149645] [014/171] (944s left) gem_close_race (basic-process) [74.221747] Starting subtest: basic-process [74.257454] Subtest basic-process: SUCCESS (0.035s) [74.444750] [015/171] (944s left) gem_close_race (basic-threads) [74.514326] Starting subtest: basic-threads [75.642028] Subtest basic-threads: SUCCESS (1.127s) [75.837413] [016/171] (942s left) gem_ctx_create (basic) [75.953311] Starting subtest: basic [75.954503] Subtest basic: SUCCESS (0.000s) [76.147258] [017/171] (942s left) gem_ctx_create (basic-files) [76.246726] Starting subtest: basic-files [78.264549] Subtest basic-files: SUCCESS (2.018s) [78.535997] [018/171] (940s left) gem_ctx_exec (basic) [78.631314] Starting subtest: basic [78.636093] Subtest basic: SUCCESS (0.005s) [78.755503] [019/171] (939s left) gem_exec_basic (basic) [78.847163] Starting subtest: basic [78.848188] Starting dynamic subtest: rcs0-smem [78.849170] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [78.856145] Starting dynamic subtest: bcs0-smem [78.857050] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [78.863381] Starting dynamic subtest: vcs0-smem [78.864436] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [78.871390] Starting dynamic subtest: vecs0-smem [78.872367] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [78.873369] Subtest basic: SUCCESS (0.004s) [79.044316] [020/171] (939s left) gem_exec_create (basic) [79.133182] Starting subtest: basic [79.134280] Starting dynamic subtest: smem [81.237649] Dynamic subtest smem: SUCCESS (2.104s) [81.239097] Subtest basic: SUCCESS (2.104s) [81.425995] [021/171] (937s left) gem_exec_fence (basic-busy) [81.635581] Starting subtest: basic-busy [81.636772] Starting dynamic subtest: rcs0 [81.703282] Dynamic subtest rcs0: SUCCESS (0.075s) [81.714705] Starting dynamic subtest: bcs0 [81.753121] Dynamic subtest bcs0: SUCCESS (0.049s) [81.763473] Starting dynamic subtest: vcs0 [81.803160] Dynamic subtest vcs0: SUCCESS (0.050s) [81.814419] Starting dynamic subtest: vecs0 [81.852050] Dynamic subtest vecs0: SUCCESS (0.048s) [81.853725] Subtest basic-busy: SUCCESS (0.225s) [82.394385] [022/171] (936s left) gem_exec_fence (basic-wait) [82.583776] Starting subtest: basic-wait [82.585327] Starting dynamic subtest: rcs0 [82.637118] Dynamic subtest rcs0: SUCCESS (0.061s) [82.648963] Starting dynamic subtest: bcs0 [82.685221] Dynamic subtest bcs0: SUCCESS (0.047s) [82.696284] Starting dynamic subtest: vcs0 [82.737132] Dynamic subtest vcs0: SUCCESS (0.052s) [82.749116] Starting dynamic subtest: vecs0 [82.785937] Dynamic subtest vecs0: SUCCESS (0.048s) [82.787568] Subtest basic-wait: SUCCESS (0.210s) [83.281692] [023/171] (935s left) gem_exec_fence (basic-await) [83.470993] Starting subtest: basic-await [83.471890] Starting dynamic subtest: rcs0 [83.544815] Dynamic subtest rcs0: SUCCESS (0.081s) [83.558685] Starting dynamic subtest: bcs0 [83.631058] Dynamic subtest bcs0: SUCCESS (0.085s) [83.648490] Starting dynamic subtest: vcs0 [83.723818] Dynamic subtest vcs0: SUCCESS (0.092s) [83.740252] Starting dynamic subtest: vecs0 [83.812301] Dynamic subtest vecs0: SUCCESS (0.088s) [83.814179] Subtest basic-await: SUCCESS (0.349s) [84.319475] [024/171] (934s left) gem_exec_fence (nb-await) [84.507983] Starting subtest: nb-await [84.508919] Starting dynamic subtest: rcs0 [84.565538] Dynamic subtest rcs0: SUCCESS (0.065s) [84.572672] Starting dynamic subtest: bcs0 [84.627978] Dynamic subtest bcs0: SUCCESS (0.062s) [84.644792] Starting dynamic subtest: vcs0 [84.694866] Dynamic subtest vcs0: SUCCESS (0.067s) [84.711620] Starting dynamic subtest: vecs0 [84.762070] Dynamic subtest vecs0: SUCCESS (0.067s) [84.763868] Subtest nb-await: SUCCESS (0.262s) [85.252316] [025/171] (933s left) gem_exec_gttfill (basic) [85.317680] Starting subtest: basic [89.700168] Subtest basic: SUCCESS (4.373s) [89.883538] [026/171] (928s left) gem_exec_parallel (engines) [90.057805] Starting subtest: engines [90.058995] Starting dynamic subtest: basic [95.681202] Dynamic subtest basic: SUCCESS (5.621s) [95.693836] Starting dynamic subtest: contexts [100.897210] Dynamic subtest contexts: SUCCESS (5.209s) [100.905679] Starting dynamic subtest: fds [105.763068] Dynamic subtest fds: SUCCESS (4.866s) [105.773504] Starting dynamic subtest: userptr [109.628131] Dynamic subtest userptr: SUCCESS (3.872s) [109.629869] Subtest engines: SUCCESS (19.569s) [109.819159] [027/171] (909s left) gem_exec_store (basic) [109.900067] Starting subtest: basic [109.989429] Subtest basic: SUCCESS (0.088s) [110.180761] [028/171] (908s left) gem_flink_basic (bad-flink) [110.249841] Starting subtest: bad-flink [110.250694] Subtest bad-flink: SUCCESS (0.000s) [110.313160] [029/171] (908s left) gem_flink_basic (bad-open) [110.378851] Starting subtest: bad-open [110.379707] Subtest bad-open: SUCCESS (0.000s) [110.445690] [030/171] (908s left) gem_flink_basic (basic) [110.510742] Starting subtest: basic [110.511630] Subtest basic: SUCCESS (0.000s) [110.595712] [031/171] (908s left) gem_flink_basic (double-flink) [110.663276] Starting subtest: double-flink [110.669717] Subtest double-flink: SUCCESS (0.000s) [110.745449] [032/171] (908s left) gem_flink_basic (flink-lifetime) [110.814067] Starting subtest: flink-lifetime [110.815876] Subtest flink-lifetime: SUCCESS (0.001s) [110.916016] [033/171] (908s left) gem_huc_copy (huc-copy) [110.987862] Starting subtest: huc-copy [110.991389] Subtest huc-copy: SUCCESS (0.003s) [111.113503] [034/171] (907s left) gem_linear_blits (basic) [111.296021] Starting subtest: basic [111.304531] Subtest basic: SUCCESS (0.009s) [111.430204] [035/171] (907s left) gem_mmap (basic) [111.547181] Starting subtest: basic [111.551121] Subtest basic: SUCCESS (0.000s) [111.640591] [036/171] (907s left) gem_mmap_gtt (basic) [111.707720] Starting subtest: basic [111.708595] Subtest basic: SUCCESS (0.001s) [111.777767] [037/171] (907s left) gem_render_linear_blits (basic) [111.849312] Starting subtest: basic [111.890207] Subtest basic: SUCCESS (0.040s) [111.960507] [038/171] (907s left) gem_render_tiled_blits (basic) [112.038933] Starting subtest: basic [112.081873] Subtest basic: SUCCESS (0.043s) [112.150522] [039/171] (906s left) gem_ringfill (basic-all) [112.482898] Starting subtest: basic-all [113.636815] Subtest basic-all: SUCCESS (1.147s) [113.743339] [040/171] (905s left) gem_softpin (allocator-basic) [113.832885] Starting subtest: allocator-basic [113.961853] Subtest allocator-basic: SUCCESS (0.120s) [114.074103] [041/171] (905s left) gem_softpin (allocator-basic-reserve) [114.159738] Starting subtest: allocator-basic-reserve [114.283784] Subtest allocator-basic-reserve: SUCCESS (0.115s) [114.393775] [042/171] (904s left) gem_softpin (safe-alignment) [114.478491] Starting subtest: safe-alignment [114.494141] Subtest safe-alignment: SUCCESS (0.016s) [114.606089] [043/171] (904s left) gem_sync (basic-all) [114.693760] Starting subtest: basic-all [117.199882] Subtest basic-all: SUCCESS (2.505s) [117.392431] [044/171] (901s left) gem_sync (basic-each) [117.462372] Starting subtest: basic-each [120.411404] Subtest basic-each: SUCCESS (2.948s) [120.601140] [045/171] (898s left) gem_tiled_blits (basic) [120.780829] Starting subtest: basic [120.802349] Subtest basic: SUCCESS (0.022s) [120.934825] [046/171] (898s left) gem_tiled_fence_blits (basic) [121.186284] Starting subtest: basic [121.208208] Subtest basic: SUCCESS (0.022s) [121.332635] [047/171] (897s left) gem_tiled_pread_basic [121.482033] [048/171] (897s left) gem_wait (busy@all-engines) [121.566473] Starting subtest: busy [121.567400] Starting dynamic subtest: all-engines [122.119488] Dynamic subtest all-engines: SUCCESS (0.552s) [122.121039] Subtest busy: SUCCESS (0.552s) [122.332734] [049/171] (896s left) gem_wait (wait@all-engines) [122.415078] Starting subtest: wait [122.416140] Starting dynamic subtest: all-engines [123.471426] Dynamic subtest all-engines: SUCCESS (1.056s) [123.473039] Subtest wait: SUCCESS (1.056s) [123.680815] [050/171] (895s left) i915_getparams_basic (basic-eu-total) [123.741252] Starting subtest: basic-eu-total [123.742792] Subtest basic-eu-total: SUCCESS (0.000s) [123.812547] [051/171] (895s left) i915_getparams_basic (basic-subslice-total) [123.868333] Starting subtest: basic-subslice-total [123.869959] Subtest basic-subslice-total: SUCCESS (0.000s) [123.926665] [052/171] (895s left) i915_hangman (error-state-basic) [123.994329] Starting subtest: error-state-basic [124.108913] Subtest error-state-basic: SUCCESS (0.115s) [124.196744] [053/171] (895s left) i915_pciid [124.330202] [054/171] (894s left) kms_addfb_basic (addfb25-bad-modifier) [124.422110] Starting subtest: addfb25-bad-modifier [124.422950] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [124.537340] [055/171] (894s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [124.627548] Starting subtest: addfb25-framebuffer-vs-set-tiling [124.628419] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [124.758949] [056/171] (894s left) kms_addfb_basic (addfb25-modifier-no-flag) [124.860168] Starting subtest: addfb25-modifier-no-flag [124.861060] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [125.009620] [057/171] (894s left) kms_addfb_basic (addfb25-x-tiled-legacy) [125.117204] Starting subtest: addfb25-x-tiled-legacy [125.118108] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [125.251868] [058/171] (894s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [125.368333] Starting subtest: addfb25-x-tiled-mismatch-legacy [125.369603] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [125.514246] [059/171] (893s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [125.649726] Starting subtest: addfb25-yf-tiled-legacy [125.650702] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [125.778907] [060/171] (893s left) kms_addfb_basic (addfb25-y-tiled-legacy) [125.921516] Starting subtest: addfb25-y-tiled-legacy [125.922528] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [126.050591] [061/171] (893s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [126.194245] Starting subtest: addfb25-y-tiled-small-legacy [126.195237] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [126.315579] [062/171] (893s left) kms_addfb_basic (bad-pitch-0) [126.411244] Starting subtest: bad-pitch-0 [126.412218] Subtest bad-pitch-0: SUCCESS (0.000s) [126.586319] [063/171] (892s left) kms_addfb_basic (bad-pitch-1024) [126.686670] Starting subtest: bad-pitch-1024 [126.687690] Subtest bad-pitch-1024: SUCCESS (0.000s) [126.855201] [064/171] (892s left) kms_addfb_basic (bad-pitch-128) [126.955783] Starting subtest: bad-pitch-128 [126.956967] Subtest bad-pitch-128: SUCCESS (0.000s) [127.126612] [065/171] (892s left) kms_addfb_basic (bad-pitch-256) [127.227531] Starting subtest: bad-pitch-256 [127.228547] Subtest bad-pitch-256: SUCCESS (0.000s) [127.396817] [066/171] (892s left) kms_addfb_basic (bad-pitch-32) [127.497786] Starting subtest: bad-pitch-32 [127.498939] Subtest bad-pitch-32: SUCCESS (0.000s) [127.675805] [067/171] (891s left) kms_addfb_basic (bad-pitch-63) [127.776496] Starting subtest: bad-pitch-63 [127.777961] Subtest bad-pitch-63: SUCCESS (0.000s) [127.960623] [068/171] (891s left) kms_addfb_basic (bad-pitch-65536) [128.062768] Starting subtest: bad-pitch-65536 [128.063809] Subtest bad-pitch-65536: SUCCESS (0.000s) [128.241417] [069/171] (891s left) kms_addfb_basic (bad-pitch-999) [128.341805] Starting subtest: bad-pitch-999 [128.342835] Subtest bad-pitch-999: SUCCESS (0.000s) [128.514204] [070/171] (891s left) kms_addfb_basic (basic) [128.612770] Starting subtest: basic [128.613847] Subtest basic: SUCCESS (0.000s) [128.783350] [071/171] (890s left) kms_addfb_basic (basic-x-tiled-legacy) [128.953569] Starting subtest: basic-x-tiled-legacy [128.954703] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [129.053535] [072/171] (890s left) kms_addfb_basic (basic-y-tiled-legacy) [129.223788] Starting subtest: basic-y-tiled-legacy [129.224859] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [129.328198] [073/171] (890s left) kms_addfb_basic (bo-too-small) [129.454311] Starting subtest: bo-too-small [129.455477] Subtest bo-too-small: SUCCESS (0.000s) [129.596727] [074/171] (890s left) kms_addfb_basic (bo-too-small-due-to-tiling) [129.721594] Starting subtest: bo-too-small-due-to-tiling [129.722579] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [129.867207] [075/171] (889s left) kms_addfb_basic (clobberred-modifier) [129.972600] Starting subtest: clobberred-modifier [129.973771] Subtest clobberred-modifier: SUCCESS (0.000s) [130.141242] [076/171] (889s left) kms_addfb_basic (framebuffer-vs-set-tiling) [130.313414] Starting subtest: framebuffer-vs-set-tiling [130.314458] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [130.413136] [077/171] (889s left) kms_addfb_basic (invalid-get-prop) [130.585947] Starting subtest: invalid-get-prop [130.587076] Subtest invalid-get-prop: SUCCESS (0.000s) [130.692198] [078/171] (889s left) kms_addfb_basic (invalid-get-prop-any) [130.859191] Starting subtest: invalid-get-prop-any [130.860366] Subtest invalid-get-prop-any: SUCCESS (0.000s) [130.969311] [079/171] (888s left) kms_addfb_basic (invalid-set-prop) [131.136224] Starting subtest: invalid-set-prop [131.137321] Subtest invalid-set-prop: SUCCESS (0.000s) [131.241126] [080/171] (888s left) kms_addfb_basic (invalid-set-prop-any) [131.409330] Starting subtest: invalid-set-prop-any [131.410369] Subtest invalid-set-prop-any: SUCCESS (0.000s) [131.511311] [081/171] (888s left) kms_addfb_basic (no-handle) [131.612793] Starting subtest: no-handle [131.613797] Subtest no-handle: SUCCESS (0.000s) [131.785939] [082/171] (888s left) kms_addfb_basic (size-max) [131.911135] Starting subtest: size-max [131.912098] Subtest size-max: SUCCESS (0.000s) [132.068690] [083/171] (887s left) kms_addfb_basic (small-bo) [132.192459] Starting subtest: small-bo [132.193513] Subtest small-bo: SUCCESS (0.000s) [132.342657] [084/171] (887s left) kms_addfb_basic (tile-pitch-mismatch) [132.507826] Starting subtest: tile-pitch-mismatch [132.508948] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [132.626838] [085/171] (887s left) kms_addfb_basic (too-high) [132.748652] Starting subtest: too-high [132.749692] Subtest too-high: SUCCESS (0.001s) [132.886292] [086/171] (887s left) kms_addfb_basic (too-wide) [133.017642] Starting subtest: too-wide [133.018838] Subtest too-wide: SUCCESS (0.000s) [133.164148] [087/171] (886s left) kms_addfb_basic (unused-handle) [133.265569] Starting subtest: unused-handle [133.266616] Subtest unused-handle: SUCCESS (0.000s) [133.439921] [088/171] (886s left) kms_addfb_basic (unused-modifier) [133.540353] Starting subtest: unused-modifier [133.541373] Subtest unused-modifier: SUCCESS (0.000s) [133.719516] [089/171] (886s left) kms_addfb_basic (unused-offsets) [133.818469] Starting subtest: unused-offsets [133.819453] Subtest unused-offsets: SUCCESS (0.000s) [133.985658] [090/171] (886s left) kms_addfb_basic (unused-pitches) [134.085955] Starting subtest: unused-pitches [134.087084] Subtest unused-pitches: SUCCESS (0.000s) [134.273434] [091/171] (885s left) kms_busy (basic) [134.407379] Starting subtest: basic [134.408647] Starting dynamic subtest: flip [135.371884] Dynamic subtest flip: SUCCESS (0.965s) [135.388466] Starting dynamic subtest: modeset [139.170932] Dynamic subtest modeset: SUCCESS (3.798s) [139.173800] Subtest basic: SUCCESS (4.763s) [140.130674] [092/171] (879s left) kms_chamelium_hpd (dp-hpd-fast) [140.506792] Subtest dp-hpd-fast: SKIP (0.000s) [141.431950] [093/171] (878s left) kms_chamelium_edid (dp-edid-read) [141.816818] Subtest dp-edid-read: SKIP (0.000s) [142.709443] [094/171] (877s left) kms_chamelium_frames (dp-crc-fast) [143.112874] Subtest dp-crc-fast: SKIP (0.000s) [143.992372] [095/171] (876s left) kms_chamelium_hpd (hdmi-hpd-fast) [144.382791] Subtest hdmi-hpd-fast: SKIP (0.000s) [145.271078] [096/171] (874s left) kms_chamelium_edid (hdmi-edid-read) [145.663722] Subtest hdmi-edid-read: SKIP (0.000s) [146.551195] [097/171] (873s left) kms_chamelium_frames (hdmi-crc-fast) [146.960820] Subtest hdmi-crc-fast: SKIP (0.000s) [147.829118] [098/171] (872s left) kms_chamelium_hpd (vga-hpd-fast) [148.223641] Subtest vga-hpd-fast: SKIP (0.000s) [149.110499] [099/171] (871s left) kms_chamelium_edid (vga-edid-read) [149.506337] Subtest vga-edid-read: SKIP (0.000s) [150.390552] [100/171] (869s left) kms_prop_blob (basic) [150.449224] Starting subtest: basic [150.449998] Subtest basic: SUCCESS (0.000s) [150.516588] [101/171] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [150.628381] Starting subtest: basic-busy-flip-before-cursor-atomic [150.630030] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [150.746320] [102/171] (869s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [150.847529] Starting subtest: basic-busy-flip-before-cursor-legacy [150.849215] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [150.949721] [103/171] (869s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [151.067336] Starting subtest: basic-flip-after-cursor-atomic [152.298296] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.232s) [153.250468] [104/171] (867s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [153.368217] Starting subtest: basic-flip-after-cursor-legacy [154.589910] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.221s) [155.552865] [105/171] (864s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [155.663251] Starting subtest: basic-flip-after-cursor-varying-size [156.889057] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.222s) [157.814904] [106/171] (862s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [157.923387] Starting subtest: basic-flip-before-cursor-atomic [159.149927] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.225s) [160.095098] [107/171] (860s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [160.212286] Starting subtest: basic-flip-before-cursor-legacy [161.429427] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.217s) [162.400270] [108/171] (857s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [162.518253] Starting subtest: basic-flip-before-cursor-varying-size [163.740555] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.223s) [164.705945] [109/171] (855s left) kms_flip (basic-flip-vs-dpms) [164.772791] Starting subtest: basic-flip-vs-dpms [164.774855] Starting dynamic subtest: A-eDP1 [167.592359] Dynamic subtest A-eDP1: SUCCESS (2.817s) [167.610101] Starting dynamic subtest: B-eDP1 [170.016287] Dynamic subtest B-eDP1: SUCCESS (2.423s) [170.025557] Starting dynamic subtest: C-eDP1 [172.392769] Dynamic subtest C-eDP1: SUCCESS (2.375s) [172.394613] Subtest basic-flip-vs-dpms: SUCCESS (7.622s) [173.297363] [110/171] (847s left) kms_flip (basic-flip-vs-modeset) [173.369338] Starting subtest: basic-flip-vs-modeset [173.371265] Starting dynamic subtest: A-eDP1 [176.234520] Dynamic subtest A-eDP1: SUCCESS (2.861s) [176.251163] Starting dynamic subtest: B-eDP1 [178.599563] Dynamic subtest B-eDP1: SUCCESS (2.365s) [178.606659] Starting dynamic subtest: C-eDP1 [181.886867] Dynamic subtest C-eDP1: SUCCESS (3.283s) [181.887867] Subtest basic-flip-vs-modeset: SUCCESS (8.515s) [182.256747] [111/171] (838s left) kms_flip (basic-flip-vs-wf_vblank) [182.327916] Starting subtest: basic-flip-vs-wf_vblank [182.329937] Starting dynamic subtest: A-eDP1 [184.612323] Dynamic subtest A-eDP1: SUCCESS (2.282s) [184.621315] Starting dynamic subtest: B-eDP1 [186.894715] Dynamic subtest B-eDP1: SUCCESS (2.281s) [186.904221] Starting dynamic subtest: C-eDP1 [189.114198] Dynamic subtest C-eDP1: SUCCESS (2.219s) [189.115707] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.789s) [190.433696] [112/171] (829s left) kms_flip (basic-plain-flip) [190.504205] Starting subtest: basic-plain-flip [190.506131] Starting dynamic subtest: A-eDP1 [192.499426] Dynamic subtest A-eDP1: SUCCESS (1.993s) [192.508565] Starting dynamic subtest: B-eDP1 [194.483422] Dynamic subtest B-eDP1: SUCCESS (1.983s) [194.492538] Starting dynamic subtest: C-eDP1 [196.448330] Dynamic subtest C-eDP1: SUCCESS (1.965s) [196.449805] Subtest basic-plain-flip: SUCCESS (5.946s) [197.729313] [113/171] (822s left) kms_force_connector_basic (force-connector-state) [197.789569] Starting subtest: force-connector-state [198.245509] Subtest force-connector-state: SUCCESS (0.456s) [199.434574] [114/171] (821s left) kms_force_connector_basic (force-edid) [199.489260] Starting subtest: force-edid [199.519812] Subtest force-edid: SUCCESS (0.029s) [199.614634] [115/171] (820s left) kms_force_connector_basic (force-load-detect) [199.671323] Starting subtest: force-load-detect [199.673040] Subtest force-load-detect: SKIP (0.000s) [199.765777] [116/171] (820s left) kms_force_connector_basic (prune-stale-modes) [199.822337] Starting subtest: prune-stale-modes [199.855363] Subtest prune-stale-modes: SUCCESS (0.033s) [199.950087] [117/171] (820s left) kms_frontbuffer_tracking (basic) [200.023355] Starting subtest: basic [204.383757] Subtest basic: SUCCESS (4.360s) [204.481529] [118/171] (816s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [204.608777] Starting subtest: compare-crc-sanitycheck [204.609898] Starting dynamic subtest: pipe-A-eDP-1 [205.322748] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.699s) [205.334378] Starting dynamic subtest: pipe-B-eDP-1 [206.722037] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.408s) [206.731283] Starting dynamic subtest: pipe-C-eDP-1 [208.129675] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.411s) [208.136147] Subtest compare-crc-sanitycheck: SUCCESS (3.520s) [209.083319] [119/171] (811s left) kms_pipe_crc_basic (hang-read-crc) [209.156160] Starting subtest: hang-read-crc [209.156972] Starting dynamic subtest: pipe-A-eDP-1 [211.486082] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.327s) [211.501689] Starting dynamic subtest: pipe-B-eDP-1 [214.587867] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.103s) [214.595388] Starting dynamic subtest: pipe-C-eDP-1 [217.620462] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.032s) [217.621731] Subtest hang-read-crc: SUCCESS (8.464s) [218.552776] [120/171] (802s left) kms_pipe_crc_basic (nonblocking-crc) [218.639816] Starting subtest: nonblocking-crc [218.640775] Starting dynamic subtest: pipe-A-eDP-1 [219.512698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.872s) [219.519939] Starting dynamic subtest: pipe-B-eDP-1 [221.115242] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.602s) [221.130518] Starting dynamic subtest: pipe-C-eDP-1 [222.693341] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.578s) [222.694210] Subtest nonblocking-crc: SUCCESS (4.054s) [223.653739] [121/171] (796s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [223.731619] Starting subtest: nonblocking-crc-frame-sequence [223.732431] Starting dynamic subtest: pipe-A-eDP-1 [224.602753] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.871s) [224.610045] Starting dynamic subtest: pipe-B-eDP-1 [226.230238] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.627s) [226.237318] Starting dynamic subtest: pipe-C-eDP-1 [227.809105] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.579s) [227.809897] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.078s) [228.769742] [122/171] (791s left) kms_pipe_crc_basic (read-crc) [228.848854] Starting subtest: read-crc [228.849675] Starting dynamic subtest: pipe-A-eDP-1 [229.642180] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.793s) [229.657886] Starting dynamic subtest: pipe-B-eDP-1 [231.158280] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.513s) [231.173914] Starting dynamic subtest: pipe-C-eDP-1 [232.693844] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.535s) [232.695170] Subtest read-crc: SUCCESS (3.844s) [233.633914] [123/171] (786s left) kms_pipe_crc_basic (read-crc-frame-sequence) [233.719774] Starting subtest: read-crc-frame-sequence [233.720926] Starting dynamic subtest: pipe-A-eDP-1 [234.513065] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.794s) [234.528943] Starting dynamic subtest: pipe-B-eDP-1 [236.026838] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.511s) [236.042361] Starting dynamic subtest: pipe-C-eDP-1 [237.559691] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.532s) [237.560898] Subtest read-crc-frame-sequence: SUCCESS (3.841s) [238.500943] [124/171] (782s left) kms_psr (primary_page_flip) [238.589365] Starting subtest: primary_page_flip [240.586175] Subtest primary_page_flip: SUCCESS (1.993s) [241.507452] [125/171] (779s left) kms_psr (cursor_plane_move) [241.585177] Starting subtest: cursor_plane_move [243.572747] Subtest cursor_plane_move: SUCCESS (1.986s) [244.515407] [126/171] (776s left) kms_psr (sprite_plane_onoff) [244.594958] Starting subtest: sprite_plane_onoff [246.657333] Subtest sprite_plane_onoff: SUCCESS (2.060s) [247.585982] [127/171] (773s left) kms_psr (primary_mmap_gtt) [247.662335] Starting subtest: primary_mmap_gtt [249.653094] Subtest primary_mmap_gtt: SUCCESS (1.991s) [250.594134] [128/171] (770s left) kms_setmode (basic-clone-single-crtc) [250.651616] Starting subtest: basic-clone-single-crtc [250.653933] Subtest basic-clone-single-crtc: SKIP (0.000s) [250.726648] [129/171] (769s left) i915_pm_backlight (basic-brightness) [250.801308] Starting subtest: basic-brightness [250.873604] Starting dynamic subtest: eDP-1 [251.233505] Dynamic subtest eDP-1: SUCCESS (0.360s) [251.234958] Subtest basic-brightness: SUCCESS (0.433s) [252.194579] [130/171] (768s left) i915_pm_rpm (basic-pci-d3-state) [257.543047] Starting subtest: basic-pci-d3-state [262.219843] Subtest basic-pci-d3-state: SUCCESS (4.674s) [262.393297] [131/171] (758s left) i915_pm_rpm (basic-rte) [262.447971] Starting subtest: basic-rte [272.395614] Subtest basic-rte: SUCCESS (9.945s) [277.798108] [132/171] (742s left) i915_pm_rps (basic-api) [277.861295] Starting subtest: basic-api [277.862889] Subtest basic-api: SKIP (0.000s) [277.938533] [133/171] (742s left) prime_self_import (basic-llseek-bad) [277.996223] Starting subtest: basic-llseek-bad [277.998412] Subtest basic-llseek-bad: SUCCESS (0.001s) [278.088720] [134/171] (742s left) prime_self_import (basic-llseek-size) [278.143294] Starting subtest: basic-llseek-size [278.145442] Subtest basic-llseek-size: SUCCESS (0.002s) [278.221756] [135/171] (742s left) prime_self_import (basic-with_fd_dup) [278.275083] Starting subtest: basic-with_fd_dup [278.277346] Subtest basic-with_fd_dup: SUCCESS (0.002s) [278.373395] [136/171] (742s left) prime_self_import (basic-with_one_bo) [278.427107] Starting subtest: basic-with_one_bo [278.429314] Subtest basic-with_one_bo: SUCCESS (0.003s) [278.509317] [137/171] (742s left) prime_self_import (basic-with_one_bo_two_files) [278.565089] Starting subtest: basic-with_one_bo_two_files [278.567360] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [278.672547] [138/171] (742s left) prime_self_import (basic-with_two_bos) [278.725328] Starting subtest: basic-with_two_bos [278.727549] Subtest basic-with_two_bos: SUCCESS (0.002s) [278.822187] [139/171] (742s left) prime_vgem (basic-fence-flip) [278.898208] Starting subtest: basic-fence-flip [279.350481] Subtest basic-fence-flip: SUCCESS (0.452s) [279.462382] [140/171] (741s left) prime_vgem (basic-fence-mmap) [279.542431] Starting subtest: basic-fence-mmap [279.565523] Subtest basic-fence-mmap: SUCCESS (0.023s) [279.646538] [141/171] (741s left) prime_vgem (basic-fence-read) [279.722994] Starting subtest: basic-fence-read [279.732118] Subtest basic-fence-read: SKIP (0.008s) [279.829477] [142/171] (741s left) prime_vgem (basic-gtt) [279.925499] Starting subtest: basic-gtt [279.941921] Subtest basic-gtt: SUCCESS (0.017s) [280.027962] [143/171] (740s left) prime_vgem (basic-read) [280.105720] Starting subtest: basic-read [280.114822] Subtest basic-read: SKIP (0.008s) [280.212825] [144/171] (740s left) prime_vgem (basic-write) [280.304756] Starting subtest: basic-write [280.314476] Subtest basic-write: SKIP (0.009s) [280.412902] [145/171] (740s left) prime_vgem (basic-userptr) [280.490983] Starting subtest: basic-userptr [280.501087] Subtest basic-userptr: SKIP (0.009s) [280.596289] [146/171] (740s left) vgem_basic (setversion) [280.667289] Starting subtest: setversion [280.669788] Subtest setversion: SUCCESS (0.000s) [280.728169] [147/171] (740s left) vgem_basic (create) [280.800631] Starting subtest: create [280.802111] Subtest create: SUCCESS (0.000s) [280.863231] [148/171] (740s left) vgem_basic (debugfs) [280.933868] Starting subtest: debugfs [280.935628] Subtest debugfs: SUCCESS (0.000s) [280.997704] [149/171] (740s left) vgem_basic (dmabuf-export) [281.067208] Starting subtest: dmabuf-export [281.087433] Subtest dmabuf-export: SUCCESS (0.018s) [281.179653] [150/171] (739s left) vgem_basic (dmabuf-fence) [281.250754] Starting subtest: dmabuf-fence [281.252434] Subtest dmabuf-fence: SUCCESS (0.000s) [281.312115] [151/171] (739s left) vgem_basic (dmabuf-fence-before) [281.367063] Starting subtest: dmabuf-fence-before [281.367881] Subtest dmabuf-fence-before: SUCCESS (0.000s) [281.428166] [152/171] (739s left) vgem_basic (dmabuf-mmap) [281.500508] Starting subtest: dmabuf-mmap [281.518696] Subtest dmabuf-mmap: SUCCESS (0.018s) [281.577929] [153/171] (739s left) vgem_basic (mmap) [281.650427] Starting subtest: mmap [281.660543] Subtest mmap: SUCCESS (0.010s) [281.705128] [154/171] (739s left) vgem_basic (second-client) [281.767168] Starting subtest: second-client [281.818203] Subtest second-client: SUCCESS (0.050s) [281.880842] [155/171] (739s left) vgem_basic (sysfs) [281.950544] Starting subtest: sysfs [281.952562] Subtest sysfs: SUCCESS (0.000s) [282.015544] [156/171] (739s left) core_hotunplug (unbind-rebind) [282.083922] Starting subtest: unbind-rebind [284.337589] Subtest unbind-rebind: SUCCESS (2.248s) [284.351082] [157/171] (736s left) vgem_basic (unload) [284.409254] Starting subtest: unload [313.215972] Subtest unload: SUCCESS (28.771s) [313.300366] [158/171] (707s left) i915_module_load (reload) [313.355809] Starting subtest: reload [316.138132] Subtest reload: SUCCESS (2.782s) [316.152137] [159/171] (705s left) gem_lmem_swapping (basic) [316.216628] Subtest basic: SKIP (0.000s) [316.246579] [160/171] (705s left) gem_lmem_swapping (parallel-random-engines) [316.309164] Subtest parallel-random-engines: SKIP (0.000s) [316.350471] [161/171] (704s left) gem_lmem_swapping (random-engines) [316.422433] Subtest random-engines: SKIP (0.000s) [316.446420] [162/171] (704s left) gem_lmem_swapping (verify-random) [316.505199] Subtest verify-random: SKIP (0.000s) [316.529228] [163/171] (704s left) i915_pm_rpm (module-reload) [322.975713] Starting subtest: module-reload [343.906070] Subtest module-reload: SUCCESS (20.925s) [343.925118] [164/171] (677s left) i915_selftest (live) [343.987739] Starting subtest: live [343.988716] Starting dynamic subtest: sanitycheck [345.500835] Dynamic subtest sanitycheck: SUCCESS (1.504s) [345.506752] Starting dynamic subtest: uncore [346.962932] Dynamic subtest uncore: SUCCESS (1.462s) [346.968478] Starting dynamic subtest: workarounds [349.210891] Dynamic subtest workarounds: SUCCESS (2.247s) [349.216523] Starting dynamic subtest: gt_engines [351.205807] Dynamic subtest gt_engines: SUCCESS (1.995s) [351.211779] Starting dynamic subtest: gt_timelines [361.316449] Dynamic subtest gt_timelines: SUCCESS (10.110s) [361.323792] Starting dynamic subtest: gt_contexts [362.973967] Dynamic subtest gt_contexts: SUCCESS (1.657s) [362.980182] Starting dynamic subtest: gt_lrc [367.086810] Dynamic subtest gt_lrc: SUCCESS (4.112s) [367.092623] Starting dynamic subtest: gt_mocs [369.075993] Dynamic subtest gt_mocs: SUCCESS (1.989s) [369.081608] Starting dynamic subtest: gt_pm [371.505050] Dynamic subtest gt_pm: SUCCESS (2.429s) [371.511053] Starting dynamic subtest: gt_heartbeat [373.237042] Dynamic subtest gt_heartbeat: SUCCESS (1.732s) [373.243196] Starting dynamic subtest: requests [381.029431] Dynamic subtest requests: SUCCESS (7.792s) [381.037059] Starting dynamic subtest: migrate [385.370859] Dynamic subtest migrate: SUCCESS (4.341s) [385.376664] Starting dynamic subtest: active [386.845858] Dynamic subtest active: SUCCESS (1.474s) [386.851507] Starting dynamic subtest: objects [389.391877] Dynamic subtest objects: SUCCESS (2.546s) [389.397776] Starting dynamic subtest: mman [394.773286] Dynamic subtest mman: SUCCESS (5.381s) [394.779790] Starting dynamic subtest: dmabuf [396.415995] Dynamic subtest dmabuf: SUCCESS (1.642s) [396.422125] Starting dynamic subtest: vma [397.961933] Dynamic subtest vma: SUCCESS (1.545s) [397.967868] Starting dynamic subtest: coherency [401.882979] Dynamic subtest coherency: SUCCESS (3.920s) [401.888844] Starting dynamic subtest: gtt [412.589520] Dynamic subtest gtt: SUCCESS (10.706s) [412.596836] Starting dynamic subtest: gem [414.315891] Dynamic subtest gem: SUCCESS (1.726s) [414.322082] Starting dynamic subtest: evict [417.758764] Dynamic subtest evict: SUCCESS (3.442s) [417.764668] Starting dynamic subtest: hugepages [424.388613] Dynamic subtest hugepages: SUCCESS (6.629s) [424.396253] Starting dynamic subtest: gem_contexts [439.059628] Dynamic subtest gem_contexts: SUCCESS (14.670s) [439.067253] Starting dynamic subtest: client [440.686440] Dynamic subtest client: SUCCESS (1.626s) [440.693225] Starting dynamic subtest: gem_migrate [442.284038] Dynamic subtest gem_migrate: SUCCESS (1.597s) [442.290196] Starting dynamic subtest: reset [446.602147] Dynamic subtest reset: SUCCESS (4.318s) [446.608774] Starting dynamic subtest: memory_region [448.178199] Dynamic subtest memory_region: SUCCESS (1.576s) [448.184545] Starting dynamic subtest: hangcheck [463.821943] Dynamic subtest hangcheck: SUCCESS (15.643s) [463.830350] Starting dynamic subtest: execlists [465.453051] Dynamic subtest execlists: SUCCESS (1.631s) [465.460044] Starting dynamic subtest: ring_submission [467.030609] Dynamic subtest ring_submission: SUCCESS (1.576s) [467.036941] Starting dynamic subtest: perf [468.712183] Dynamic subtest perf: SUCCESS (1.682s) [468.718836] Starting dynamic subtest: slpc [475.169237] Dynamic subtest slpc: FAIL (6.402s) [475.174277] Starting dynamic subtest: guc [477.524850] Dynamic subtest guc: SUCCESS (2.409s) [477.530722] Starting dynamic subtest: guc_multi_lrc [479.099806] Dynamic subtest guc_multi_lrc: SUCCESS (1.575s) [479.105740] Starting dynamic subtest: guc_hang [481.240896] Dynamic subtest guc_hang: SUCCESS (2.141s) [481.246775] Starting dynamic subtest: late_gt_pm [482.846752] Dynamic subtest late_gt_pm: SUCCESS (1.606s) [482.847579] Subtest live: FAIL (138.850s) [482.899544] [165/171] (538s left) dmabuf (all-tests) [482.963864] Starting subtest: all-tests [482.965525] Starting dynamic subtest: sanitycheck [482.983683] Dynamic subtest sanitycheck: SUCCESS (0.019s) [482.993590] Starting dynamic subtest: dma_fence [483.120328] Dynamic subtest dma_fence: SUCCESS (0.136s) [483.128901] Starting dynamic subtest: dma_fence_chain [498.053985] Dynamic subtest dma_fence_chain: SUCCESS (14.933s) [498.071099] Starting dynamic subtest: dma_fence_unwrap [498.087354] Dynamic subtest dma_fence_unwrap: SUCCESS (0.032s) [498.107140] Starting dynamic subtest: dma_resv [498.119612] Dynamic subtest dma_resv: SUCCESS (0.031s) [498.121465] Subtest all-tests: SUCCESS (15.156s) [498.140101] [166/171] (523s left) i915_suspend (basic-s2idle-without-i915) [498.211052] Starting subtest: basic-s2idle-without-i915 [517.586591] Subtest basic-s2idle-without-i915: SUCCESS (4.408s) [517.907028] [167/171] (518s left) i915_suspend (basic-s3-without-i915) [517.969202] Starting subtest: basic-s3-without-i915 [537.522365] Subtest basic-s3-without-i915: SUCCESS (3.035s) [537.911413] [168/171] (514s left) gem_exec_suspend (basic-s0) [538.055636] Starting subtest: basic-S0 [538.056826] Starting dynamic subtest: smem [556.594629] Dynamic subtest smem: SUCCESS (3.263s) [556.596359] Subtest basic-S0: SUCCESS (3.264s) [556.753127] [169/171] (511s left) gem_exec_suspend (basic-s3) [556.818419] Starting subtest: basic-S3 [556.819404] Starting dynamic subtest: smem [574.593938] Dynamic subtest smem: SUCCESS (2.824s) [574.596112] Subtest basic-S3: SUCCESS (2.824s) [574.757423] [170/171] (508s left) kms_chamelium_hpd (common-hpd-after-suspend) [575.148427] Subtest common-hpd-after-suspend: SKIP (0.000s) [576.068028] [171/171] (507s left) kms_pipe_crc_basic (suspend-read-crc) [576.143944] Starting subtest: suspend-read-crc [576.144775] Starting dynamic subtest: pipe-A-eDP-1 [593.834052] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.451s) [593.853421] Starting dynamic subtest: pipe-B-eDP-1 [611.807173] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.126s) [611.816144] Starting dynamic subtest: pipe-C-eDP-1 [629.803126] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.171s) [629.804334] Subtest suspend-read-crc: SUCCESS (8.750s) [630.712187] Closing watchdogs Done.