[46.416986] Initializing watchdogs
[46.417106]   /dev/watchdog0
[46.423799] [001/170] (960s left) i915_module_load (load)
[46.505191] Starting subtest: load
[47.842414] Subtest load: SUCCESS (1.337s)
[47.860693] [002/170] (959s left) core_auth (basic-auth)
[47.999180] Starting subtest: basic-auth
[48.000213] Subtest basic-auth: SUCCESS (0.001s)
[48.063390] [003/170] (958s left) debugfs_test (read_all_entries)
[48.164051] Starting subtest: read_all_entries
[48.660351] Subtest read_all_entries: SUCCESS (0.496s)
[48.779880] [004/170] (958s left) debugfs_test (basic-hwmon)
[48.877211] Starting subtest: basic-hwmon
[48.881543] Subtest basic-hwmon: SUCCESS (0.004s)
[49.012615] [005/170] (957s left) fbdev (eof)
[49.092833] Starting subtest: eof
[49.093726] Subtest eof: SUCCESS (0.000s)
[49.148138] [006/170] (957s left) fbdev (info)
[49.223794] Starting subtest: info
[49.224836] Subtest info: SUCCESS (0.000s)
[49.279652] [007/170] (957s left) fbdev (nullptr)
[49.359569] Starting subtest: nullptr
[49.360580] Subtest nullptr: SUCCESS (0.000s)
[49.416906] [008/170] (957s left) fbdev (read)
[49.509542] Starting subtest: read
[61.871244] Subtest read: SUCCESS (12.327s)
[61.898282] [009/170] (945s left) fbdev (write)
[61.976386] Starting subtest: write
[68.122212] Subtest write: SUCCESS (6.137s)
[68.164977] [010/170] (938s left) gem_basic (bad-close)
[68.253337] Starting subtest: bad-close
[68.255311] Subtest bad-close: SUCCESS (0.000s)
[68.321729] [011/170] (938s left) gem_basic (create-close)
[68.409995] Starting subtest: create-close
[68.411876] Subtest create-close: SUCCESS (0.000s)
[68.494812] [012/170] (938s left) gem_basic (create-fd-close)
[68.602204] Starting subtest: create-fd-close
[68.603992] Subtest create-fd-close: SUCCESS (0.000s)
[68.686959] [013/170] (938s left) gem_busy (busy@all-engines)
[68.814033] Starting subtest: busy
[68.815207] Starting dynamic subtest: all-engines
[68.955432] Dynamic subtest all-engines: SUCCESS (0.142s)
[68.956462] Subtest busy: SUCCESS (0.142s)
[69.445275] [014/170] (937s left) gem_close_race (basic-process)
[69.589903] Starting subtest: basic-process
[69.646486] Subtest basic-process: SUCCESS (0.056s)
[69.895676] [015/170] (937s left) gem_close_race (basic-threads)
[70.021056] Starting subtest: basic-threads
[71.233355] Subtest basic-threads: SUCCESS (1.212s)
[71.499330] [016/170] (935s left) gem_ctx_create (basic)
[71.614903] Starting subtest: basic
[71.615838] Subtest basic: SUCCESS (0.000s)
[71.828292] [017/170] (935s left) gem_ctx_create (basic-files)
[71.934385] Starting subtest: basic-files
[73.950579] Subtest basic-files: SUCCESS (2.016s)
[74.349144] [018/170] (932s left) gem_ctx_exec (basic)
[74.441703] Starting subtest: basic
[74.447413] Subtest basic: SUCCESS (0.006s)
[74.558034] [019/170] (932s left) gem_exec_basic (basic)
[74.681705] Starting subtest: basic
[74.682730] Starting dynamic subtest: rcs0-smem
[74.684860] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[74.690985] Starting dynamic subtest: bcs0-smem
[74.692073] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[74.698297] Starting dynamic subtest: vcs0-smem
[74.699362] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[74.704851] Starting dynamic subtest: vcs1-smem
[74.706047] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[74.711540] Starting dynamic subtest: vecs0-smem
[74.712685] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[74.718246] Starting dynamic subtest: vecs1-smem
[74.719404] Dynamic subtest vecs1-smem: SUCCESS (0.001s)
[74.724991] Starting dynamic subtest: ccs0-smem
[74.726172] Dynamic subtest ccs0-smem: SUCCESS (0.001s)
[74.731685] Starting dynamic subtest: ccs1-smem
[74.732797] Dynamic subtest ccs1-smem: SUCCESS (0.001s)
[74.738374] Starting dynamic subtest: ccs2-smem
[74.739513] Dynamic subtest ccs2-smem: SUCCESS (0.001s)
[74.745093] Starting dynamic subtest: ccs3-smem
[74.746221] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[74.751769] Starting dynamic subtest: rcs0-lmem0
[74.752666] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[74.757965] Starting dynamic subtest: bcs0-lmem0
[74.758871] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[74.764224] Starting dynamic subtest: vcs0-lmem0
[74.765108] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[74.770401] Starting dynamic subtest: vcs1-lmem0
[74.771277] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[74.776606] Starting dynamic subtest: vecs0-lmem0
[74.777477] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[74.782830] Starting dynamic subtest: vecs1-lmem0
[74.783805] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[74.789155] Starting dynamic subtest: ccs0-lmem0
[74.790239] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[74.795603] Starting dynamic subtest: ccs1-lmem0
[74.796540] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[74.802066] Starting dynamic subtest: ccs2-lmem0
[74.803130] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[74.808515] Starting dynamic subtest: ccs3-lmem0
[74.809655] Dynamic subtest ccs3-lmem0: SUCCESS (0.000s)
[74.810745] Subtest basic: SUCCESS (0.014s)
[74.896222] [020/170] (932s left) gem_exec_create (basic)
[75.006458] Starting subtest: basic
[75.007553] Starting dynamic subtest: smem
[77.123875] Dynamic subtest smem: SUCCESS (2.117s)
[77.131251] Starting dynamic subtest: lmem0
[79.256927] Dynamic subtest lmem0: SUCCESS (2.133s)
[79.257880] Subtest basic: SUCCESS (4.251s)
[79.464764] [021/170] (927s left) gem_exec_fence (basic-busy)
[79.707323] Starting subtest: basic-busy
[79.708415] Starting dynamic subtest: rcs0
[79.809793] Dynamic subtest rcs0: SUCCESS (0.110s)
[79.819419] Starting dynamic subtest: bcs0
[79.862215] Dynamic subtest bcs0: SUCCESS (0.052s)
[79.882588] Starting dynamic subtest: vcs0
[79.922719] Dynamic subtest vcs0: SUCCESS (0.059s)
[79.947775] Starting dynamic subtest: vcs1
[79.984588] Dynamic subtest vcs1: SUCCESS (0.061s)
[80.009489] Starting dynamic subtest: vecs0
[80.046386] Dynamic subtest vecs0: SUCCESS (0.062s)
[80.071688] Starting dynamic subtest: vecs1
[80.105473] Dynamic subtest vecs1: SUCCESS (0.059s)
[80.129992] Starting dynamic subtest: ccs0
[80.168465] Dynamic subtest ccs0: SUCCESS (0.063s)
[80.193678] Starting dynamic subtest: ccs1
[80.234428] Dynamic subtest ccs1: SUCCESS (0.066s)
[80.259328] Starting dynamic subtest: ccs2
[80.296633] Dynamic subtest ccs2: SUCCESS (0.062s)
[80.321878] Starting dynamic subtest: ccs3
[80.356422] Dynamic subtest ccs3: SUCCESS (0.059s)
[80.358807] Subtest basic-busy: SUCCESS (0.657s)
[81.097621] [022/170] (926s left) gem_exec_fence (basic-wait)
[81.371696] Starting subtest: basic-wait
[81.372723] Starting dynamic subtest: rcs0
[81.470897] Dynamic subtest rcs0: SUCCESS (0.107s)
[81.484664] Starting dynamic subtest: bcs0
[81.528384] Dynamic subtest bcs0: SUCCESS (0.056s)
[81.554366] Starting dynamic subtest: vcs0
[81.585766] Dynamic subtest vcs0: SUCCESS (0.057s)
[81.603600] Starting dynamic subtest: vcs1
[81.639230] Dynamic subtest vcs1: SUCCESS (0.053s)
[81.665199] Starting dynamic subtest: vecs0
[81.698179] Dynamic subtest vecs0: SUCCESS (0.059s)
[81.720702] Starting dynamic subtest: vecs1
[81.753764] Dynamic subtest vecs1: SUCCESS (0.055s)
[81.774791] Starting dynamic subtest: ccs0
[81.809947] Dynamic subtest ccs0: SUCCESS (0.056s)
[81.830488] Starting dynamic subtest: ccs1
[81.868864] Dynamic subtest ccs1: SUCCESS (0.059s)
[81.894159] Starting dynamic subtest: ccs2
[81.932445] Dynamic subtest ccs2: SUCCESS (0.063s)
[81.957606] Starting dynamic subtest: ccs3
[81.998449] Dynamic subtest ccs3: SUCCESS (0.066s)
[82.000775] Subtest basic-wait: SUCCESS (0.634s)
[82.631939] [023/170] (924s left) gem_exec_fence (basic-await)
[82.915197] Starting subtest: basic-await
[82.916228] Starting dynamic subtest: rcs0
[83.059574] Dynamic subtest rcs0: SUCCESS (0.152s)
[83.077460] Starting dynamic subtest: bcs0
[83.190249] Dynamic subtest bcs0: SUCCESS (0.131s)
[83.196213] Starting dynamic subtest: vcs0
[83.302253] Dynamic subtest vcs0: SUCCESS (0.112s)
[83.308473] Starting dynamic subtest: vcs1
[83.421384] Dynamic subtest vcs1: SUCCESS (0.119s)
[83.427918] Starting dynamic subtest: vecs0
[83.539344] Dynamic subtest vecs0: SUCCESS (0.118s)
[83.545121] Starting dynamic subtest: vecs1
[83.656530] Dynamic subtest vecs1: SUCCESS (0.117s)
[83.663482] Starting dynamic subtest: ccs0
[83.769937] Dynamic subtest ccs0: SUCCESS (0.113s)
[83.776607] Starting dynamic subtest: ccs1
[83.885604] Dynamic subtest ccs1: SUCCESS (0.116s)
[83.891621] Starting dynamic subtest: ccs2
[83.997222] Dynamic subtest ccs2: SUCCESS (0.111s)
[84.004698] Starting dynamic subtest: ccs3
[84.112724] Dynamic subtest ccs3: SUCCESS (0.115s)
[84.113910] Subtest basic-await: SUCCESS (1.206s)
[84.715701] [024/170] (922s left) gem_exec_fence (nb-await)
[84.944335] Starting subtest: nb-await
[84.945333] Starting dynamic subtest: rcs0
[85.043901] Dynamic subtest rcs0: SUCCESS (0.105s)
[85.051952] Starting dynamic subtest: bcs0
[85.112884] Dynamic subtest bcs0: SUCCESS (0.069s)
[85.129189] Starting dynamic subtest: vcs0
[85.207622] Dynamic subtest vcs0: SUCCESS (0.094s)
[85.215226] Starting dynamic subtest: vcs1
[85.276997] Dynamic subtest vcs1: SUCCESS (0.069s)
[85.290895] Starting dynamic subtest: vecs0
[85.368244] Dynamic subtest vecs0: SUCCESS (0.090s)
[85.402456] Starting dynamic subtest: vecs1
[85.473422] Dynamic subtest vecs1: SUCCESS (0.106s)
[85.486023] Starting dynamic subtest: ccs0
[85.556224] Dynamic subtest ccs0: SUCCESS (0.082s)
[85.586716] Starting dynamic subtest: ccs1
[85.658686] Dynamic subtest ccs1: SUCCESS (0.103s)
[85.672587] Starting dynamic subtest: ccs2
[85.743827] Dynamic subtest ccs2: SUCCESS (0.084s)
[85.772256] Starting dynamic subtest: ccs3
[85.845390] Dynamic subtest ccs3: SUCCESS (0.102s)
[85.846695] Subtest nb-await: SUCCESS (0.906s)
[86.470304] [025/170] (920s left) gem_exec_gttfill (basic)
[86.588181] Starting subtest: basic
[93.795057] Subtest basic: SUCCESS (7.198s)
[94.066592] [026/170] (913s left) gem_exec_parallel (engines)
[94.222470] Starting subtest: engines
[94.223431] Starting dynamic subtest: basic
[96.898478] Dynamic subtest basic: SUCCESS (2.676s)
[96.905698] Starting dynamic subtest: contexts
[99.884472] Dynamic subtest contexts: SUCCESS (2.977s)
[99.891082] Starting dynamic subtest: fds
[103.528520] Dynamic subtest fds: SUCCESS (3.644s)
[103.534913] Starting dynamic subtest: userptr
[105.358350] Dynamic subtest userptr: SUCCESS (1.838s)
[105.359515] Subtest engines: SUCCESS (11.136s)
[105.655077] [027/170] (901s left) gem_exec_store (basic)
[105.773149] Starting subtest: basic
[105.934846] Subtest basic: SUCCESS (0.161s)
[106.180378] [028/170] (901s left) gem_flink_basic (bad-flink)
[106.273472] Starting subtest: bad-flink
[106.274427] Subtest bad-flink: SUCCESS (0.000s)
[106.332511] [029/170] (901s left) gem_flink_basic (bad-open)
[106.422034] Starting subtest: bad-open
[106.422966] Subtest bad-open: SUCCESS (0.000s)
[106.481806] [030/170] (900s left) gem_flink_basic (basic)
[106.572192] Starting subtest: basic
[106.573227] Subtest basic: SUCCESS (0.000s)
[106.653015] [031/170] (900s left) gem_flink_basic (double-flink)
[106.752266] Starting subtest: double-flink
[106.753295] Subtest double-flink: SUCCESS (0.000s)
[106.842990] [032/170] (900s left) gem_flink_basic (flink-lifetime)
[106.933248] Starting subtest: flink-lifetime
[106.935366] Subtest flink-lifetime: SUCCESS (0.002s)
[107.022307] [033/170] (900s left) gem_huc_copy (huc-copy)
[107.152136] Starting subtest: huc-copy
[107.159494] Subtest huc-copy: SUCCESS (0.007s)
[107.293561] [034/170] (900s left) gem_linear_blits (basic)
[107.505123] Starting subtest: basic
[107.542712] Subtest basic: SUCCESS (0.038s)
[107.692508] [035/170] (899s left) gem_mmap (basic)
[107.841431] Subtest basic: SKIP (0.000s)
[107.870329] [036/170] (899s left) gem_mmap_gtt (basic)
[107.961576] Subtest basic: SKIP (0.000s)
[107.986036] [037/170] (899s left) gem_render_linear_blits (basic)
[108.084426] Starting subtest: basic
[108.165400] Subtest basic: SUCCESS (0.081s)
[108.237067] [038/170] (899s left) gem_render_tiled_blits (basic)
[108.340178] Subtest basic: SKIP (0.000s)
[108.369125] [039/170] (899s left) gem_ringfill (basic-all)
[108.828212] Starting subtest: basic-all
[110.349543] Subtest basic-all: SUCCESS (1.516s)
[110.515997] [040/170] (897s left) gem_softpin (allocator-basic)
[110.627091] Starting subtest: allocator-basic
[110.900292] Subtest allocator-basic: SUCCESS (0.265s)
[111.048650] [041/170] (896s left) gem_softpin (allocator-basic-reserve)
[111.161597] Starting subtest: allocator-basic-reserve
[111.437122] Subtest allocator-basic-reserve: SUCCESS (0.267s)
[111.555691] [042/170] (896s left) gem_softpin (safe-alignment)
[111.682758] Starting subtest: safe-alignment
[111.752198] Subtest safe-alignment: SUCCESS (0.069s)
[111.898980] [043/170] (895s left) gem_sync (basic-all)
[112.010485] Starting subtest: basic-all
[115.877231] Subtest basic-all: SUCCESS (3.867s)
[116.091530] [044/170] (891s left) gem_sync (basic-each)
[116.206084] Starting subtest: basic-each
[118.819629] Subtest basic-each: SUCCESS (2.612s)
[119.044367] [045/170] (888s left) gem_tiled_blits (basic)
[119.143222] Subtest basic: SKIP (0.000s)
[119.169396] [046/170] (888s left) gem_tiled_fence_blits (basic)
[119.268204] Subtest basic: SKIP (0.000s)
[119.302688] [047/170] (888s left) gem_tiled_pread_basic
[119.419552] [048/170] (888s left) gem_wait (busy@all-engines)
[119.529931] Starting subtest: busy
[119.531062] Starting dynamic subtest: all-engines
[120.110553] Dynamic subtest all-engines: SUCCESS (0.581s)
[120.111545] Subtest busy: SUCCESS (0.581s)
[120.380286] [049/170] (887s left) gem_wait (wait@all-engines)
[120.492574] Starting subtest: wait
[120.493663] Starting dynamic subtest: all-engines
[121.599404] Dynamic subtest all-engines: SUCCESS (1.105s)
[121.602122] Subtest wait: SUCCESS (1.105s)
[121.880888] [050/170] (885s left) i915_getparams_basic (basic-eu-total)
[121.984145] Starting subtest: basic-eu-total
[121.986065] Subtest basic-eu-total: SUCCESS (0.000s)
[122.063767] [051/170] (885s left) i915_getparams_basic (basic-subslice-total)
[122.160121] Starting subtest: basic-subslice-total
[122.162174] Subtest basic-subslice-total: SUCCESS (0.000s)
[122.236091] [052/170] (885s left) i915_hangman (error-state-basic)
[122.349254] Starting subtest: error-state-basic
[122.547237] Subtest error-state-basic: SUCCESS (0.198s)
[122.630961] [053/170] (885s left) i915_pciid
[122.800732] [054/170] (885s left) kms_addfb_basic (addfb25-bad-modifier)
[122.894762] Starting subtest: addfb25-bad-modifier
[122.895892] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[123.033412] [055/170] (884s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[123.127521] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[123.266800] [056/170] (884s left) kms_addfb_basic (addfb25-modifier-no-flag)
[123.357340] Starting subtest: addfb25-modifier-no-flag
[123.358369] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[123.502326] [057/170] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[123.597366] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[123.737227] [058/170] (884s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[123.832306] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[123.969065] [059/170] (884s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[124.134287] Starting subtest: addfb25-yf-tiled-legacy
[124.135328] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[124.224009] [060/170] (883s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[124.378267] Starting subtest: addfb25-y-tiled-legacy
[124.379279] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[124.466737] [061/170] (883s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[124.620784] Starting subtest: addfb25-y-tiled-small-legacy
[124.622771] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[124.716569] [062/170] (883s left) kms_addfb_basic (bad-pitch-0)
[124.807314] Starting subtest: bad-pitch-0
[124.808252] Subtest bad-pitch-0: SUCCESS (0.000s)
[124.952654] [063/170] (883s left) kms_addfb_basic (bad-pitch-1024)
[125.046365] Starting subtest: bad-pitch-1024
[125.047402] Subtest bad-pitch-1024: SUCCESS (0.000s)
[125.185535] [064/170] (882s left) kms_addfb_basic (bad-pitch-128)
[125.280249] Starting subtest: bad-pitch-128
[125.281297] Subtest bad-pitch-128: SUCCESS (0.000s)
[125.433426] [065/170] (882s left) kms_addfb_basic (bad-pitch-256)
[125.525280] Starting subtest: bad-pitch-256
[125.526391] Subtest bad-pitch-256: SUCCESS (0.000s)
[125.683427] [066/170] (882s left) kms_addfb_basic (bad-pitch-32)
[125.775416] Starting subtest: bad-pitch-32
[125.776470] Subtest bad-pitch-32: SUCCESS (0.000s)
[125.933728] [067/170] (882s left) kms_addfb_basic (bad-pitch-63)
[126.025277] Starting subtest: bad-pitch-63
[126.026334] Subtest bad-pitch-63: SUCCESS (0.000s)
[126.169191] [068/170] (881s left) kms_addfb_basic (bad-pitch-65536)
[126.263375] Starting subtest: bad-pitch-65536
[126.264404] Subtest bad-pitch-65536: SUCCESS (0.000s)
[126.418745] [069/170] (881s left) kms_addfb_basic (bad-pitch-999)
[126.512341] Starting subtest: bad-pitch-999
[126.513389] Subtest bad-pitch-999: SUCCESS (0.000s)
[126.669933] [070/170] (881s left) kms_addfb_basic (basic)
[126.763244] Starting subtest: basic
[126.764288] Subtest basic: SUCCESS (0.000s)
[126.920121] [071/170] (881s left) kms_addfb_basic (basic-x-tiled-legacy)
[127.015245] Starting subtest: basic-x-tiled-legacy
[127.017226] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[127.153332] [072/170] (881s left) kms_addfb_basic (basic-y-tiled-legacy)
[127.249440] Starting subtest: basic-y-tiled-legacy
[127.251427] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[127.400579] [073/170] (880s left) kms_addfb_basic (bo-too-small)
[127.554434] Starting subtest: bo-too-small
[127.555446] Subtest bo-too-small: SUCCESS (0.000s)
[127.633642] [074/170] (880s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[127.791259] Starting subtest: bo-too-small-due-to-tiling
[127.793233] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[127.883552] [075/170] (880s left) kms_addfb_basic (clobberred-modifier)
[127.974200] Starting subtest: clobberred-modifier
[127.976273] Subtest clobberred-modifier: SKIP (0.000s)
[128.116992] [076/170] (880s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[128.210282] Starting subtest: framebuffer-vs-set-tiling
[128.212254] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[128.350321] [077/170] (879s left) kms_addfb_basic (invalid-get-prop)
[128.442269] Starting subtest: invalid-get-prop
[128.443277] Subtest invalid-get-prop: SUCCESS (0.000s)
[128.583767] [078/170] (879s left) kms_addfb_basic (invalid-get-prop-any)
[128.677405] Starting subtest: invalid-get-prop-any
[128.678392] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[128.817263] [079/170] (879s left) kms_addfb_basic (invalid-set-prop)
[128.909120] Starting subtest: invalid-set-prop
[128.910112] Subtest invalid-set-prop: SUCCESS (0.000s)
[129.050915] [080/170] (879s left) kms_addfb_basic (invalid-set-prop-any)
[129.144298] Starting subtest: invalid-set-prop-any
[129.145300] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[129.283569] [081/170] (879s left) kms_addfb_basic (no-handle)
[129.375253] Starting subtest: no-handle
[129.376283] Subtest no-handle: SUCCESS (0.000s)
[129.518086] [082/170] (878s left) kms_addfb_basic (size-max)
[129.672028] Starting subtest: size-max
[129.673033] Subtest size-max: SUCCESS (0.000s)
[129.766923] [083/170] (878s left) kms_addfb_basic (small-bo)
[129.919812] Starting subtest: small-bo
[129.920854] Subtest small-bo: SUCCESS (0.000s)
[130.017248] [084/170] (878s left) kms_addfb_basic (tile-pitch-mismatch)
[130.110308] Starting subtest: tile-pitch-mismatch
[130.112275] Subtest tile-pitch-mismatch: SKIP (0.000s)
[130.251583] [085/170] (878s left) kms_addfb_basic (too-high)
[130.404961] Starting subtest: too-high
[130.406039] Subtest too-high: SUCCESS (0.000s)
[130.483700] [086/170] (877s left) kms_addfb_basic (too-wide)
[130.636798] Starting subtest: too-wide
[130.637926] Subtest too-wide: SUCCESS (0.000s)
[130.733439] [087/170] (877s left) kms_addfb_basic (unused-handle)
[130.823995] Starting subtest: unused-handle
[130.824917] Subtest unused-handle: SUCCESS (0.000s)
[130.967168] [088/170] (877s left) kms_addfb_basic (unused-modifier)
[131.058200] Starting subtest: unused-modifier
[131.059203] Subtest unused-modifier: SUCCESS (0.000s)
[131.200263] [089/170] (877s left) kms_addfb_basic (unused-offsets)
[131.292252] Starting subtest: unused-offsets
[131.293262] Subtest unused-offsets: SUCCESS (0.000s)
[131.433562] [090/170] (877s left) kms_addfb_basic (unused-pitches)
[131.526220] Starting subtest: unused-pitches
[131.527237] Subtest unused-pitches: SUCCESS (0.000s)
[131.667094] [091/170] (876s left) kms_busy (basic)
[131.837821] Starting subtest: basic
[131.838846] Starting dynamic subtest: flip
[132.589551] Dynamic subtest flip: SUCCESS (0.748s)
[132.597366] Starting dynamic subtest: modeset
[133.517247] Dynamic subtest modeset: SUCCESS (0.930s)
[133.518232] Subtest basic: SUCCESS (1.680s)
[133.707359] [092/170] (874s left) kms_chamelium_hpd (dp-hpd-fast)
[133.942831] Subtest dp-hpd-fast: SKIP (0.000s)
[134.111453] [093/170] (874s left) kms_chamelium_edid (dp-edid-read)
[134.343165] Subtest dp-edid-read: SKIP (0.000s)
[134.474513] [094/170] (874s left) kms_chamelium_frames (dp-crc-fast)
[134.707212] Subtest dp-crc-fast: SKIP (0.000s)
[134.840174] [095/170] (873s left) kms_chamelium_hpd (hdmi-hpd-fast)
[135.072398] Subtest hdmi-hpd-fast: SKIP (0.000s)
[135.211578] [096/170] (873s left) kms_chamelium_edid (hdmi-edid-read)
[135.442719] Subtest hdmi-edid-read: SKIP (0.000s)
[135.574428] [097/170] (873s left) kms_chamelium_frames (hdmi-crc-fast)
[135.806766] Subtest hdmi-crc-fast: SKIP (0.000s)
[135.937417] [098/170] (872s left) kms_chamelium_hpd (vga-hpd-fast)
[136.168638] Subtest vga-hpd-fast: SKIP (0.000s)
[136.303606] [099/170] (872s left) kms_chamelium_edid (vga-edid-read)
[136.535218] Subtest vga-edid-read: SKIP (0.000s)
[136.670084] [100/170] (872s left) kms_prop_blob (basic)
[136.762560] Starting subtest: basic
[136.763555] Subtest basic: SUCCESS (0.000s)
[136.830477] [101/170] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[136.984693] Starting subtest: basic-busy-flip-before-cursor-atomic
[136.986765] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[137.047214] [102/170] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[137.201146] Starting subtest: basic-busy-flip-before-cursor-legacy
[137.203156] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[137.263892] [103/170] (871s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[137.416903] Starting subtest: basic-flip-after-cursor-atomic
[138.467920] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.050s)
[138.687199] [104/170] (870s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[138.841052] Starting subtest: basic-flip-after-cursor-legacy
[139.904456] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.064s)
[140.104938] [105/170] (868s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[140.260712] Starting subtest: basic-flip-after-cursor-varying-size
[141.339173] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.078s)
[141.537400] [106/170] (867s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[141.692831] Starting subtest: basic-flip-before-cursor-atomic
[142.771131] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.078s)
[142.990090] [107/170] (865s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[143.146715] Starting subtest: basic-flip-before-cursor-legacy
[144.224014] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.077s)
[144.439825] [108/170] (864s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[144.593241] Starting subtest: basic-flip-before-cursor-varying-size
[145.672976] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.080s)
[145.899922] [109/170] (862s left) kms_flip (basic-flip-vs-dpms)
[146.055060] Starting subtest: basic-flip-vs-dpms
[146.064044] Starting dynamic subtest: A-DP1
[147.151634] Dynamic subtest A-DP1: SUCCESS (1.087s)
[147.159198] Starting dynamic subtest: B-DP1
[148.084020] Dynamic subtest B-DP1: SUCCESS (0.931s)
[148.091795] Starting dynamic subtest: C-DP1
[148.989021] Dynamic subtest C-DP1: SUCCESS (0.904s)
[148.999047] Starting dynamic subtest: D-DP1
[149.889932] Dynamic subtest D-DP1: SUCCESS (0.900s)
[149.893419] Subtest basic-flip-vs-dpms: SUCCESS (3.839s)
[150.108826] [110/170] (858s left) kms_flip (basic-flip-vs-modeset)
[150.248546] Starting subtest: basic-flip-vs-modeset
[150.254140] Starting dynamic subtest: A-DP1
[151.138265] Dynamic subtest A-DP1: SUCCESS (0.884s)
[151.146120] Starting dynamic subtest: B-DP1
[152.035310] Dynamic subtest B-DP1: SUCCESS (0.896s)
[152.042897] Starting dynamic subtest: C-DP1
[152.932181] Dynamic subtest C-DP1: SUCCESS (0.896s)
[152.939899] Starting dynamic subtest: D-DP1
[153.821270] Dynamic subtest D-DP1: SUCCESS (0.889s)
[153.826043] Subtest basic-flip-vs-modeset: SUCCESS (3.578s)
[154.034029] [111/170] (854s left) kms_flip (basic-flip-vs-wf_vblank)
[154.172496] Starting subtest: basic-flip-vs-wf_vblank
[154.176762] Starting dynamic subtest: A-DP1
[155.384553] Dynamic subtest A-DP1: SUCCESS (1.208s)
[155.392267] Starting dynamic subtest: B-DP1
[156.505477] Dynamic subtest B-DP1: SUCCESS (1.120s)
[156.513122] Starting dynamic subtest: C-DP1
[157.618614] Dynamic subtest C-DP1: SUCCESS (1.112s)
[157.626195] Starting dynamic subtest: D-DP1
[158.734503] Dynamic subtest D-DP1: SUCCESS (1.115s)
[158.739410] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.569s)
[158.988207] [112/170] (849s left) kms_flip (basic-plain-flip)
[159.126506] Starting subtest: basic-plain-flip
[159.131300] Starting dynamic subtest: A-DP1
[160.047491] Dynamic subtest A-DP1: SUCCESS (0.916s)
[160.055268] Starting dynamic subtest: B-DP1
[160.871386] Dynamic subtest B-DP1: SUCCESS (0.823s)
[160.879266] Starting dynamic subtest: C-DP1
[161.706659] Dynamic subtest C-DP1: SUCCESS (0.835s)
[161.714459] Starting dynamic subtest: D-DP1
[162.538804] Dynamic subtest D-DP1: SUCCESS (0.831s)
[162.544322] Subtest basic-plain-flip: SUCCESS (3.419s)
[162.807959] [113/170] (846s left) kms_force_connector_basic (force-connector-state)
[162.905722] Starting subtest: force-connector-state
[163.457150] Subtest force-connector-state: SUCCESS (0.551s)
[163.730119] [114/170] (845s left) kms_force_connector_basic (force-edid)
[163.826494] Starting subtest: force-edid
[163.844174] Subtest force-edid: SUCCESS (0.017s)
[164.013300] [115/170] (844s left) kms_force_connector_basic (force-load-detect)
[164.109149] Starting subtest: force-load-detect
[164.110839] Subtest force-load-detect: SKIP (0.000s)
[164.230166] [116/170] (844s left) kms_force_connector_basic (prune-stale-modes)
[164.325062] Starting subtest: prune-stale-modes
[164.336049] Subtest prune-stale-modes: SKIP (0.010s)
[164.496672] [117/170] (844s left) kms_frontbuffer_tracking (basic)
[164.659727] Starting subtest: basic
[169.074551] Subtest basic: SUCCESS (4.416s)
[169.166550] [118/170] (839s left) kms_pipe_crc_basic (compare-crc-sanitycheck)
[169.323055] Starting subtest: compare-crc-sanitycheck
[169.324157] Starting dynamic subtest: pipe-A-DP-1
[169.881551] Dynamic subtest pipe-A-DP-1: SUCCESS (0.557s)
[169.891229] Starting dynamic subtest: pipe-B-DP-1
[170.447891] Dynamic subtest pipe-B-DP-1: SUCCESS (0.564s)
[170.457780] Starting dynamic subtest: pipe-C-DP-1
[171.079164] Dynamic subtest pipe-C-DP-1: SUCCESS (0.627s)
[171.087204] Starting dynamic subtest: pipe-D-DP-1
[171.779683] Dynamic subtest pipe-D-DP-1: SUCCESS (0.699s)
[171.780771] Subtest compare-crc-sanitycheck: SUCCESS (2.457s)
[171.979029] [119/170] (837s left) kms_pipe_crc_basic (hang-read-crc)
[172.133043] Starting subtest: hang-read-crc
[172.134065] Starting dynamic subtest: pipe-A-DP-1
[173.657594] Dynamic subtest pipe-A-DP-1: SUCCESS (1.522s)
[173.665552] Starting dynamic subtest: pipe-B-DP-1
[175.200454] Dynamic subtest pipe-B-DP-1: SUCCESS (1.541s)
[175.208956] Starting dynamic subtest: pipe-C-DP-1
[176.868626] Dynamic subtest pipe-C-DP-1: SUCCESS (1.666s)
[176.877770] Starting dynamic subtest: pipe-D-DP-1
[178.662474] Dynamic subtest pipe-D-DP-1: SUCCESS (1.791s)
[178.663400] Subtest hang-read-crc: SUCCESS (6.530s)
[178.856633] [120/170] (830s left) kms_pipe_crc_basic (nonblocking-crc)
[179.015520] Starting subtest: nonblocking-crc
[179.016482] Starting dynamic subtest: pipe-A-DP-1
[179.723613] Dynamic subtest pipe-A-DP-1: SUCCESS (0.706s)
[179.732173] Starting dynamic subtest: pipe-B-DP-1
[180.445563] Dynamic subtest pipe-B-DP-1: SUCCESS (0.720s)
[180.455232] Starting dynamic subtest: pipe-C-DP-1
[181.225357] Dynamic subtest pipe-C-DP-1: SUCCESS (0.777s)
[181.234292] Starting dynamic subtest: pipe-D-DP-1
[182.075149] Dynamic subtest pipe-D-DP-1: SUCCESS (0.846s)
[182.076197] Subtest nonblocking-crc: SUCCESS (3.059s)
[182.272436] [121/170] (826s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[182.428809] Starting subtest: nonblocking-crc-frame-sequence
[182.429860] Starting dynamic subtest: pipe-A-DP-1
[183.123285] Dynamic subtest pipe-A-DP-1: SUCCESS (0.693s)
[183.131781] Starting dynamic subtest: pipe-B-DP-1
[183.842845] Dynamic subtest pipe-B-DP-1: SUCCESS (0.717s)
[183.851541] Starting dynamic subtest: pipe-C-DP-1
[184.671446] Dynamic subtest pipe-C-DP-1: FAIL (0.764s)
[184.679210] Starting dynamic subtest: pipe-D-DP-1
[185.457803] Dynamic subtest pipe-D-DP-1: SUCCESS (0.846s)
[185.458781] Subtest nonblocking-crc-frame-sequence: FAIL (3.030s)
[185.665471] [122/170] (823s left) kms_pipe_crc_basic (read-crc)
[185.820843] Starting subtest: read-crc
[185.821885] Starting dynamic subtest: pipe-A-DP-1
[186.465795] Dynamic subtest pipe-A-DP-1: SUCCESS (0.643s)
[186.474562] Starting dynamic subtest: pipe-B-DP-1
[187.135798] Dynamic subtest pipe-B-DP-1: SUCCESS (0.668s)
[187.145036] Starting dynamic subtest: pipe-C-DP-1
[187.864535] Dynamic subtest pipe-C-DP-1: SUCCESS (0.726s)
[187.874401] Starting dynamic subtest: pipe-D-DP-1
[188.640624] Dynamic subtest pipe-D-DP-1: SUCCESS (0.773s)
[188.641527] Subtest read-crc: SUCCESS (2.820s)
[188.843273] [123/170] (820s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[188.999736] Starting subtest: read-crc-frame-sequence
[189.000693] Starting dynamic subtest: pipe-A-DP-1
[189.625130] Dynamic subtest pipe-A-DP-1: SUCCESS (0.624s)
[189.634234] Starting dynamic subtest: pipe-B-DP-1
[190.279893] Dynamic subtest pipe-B-DP-1: SUCCESS (0.652s)
[190.288730] Starting dynamic subtest: pipe-C-DP-1
[190.993568] Dynamic subtest pipe-C-DP-1: SUCCESS (0.711s)
[191.003128] Starting dynamic subtest: pipe-D-DP-1
[191.792197] Dynamic subtest pipe-D-DP-1: SUCCESS (0.795s)
[191.793229] Subtest read-crc-frame-sequence: SUCCESS (2.792s)
[191.991481] [124/170] (817s left) kms_psr (primary_page_flip)
[192.088665] Subtest primary_page_flip: SKIP (0.000s)
[192.127643] [125/170] (816s left) kms_psr (cursor_plane_move)
[192.220591] Subtest cursor_plane_move: SKIP (0.000s)
[192.260980] [126/170] (816s left) kms_psr (sprite_plane_onoff)
[192.353913] Subtest sprite_plane_onoff: SKIP (0.000s)
[192.394465] [127/170] (816s left) kms_psr (primary_mmap_gtt)
[192.488559] Subtest primary_mmap_gtt: SKIP (0.000s)
[192.527654] [128/170] (816s left) kms_setmode (basic-clone-single-crtc)
[192.620028] Starting subtest: basic-clone-single-crtc
[192.622661] Subtest basic-clone-single-crtc: SKIP (0.001s)
[192.693180] [129/170] (816s left) i915_pm_backlight (basic-brightness)
[192.851738] Subtest basic-brightness: SKIP (0.000s)
[192.877796] [130/170] (816s left) i915_pm_rpm (basic-pci-d3-state)
[194.487278] Starting subtest: basic-pci-d3-state
[195.532741] Subtest basic-pci-d3-state: SUCCESS (1.046s)
[195.686925] [131/170] (813s left) i915_pm_rpm (basic-rte)
[195.763308] Starting subtest: basic-rte
[198.533655] Subtest basic-rte: SUCCESS (2.770s)
[199.678842] [132/170] (809s left) i915_pm_rps (basic-api)
[199.780192] Starting subtest: basic-api
[199.782046] Subtest basic-api: SKIP (0.001s)
[199.852521] [133/170] (809s left) prime_self_import (basic-llseek-bad)
[199.929080] Starting subtest: basic-llseek-bad
[199.946571] Subtest basic-llseek-bad: SUCCESS (0.017s)
[200.040641] [134/170] (809s left) prime_self_import (basic-llseek-size)
[200.132961] Starting subtest: basic-llseek-size
[200.151703] Subtest basic-llseek-size: SUCCESS (0.018s)
[200.269362] [135/170] (809s left) prime_self_import (basic-with_fd_dup)
[200.352166] Starting subtest: basic-with_fd_dup
[200.370438] Subtest basic-with_fd_dup: SUCCESS (0.018s)
[200.495779] [136/170] (808s left) prime_self_import (basic-with_one_bo)
[200.583028] Starting subtest: basic-with_one_bo
[200.602866] Subtest basic-with_one_bo: SUCCESS (0.019s)
[200.666373] [137/170] (808s left) prime_self_import (basic-with_one_bo_two_files)
[200.739096] Starting subtest: basic-with_one_bo_two_files
[200.757387] Subtest basic-with_one_bo_two_files: SUCCESS (0.018s)
[200.867424] [138/170] (808s left) prime_self_import (basic-with_two_bos)
[200.968851] Starting subtest: basic-with_two_bos
[200.988209] Subtest basic-with_two_bos: SUCCESS (0.019s)
[201.099906] [139/170] (808s left) prime_vgem (basic-fence-flip)
[201.229156] Starting subtest: basic-fence-flip
[201.339724] Subtest basic-fence-flip: SKIP (0.110s)
[201.447166] [140/170] (807s left) prime_vgem (basic-fence-mmap)
[201.564263] Starting subtest: basic-fence-mmap
[201.566238] Subtest basic-fence-mmap: SKIP (0.000s)
[201.661737] [141/170] (807s left) prime_vgem (basic-fence-read)
[201.798170] Starting subtest: basic-fence-read
[201.805468] Subtest basic-fence-read: SKIP (0.006s)
[201.925916] [142/170] (807s left) prime_vgem (basic-gtt)
[202.045189] Starting subtest: basic-gtt
[202.047258] Subtest basic-gtt: SKIP (0.000s)
[202.150643] [143/170] (807s left) prime_vgem (basic-read)
[202.293844] Starting subtest: basic-read
[202.300550] Subtest basic-read: SKIP (0.006s)
[202.424657] [144/170] (807s left) prime_vgem (basic-write)
[202.563613] Starting subtest: basic-write
[202.570802] Subtest basic-write: SKIP (0.006s)
[202.714703] [145/170] (806s left) vgem_basic (setversion)
[202.806148] Starting subtest: setversion
[202.808258] Subtest setversion: SUCCESS (0.000s)
[202.863220] [146/170] (806s left) vgem_basic (create)
[202.956185] Starting subtest: create
[202.957270] Subtest create: SUCCESS (0.000s)
[203.017554] [147/170] (806s left) vgem_basic (debugfs)
[203.106242] Starting subtest: debugfs
[203.107299] Subtest debugfs: SUCCESS (0.000s)
[203.178338] [148/170] (806s left) vgem_basic (dmabuf-export)
[203.289483] Starting subtest: dmabuf-export
[203.306859] Subtest dmabuf-export: SUCCESS (0.017s)
[203.417582] [149/170] (806s left) vgem_basic (dmabuf-fence)
[203.506242] Starting subtest: dmabuf-fence
[203.507326] Subtest dmabuf-fence: SUCCESS (0.000s)
[203.563645] [150/170] (806s left) vgem_basic (dmabuf-fence-before)
[203.656221] Starting subtest: dmabuf-fence-before
[203.657270] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[203.714965] [151/170] (805s left) vgem_basic (dmabuf-mmap)
[203.806143] Starting subtest: dmabuf-mmap
[203.819474] Subtest dmabuf-mmap: SUCCESS (0.013s)
[203.863283] [152/170] (805s left) vgem_basic (mmap)
[203.956226] Starting subtest: mmap
[203.965091] Subtest mmap: SUCCESS (0.009s)
[204.012845] [153/170] (805s left) vgem_basic (second-client)
[204.089378] Starting subtest: second-client
[204.138982] Subtest second-client: SUCCESS (0.049s)
[204.226105] [154/170] (805s left) vgem_basic (sysfs)
[204.306271] Starting subtest: sysfs
[204.307350] Subtest sysfs: SUCCESS (0.000s)
[204.362897] [155/170] (805s left) core_hotunplug (unbind-rebind)
[204.489686] Starting subtest: unbind-rebind
[207.321420] Subtest unbind-rebind: SUCCESS (2.832s)
[207.342399] [156/170] (802s left) vgem_basic (unload)
[207.423609] Starting subtest: unload
[236.418688] Subtest unload: SUCCESS (28.960s)
[236.503570] [157/170] (773s left) i915_module_load (reload)
[236.580282] Starting subtest: reload
[240.437719] Subtest reload: SUCCESS (3.857s)
[240.454656] [158/170] (769s left) gem_lmem_swapping (basic)
[244.315049] Starting subtest: basic
[244.315895] Starting dynamic subtest: lmem0
[271.930978] Dynamic subtest lmem0: SUCCESS (27.606s)
[271.932085] Subtest basic: SUCCESS (27.607s)
[274.728578] [159/170] (735s left) gem_lmem_swapping (parallel-random-engines)
[275.641485] Starting subtest: parallel-random-engines
[275.642540] Starting dynamic subtest: lmem0
[277.149590] Dynamic subtest lmem0: SUCCESS (1.499s)
[277.150625] Subtest parallel-random-engines: SUCCESS (1.499s)
[278.690400] [160/170] (731s left) gem_lmem_swapping (random-engines)
[279.674430] Starting subtest: random-engines
[279.675491] Starting dynamic subtest: lmem0
[280.929048] Dynamic subtest lmem0: SUCCESS (1.246s)
[280.930149] Subtest random-engines: SUCCESS (1.246s)
[282.469867] [161/170] (727s left) gem_lmem_swapping (verify-random)
[283.464964] Starting subtest: verify-random
[283.466039] Starting dynamic subtest: lmem0
[294.471152] Dynamic subtest lmem0: SUCCESS (10.997s)
[294.472113] Subtest verify-random: SUCCESS (10.998s)
[296.137207] [162/170] (713s left) i915_pm_rpm (module-reload)
[299.732112] Starting subtest: module-reload
[315.538343] Subtest module-reload: SUCCESS (15.795s)
[315.581085] [163/170] (694s left) i915_selftest (live)
[315.673912] Starting subtest: live
[315.675013] Starting dynamic subtest: sanitycheck
[317.780332] Dynamic subtest sanitycheck: SUCCESS (2.097s)
[317.786885] Starting dynamic subtest: uncore
[319.846201] Dynamic subtest uncore: SUCCESS (2.065s)
[319.851971] Starting dynamic subtest: workarounds
[324.423454] Dynamic subtest workarounds: SUCCESS (4.576s)
[324.430885] Starting dynamic subtest: gt_engines
[327.550500] Dynamic subtest gt_engines: SUCCESS (3.126s)
[327.557690] Starting dynamic subtest: gt_timelines
[361.372524] Dynamic subtest gt_timelines: SUCCESS (33.821s)
[361.380430] Starting dynamic subtest: gt_contexts
[363.449513] Dynamic subtest gt_contexts: SUCCESS (2.076s)
[363.455447] Starting dynamic subtest: gt_lrc
[372.682401] Dynamic subtest gt_lrc: SUCCESS (9.232s)
[372.689965] Starting dynamic subtest: gt_mocs
[376.748407] Dynamic subtest gt_mocs: SUCCESS (4.065s)
[376.755310] Starting dynamic subtest: gt_pm
[379.713446] Dynamic subtest gt_pm: SUCCESS (2.964s)
[379.720021] Starting dynamic subtest: gt_heartbeat
[382.040341] Dynamic subtest gt_heartbeat: SUCCESS (2.326s)
[382.049534] Starting dynamic subtest: gt_tlb
[399.033956] Dynamic subtest gt_tlb: SUCCESS (16.991s)
[399.040214] Starting dynamic subtest: requests
[417.112659] Dynamic subtest requests: SUCCESS (18.079s)
[417.120143] Starting dynamic subtest: migrate
[422.696585] Dynamic subtest migrate: SUCCESS (5.583s)
[422.704148] Starting dynamic subtest: active
[424.794752] Dynamic subtest active: SUCCESS (2.097s)
[424.801880] Starting dynamic subtest: objects
[428.216533] Dynamic subtest objects: SUCCESS (3.421s)
[428.224132] Starting dynamic subtest: mman
[439.369154] Dynamic subtest mman: SUCCESS (11.152s)
[439.375213] Starting dynamic subtest: dmabuf
[441.395206] Dynamic subtest dmabuf: SUCCESS (2.025s)
[441.401211] Starting dynamic subtest: vma
[443.452150] Dynamic subtest vma: SUCCESS (2.056s)
[443.457959] Starting dynamic subtest: coherency
[447.861189] Dynamic subtest coherency: SUCCESS (4.408s)
[447.867131] Starting dynamic subtest: gtt
[458.527520] Dynamic subtest gtt: SUCCESS (10.665s)
[458.535111] Starting dynamic subtest: gem
[460.651584] Dynamic subtest gem: SUCCESS (2.123s)
[460.658302] Starting dynamic subtest: evict
[465.214442] Dynamic subtest evict: SUCCESS (4.562s)
[465.221366] Starting dynamic subtest: hugepages
[482.848361] Dynamic subtest hugepages: SUCCESS (17.633s)
[482.855754] Starting dynamic subtest: gem_contexts
[529.762254] Dynamic subtest gem_contexts: SUCCESS (46.886s)
[529.768214] Starting dynamic subtest: client
[531.868498] Dynamic subtest client: SUCCESS (2.132s)
[531.875582] Starting dynamic subtest: gem_migrate
[537.077435] Dynamic subtest gem_migrate: SUCCESS (5.207s)
[537.086668] Starting dynamic subtest: reset
[539.270867] Dynamic subtest reset: SUCCESS (2.193s)
[539.278711] Starting dynamic subtest: memory_region
[542.911606] Dynamic subtest memory_region: SUCCESS (3.640s)
[542.919757] Starting dynamic subtest: hangcheck
[590.030693] Dynamic subtest hangcheck: SUCCESS (47.118s)
[590.038568] Starting dynamic subtest: execlists
[592.102398] Dynamic subtest execlists: SUCCESS (2.071s)
[592.116971] Starting dynamic subtest: ring_submission
[594.198508] Dynamic subtest ring_submission: SUCCESS (2.095s)
[594.205651] Starting dynamic subtest: perf
[596.438362] Dynamic subtest perf: SUCCESS (2.239s)
[596.445486] Starting dynamic subtest: slpc
[606.404483] Dynamic subtest slpc: SUCCESS (9.965s)
[606.412143] Starting dynamic subtest: guc
[610.069570] Dynamic subtest guc: SUCCESS (3.664s)
[610.077060] Starting dynamic subtest: guc_multi_lrc
[612.214495] Dynamic subtest guc_multi_lrc: SUCCESS (2.144s)
[612.221864] Starting dynamic subtest: guc_hang
[615.005293] Dynamic subtest guc_hang: SUCCESS (2.790s)
[615.011970] Starting dynamic subtest: late_gt_pm
[617.113349] Dynamic subtest late_gt_pm: SUCCESS (2.107s)
[617.114371] Subtest live: SUCCESS (301.431s)
[617.592582] [164/170] (392s left) dmabuf (all-tests)
[617.671619] Starting subtest: all-tests
[617.674732] Starting dynamic subtest: sanitycheck
[617.740836] Dynamic subtest sanitycheck: SUCCESS (0.068s)
[617.750138] Starting dynamic subtest: dma_fence
[617.922707] Dynamic subtest dma_fence: SUCCESS (0.181s)
[617.937199] Starting dynamic subtest: dma_fence_chain
[631.957146] Dynamic subtest dma_fence_chain: SUCCESS (14.025s)
[631.963436] Starting dynamic subtest: dma_fence_unwrap
[632.040823] Dynamic subtest dma_fence_unwrap: SUCCESS (0.090s)
[632.057137] Starting dynamic subtest: dma_resv
[632.127464] Dynamic subtest dma_resv: SUCCESS (0.084s)
[632.129806] Subtest all-tests: SUCCESS (14.455s)
[632.185123] [165/170] (377s left) i915_suspend (basic-s2idle-without-i915)
[632.273559] Starting subtest: basic-s2idle-without-i915
[653.265606] Subtest basic-s2idle-without-i915: SUCCESS (5.772s)
[653.474746] [166/170] (371s left) i915_suspend (basic-s3-without-i915)
[653.554765] Starting subtest: basic-s3-without-i915
[656.412576] Subtest basic-s3-without-i915: SKIP (2.845s)
[657.280062] [167/170] (368s left) gem_exec_suspend (basic-s0)
[657.398781] Starting subtest: basic-S0
[657.399704] Starting dynamic subtest: smem
[677.964173] Dynamic subtest smem: SUCCESS (5.762s)
[677.974995] Starting dynamic subtest: lmem0
[697.965186] Dynamic subtest lmem0: SUCCESS (5.762s)
[697.966387] Subtest basic-S0: SUCCESS (11.526s)
[698.150794] [168/170] (356s left) gem_exec_suspend (basic-s3)
[698.264541] Starting subtest: basic-S3
[698.265480] Starting dynamic subtest: smem
[718.960284] Dynamic subtest smem: SUCCESS (5.695s)
[718.972816] Starting dynamic subtest: lmem0
[738.960264] Dynamic subtest lmem0: SUCCESS (5.752s)
[738.961471] Subtest basic-S3: SUCCESS (11.450s)
[739.148149] [169/170] (344s left) kms_chamelium_hpd (common-hpd-after-suspend)
[739.390630] Subtest common-hpd-after-suspend: SKIP (0.000s)
[739.522451] [170/170] (344s left) kms_pipe_crc_basic (suspend-read-crc)
[739.676388] Starting subtest: suspend-read-crc
[739.679168] Starting dynamic subtest: pipe-A-DP-1
[757.306541] Dynamic subtest pipe-A-DP-1: SUCCESS (2.781s)
[757.316966] Starting dynamic subtest: pipe-B-DP-1
[775.341285] Dynamic subtest pipe-B-DP-1: SUCCESS (2.769s)
[775.351311] Starting dynamic subtest: pipe-C-DP-1
[793.411950] Dynamic subtest pipe-C-DP-1: SUCCESS (2.918s)
[793.421842] Starting dynamic subtest: pipe-D-DP-1
[811.474720] Dynamic subtest pipe-D-DP-1: SUCCESS (3.055s)
[811.475648] Subtest suspend-read-crc: SUCCESS (11.534s)
[811.643678] Closing watchdogs
Done.