[46.445556] Initializing watchdogs
[46.445663]   /dev/watchdog0
[46.452837] [001/165] (960s left) i915_module_load (load)
[46.529661] Starting subtest: load
[47.554095] Subtest load: SUCCESS (1.024s)
[47.572828] [002/165] (959s left) core_auth (basic-auth)
[47.673215] Starting subtest: basic-auth
[47.674413] Subtest basic-auth: SUCCESS (0.001s)
[47.751260] [003/165] (959s left) debugfs_test (read_all_entries)
[47.853255] Starting subtest: read_all_entries
[47.939481] Subtest read_all_entries: SUCCESS (0.085s)
[48.045158] [004/165] (958s left) debugfs_test (basic-hwmon)
[48.128612] Starting subtest: basic-hwmon
[48.130622] Subtest basic-hwmon: SKIP (0.000s)
[48.248345] [005/165] (958s left) fbdev (eof)
[48.326561] Starting subtest: eof
[48.327696] Subtest eof: SUCCESS (0.001s)
[48.380590] [006/165] (958s left) fbdev (info)
[48.446659] Starting subtest: info
[48.447745] Subtest info: SUCCESS (0.000s)
[48.519233] [007/165] (958s left) fbdev (nullptr)
[48.592113] Starting subtest: nullptr
[48.593091] Subtest nullptr: SUCCESS (0.000s)
[48.646369] [008/165] (958s left) fbdev (read)
[48.725956] Starting subtest: read
[49.622754] Subtest read: SUCCESS (0.888s)
[49.672494] [009/165] (957s left) fbdev (write)
[49.759274] Starting subtest: write
[50.197512] Subtest write: SUCCESS (0.430s)
[50.259142] [010/165] (956s left) gem_basic (bad-close)
[50.327550] Starting subtest: bad-close
[50.329452] Subtest bad-close: SUCCESS (0.000s)
[50.388645] [011/165] (956s left) gem_basic (create-close)
[50.462441] Starting subtest: create-close
[50.464196] Subtest create-close: SUCCESS (0.000s)
[50.537830] [012/165] (956s left) gem_basic (create-fd-close)
[50.605963] Starting subtest: create-fd-close
[50.608028] Subtest create-fd-close: SUCCESS (0.000s)
[50.700747] [013/165] (956s left) gem_busy (busy@all-engines)
[50.797238] Starting subtest: busy
[50.798265] Starting dynamic subtest: all-engines
[50.859147] Dynamic subtest all-engines: SUCCESS (0.062s)
[50.860055] Subtest busy: SUCCESS (0.062s)
[51.274212] [014/165] (955s left) gem_close_race (basic-process)
[51.361288] Starting subtest: basic-process
[51.434390] Subtest basic-process: SUCCESS (0.073s)
[51.674955] [015/165] (955s left) gem_close_race (basic-threads)
[51.762253] Starting subtest: basic-threads
[52.972062] Subtest basic-threads: SUCCESS (1.210s)
[53.226403] [016/165] (954s left) gem_ctx_create (basic)
[53.315525] Starting subtest: basic
[53.316569] Subtest basic: SUCCESS (0.000s)
[53.539964] [017/165] (953s left) gem_ctx_create (basic-files)
[53.622813] Starting subtest: basic-files
[55.646120] Subtest basic-files: SUCCESS (2.023s)
[55.935576] [018/165] (951s left) gem_ctx_exec (basic)
[56.010779] Starting subtest: basic
[56.014997] Subtest basic: SUCCESS (0.004s)
[56.154374] [019/165] (951s left) gem_exec_basic (basic)
[56.235703] Starting subtest: basic
[56.236741] Starting dynamic subtest: rcs0-smem
[56.237675] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[56.244908] Starting dynamic subtest: bcs0-smem
[56.245805] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[56.252937] Starting dynamic subtest: vcs0-smem
[56.254200] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[56.261104] Starting dynamic subtest: vecs0-smem
[56.261972] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[56.262826] Subtest basic: SUCCESS (0.006s)
[56.496475] [020/165] (950s left) gem_exec_create (basic)
[56.583269] Starting subtest: basic
[56.584635] Starting dynamic subtest: smem
[58.628500] Dynamic subtest smem: SUCCESS (2.047s)
[58.629575] Subtest basic: SUCCESS (2.047s)
[58.850307] [021/165] (948s left) gem_exec_fence (basic-busy)
[59.078584] Starting subtest: basic-busy
[59.080112] Starting dynamic subtest: rcs0
[59.108749] Dynamic subtest rcs0: SUCCESS (0.030s)
[59.121529] Starting dynamic subtest: bcs0
[59.136689] Dynamic subtest bcs0: SUCCESS (0.028s)
[59.150152] Starting dynamic subtest: vcs0
[59.158425] Dynamic subtest vcs0: SUCCESS (0.022s)
[59.168344] Starting dynamic subtest: vecs0
[59.191387] Dynamic subtest vecs0: SUCCESS (0.033s)
[59.192489] Subtest basic-busy: SUCCESS (0.113s)
[59.931821] [022/165] (947s left) gem_exec_fence (basic-wait)
[60.168303] Starting subtest: basic-wait
[60.170125] Starting dynamic subtest: rcs0
[60.201544] Dynamic subtest rcs0: SUCCESS (0.034s)
[60.213814] Starting dynamic subtest: bcs0
[60.229805] Dynamic subtest bcs0: SUCCESS (0.028s)
[60.242190] Starting dynamic subtest: vcs0
[60.257521] Dynamic subtest vcs0: SUCCESS (0.028s)
[60.269312] Starting dynamic subtest: vecs0
[60.289460] Dynamic subtest vecs0: SUCCESS (0.032s)
[60.290810] Subtest basic-wait: SUCCESS (0.122s)
[60.966399] [023/165] (946s left) gem_exec_fence (basic-await)
[61.205759] Starting subtest: basic-await
[61.207130] Starting dynamic subtest: rcs0
[61.305226] Dynamic subtest rcs0: SUCCESS (0.099s)
[61.313210] Starting dynamic subtest: bcs0
[61.396570] Dynamic subtest bcs0: SUCCESS (0.091s)
[61.407107] Starting dynamic subtest: vcs0
[61.497806] Dynamic subtest vcs0: SUCCESS (0.101s)
[61.509403] Starting dynamic subtest: vecs0
[61.605712] Dynamic subtest vecs0: SUCCESS (0.108s)
[61.606773] Subtest basic-await: SUCCESS (0.400s)
[62.325969] [024/165] (945s left) gem_exec_fence (nb-await)
[62.565420] Starting subtest: nb-await
[62.566682] Starting dynamic subtest: rcs0
[62.630728] Dynamic subtest rcs0: SUCCESS (0.065s)
[62.651282] Starting dynamic subtest: bcs0
[62.710505] Dynamic subtest bcs0: SUCCESS (0.076s)
[62.754871] Starting dynamic subtest: vcs0
[62.831103] Dynamic subtest vcs0: SUCCESS (0.108s)
[62.898194] Starting dynamic subtest: vecs0
[62.947715] Dynamic subtest vecs0: SUCCESS (0.127s)
[62.952809] Subtest nb-await: SUCCESS (0.380s)
[63.703214] [025/165] (943s left) gem_exec_gttfill (basic)
[63.790089] Starting subtest: basic
[73.173966] Subtest basic: SUCCESS (9.375s)
[73.368266] [026/165] (934s left) gem_exec_parallel (engines)
[73.587775] Starting subtest: engines
[73.589031] Starting dynamic subtest: basic
[76.069541] Dynamic subtest basic: SUCCESS (2.482s)
[76.081067] Starting dynamic subtest: contexts
[79.482913] Dynamic subtest contexts: SUCCESS (3.404s)
[79.492260] Starting dynamic subtest: fds
[86.479064] Dynamic subtest fds: SUCCESS (7.004s)
[86.488995] Starting dynamic subtest: userptr
[88.746858] Dynamic subtest userptr: SUCCESS (2.266s)
[88.749273] Subtest engines: SUCCESS (15.158s)
[88.980637] [027/165] (918s left) gem_exec_store (basic)
[89.069783] Starting subtest: basic
[89.120470] Subtest basic: SUCCESS (0.051s)
[89.357729] [028/165] (918s left) gem_flink_basic (bad-flink)
[89.437785] Starting subtest: bad-flink
[89.438890] Subtest bad-flink: SUCCESS (0.000s)
[89.505761] [029/165] (918s left) gem_flink_basic (bad-open)
[89.575635] Starting subtest: bad-open
[89.576730] Subtest bad-open: SUCCESS (0.000s)
[89.640021] [030/165] (917s left) gem_flink_basic (basic)
[89.711281] Starting subtest: basic
[89.712639] Subtest basic: SUCCESS (0.000s)
[89.822256] [031/165] (917s left) gem_flink_basic (double-flink)
[89.901384] Starting subtest: double-flink
[89.902628] Subtest double-flink: SUCCESS (0.000s)
[90.038437] [032/165] (917s left) gem_flink_basic (flink-lifetime)
[90.109698] Starting subtest: flink-lifetime
[90.110889] Subtest flink-lifetime: SUCCESS (0.002s)
[90.244185] [033/165] (917s left) gem_huc_copy (huc-copy)
[90.321966] Starting subtest: huc-copy
[90.324656] Subtest huc-copy: SKIP (0.000s)
[90.461468] [034/165] (917s left) gem_linear_blits (basic)
[90.670081] Starting subtest: basic
[90.678651] Subtest basic: SUCCESS (0.009s)
[90.846355] [035/165] (916s left) gem_mmap (basic)
[90.972254] Starting subtest: basic
[90.976499] Subtest basic: SUCCESS (0.001s)
[91.064553] [036/165] (916s left) gem_mmap_gtt (basic)
[91.134607] Starting subtest: basic
[91.135652] Subtest basic: SUCCESS (0.001s)
[91.190873] [037/165] (916s left) gem_render_linear_blits (basic)
[91.272896] Starting subtest: basic
[91.313026] Subtest basic: SUCCESS (0.041s)
[91.357751] [038/165] (916s left) gem_render_tiled_blits (basic)
[91.435842] Starting subtest: basic
[91.479112] Subtest basic: SUCCESS (0.043s)
[91.524112] [039/165] (916s left) gem_ringfill (basic-all)
[91.796197] Starting subtest: basic-all
[92.964558] Subtest basic-all: SUCCESS (1.160s)
[93.084277] [040/165] (914s left) gem_softpin (allocator-basic)
[93.172871] Starting subtest: allocator-basic
[93.322348] Subtest allocator-basic: SUCCESS (0.141s)
[93.441414] [041/165] (914s left) gem_softpin (allocator-basic-reserve)
[93.519715] Starting subtest: allocator-basic-reserve
[93.663337] Subtest allocator-basic-reserve: SUCCESS (0.133s)
[93.789550] [042/165] (914s left) gem_softpin (safe-alignment)
[93.871441] Starting subtest: safe-alignment
[93.887851] Subtest safe-alignment: SUCCESS (0.015s)
[94.019937] [043/165] (913s left) gem_sync (basic-all)
[94.111302] Starting subtest: basic-all
[96.343561] Subtest basic-all: SUCCESS (2.232s)
[96.590428] [044/165] (911s left) gem_sync (basic-each)
[96.682311] Starting subtest: basic-each
[98.850488] Subtest basic-each: SUCCESS (2.168s)
[99.140252] [045/165] (908s left) gem_tiled_blits (basic)
[99.356582] Starting subtest: basic
[99.383510] Subtest basic: SUCCESS (0.026s)
[99.542143] [046/165] (908s left) gem_tiled_fence_blits (basic)
[99.813057] Starting subtest: basic
[99.826325] Subtest basic: SUCCESS (0.013s)
[99.981115] [047/165] (908s left) gem_tiled_pread_basic
[100.360987] [048/165] (907s left) gem_wait (busy@all-engines)
[100.455994] Starting subtest: busy
[100.456962] Starting dynamic subtest: all-engines
[100.982206] Dynamic subtest all-engines: SUCCESS (0.526s)
[100.983281] Subtest busy: SUCCESS (0.527s)
[101.261312] [049/165] (906s left) gem_wait (wait@all-engines)
[101.357656] Starting subtest: wait
[101.358617] Starting dynamic subtest: all-engines
[102.415816] Dynamic subtest all-engines: SUCCESS (1.056s)
[102.419162] Subtest wait: SUCCESS (1.057s)
[102.728798] [050/165] (905s left) i915_getparams_basic (basic-eu-total)
[102.803372] Starting subtest: basic-eu-total
[102.805285] Subtest basic-eu-total: SUCCESS (0.000s)
[102.881819] [051/165] (905s left) i915_getparams_basic (basic-subslice-total)
[102.958594] Starting subtest: basic-subslice-total
[102.960519] Subtest basic-subslice-total: SUCCESS (0.000s)
[103.030956] [052/165] (905s left) i915_hangman (error-state-basic)
[103.121066] Starting subtest: error-state-basic
[103.129187] Subtest error-state-basic: SUCCESS (0.008s)
[103.193925] [053/165] (904s left) i915_pciid
[103.331202] [054/165] (904s left) kms_addfb_basic (addfb25-4-tiled)
[103.451049] Starting subtest: addfb25-4-tiled
[103.452180] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[103.558065] [055/165] (904s left) kms_addfb_basic (addfb25-bad-modifier)
[103.646389] Starting subtest: addfb25-bad-modifier
[103.647418] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[103.780851] [056/165] (904s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[103.854271] Starting subtest: addfb25-framebuffer-vs-set-tiling
[103.855316] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[104.003643] [057/165] (904s left) kms_addfb_basic (addfb25-modifier-no-flag)
[104.077381] Starting subtest: addfb25-modifier-no-flag
[104.078438] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[104.236910] [058/165] (904s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[104.309201] Starting subtest: addfb25-x-tiled-legacy
[104.310315] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[104.464038] [059/165] (903s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[104.551609] Starting subtest: addfb25-x-tiled-mismatch-legacy
[104.552647] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[104.698546] [060/165] (903s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[104.820090] Starting subtest: addfb25-yf-tiled-legacy
[104.821149] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[104.921917] [061/165] (903s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[105.034756] Starting subtest: addfb25-y-tiled-legacy
[105.035810] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[105.153252] [062/165] (903s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[105.268261] Starting subtest: addfb25-y-tiled-small-legacy
[105.269192] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[105.379912] [063/165] (903s left) kms_addfb_basic (bad-pitch-0)
[105.468320] Starting subtest: bad-pitch-0
[105.469280] Subtest bad-pitch-0: SUCCESS (0.000s)
[105.633900] [064/165] (902s left) kms_addfb_basic (bad-pitch-1024)
[105.718490] Starting subtest: bad-pitch-1024
[105.719615] Subtest bad-pitch-1024: SUCCESS (0.000s)
[105.845115] [065/165] (902s left) kms_addfb_basic (bad-pitch-128)
[105.916501] Starting subtest: bad-pitch-128
[105.917521] Subtest bad-pitch-128: SUCCESS (0.000s)
[106.057034] [066/165] (902s left) kms_addfb_basic (bad-pitch-256)
[106.129532] Starting subtest: bad-pitch-256
[106.130526] Subtest bad-pitch-256: SUCCESS (0.000s)
[106.272302] [067/165] (902s left) kms_addfb_basic (bad-pitch-32)
[106.357575] Starting subtest: bad-pitch-32
[106.358648] Subtest bad-pitch-32: SUCCESS (0.000s)
[106.519622] [068/165] (902s left) kms_addfb_basic (bad-pitch-63)
[106.602376] Starting subtest: bad-pitch-63
[106.603316] Subtest bad-pitch-63: SUCCESS (0.000s)
[106.769200] [069/165] (901s left) kms_addfb_basic (bad-pitch-65536)
[106.842132] Starting subtest: bad-pitch-65536
[106.843249] Subtest bad-pitch-65536: SUCCESS (0.000s)
[106.974670] [070/165] (901s left) kms_addfb_basic (bad-pitch-999)
[107.050356] Starting subtest: bad-pitch-999
[107.051509] Subtest bad-pitch-999: SUCCESS (0.000s)
[107.198836] [071/165] (901s left) kms_addfb_basic (basic)
[107.282132] Starting subtest: basic
[107.283138] Subtest basic: SUCCESS (0.000s)
[107.435660] [072/165] (901s left) kms_addfb_basic (basic-x-tiled-legacy)
[107.521591] Starting subtest: basic-x-tiled-legacy
[107.522531] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[107.679226] [073/165] (901s left) kms_addfb_basic (basic-y-tiled-legacy)
[107.767180] Starting subtest: basic-y-tiled-legacy
[107.768124] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[107.929758] [074/165] (900s left) kms_addfb_basic (bo-too-small)
[108.051289] Starting subtest: bo-too-small
[108.052313] Subtest bo-too-small: SUCCESS (0.000s)
[108.151465] [075/165] (900s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[108.261411] Starting subtest: bo-too-small-due-to-tiling
[108.262436] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[108.364973] [076/165] (900s left) kms_addfb_basic (clobberred-modifier)
[108.436602] Starting subtest: clobberred-modifier
[108.437705] Subtest clobberred-modifier: SUCCESS (0.000s)
[108.564795] [077/165] (900s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[108.639054] Starting subtest: framebuffer-vs-set-tiling
[108.640139] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[108.797018] [078/165] (900s left) kms_addfb_basic (invalid-get-prop)
[108.868250] Starting subtest: invalid-get-prop
[108.869192] Subtest invalid-get-prop: SUCCESS (0.000s)
[109.022418] [079/165] (899s left) kms_addfb_basic (invalid-get-prop-any)
[109.096282] Starting subtest: invalid-get-prop-any
[109.097204] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[109.232852] [080/165] (899s left) kms_addfb_basic (invalid-set-prop)
[109.305682] Starting subtest: invalid-set-prop
[109.306926] Subtest invalid-set-prop: SUCCESS (0.000s)
[109.449381] [081/165] (899s left) kms_addfb_basic (invalid-set-prop-any)
[109.521603] Starting subtest: invalid-set-prop-any
[109.522707] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[109.671530] [082/165] (899s left) kms_addfb_basic (no-handle)
[109.743828] Starting subtest: no-handle
[109.745150] Subtest no-handle: SUCCESS (0.000s)
[109.904092] [083/165] (899s left) kms_addfb_basic (size-max)
[110.025159] Starting subtest: size-max
[110.026257] Subtest size-max: SUCCESS (0.000s)
[110.177509] [084/165] (898s left) kms_addfb_basic (small-bo)
[110.292740] Starting subtest: small-bo
[110.293916] Subtest small-bo: SUCCESS (0.000s)
[110.388593] [085/165] (898s left) kms_addfb_basic (tile-pitch-mismatch)
[110.462306] Starting subtest: tile-pitch-mismatch
[110.463340] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[110.596654] [086/165] (898s left) kms_addfb_basic (too-high)
[110.708216] Starting subtest: too-high
[110.709151] Subtest too-high: SUCCESS (0.001s)
[110.801682] [087/165] (898s left) kms_addfb_basic (too-wide)
[110.911245] Starting subtest: too-wide
[110.912243] Subtest too-wide: SUCCESS (0.000s)
[111.029360] [088/165] (898s left) kms_addfb_basic (unused-handle)
[111.112470] Starting subtest: unused-handle
[111.113519] Subtest unused-handle: SUCCESS (0.000s)
[111.244137] [089/165] (897s left) kms_addfb_basic (unused-modifier)
[111.316103] Starting subtest: unused-modifier
[111.317077] Subtest unused-modifier: SUCCESS (0.000s)
[111.456286] [090/165] (897s left) kms_addfb_basic (unused-offsets)
[111.530509] Starting subtest: unused-offsets
[111.531537] Subtest unused-offsets: SUCCESS (0.000s)
[111.677018] [091/165] (897s left) kms_addfb_basic (unused-pitches)
[111.757315] Starting subtest: unused-pitches
[111.758240] Subtest unused-pitches: SUCCESS (0.000s)
[111.908594] [092/165] (897s left) kms_busy (basic)
[112.033198] Starting subtest: basic
[112.034282] Starting dynamic subtest: flip
[112.954858] Dynamic subtest flip: SUCCESS (0.918s)
[112.969674] Starting dynamic subtest: modeset
[117.165101] Dynamic subtest modeset: SUCCESS (4.209s)
[117.170252] Subtest basic: SUCCESS (5.130s)
[118.094054] [093/165] (891s left) kms_prop_blob (basic)
[118.169855] Starting subtest: basic
[118.170931] Subtest basic: SUCCESS (0.000s)
[118.254984] [094/165] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[118.377183] Starting subtest: basic-busy-flip-before-cursor-atomic
[118.379160] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[118.458808] [095/165] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[118.567213] Starting subtest: basic-busy-flip-before-cursor-legacy
[118.569071] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[118.670562] [096/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[118.789241] Starting subtest: basic-flip-after-cursor-atomic
[120.085577] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.294s)
[121.025971] [097/165] (888s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[121.134385] Starting subtest: basic-flip-after-cursor-legacy
[122.462296] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.324s)
[123.348836] [098/165] (885s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[123.461161] Starting subtest: basic-flip-after-cursor-varying-size
[124.734207] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.273s)
[125.629681] [099/165] (883s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[125.741284] Starting subtest: basic-flip-before-cursor-atomic
[127.016702] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.273s)
[127.901965] [100/165] (881s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[128.009237] Starting subtest: basic-flip-before-cursor-legacy
[129.297743] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.288s)
[130.235746] [101/165] (879s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[130.345091] Starting subtest: basic-flip-before-cursor-varying-size
[131.660351] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.311s)
[132.543118] [102/165] (876s left) kms_dsc (dsc-basic)
[132.652249] Subtest dsc-basic: SKIP (0.000s)
[132.701436] [103/165] (876s left) kms_flip (basic-flip-vs-dpms)
[132.789944] Starting subtest: basic-flip-vs-dpms
[132.793581] Starting dynamic subtest: A-eDP1
[135.635947] Dynamic subtest A-eDP1: SUCCESS (2.839s)
[135.673920] Starting dynamic subtest: B-eDP1
[138.022392] Dynamic subtest B-eDP1: SUCCESS (2.378s)
[138.078463] Starting dynamic subtest: C-eDP1
[140.368410] Dynamic subtest C-eDP1: SUCCESS (2.343s)
[140.381286] Subtest basic-flip-vs-dpms: SUCCESS (7.591s)
[141.260390] [104/165] (868s left) kms_flip (basic-flip-vs-modeset)
[141.350714] Starting subtest: basic-flip-vs-modeset
[141.353505] Starting dynamic subtest: A-eDP1
[144.200745] Dynamic subtest A-eDP1: SUCCESS (2.839s)
[144.258240] Starting dynamic subtest: B-eDP1
[146.572641] Dynamic subtest B-eDP1: SUCCESS (2.363s)
[146.609964] Starting dynamic subtest: C-eDP1
[148.951325] Dynamic subtest C-eDP1: SUCCESS (2.368s)
[148.974206] Subtest basic-flip-vs-modeset: SUCCESS (7.623s)
[149.878780] [105/165] (859s left) kms_flip (basic-flip-vs-wf_vblank)
[149.981960] Starting subtest: basic-flip-vs-wf_vblank
[149.986189] Starting dynamic subtest: A-eDP1
[152.284971] Dynamic subtest A-eDP1: SUCCESS (2.298s)
[152.297706] Starting dynamic subtest: B-eDP1
[154.586231] Dynamic subtest B-eDP1: SUCCESS (2.300s)
[154.601142] Starting dynamic subtest: C-eDP1
[156.831268] Dynamic subtest C-eDP1: SUCCESS (2.244s)
[156.835188] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.853s)
[158.143159] [106/165] (851s left) kms_flip (basic-plain-flip)
[158.231959] Starting subtest: basic-plain-flip
[158.236306] Starting dynamic subtest: A-eDP1
[160.261966] Dynamic subtest A-eDP1: SUCCESS (2.020s)
[160.317993] Starting dynamic subtest: B-eDP1
[162.316209] Dynamic subtest B-eDP1: SUCCESS (2.043s)
[162.389430] Starting dynamic subtest: C-eDP1
[164.414995] Dynamic subtest C-eDP1: SUCCESS (2.088s)
[164.434481] Subtest basic-plain-flip: SUCCESS (6.200s)
[165.821635] [107/165] (843s left) kms_force_connector_basic (force-connector-state)
[165.923068] Starting subtest: force-connector-state
[166.455304] Subtest force-connector-state: SUCCESS (0.532s)
[167.677305] [108/165] (841s left) kms_force_connector_basic (force-edid)
[167.779342] Starting subtest: force-edid
[167.816996] Subtest force-edid: SUCCESS (0.036s)
[168.017964] [109/165] (841s left) kms_force_connector_basic (force-load-detect)
[168.132250] Starting subtest: force-load-detect
[168.134345] Subtest force-load-detect: SKIP (0.000s)
[168.282081] [110/165] (841s left) kms_force_connector_basic (prune-stale-modes)
[168.381333] Starting subtest: prune-stale-modes
[168.414281] Subtest prune-stale-modes: SUCCESS (0.035s)
[168.612370] [111/165] (841s left) kms_frontbuffer_tracking (basic)
[168.722806] Starting subtest: basic
[171.704182] Subtest basic: SUCCESS (2.981s)
[171.820183] [112/165] (837s left) kms_hdmi_inject (inject-audio)
[172.230252] Starting subtest: inject-audio
[172.370346] Subtest inject-audio: SUCCESS (0.142s)
[173.156731] [113/165] (836s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[173.270953] Starting subtest: compare-crc-sanitycheck-xr24
[173.272073] Starting dynamic subtest: pipe-A-eDP-1
[174.009698] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.730s)
[174.066912] Starting dynamic subtest: pipe-B-eDP-1
[175.330163] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.305s)
[175.385940] Starting dynamic subtest: pipe-C-eDP-1
[176.691650] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.345s)
[176.695743] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.421s)
[177.600184] [114/165] (832s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[177.720446] Starting subtest: compare-crc-sanitycheck-nv12
[177.721498] Starting dynamic subtest: pipe-A-eDP-1
[177.723449] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[177.735534] Starting dynamic subtest: pipe-B-eDP-1
[177.737521] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[177.748820] Starting dynamic subtest: pipe-C-eDP-1
[177.750687] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[177.752648] Subtest compare-crc-sanitycheck-nv12: SKIP (0.009s)
[177.813080] [115/165] (831s left) kms_pipe_crc_basic (hang-read-crc)
[177.922147] Starting subtest: hang-read-crc
[177.923151] Starting dynamic subtest: pipe-A-eDP-1
[180.584346] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.658s)
[180.648883] Starting dynamic subtest: pipe-B-eDP-1
[183.939088] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.324s)
[184.010567] Starting dynamic subtest: pipe-C-eDP-1
[187.180342] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.226s)
[187.184423] Subtest hang-read-crc: SUCCESS (9.258s)
[188.117087] [116/165] (821s left) kms_pipe_crc_basic (nonblocking-crc)
[188.241699] Starting subtest: nonblocking-crc
[188.242737] Starting dynamic subtest: pipe-A-eDP-1
[189.243195] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.991s)
[189.305234] Starting dynamic subtest: pipe-B-eDP-1
[190.996232] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.737s)
[191.072605] Starting dynamic subtest: pipe-C-eDP-1
[192.741392] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.718s)
[192.745363] Subtest nonblocking-crc: SUCCESS (4.495s)
[193.625827] [117/165] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[193.739076] Starting subtest: nonblocking-crc-frame-sequence
[193.742242] Starting dynamic subtest: pipe-A-eDP-1
[194.764800] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.020s)
[194.840195] Starting dynamic subtest: pipe-B-eDP-1
[196.508466] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.715s)
[196.580642] Starting dynamic subtest: pipe-C-eDP-1
[198.286234] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.765s)
[198.301483] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.550s)
[199.222084] [118/165] (810s left) kms_pipe_crc_basic (read-crc)
[199.346165] Starting subtest: read-crc
[199.347213] Starting dynamic subtest: pipe-A-eDP-1
[200.248087] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.893s)
[200.314648] Starting dynamic subtest: pipe-B-eDP-1
[201.957353] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.683s)
[202.031599] Starting dynamic subtest: pipe-C-eDP-1
[203.540477] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.557s)
[203.547474] Subtest read-crc: SUCCESS (4.189s)
[204.412288] [119/165] (805s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[204.523923] Starting subtest: read-crc-frame-sequence
[204.526579] Starting dynamic subtest: pipe-A-eDP-1
[205.498326] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.966s)
[205.568577] Starting dynamic subtest: pipe-B-eDP-1
[207.143915] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.616s)
[207.204511] Starting dynamic subtest: pipe-C-eDP-1
[208.785131] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.614s)
[208.788850] Subtest read-crc-frame-sequence: SUCCESS (4.258s)
[209.741977] [120/165] (800s left) kms_pm_backlight (basic-brightness)
[209.870761] Starting subtest: basic-brightness
[209.984378] Starting dynamic subtest: eDP-1
[210.599124] Dynamic subtest eDP-1: SUCCESS (0.609s)
[210.603155] Subtest basic-brightness: SUCCESS (0.727s)
[211.509954] [121/165] (798s left) kms_pm_rpm (basic-pci-d3-state)
[213.267350] Starting subtest: basic-pci-d3-state
[217.715257] Subtest basic-pci-d3-state: SUCCESS (4.448s)
[217.880971] [122/165] (792s left) kms_pm_rpm (basic-rte)
[217.956248] Starting subtest: basic-rte
[224.101873] Subtest basic-rte: SUCCESS (6.144s)
[225.716248] [123/165] (784s left) kms_psr (primary_page_flip)
[225.830552] Starting subtest: primary_page_flip
[227.926274] Subtest primary_page_flip: SUCCESS (2.086s)
[228.830490] [124/165] (781s left) kms_psr (cursor_plane_move)
[228.943391] Starting subtest: cursor_plane_move
[230.992676] Subtest cursor_plane_move: SUCCESS (2.047s)
[231.940487] [125/165] (778s left) kms_psr (sprite_plane_onoff)
[232.071313] Starting subtest: sprite_plane_onoff
[234.161790] Subtest sprite_plane_onoff: SUCCESS (2.079s)
[235.120886] [126/165] (775s left) kms_psr (primary_mmap_gtt)
[235.238805] Starting subtest: primary_mmap_gtt
[237.286706] Subtest primary_mmap_gtt: SUCCESS (2.040s)
[238.231743] [127/165] (771s left) kms_setmode (basic-clone-single-crtc)
[238.305234] Starting subtest: basic-clone-single-crtc
[238.307877] Subtest basic-clone-single-crtc: SKIP (0.001s)
[238.404223] [128/165] (771s left) i915_pm_rps (basic-api)
[238.489720] Starting subtest: basic-api
[238.494774] Subtest basic-api: SUCCESS (0.005s)
[238.622426] [129/165] (771s left) prime_self_import (basic-llseek-bad)
[238.703957] Starting subtest: basic-llseek-bad
[238.706271] Subtest basic-llseek-bad: SUCCESS (0.002s)
[238.844310] [130/165] (771s left) prime_self_import (basic-llseek-size)
[238.914819] Starting subtest: basic-llseek-size
[238.918728] Subtest basic-llseek-size: SUCCESS (0.004s)
[239.052263] [131/165] (771s left) prime_self_import (basic-with_fd_dup)
[239.124579] Starting subtest: basic-with_fd_dup
[239.129165] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[239.261722] [132/165] (771s left) prime_self_import (basic-with_one_bo)
[239.335036] Starting subtest: basic-with_one_bo
[239.337077] Subtest basic-with_one_bo: SUCCESS (0.004s)
[239.454776] [133/165] (770s left) prime_self_import (basic-with_one_bo_two_files)
[239.531606] Starting subtest: basic-with_one_bo_two_files
[239.535866] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[239.666845] [134/165] (770s left) prime_self_import (basic-with_two_bos)
[239.736069] Starting subtest: basic-with_two_bos
[239.739984] Subtest basic-with_two_bos: SUCCESS (0.004s)
[239.853030] [135/165] (770s left) prime_vgem (basic-fence-flip)
[239.938515] Starting subtest: basic-fence-flip
[240.414606] Subtest basic-fence-flip: SUCCESS (0.476s)
[240.524572] [136/165] (769s left) prime_vgem (basic-fence-mmap)
[240.605515] Starting subtest: basic-fence-mmap
[240.643759] Subtest basic-fence-mmap: SUCCESS (0.038s)
[240.733286] [137/165] (769s left) prime_vgem (basic-fence-read)
[240.822340] Starting subtest: basic-fence-read
[240.882223] Subtest basic-fence-read: SUCCESS (0.060s)
[240.968624] [138/165] (769s left) prime_vgem (basic-gtt)
[241.055103] Starting subtest: basic-gtt
[241.073023] Subtest basic-gtt: SUCCESS (0.018s)
[241.164015] [139/165] (769s left) prime_vgem (basic-read)
[241.268448] Starting subtest: basic-read
[241.295313] Subtest basic-read: SUCCESS (0.027s)
[241.406352] [140/165] (769s left) prime_vgem (basic-write)
[241.488687] Starting subtest: basic-write
[241.518780] Subtest basic-write: SUCCESS (0.030s)
[241.595345] [141/165] (768s left) vgem_basic (setversion)
[241.682473] Starting subtest: setversion
[241.684261] Subtest setversion: SUCCESS (0.000s)
[241.742172] [142/165] (768s left) vgem_basic (create)
[241.815987] Starting subtest: create
[241.817108] Subtest create: SUCCESS (0.000s)
[241.875516] [143/165] (768s left) vgem_basic (debugfs)
[241.966134] Starting subtest: debugfs
[241.967221] Subtest debugfs: SUCCESS (0.001s)
[242.028456] [144/165] (768s left) vgem_basic (dmabuf-export)
[242.116086] Starting subtest: dmabuf-export
[242.128961] Subtest dmabuf-export: SUCCESS (0.011s)
[242.225671] [145/165] (768s left) vgem_basic (dmabuf-fence)
[242.300440] Starting subtest: dmabuf-fence
[242.301462] Subtest dmabuf-fence: SUCCESS (0.001s)
[242.358726] [146/165] (768s left) vgem_basic (dmabuf-fence-before)
[242.436145] Starting subtest: dmabuf-fence-before
[242.437063] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[242.491765] [147/165] (768s left) vgem_basic (dmabuf-mmap)
[242.566088] Starting subtest: dmabuf-mmap
[242.584182] Subtest dmabuf-mmap: SUCCESS (0.018s)
[242.641604] [148/165] (768s left) vgem_basic (mmap)
[242.716186] Starting subtest: mmap
[242.728579] Subtest mmap: SUCCESS (0.012s)
[242.792197] [149/165] (767s left) vgem_basic (second-client)
[242.866373] Starting subtest: second-client
[242.907075] Subtest second-client: SUCCESS (0.033s)
[242.965925] [150/165] (767s left) vgem_basic (sysfs)
[243.049675] Starting subtest: sysfs
[243.050710] Subtest sysfs: SUCCESS (0.001s)
[243.109249] [151/165] (767s left) core_hotunplug (unbind-rebind)
[243.216693] Starting subtest: unbind-rebind
[247.578777] Subtest unbind-rebind: SUCCESS (4.362s)
[247.606044] [152/165] (763s left) vgem_basic (unload)
[247.684657] Starting subtest: unload
[276.783955] Subtest unload: SUCCESS (29.062s)
[276.883387] [153/165] (733s left) i915_module_load (reload)
[276.954187] Starting subtest: reload
[280.223084] Subtest reload: SUCCESS (3.268s)
[280.248568] [154/165] (730s left) gem_lmem_swapping (basic)
[280.382140] Subtest basic: SKIP (0.000s)
[280.425540] [155/165] (730s left) gem_lmem_swapping (parallel-random-engines)
[280.513692] Subtest parallel-random-engines: SKIP (0.000s)
[280.552204] [156/165] (730s left) gem_lmem_swapping (random-engines)
[280.632454] Subtest random-engines: SKIP (0.000s)
[280.668622] [157/165] (730s left) gem_lmem_swapping (verify-random)
[280.747800] Subtest verify-random: SKIP (0.000s)
[280.785946] [158/165] (730s left) i915_pm_rpm (module-reload)
[283.498808] Starting subtest: module-reload
[295.914850] Subtest module-reload: SUCCESS (12.413s)
[295.943993] [159/165] (715s left) i915_selftest (live)
[296.040542] Starting subtest: live
[296.044289] Starting dynamic subtest: sanitycheck
[297.735766] Dynamic subtest sanitycheck: SUCCESS (1.685s)
[297.743474] Starting dynamic subtest: uncore
[299.483613] Dynamic subtest uncore: SUCCESS (1.746s)
[299.491269] Starting dynamic subtest: workarounds
[301.383061] Dynamic subtest workarounds: SUCCESS (1.897s)
[301.392034] Starting dynamic subtest: gt_engines
[303.527675] Dynamic subtest gt_engines: SUCCESS (2.142s)
[303.537971] Starting dynamic subtest: gt_timelines
[314.657732] Dynamic subtest gt_timelines: SUCCESS (11.128s)
[314.665362] Starting dynamic subtest: gt_contexts
[316.427138] Dynamic subtest gt_contexts: SUCCESS (1.767s)
[316.437929] Starting dynamic subtest: gt_lrc
[320.576632] Dynamic subtest gt_lrc: SUCCESS (4.147s)
[320.587050] Starting dynamic subtest: gt_mocs
[322.392542] Dynamic subtest gt_mocs: SUCCESS (1.814s)
[322.400193] Starting dynamic subtest: gt_pm
[328.437698] Dynamic subtest gt_pm: SUCCESS (6.043s)
[328.445395] Starting dynamic subtest: gt_heartbeat
[330.327793] Dynamic subtest gt_heartbeat: SUCCESS (1.888s)
[330.339360] Starting dynamic subtest: gt_tlb
[333.045687] Dynamic subtest gt_tlb: SUCCESS (2.717s)
[333.058388] Starting dynamic subtest: requests
[340.551734] Dynamic subtest requests: SUCCESS (7.503s)
[340.559492] Starting dynamic subtest: migrate
[345.003703] Dynamic subtest migrate: SUCCESS (4.450s)
[345.011511] Starting dynamic subtest: active
[346.718687] Dynamic subtest active: SUCCESS (1.713s)
[346.726906] Starting dynamic subtest: objects
[349.542781] Dynamic subtest objects: SUCCESS (2.822s)
[349.551360] Starting dynamic subtest: mman
[354.656809] Dynamic subtest mman: SUCCESS (5.112s)
[354.665076] Starting dynamic subtest: dmabuf
[356.366721] Dynamic subtest dmabuf: SUCCESS (1.708s)
[356.374811] Starting dynamic subtest: vma
[358.106713] Dynamic subtest vma: SUCCESS (1.738s)
[358.118368] Starting dynamic subtest: coherency
[360.947680] Dynamic subtest coherency: SUCCESS (2.839s)
[360.958240] Starting dynamic subtest: gtt
[369.495742] Dynamic subtest gtt: SUCCESS (8.546s)
[369.504268] Starting dynamic subtest: gem
[371.379635] Dynamic subtest gem: SUCCESS (1.882s)
[371.387370] Starting dynamic subtest: evict
[374.624715] Dynamic subtest evict: SUCCESS (3.243s)
[374.635138] Starting dynamic subtest: hugepages
[381.593756] Dynamic subtest hugepages: SUCCESS (6.967s)
[381.601612] Starting dynamic subtest: gem_contexts
[396.277753] Dynamic subtest gem_contexts: SUCCESS (14.682s)
[396.285672] Starting dynamic subtest: client
[398.029732] Dynamic subtest client: SUCCESS (1.751s)
[398.037622] Starting dynamic subtest: gem_migrate
[399.765740] Dynamic subtest gem_migrate: SUCCESS (1.734s)
[399.773528] Starting dynamic subtest: reset
[402.160763] Dynamic subtest reset: SUCCESS (2.393s)
[402.172410] Starting dynamic subtest: memory_region
[403.853369] Dynamic subtest memory_region: SUCCESS (1.700s)
[403.864236] Starting dynamic subtest: hangcheck
[428.007844] Dynamic subtest hangcheck: SUCCESS (24.144s)
[428.016470] Starting dynamic subtest: execlists
[437.494677] Dynamic subtest execlists: SUCCESS (9.485s)
[437.505350] Starting dynamic subtest: ring_submission
[439.171707] Dynamic subtest ring_submission: SUCCESS (1.675s)
[439.179747] Starting dynamic subtest: perf
[441.110731] Dynamic subtest perf: SUCCESS (1.938s)
[441.118691] Starting dynamic subtest: slpc
[442.843105] Dynamic subtest slpc: SUCCESS (1.730s)
[442.854099] Starting dynamic subtest: guc
[444.571671] Dynamic subtest guc: SUCCESS (1.726s)
[444.579427] Starting dynamic subtest: guc_multi_lrc
[446.357734] Dynamic subtest guc_multi_lrc: SUCCESS (1.785s)
[446.365071] Starting dynamic subtest: guc_hang
[448.096827] Dynamic subtest guc_hang: SUCCESS (1.738s)
[448.109945] Starting dynamic subtest: late_gt_pm
[449.896914] Dynamic subtest late_gt_pm: SUCCESS (1.798s)
[449.898044] Subtest live: SUCCESS (153.849s)
[449.922806] [160/165] (561s left) dmabuf (all-tests)
[450.010096] Starting subtest: all-tests
[450.011785] Starting dynamic subtest: sanitycheck
[450.070778] Dynamic subtest sanitycheck: SUCCESS (0.060s)
[450.091916] Starting dynamic subtest: dma_fence
[450.261580] Dynamic subtest dma_fence: SUCCESS (0.187s)
[450.278926] Starting dynamic subtest: dma_fence_chain
[466.232481] Dynamic subtest dma_fence_chain: SUCCESS (15.960s)
[466.249316] Starting dynamic subtest: dma_fence_unwrap
[466.305110] Dynamic subtest dma_fence_unwrap: SUCCESS (0.076s)
[466.340822] Starting dynamic subtest: dma_resv
[466.403110] Dynamic subtest dma_resv: SUCCESS (0.087s)
[466.406248] Subtest all-tests: SUCCESS (16.395s)
[466.449891] [161/165] (544s left) i915_suspend (basic-s2idle-without-i915)
[466.531500] Starting subtest: basic-s2idle-without-i915
[486.428553] Subtest basic-s2idle-without-i915: SUCCESS (4.201s)
[489.814144] [162/165] (540s left) i915_suspend (basic-s3-without-i915)
[489.891930] Starting subtest: basic-s3-without-i915
[510.172750] Subtest basic-s3-without-i915: SUCCESS (4.020s)
[513.590151] [163/165] (535s left) gem_exec_suspend (basic-s0)
[513.706573] Starting subtest: basic-S0
[513.709168] Starting dynamic subtest: smem
[532.380129] Dynamic subtest smem: SUCCESS (3.184s)
[532.381318] Subtest basic-S0: SUCCESS (3.186s)
[536.645634] [164/165] (532s left) gem_exec_suspend (basic-s3)
[536.736564] Starting subtest: basic-S3
[536.740059] Starting dynamic subtest: smem
[557.400397] Dynamic subtest smem: SUCCESS (4.172s)
[557.401343] Subtest basic-S3: SUCCESS (4.174s)
[559.680922] [165/165] (527s left) kms_pipe_crc_basic (suspend-read-crc)
[559.801797] Starting subtest: suspend-read-crc
[559.802856] Starting dynamic subtest: pipe-A-eDP-1
[588.251588] Dynamic subtest pipe-A-eDP-1: SUCCESS (12.460s)
[588.275377] Starting dynamic subtest: pipe-B-eDP-1
[609.582481] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.343s)
[609.639388] Starting dynamic subtest: pipe-C-eDP-1
[630.372833] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.911s)
[630.375261] Subtest suspend-read-crc: SUCCESS (20.769s)
[634.256144] Closing watchdogs
Done.