[41.936304] Initializing watchdogs
[41.936588]   /dev/watchdog0
[41.992796] [001/165] (960s left) i915_module_load (load)
[42.234608] Starting subtest: load
[44.811206] Subtest load: SUCCESS (2.556s)
[44.923696] [002/165] (957s left) core_auth (basic-auth)
[45.199127] Starting subtest: basic-auth
[45.221468] Subtest basic-auth: SUCCESS (0.002s)
[45.307985] [003/165] (957s left) debugfs_test (read_all_entries)
[45.566635] Starting subtest: read_all_entries
[45.964849] Subtest read_all_entries: SUCCESS (0.412s)
[46.158093] [004/165] (956s left) debugfs_test (basic-hwmon)
[46.387965] Starting subtest: basic-hwmon
[46.431962] Subtest basic-hwmon: SKIP (0.000s)
[46.571327] [005/165] (956s left) fbdev (eof)
[46.814117] Starting subtest: eof
[46.833781] Subtest eof: SUCCESS (0.002s)
[46.942599] [006/165] (956s left) fbdev (info)
[47.176967] Starting subtest: info
[47.197891] Subtest info: SUCCESS (0.000s)
[47.305571] [007/165] (955s left) fbdev (nullptr)
[47.539668] Starting subtest: nullptr
[47.561811] Subtest nullptr: SUCCESS (0.000s)
[47.667089] [008/165] (955s left) fbdev (read)
[47.874388] Starting subtest: read
[49.335421] Subtest read: SUCCESS (1.477s)
[49.440776] [009/165] (953s left) fbdev (write)
[49.668344] Starting subtest: write
[50.406706] Subtest write: SUCCESS (0.765s)
[50.512562] [010/165] (952s left) gem_basic (bad-close)
[50.741285] Starting subtest: bad-close
[50.788504] Subtest bad-close: SUCCESS (0.000s)
[50.875900] [011/165] (952s left) gem_basic (create-close)
[51.109322] Starting subtest: create-close
[51.148757] Subtest create-close: SUCCESS (0.000s)
[51.234236] [012/165] (952s left) gem_basic (create-fd-close)
[51.460216] Starting subtest: create-fd-close
[51.504800] Subtest create-fd-close: SUCCESS (0.000s)
[51.592676] [013/165] (951s left) gem_busy (busy@all-engines)
[51.850796] Starting subtest: busy
[51.871730] Starting dynamic subtest: all-engines
[51.916319] Dynamic subtest all-engines: SUCCESS (0.091s)
[51.938234] Subtest busy: SUCCESS (0.092s)
[52.322141] [014/165] (951s left) gem_close_race (basic-process)
[52.588052] Starting subtest: basic-process
[52.669269] Subtest basic-process: SUCCESS (0.108s)
[52.888613] [015/165] (950s left) gem_close_race (basic-threads)
[53.139463] Starting subtest: basic-threads
[54.353767] Subtest basic-threads: SUCCESS (1.230s)
[54.571797] [016/165] (949s left) gem_ctx_create (basic)
[54.859911] Starting subtest: basic
[54.888131] Subtest basic: SUCCESS (0.000s)
[55.059316] [017/165] (948s left) gem_ctx_create (basic-files)
[55.323826] Starting subtest: basic-files
[57.344295] Subtest basic-files: SUCCESS (2.039s)
[57.590275] [018/165] (946s left) gem_ctx_exec (basic)
[57.849834] Starting subtest: basic
[57.871352] Subtest basic: SUCCESS (0.009s)
[57.957700] [019/165] (946s left) gem_exec_basic (basic)
[58.194879] Starting subtest: basic
[58.214896] Starting dynamic subtest: rcs0-smem
[58.237232] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[58.273963] Starting dynamic subtest: bcs0-smem
[58.293444] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[58.327317] Starting dynamic subtest: vcs0-smem
[58.349979] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[58.385531] Starting dynamic subtest: vecs0-smem
[58.405304] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[58.425692] Subtest basic: SUCCESS (0.012s)
[58.516325] [020/165] (945s left) gem_exec_create (basic)
[58.790306] Starting subtest: basic
[58.809176] Starting dynamic subtest: smem
[60.840066] Dynamic subtest smem: SUCCESS (2.065s)
[60.861845] Subtest basic: SUCCESS (2.066s)
[61.057410] [021/165] (943s left) gem_exec_fence (basic-busy)
[61.417498] Starting subtest: basic-busy
[61.438793] Starting dynamic subtest: rcs0
[61.477711] Dynamic subtest rcs0: SUCCESS (0.033s)
[61.513864] Starting dynamic subtest: bcs0
[61.555710] Dynamic subtest bcs0: SUCCESS (0.026s)
[61.587909] Starting dynamic subtest: vcs0
[61.630364] Dynamic subtest vcs0: SUCCESS (0.029s)
[61.671496] Starting dynamic subtest: vecs0
[61.712756] Dynamic subtest vecs0: SUCCESS (0.031s)
[61.737327] Subtest basic-busy: SUCCESS (0.119s)
[62.389917] [022/165] (941s left) gem_exec_fence (basic-wait)
[62.742054] Starting subtest: basic-wait
[62.761423] Starting dynamic subtest: rcs0
[62.781632] Dynamic subtest rcs0: SUCCESS (0.034s)
[62.820218] Starting dynamic subtest: bcs0
[62.840261] Dynamic subtest bcs0: SUCCESS (0.024s)
[62.874444] Starting dynamic subtest: vcs0
[62.895778] Dynamic subtest vcs0: SUCCESS (0.023s)
[62.931989] Starting dynamic subtest: vecs0
[62.953777] Dynamic subtest vecs0: SUCCESS (0.027s)
[62.973214] Subtest basic-wait: SUCCESS (0.110s)
[63.559530] [023/165] (940s left) gem_exec_fence (basic-await)
[63.911046] Starting subtest: basic-await
[63.929460] Starting dynamic subtest: rcs0
[64.053200] Dynamic subtest rcs0: SUCCESS (0.141s)
[64.089550] Starting dynamic subtest: bcs0
[64.188826] Dynamic subtest bcs0: SUCCESS (0.134s)
[64.228593] Starting dynamic subtest: vcs0
[64.320625] Dynamic subtest vcs0: SUCCESS (0.133s)
[64.359104] Starting dynamic subtest: vecs0
[64.457330] Dynamic subtest vecs0: SUCCESS (0.136s)
[64.477240] Subtest basic-await: SUCCESS (0.547s)
[65.156100] [024/165] (939s left) gem_exec_fence (nb-await)
[65.511705] Starting subtest: nb-await
[65.534974] Starting dynamic subtest: rcs0
[65.591777] Dynamic subtest rcs0: SUCCESS (0.078s)
[65.626840] Starting dynamic subtest: bcs0
[65.675726] Dynamic subtest bcs0: SUCCESS (0.070s)
[65.711494] Starting dynamic subtest: vcs0
[65.754414] Dynamic subtest vcs0: SUCCESS (0.071s)
[65.950575] Starting dynamic subtest: vecs0
[65.969701] Dynamic subtest vecs0: SUCCESS (0.071s)
[65.988640] Subtest nb-await: SUCCESS (0.293s)
[66.507441] [025/165] (938s left) gem_exec_gttfill (basic)
[66.741316] Starting subtest: basic
[88.666324] Subtest basic: SUCCESS (21.927s)
[88.893461] [026/165] (915s left) gem_exec_parallel (engines)
[89.300048] Starting subtest: engines
[89.319126] Starting dynamic subtest: basic
[93.059180] Dynamic subtest basic: SUCCESS (3.596s)
[93.097457] Starting dynamic subtest: contexts
[97.771260] Dynamic subtest contexts: SUCCESS (4.724s)
[97.809654] Starting dynamic subtest: fds
[104.722503] Dynamic subtest fds: SUCCESS (6.946s)
[104.759699] Starting dynamic subtest: userptr
[108.414808] Dynamic subtest userptr: SUCCESS (3.675s)
[108.434281] Subtest engines: SUCCESS (18.942s)
[108.540560] [027/165] (896s left) gem_exec_store (basic)
[108.841326] Starting subtest: basic
[108.860687] Subtest basic: SUCCESS (0.067s)
[109.059604] [028/165] (895s left) gem_flink_basic (bad-flink)
[109.287278] Starting subtest: bad-flink
[109.307539] Subtest bad-flink: SUCCESS (0.000s)
[109.418873] [029/165] (895s left) gem_flink_basic (bad-open)
[109.689043] Starting subtest: bad-open
[109.717139] Subtest bad-open: SUCCESS (0.000s)
[109.835777] [030/165] (895s left) gem_flink_basic (basic)
[110.107279] Starting subtest: basic
[110.132558] Subtest basic: SUCCESS (0.000s)
[110.234340] [031/165] (894s left) gem_flink_basic (double-flink)
[110.483259] Starting subtest: double-flink
[110.512323] Subtest double-flink: SUCCESS (0.000s)
[110.615829] [032/165] (894s left) gem_flink_basic (flink-lifetime)
[110.889227] Starting subtest: flink-lifetime
[110.916153] Subtest flink-lifetime: SUCCESS (0.003s)
[111.025866] [033/165] (894s left) gem_huc_copy (huc-copy)
[111.283224] Starting subtest: huc-copy
[111.303717] Subtest huc-copy: SUCCESS (0.005s)
[111.395982] [034/165] (894s left) gem_linear_blits (basic)
[111.787311] Starting subtest: basic
[111.829687] Subtest basic: SUCCESS (0.027s)
[112.017822] [035/165] (893s left) gem_mmap (basic)
[112.437591] Starting subtest: basic
[112.549757] Subtest basic: SUCCESS (0.001s)
[112.638783] [036/165] (893s left) gem_mmap_gtt (basic)
[112.882335] Starting subtest: basic
[112.903101] Subtest basic: SUCCESS (0.001s)
[112.997690] [037/165] (892s left) gem_render_linear_blits (basic)
[113.255531] Starting subtest: basic
[113.363377] Subtest basic: SUCCESS (0.084s)
[113.455356] [038/165] (892s left) gem_render_tiled_blits (basic)
[113.695167] Starting subtest: basic
[113.821534] Subtest basic: SUCCESS (0.121s)
[113.911768] [039/165] (892s left) gem_ringfill (basic-all)
[114.430533] Starting subtest: basic-all
[115.603049] Subtest basic-all: SUCCESS (1.199s)
[115.740420] [040/165] (890s left) gem_softpin (allocator-basic)
[115.988506] Starting subtest: allocator-basic
[116.207823] Subtest allocator-basic: SUCCESS (0.246s)
[116.372575] [041/165] (889s left) gem_softpin (allocator-basic-reserve)
[116.621399] Starting subtest: allocator-basic-reserve
[116.823486] Subtest allocator-basic-reserve: SUCCESS (0.243s)
[116.958734] [042/165] (889s left) gem_softpin (safe-alignment)
[117.186301] Starting subtest: safe-alignment
[117.206487] Subtest safe-alignment: SUCCESS (0.031s)
[117.324402] [043/165] (888s left) gem_sync (basic-all)
[117.736648] Starting subtest: basic-all
[120.707833] Subtest basic-all: SUCCESS (3.007s)
[120.795641] [044/165] (885s left) gem_sync (basic-each)
[121.192639] Starting subtest: basic-each
[123.529223] Subtest basic-each: SUCCESS (2.499s)
[123.747644] [045/165] (882s left) gem_tiled_blits (basic)
[124.101893] Starting subtest: basic
[124.159260] Subtest basic: SUCCESS (0.055s)
[124.350793] [046/165] (882s left) gem_tiled_fence_blits (basic)
[124.887706] Starting subtest: basic
[124.930182] Subtest basic: SUCCESS (0.042s)
[125.207645] [047/165] (881s left) gem_tiled_pread_basic
[126.053660] [048/165] (880s left) gem_wait (busy@all-engines)
[126.307445] Starting subtest: busy
[126.327041] Starting dynamic subtest: all-engines
[126.833624] Dynamic subtest all-engines: SUCCESS (0.526s)
[126.852979] Subtest busy: SUCCESS (0.527s)
[127.090358] [049/165] (879s left) gem_wait (wait@all-engines)
[127.339340] Starting subtest: wait
[127.361447] Starting dynamic subtest: all-engines
[128.370066] Dynamic subtest all-engines: SUCCESS (1.046s)
[128.392676] Subtest wait: SUCCESS (1.046s)
[128.641559] [050/165] (878s left) i915_getparams_basic (basic-eu-total)
[128.872033] Starting subtest: basic-eu-total
[128.913584] Subtest basic-eu-total: SUCCESS (0.000s)
[129.007245] [051/165] (877s left) i915_getparams_basic (basic-subslice-total)
[129.235530] Starting subtest: basic-subslice-total
[129.278438] Subtest basic-subslice-total: SUCCESS (0.000s)
[129.367295] [052/165] (877s left) i915_hangman (error-state-basic)
[129.584881] Starting subtest: error-state-basic
[129.877546] Subtest error-state-basic: SUCCESS (0.288s)
[129.974553] [053/165] (877s left) i915_pciid
[130.312992] [054/165] (876s left) kms_addfb_basic (addfb25-4-tiled)
[130.693801] Starting subtest: addfb25-4-tiled
[130.716362] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[130.806897] [055/165] (876s left) kms_addfb_basic (addfb25-bad-modifier)
[131.056383] Starting subtest: addfb25-bad-modifier
[131.079563] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[131.227493] [056/165] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[131.458035] Starting subtest: addfb25-framebuffer-vs-set-tiling
[131.480438] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[131.657972] [057/165] (875s left) kms_addfb_basic (addfb25-modifier-no-flag)
[131.900908] Starting subtest: addfb25-modifier-no-flag
[131.920024] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[132.091780] [058/165] (875s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[132.320514] Starting subtest: addfb25-x-tiled-legacy
[132.339802] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[132.510855] [059/165] (875s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[132.743990] Starting subtest: addfb25-x-tiled-mismatch-legacy
[132.766240] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[132.942147] [060/165] (874s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[133.258423] Starting subtest: addfb25-yf-tiled-legacy
[133.279924] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[133.374352] [061/165] (874s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[133.683643] Starting subtest: addfb25-y-tiled-legacy
[133.702734] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[133.813685] [062/165] (874s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[134.123480] Starting subtest: addfb25-y-tiled-small-legacy
[134.141988] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[134.244354] [063/165] (873s left) kms_addfb_basic (bad-pitch-0)
[134.470137] Starting subtest: bad-pitch-0
[134.491855] Subtest bad-pitch-0: SUCCESS (0.000s)
[134.674352] [064/165] (873s left) kms_addfb_basic (bad-pitch-1024)
[134.921806] Starting subtest: bad-pitch-1024
[134.940438] Subtest bad-pitch-1024: SUCCESS (0.000s)
[135.104109] [065/165] (873s left) kms_addfb_basic (bad-pitch-128)
[135.351866] Starting subtest: bad-pitch-128
[135.371168] Subtest bad-pitch-128: SUCCESS (0.000s)
[135.544555] [066/165] (872s left) kms_addfb_basic (bad-pitch-256)
[135.814897] Starting subtest: bad-pitch-256
[135.836930] Subtest bad-pitch-256: SUCCESS (0.000s)
[135.983080] [067/165] (872s left) kms_addfb_basic (bad-pitch-32)
[136.225465] Starting subtest: bad-pitch-32
[136.247374] Subtest bad-pitch-32: SUCCESS (0.000s)
[136.413222] [068/165] (871s left) kms_addfb_basic (bad-pitch-63)
[136.665871] Starting subtest: bad-pitch-63
[136.688352] Subtest bad-pitch-63: SUCCESS (0.000s)
[136.844247] [069/165] (871s left) kms_addfb_basic (bad-pitch-65536)
[137.085662] Starting subtest: bad-pitch-65536
[137.105049] Subtest bad-pitch-65536: SUCCESS (0.001s)
[137.257724] [070/165] (871s left) kms_addfb_basic (bad-pitch-999)
[137.485893] Starting subtest: bad-pitch-999
[137.504783] Subtest bad-pitch-999: SUCCESS (0.000s)
[137.675737] [071/165] (870s left) kms_addfb_basic (basic)
[137.901349] Starting subtest: basic
[137.921340] Subtest basic: SUCCESS (0.000s)
[138.093625] [072/165] (870s left) kms_addfb_basic (basic-x-tiled-legacy)
[138.349980] Starting subtest: basic-x-tiled-legacy
[138.371531] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[138.524128] [073/165] (870s left) kms_addfb_basic (basic-y-tiled-legacy)
[138.752998] Starting subtest: basic-y-tiled-legacy
[138.773151] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[138.957701] [074/165] (869s left) kms_addfb_basic (bo-too-small)
[139.272988] Starting subtest: bo-too-small
[139.293584] Subtest bo-too-small: SUCCESS (0.001s)
[139.386647] [075/165] (869s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[139.699548] Starting subtest: bo-too-small-due-to-tiling
[139.726974] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[139.818228] [076/165] (869s left) kms_addfb_basic (clobberred-modifier)
[140.044354] Starting subtest: clobberred-modifier
[140.063062] Subtest clobberred-modifier: SUCCESS (0.000s)
[140.241902] [077/165] (868s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[140.492589] Starting subtest: framebuffer-vs-set-tiling
[140.513712] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[140.676843] [078/165] (868s left) kms_addfb_basic (invalid-get-prop)
[140.904212] Starting subtest: invalid-get-prop
[140.925568] Subtest invalid-get-prop: SUCCESS (0.000s)
[141.107620] [079/165] (868s left) kms_addfb_basic (invalid-get-prop-any)
[141.335656] Starting subtest: invalid-get-prop-any
[141.355229] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[141.539897] [080/165] (867s left) kms_addfb_basic (invalid-set-prop)
[141.788310] Starting subtest: invalid-set-prop
[141.808592] Subtest invalid-set-prop: SUCCESS (0.000s)
[141.959758] [081/165] (867s left) kms_addfb_basic (invalid-set-prop-any)
[142.204668] Starting subtest: invalid-set-prop-any
[142.225652] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[142.375889] [082/165] (867s left) kms_addfb_basic (no-handle)
[142.605326] Starting subtest: no-handle
[142.626093] Subtest no-handle: SUCCESS (0.000s)
[142.806239] [083/165] (866s left) kms_addfb_basic (size-max)
[143.124132] Starting subtest: size-max
[143.145909] Subtest size-max: SUCCESS (0.000s)
[143.241952] [084/165] (866s left) kms_addfb_basic (small-bo)
[143.550934] Starting subtest: small-bo
[143.570598] Subtest small-bo: SUCCESS (0.000s)
[143.678337] [085/165] (866s left) kms_addfb_basic (tile-pitch-mismatch)
[143.932370] Starting subtest: tile-pitch-mismatch
[143.958253] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[144.123940] [086/165] (865s left) kms_addfb_basic (too-high)
[144.544292] Starting subtest: too-high
[144.575160] Subtest too-high: SUCCESS (0.002s)
[144.692718] [087/165] (865s left) kms_addfb_basic (too-wide)
[145.015633] Starting subtest: too-wide
[145.040224] Subtest too-wide: SUCCESS (0.000s)
[145.153871] [088/165] (864s left) kms_addfb_basic (unused-handle)
[145.404028] Starting subtest: unused-handle
[145.428476] Subtest unused-handle: SUCCESS (0.000s)
[145.589827] [089/165] (864s left) kms_addfb_basic (unused-modifier)
[145.816490] Starting subtest: unused-modifier
[145.836285] Subtest unused-modifier: SUCCESS (0.000s)
[146.007361] [090/165] (864s left) kms_addfb_basic (unused-offsets)
[146.237768] Starting subtest: unused-offsets
[146.258152] Subtest unused-offsets: SUCCESS (0.000s)
[146.426604] [091/165] (863s left) kms_addfb_basic (unused-pitches)
[146.650055] Starting subtest: unused-pitches
[146.671960] Subtest unused-pitches: SUCCESS (0.000s)
[146.839576] [092/165] (863s left) kms_busy (basic)
[147.167051] Starting subtest: basic
[147.187580] Starting dynamic subtest: flip
[148.173597] Dynamic subtest flip: SUCCESS (1.000s)
[148.214355] Starting dynamic subtest: modeset
[149.558715] Dynamic subtest modeset: SUCCESS (1.401s)
[149.579877] Subtest basic: SUCCESS (2.404s)
[149.956611] [093/165] (860s left) kms_prop_blob (basic)
[150.216593] Starting subtest: basic
[150.235735] Subtest basic: SUCCESS (0.000s)
[150.327956] [094/165] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[150.651516] Starting subtest: basic-busy-flip-before-cursor-atomic
[150.692170] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[150.787849] [095/165] (859s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[151.099761] Starting subtest: basic-busy-flip-before-cursor-legacy
[151.142703] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[151.231610] [096/165] (859s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[151.543386] Starting subtest: basic-flip-after-cursor-atomic
[152.599550] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.061s)
[152.962903] [097/165] (857s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[153.274859] Starting subtest: basic-flip-after-cursor-legacy
[154.320359] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.052s)
[154.694302] [098/165] (856s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[155.013328] Starting subtest: basic-flip-after-cursor-varying-size
[156.077791] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.074s)
[156.445200] [099/165] (854s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[156.762546] Starting subtest: basic-flip-before-cursor-atomic
[157.802558] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.054s)
[158.172253] [100/165] (853s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[158.483815] Starting subtest: basic-flip-before-cursor-legacy
[159.560357] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.063s)
[159.907706] [101/165] (851s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[160.220101] Starting subtest: basic-flip-before-cursor-varying-size
[161.289119] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.078s)
[161.643475] [102/165] (849s left) kms_dsc (dsc-basic)
[162.000410] Subtest dsc-basic: SKIP (0.000s)
[162.094330] [103/165] (849s left) kms_flip (basic-flip-vs-dpms)
[162.430563] Starting subtest: basic-flip-vs-dpms
[162.451379] Starting dynamic subtest: A-DP1
[163.650057] Dynamic subtest A-DP1: SUCCESS (1.249s)
[163.689115] Starting dynamic subtest: B-DP1
[164.826608] Dynamic subtest B-DP1: SUCCESS (1.154s)
[164.871841] Starting dynamic subtest: C-DP1
[165.966064] Dynamic subtest C-DP1: SUCCESS (1.155s)
[165.985971] Subtest basic-flip-vs-dpms: SUCCESS (3.567s)
[166.384965] [104/165] (845s left) kms_flip (basic-flip-vs-modeset)
[166.709412] Starting subtest: basic-flip-vs-modeset
[166.728610] Starting dynamic subtest: A-DP1
[167.988196] Dynamic subtest A-DP1: SUCCESS (1.284s)
[168.026669] Starting dynamic subtest: B-DP1
[169.135752] Dynamic subtest B-DP1: SUCCESS (1.150s)
[169.177714] Starting dynamic subtest: C-DP1
[170.290924] Dynamic subtest C-DP1: SUCCESS (1.144s)
[170.312286] Subtest basic-flip-vs-modeset: SUCCESS (3.589s)
[170.690705] [105/165] (840s left) kms_flip (basic-flip-vs-wf_vblank)
[171.049619] Starting subtest: basic-flip-vs-wf_vblank
[171.076819] Starting dynamic subtest: A-DP1
[172.483390] Dynamic subtest A-DP1: SUCCESS (1.468s)
[172.523959] Starting dynamic subtest: B-DP1
[173.876948] Dynamic subtest B-DP1: SUCCESS (1.389s)
[173.917798] Starting dynamic subtest: C-DP1
[175.277266] Dynamic subtest C-DP1: SUCCESS (1.392s)
[175.297204] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.260s)
[175.734221] [106/165] (835s left) kms_flip (basic-plain-flip)
[176.056540] Starting subtest: basic-plain-flip
[176.079582] Starting dynamic subtest: A-DP1
[177.229223] Dynamic subtest A-DP1: SUCCESS (1.179s)
[177.269236] Starting dynamic subtest: B-DP1
[178.336218] Dynamic subtest B-DP1: SUCCESS (1.106s)
[178.377338] Starting dynamic subtest: C-DP1
[179.449348] Dynamic subtest C-DP1: SUCCESS (1.110s)
[179.470545] Subtest basic-plain-flip: SUCCESS (3.406s)
[179.905332] [107/165] (831s left) kms_force_connector_basic (force-connector-state)
[180.188445] Subtest force-connector-state: SKIP (0.000s)
[180.280849] [108/165] (831s left) kms_force_connector_basic (force-edid)
[180.553794] Subtest force-edid: SKIP (0.000s)
[180.647800] [109/165] (831s left) kms_force_connector_basic (force-load-detect)
[180.922333] Subtest force-load-detect: SKIP (0.000s)
[181.016928] [110/165] (831s left) kms_force_connector_basic (prune-stale-modes)
[181.293861] Subtest prune-stale-modes: SKIP (0.000s)
[181.387747] [111/165] (830s left) kms_frontbuffer_tracking (basic)
[181.760151] Starting subtest: basic
[184.770801] Subtest basic: SUCCESS (3.063s)
[184.918692] [112/165] (827s left) kms_hdmi_inject (inject-audio)
[185.204358] Subtest inject-audio: SKIP (0.000s)
[185.303181] [113/165] (827s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[185.633640] Starting subtest: compare-crc-sanitycheck-xr24
[185.655735] Starting dynamic subtest: pipe-A-DP-1
[186.061130] Dynamic subtest pipe-A-DP-1: SUCCESS (0.428s)
[186.100379] Starting dynamic subtest: pipe-B-DP-1
[186.651646] Dynamic subtest pipe-B-DP-1: SUCCESS (0.605s)
[186.692835] Starting dynamic subtest: pipe-C-DP-1
[187.296773] Dynamic subtest pipe-C-DP-1: SUCCESS (0.616s)
[187.317555] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.662s)
[187.653118] [114/165] (824s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[187.976269] Starting subtest: compare-crc-sanitycheck-nv12
[187.998897] Starting dynamic subtest: pipe-A-DP-1
[188.046643] Dynamic subtest pipe-A-DP-1: SKIP (0.001s)
[188.089227] Starting dynamic subtest: pipe-B-DP-1
[188.132734] Dynamic subtest pipe-B-DP-1: SKIP (0.001s)
[188.172361] Starting dynamic subtest: pipe-C-DP-1
[188.218161] Dynamic subtest pipe-C-DP-1: SKIP (0.001s)
[188.259401] Subtest compare-crc-sanitycheck-nv12: SKIP (0.017s)
[188.361522] [115/165] (824s left) kms_pipe_crc_basic (hang-read-crc)
[188.683919] Starting subtest: hang-read-crc
[188.704496] Starting dynamic subtest: pipe-A-DP-1
[190.158273] Dynamic subtest pipe-A-DP-1: SUCCESS (1.477s)
[190.198079] Starting dynamic subtest: pipe-B-DP-1
[191.787961] Dynamic subtest pipe-B-DP-1: SUCCESS (1.622s)
[191.828330] Starting dynamic subtest: pipe-C-DP-1
[193.422048] Dynamic subtest pipe-C-DP-1: SUCCESS (1.624s)
[193.447748] Subtest hang-read-crc: SUCCESS (4.737s)
[193.755842] [116/165] (818s left) kms_pipe_crc_basic (nonblocking-crc)
[194.101841] Starting subtest: nonblocking-crc
[194.126333] Starting dynamic subtest: pipe-A-DP-1
[194.645099] Dynamic subtest pipe-A-DP-1: SUCCESS (0.572s)
[194.686695] Starting dynamic subtest: pipe-B-DP-1
[195.411439] Dynamic subtest pipe-B-DP-1: SUCCESS (0.760s)
[195.452899] Starting dynamic subtest: pipe-C-DP-1
[196.166082] Dynamic subtest pipe-C-DP-1: SUCCESS (0.751s)
[196.185609] Subtest nonblocking-crc: SUCCESS (2.098s)
[196.525608] [117/165] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[196.851095] Starting subtest: nonblocking-crc-frame-sequence
[196.870910] Starting dynamic subtest: pipe-A-DP-1
[197.437977] Dynamic subtest pipe-A-DP-1: SUCCESS (0.588s)
[197.488389] Starting dynamic subtest: pipe-B-DP-1
[198.202949] Dynamic subtest pipe-B-DP-1: SUCCESS (0.760s)
[198.251314] Starting dynamic subtest: pipe-C-DP-1
[198.941175] Dynamic subtest pipe-C-DP-1: SUCCESS (0.750s)
[198.964159] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.112s)
[199.305389] [118/165] (813s left) kms_pipe_crc_basic (read-crc)
[199.626793] Starting subtest: read-crc
[199.649094] Starting dynamic subtest: pipe-A-DP-1
[200.118314] Dynamic subtest pipe-A-DP-1: SUCCESS (0.501s)
[200.173167] Starting dynamic subtest: pipe-B-DP-1
[200.829479] Dynamic subtest pipe-B-DP-1: SUCCESS (0.697s)
[200.876753] Starting dynamic subtest: pipe-C-DP-1
[201.532809] Dynamic subtest pipe-C-DP-1: SUCCESS (0.704s)
[201.556214] Subtest read-crc: SUCCESS (1.917s)
[201.890666] [119/165] (811s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[202.198606] Starting subtest: read-crc-frame-sequence
[202.221300] Starting dynamic subtest: pipe-A-DP-1
[202.701108] Dynamic subtest pipe-A-DP-1: SUCCESS (0.495s)
[202.757189] Starting dynamic subtest: pipe-B-DP-1
[203.401055] Dynamic subtest pipe-B-DP-1: SUCCESS (0.681s)
[203.439796] Starting dynamic subtest: pipe-C-DP-1
[204.080495] Dynamic subtest pipe-C-DP-1: SUCCESS (0.696s)
[204.101614] Subtest read-crc-frame-sequence: SUCCESS (1.887s)
[204.451699] [120/165] (808s left) kms_pm_backlight (basic-brightness)
[204.790427] Subtest basic-brightness: SKIP (0.000s)
[204.890055] [121/165] (808s left) kms_pm_rpm (basic-pci-d3-state)
[206.774445] Starting subtest: basic-pci-d3-state
[207.430773] Subtest basic-pci-d3-state: SUCCESS (0.642s)
[207.649504] [122/165] (805s left) kms_pm_rpm (basic-rte)
[207.884849] Starting subtest: basic-rte
[210.043497] Subtest basic-rte: SUCCESS (2.193s)
[211.019308] [123/165] (802s left) kms_psr (psr_primary_page_flip)
[211.472537] [124/165] (801s left) kms_psr (psr_cursor_plane_move)
[211.951657] [125/165] (801s left) kms_psr (psr_sprite_plane_onoff)
[212.433894] [126/165] (801s left) kms_psr (psr_primary_mmap_gtt)
[212.898949] [127/165] (800s left) kms_setmode (basic-clone-single-crtc)
[213.166786] Starting subtest: basic-clone-single-crtc
[213.232404] Subtest basic-clone-single-crtc: SKIP (0.000s)
[213.329285] [128/165] (800s left) i915_pm_rps (basic-api)
[213.593238] Starting subtest: basic-api
[213.616795] Subtest basic-api: SUCCESS (0.007s)
[213.736219] [129/165] (800s left) prime_self_import (basic-llseek-bad)
[213.975509] Starting subtest: basic-llseek-bad
[214.020516] Subtest basic-llseek-bad: SUCCESS (0.004s)
[214.120172] [130/165] (799s left) prime_self_import (basic-llseek-size)
[214.331284] Starting subtest: basic-llseek-size
[214.373778] Subtest basic-llseek-size: SUCCESS (0.006s)
[214.469822] [131/165] (799s left) prime_self_import (basic-with_fd_dup)
[214.705168] Starting subtest: basic-with_fd_dup
[214.747792] Subtest basic-with_fd_dup: SUCCESS (0.006s)
[214.847760] [132/165] (799s left) prime_self_import (basic-with_one_bo)
[215.082726] Starting subtest: basic-with_one_bo
[215.128113] Subtest basic-with_one_bo: SUCCESS (0.007s)
[215.228707] [133/165] (799s left) prime_self_import (basic-with_one_bo_two_files)
[215.461748] Starting subtest: basic-with_one_bo_two_files
[215.506696] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[215.602529] [134/165] (798s left) prime_self_import (basic-with_two_bos)
[215.830575] Starting subtest: basic-with_two_bos
[215.872685] Subtest basic-with_two_bos: SUCCESS (0.006s)
[215.967709] [135/165] (798s left) prime_vgem (basic-fence-flip)
[216.255033] Starting subtest: basic-fence-flip
[216.798159] Subtest basic-fence-flip: SUCCESS (0.586s)
[216.932405] [136/165] (797s left) prime_vgem (basic-fence-mmap)
[217.207570] Starting subtest: basic-fence-mmap
[217.229367] Subtest basic-fence-mmap: SUCCESS (0.073s)
[217.346187] [137/165] (797s left) prime_vgem (basic-fence-read)
[217.616387] Starting subtest: basic-fence-read
[217.671946] Subtest basic-fence-read: SUCCESS (0.111s)
[217.795435] [138/165] (797s left) prime_vgem (basic-gtt)
[218.051415] Starting subtest: basic-gtt
[218.071320] Subtest basic-gtt: SUCCESS (0.035s)
[218.189099] [139/165] (796s left) prime_vgem (basic-read)
[218.441058] Starting subtest: basic-read
[218.460992] Subtest basic-read: SUCCESS (0.054s)
[218.579265] [140/165] (796s left) prime_vgem (basic-write)
[218.854204] Starting subtest: basic-write
[218.877931] Subtest basic-write: SUCCESS (0.066s)
[218.999283] [141/165] (796s left) vgem_basic (setversion)
[219.245326] Starting subtest: setversion
[219.289058] Subtest setversion: SUCCESS (0.000s)
[219.383662] [142/165] (795s left) vgem_basic (create)
[219.635827] Starting subtest: create
[219.655695] Subtest create: SUCCESS (0.001s)
[219.752242] [143/165] (795s left) vgem_basic (debugfs)
[220.005775] Starting subtest: debugfs
[220.026265] Subtest debugfs: SUCCESS (0.001s)
[220.123303] [144/165] (795s left) vgem_basic (dmabuf-export)
[220.381724] Starting subtest: dmabuf-export
[220.441676] Subtest dmabuf-export: SUCCESS (0.005s)
[220.567506] [145/165] (795s left) vgem_basic (dmabuf-fence)
[220.873154] Starting subtest: dmabuf-fence
[220.900578] Subtest dmabuf-fence: SUCCESS (0.002s)
[221.026990] [146/165] (794s left) vgem_basic (dmabuf-fence-before)
[221.324181] Starting subtest: dmabuf-fence-before
[221.353099] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[221.489536] [147/165] (794s left) vgem_basic (dmabuf-mmap)
[221.787718] Starting subtest: dmabuf-mmap
[221.818893] Subtest dmabuf-mmap: SUCCESS (0.043s)
[221.938986] [148/165] (794s left) vgem_basic (mmap)
[222.210269] Starting subtest: mmap
[222.239459] Subtest mmap: SUCCESS (0.026s)
[222.361448] [149/165] (793s left) vgem_basic (second-client)
[222.657193] Starting subtest: second-client
[222.713308] Subtest second-client: SUCCESS (0.032s)
[222.814440] [150/165] (793s left) vgem_basic (sysfs)
[223.064388] Starting subtest: sysfs
[223.086984] Subtest sysfs: SUCCESS (0.001s)
[223.181488] [151/165] (793s left) core_hotunplug (unbind-rebind)
[223.515145] Starting subtest: unbind-rebind
[227.426270] Subtest unbind-rebind: SUCCESS (3.923s)
[227.526738] [152/165] (788s left) vgem_basic (unload)
[227.765606] Starting subtest: unload
[256.939471] Subtest unload: SUCCESS (29.020s)
[257.035074] [153/165] (759s left) i915_module_load (reload)
[257.257891] Starting subtest: reload
[260.788365] Subtest reload: SUCCESS (3.531s)
[260.915439] [154/165] (755s left) gem_lmem_swapping (basic)
[261.210243] Subtest basic: SKIP (0.000s)
[261.325328] [155/165] (755s left) gem_lmem_swapping (parallel-random-engines)
[261.628295] Subtest parallel-random-engines: SKIP (0.000s)
[261.741626] [156/165] (755s left) gem_lmem_swapping (random-engines)
[262.067057] Subtest random-engines: SKIP (0.000s)
[262.187166] [157/165] (754s left) gem_lmem_swapping (verify-random)
[262.477870] Subtest verify-random: SKIP (0.000s)
[262.570403] [158/165] (754s left) i915_pm_rpm (module-reload)
[264.764329] Starting subtest: module-reload
[274.403263] Subtest module-reload: SUCCESS (9.643s)
[274.511459] [159/165] (742s left) i915_selftest (live)
[274.749312] Starting subtest: live
[274.769454] Starting dynamic subtest: sanitycheck
[276.400999] Dynamic subtest sanitycheck: SUCCESS (1.654s)
[276.436803] Starting dynamic subtest: uncore
[278.058219] Dynamic subtest uncore: SUCCESS (1.645s)
[278.110707] Starting dynamic subtest: workarounds
[279.833421] Dynamic subtest workarounds: SUCCESS (1.779s)
[279.881118] Starting dynamic subtest: gt_engines
[281.794336] Dynamic subtest gt_engines: SUCCESS (1.957s)
[281.830793] Starting dynamic subtest: gt_timelines
[304.030950] Dynamic subtest gt_timelines: SUCCESS (22.234s)
[304.076145] Starting dynamic subtest: gt_contexts
[305.731486] Dynamic subtest gt_contexts: SUCCESS (1.699s)
[305.778922] Starting dynamic subtest: gt_lrc
[310.162892] Dynamic subtest gt_lrc: SUCCESS (4.427s)
[310.199691] Starting dynamic subtest: gt_mocs
[311.972927] Dynamic subtest gt_mocs: SUCCESS (1.803s)
[312.009097] Starting dynamic subtest: gt_pm
[320.983077] Dynamic subtest gt_pm: SUCCESS (9.007s)
[321.017929] Starting dynamic subtest: gt_heartbeat
[322.589878] Dynamic subtest gt_heartbeat: SUCCESS (1.601s)
[322.635378] Starting dynamic subtest: gt_tlb
[325.167548] Dynamic subtest gt_tlb: SUCCESS (2.575s)
[325.203236] Starting dynamic subtest: requests
[333.160109] Dynamic subtest requests: SUCCESS (7.990s)
[333.195085] Starting dynamic subtest: migrate
[337.991732] Dynamic subtest migrate: SUCCESS (4.827s)
[338.036929] Starting dynamic subtest: active
[339.473083] Dynamic subtest active: SUCCESS (1.477s)
[339.506967] Starting dynamic subtest: objects
[344.060171] Dynamic subtest objects: SUCCESS (4.585s)
[344.101325] Starting dynamic subtest: mman
[353.033756] Dynamic subtest mman: SUCCESS (8.967s)
[353.081076] Starting dynamic subtest: dmabuf
[354.568146] Dynamic subtest dmabuf: SUCCESS (1.532s)
[354.613883] Starting dynamic subtest: vma
[356.261773] Dynamic subtest vma: SUCCESS (1.690s)
[356.295985] Starting dynamic subtest: coherency
[360.397635] Dynamic subtest coherency: SUCCESS (4.135s)
[360.443086] Starting dynamic subtest: gtt
[369.728097] Dynamic subtest gtt: SUCCESS (9.325s)
[369.775395] Starting dynamic subtest: gem
[372.644049] Dynamic subtest gem: SUCCESS (2.915s)
[372.691365] Starting dynamic subtest: evict
[378.767832] Dynamic subtest evict: SUCCESS (6.117s)
[378.803229] Starting dynamic subtest: hugepages
[386.849248] Dynamic subtest hugepages: SUCCESS (8.080s)
[386.895847] Starting dynamic subtest: gem_contexts
[411.696244] Dynamic subtest gem_contexts: SUCCESS (24.671s)
[411.730056] Starting dynamic subtest: client
[413.238840] Dynamic subtest client: SUCCESS (1.708s)
[413.275176] Starting dynamic subtest: gem_migrate
[414.877043] Dynamic subtest gem_migrate: SUCCESS (1.638s)
[414.914091] Starting dynamic subtest: reset
[428.511252] Dynamic subtest reset: SUCCESS (13.631s)
[428.558375] Starting dynamic subtest: memory_region
[430.054264] Dynamic subtest memory_region: SUCCESS (1.538s)
[430.090438] Starting dynamic subtest: hangcheck
[454.914870] Dynamic subtest hangcheck: SUCCESS (24.856s)
[454.951131] Starting dynamic subtest: execlists
[467.585316] Dynamic subtest execlists: SUCCESS (12.667s)
[467.621384] Starting dynamic subtest: ring_submission
[469.077757] Dynamic subtest ring_submission: SUCCESS (1.482s)
[469.133925] Starting dynamic subtest: perf
[470.931287] Dynamic subtest perf: SUCCESS (1.859s)
[470.981053] Starting dynamic subtest: slpc
[472.639355] Dynamic subtest slpc: SUCCESS (1.705s)
[472.677681] Starting dynamic subtest: guc
[474.175851] Dynamic subtest guc: SUCCESS (1.532s)
[474.213057] Starting dynamic subtest: guc_multi_lrc
[475.756959] Dynamic subtest guc_multi_lrc: SUCCESS (1.578s)
[475.793998] Starting dynamic subtest: guc_hang
[477.338484] Dynamic subtest guc_hang: SUCCESS (1.578s)
[477.385361] Starting dynamic subtest: late_gt_pm
[479.058664] Dynamic subtest late_gt_pm: SUCCESS (1.717s)
[479.078058] Subtest live: SUCCESS (204.316s)
[479.169568] [160/165] (538s left) dmabuf (all-tests)
[479.403820] Starting subtest: all-tests
[479.429477] Starting dynamic subtest: sanitycheck
[479.481079] Dynamic subtest sanitycheck: SUCCESS (0.080s)
[479.519761] Starting dynamic subtest: dma_fence
[479.670928] Dynamic subtest dma_fence: SUCCESS (0.186s)
[479.706906] Starting dynamic subtest: dma_fence_chain
[502.814501] Dynamic subtest dma_fence_chain: SUCCESS (23.142s)
[502.852711] Starting dynamic subtest: dma_fence_unwrap
[502.897734] Dynamic subtest dma_fence_unwrap: SUCCESS (0.072s)
[502.936165] Starting dynamic subtest: dma_resv
[502.982137] Dynamic subtest dma_resv: SUCCESS (0.072s)
[503.003826] Subtest all-tests: SUCCESS (23.568s)
[503.095206] [161/165] (514s left) i915_suspend (basic-s2idle-without-i915)
[503.311507] Starting subtest: basic-s2idle-without-i915
[523.584574] Subtest basic-s2idle-without-i915: SUCCESS (5.287s)
[527.961391] [162/165] (508s left) i915_suspend (basic-s3-without-i915)
[528.188564] Starting subtest: basic-s3-without-i915
[546.534634] Subtest basic-s3-without-i915: SUCCESS (3.782s)
[551.920794] [163/165] (504s left) gem_exec_suspend (basic-s0)
[552.188351] Starting subtest: basic-S0
[552.208941] Starting dynamic subtest: smem
[573.002880] Dynamic subtest smem: SUCCESS (5.367s)
[573.022508] Subtest basic-S0: SUCCESS (5.370s)
[577.396172] [164/165] (498s left) gem_exec_suspend (basic-s3)
[577.644221] Starting subtest: basic-S3
[577.665675] Starting dynamic subtest: smem
[598.324239] Dynamic subtest smem: SUCCESS (5.621s)
[598.343794] Subtest basic-S3: SUCCESS (5.624s)
[602.714733] [165/165] (492s left) kms_pipe_crc_basic (suspend-read-crc)
[603.030750] Starting subtest: suspend-read-crc
[603.051650] Starting dynamic subtest: pipe-A-DP-1
[621.230261] Dynamic subtest pipe-A-DP-1: SUCCESS (2.466s)
[621.276869] Starting dynamic subtest: pipe-B-DP-1
[640.191214] Dynamic subtest pipe-B-DP-1: SUCCESS (2.592s)
[640.236008] Starting dynamic subtest: pipe-C-DP-1
[658.183306] Dynamic subtest pipe-C-DP-1: SUCCESS (2.378s)
[658.205780] Subtest suspend-read-crc: SUCCESS (7.453s)
[662.642243] Closing watchdogs
Done.