[45.232263] Initializing watchdogs
[45.232512]   /dev/watchdog0
[45.287465] [001/165] (960s left) i915_module_load (load)
[45.730730] Starting subtest: load
[48.195912] Subtest load: SUCCESS (2.462s)
[48.305107] [002/165] (957s left) core_auth (basic-auth)
[48.566693] Starting subtest: basic-auth
[48.587277] Subtest basic-auth: SUCCESS (0.002s)
[48.671349] [003/165] (957s left) debugfs_test (read_all_entries)
[48.901331] Starting subtest: read_all_entries
[49.305270] Subtest read_all_entries: SUCCESS (0.408s)
[49.505316] [004/165] (956s left) debugfs_test (basic-hwmon)
[49.746578] Starting subtest: basic-hwmon
[49.789097] Subtest basic-hwmon: SKIP (0.000s)
[49.927437] [005/165] (956s left) fbdev (eof)
[50.148180] Starting subtest: eof
[50.173857] Subtest eof: SUCCESS (0.002s)
[50.296867] [006/165] (955s left) fbdev (info)
[50.491644] Starting subtest: info
[50.515292] Subtest info: SUCCESS (0.000s)
[50.642600] [007/165] (955s left) fbdev (nullptr)
[50.865180] Starting subtest: nullptr
[50.889358] Subtest nullptr: SUCCESS (0.000s)
[51.009537] [008/165] (955s left) fbdev (read)
[51.231257] Starting subtest: read
[52.700784] Subtest read: SUCCESS (1.474s)
[52.810243] [009/165] (953s left) fbdev (write)
[53.024222] Starting subtest: write
[53.769787] Subtest write: SUCCESS (0.762s)
[53.877639] [010/165] (952s left) gem_basic (bad-close)
[54.089451] Starting subtest: bad-close
[54.131682] Subtest bad-close: SUCCESS (0.000s)
[54.219308] [011/165] (952s left) gem_basic (create-close)
[54.448422] Starting subtest: create-close
[54.493192] Subtest create-close: SUCCESS (0.000s)
[54.583184] [012/165] (952s left) gem_basic (create-fd-close)
[54.815062] Starting subtest: create-fd-close
[54.857989] Subtest create-fd-close: SUCCESS (0.000s)
[54.942834] [013/165] (951s left) gem_busy (busy@all-engines)
[55.173044] Starting subtest: busy
[55.193104] Starting dynamic subtest: all-engines
[55.276177] Dynamic subtest all-engines: SUCCESS (0.108s)
[55.298309] Subtest busy: SUCCESS (0.109s)
[55.688218] [014/165] (951s left) gem_close_race (basic-process)
[55.944336] Starting subtest: basic-process
[56.027761] Subtest basic-process: SUCCESS (0.104s)
[56.258209] [015/165] (950s left) gem_close_race (basic-threads)
[56.489901] Starting subtest: basic-threads
[57.720557] Subtest basic-threads: SUCCESS (1.231s)
[57.956916] [016/165] (949s left) gem_ctx_create (basic)
[58.187792] Starting subtest: basic
[58.208209] Subtest basic: SUCCESS (0.000s)
[58.407104] [017/165] (948s left) gem_ctx_create (basic-files)
[58.637521] Starting subtest: basic-files
[60.668691] Subtest basic-files: SUCCESS (2.038s)
[60.961221] [018/165] (946s left) gem_ctx_exec (basic)
[61.211980] Starting subtest: basic
[61.237463] Subtest basic: SUCCESS (0.009s)
[61.332322] [019/165] (946s left) gem_exec_basic (basic)
[61.555831] Starting subtest: basic
[61.580039] Starting dynamic subtest: rcs0-smem
[61.602831] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[61.637931] Starting dynamic subtest: bcs0-smem
[61.659956] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[61.695757] Starting dynamic subtest: vcs0-smem
[61.716051] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[61.750911] Starting dynamic subtest: vecs0-smem
[61.774044] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[61.795946] Subtest basic: SUCCESS (0.011s)
[61.885099] [020/165] (945s left) gem_exec_create (basic)
[62.117110] Starting subtest: basic
[62.138484] Starting dynamic subtest: smem
[64.184572] Dynamic subtest smem: SUCCESS (2.068s)
[64.206999] Subtest basic: SUCCESS (2.069s)
[64.405586] [021/165] (943s left) gem_exec_fence (basic-busy)
[64.765227] Starting subtest: basic-busy
[64.787173] Starting dynamic subtest: rcs0
[64.829392] Dynamic subtest rcs0: SUCCESS (0.030s)
[64.866962] Starting dynamic subtest: bcs0
[64.908561] Dynamic subtest bcs0: SUCCESS (0.025s)
[64.941883] Starting dynamic subtest: vcs0
[64.985393] Dynamic subtest vcs0: SUCCESS (0.034s)
[65.020205] Starting dynamic subtest: vecs0
[65.061168] Dynamic subtest vecs0: SUCCESS (0.025s)
[65.082598] Subtest basic-busy: SUCCESS (0.115s)
[65.655101] [022/165] (941s left) gem_exec_fence (basic-wait)
[66.013880] Starting subtest: basic-wait
[66.037931] Starting dynamic subtest: rcs0
[66.060647] Dynamic subtest rcs0: SUCCESS (0.027s)
[66.095994] Starting dynamic subtest: bcs0
[66.116961] Dynamic subtest bcs0: SUCCESS (0.035s)
[66.154328] Starting dynamic subtest: vcs0
[66.176904] Dynamic subtest vcs0: SUCCESS (0.026s)
[66.211234] Starting dynamic subtest: vecs0
[66.231714] Dynamic subtest vecs0: SUCCESS (0.027s)
[66.254166] Subtest basic-wait: SUCCESS (0.116s)
[66.823381] [023/165] (940s left) gem_exec_fence (basic-await)
[67.181416] Starting subtest: basic-await
[67.204222] Starting dynamic subtest: rcs0
[67.320116] Dynamic subtest rcs0: SUCCESS (0.139s)
[67.360108] Starting dynamic subtest: bcs0
[67.457101] Dynamic subtest bcs0: SUCCESS (0.134s)
[67.494974] Starting dynamic subtest: vcs0
[67.595241] Dynamic subtest vcs0: SUCCESS (0.137s)
[67.635533] Starting dynamic subtest: vecs0
[67.725291] Dynamic subtest vecs0: SUCCESS (0.132s)
[67.747638] Subtest basic-await: SUCCESS (0.545s)
[68.450788] [024/165] (939s left) gem_exec_fence (nb-await)
[68.806824] Starting subtest: nb-await
[68.826279] Starting dynamic subtest: rcs0
[68.885771] Dynamic subtest rcs0: SUCCESS (0.078s)
[68.923235] Starting dynamic subtest: bcs0
[68.963583] Dynamic subtest bcs0: SUCCESS (0.070s)
[69.001988] Starting dynamic subtest: vcs0
[69.045145] Dynamic subtest vcs0: SUCCESS (0.070s)
[69.081165] Starting dynamic subtest: vecs0
[69.104684] Dynamic subtest vecs0: SUCCESS (0.071s)
[69.127406] Subtest nb-await: SUCCESS (0.291s)
[69.807593] [025/165] (938s left) gem_exec_gttfill (basic)
[70.038944] Starting subtest: basic
[92.400203] Subtest basic: SUCCESS (22.201s)
[92.499194] [026/165] (915s left) gem_exec_parallel (engines)
[92.893489] Starting subtest: engines
[92.914802] Starting dynamic subtest: basic
[96.713192] Dynamic subtest basic: SUCCESS (3.644s)
[96.749306] Starting dynamic subtest: contexts
[101.446040] Dynamic subtest contexts: SUCCESS (4.744s)
[101.486212] Starting dynamic subtest: fds
[107.785652] Dynamic subtest fds: SUCCESS (6.354s)
[107.825217] Starting dynamic subtest: userptr
[111.459544] Dynamic subtest userptr: SUCCESS (3.652s)
[111.481808] Subtest engines: SUCCESS (18.395s)
[111.589071] [027/165] (896s left) gem_exec_store (basic)
[111.893890] Starting subtest: basic
[111.914300] Subtest basic: SUCCESS (0.079s)
[112.126721] [028/165] (896s left) gem_flink_basic (bad-flink)
[112.359230] Starting subtest: bad-flink
[112.379704] Subtest bad-flink: SUCCESS (0.000s)
[112.472571] [029/165] (895s left) gem_flink_basic (bad-open)
[112.705777] Starting subtest: bad-open
[112.728334] Subtest bad-open: SUCCESS (0.000s)
[112.819094] [030/165] (895s left) gem_flink_basic (basic)
[113.029850] Starting subtest: basic
[113.050746] Subtest basic: SUCCESS (0.000s)
[113.142839] [031/165] (895s left) gem_flink_basic (double-flink)
[113.375268] Starting subtest: double-flink
[113.398070] Subtest double-flink: SUCCESS (0.000s)
[113.487952] [032/165] (895s left) gem_flink_basic (flink-lifetime)
[113.717771] Starting subtest: flink-lifetime
[113.738060] Subtest flink-lifetime: SUCCESS (0.003s)
[113.830158] [033/165] (894s left) gem_huc_copy (huc-copy)
[114.064359] Starting subtest: huc-copy
[114.086805] Subtest huc-copy: SUCCESS (0.008s)
[114.197101] [034/165] (894s left) gem_linear_blits (basic)
[114.594597] Starting subtest: basic
[114.617229] Subtest basic: SUCCESS (0.021s)
[114.783751] [035/165] (893s left) gem_mmap (basic)
[115.224043] Starting subtest: basic
[115.333878] Subtest basic: SUCCESS (0.001s)
[115.424417] [036/165] (893s left) gem_mmap_gtt (basic)
[115.660944] Starting subtest: basic
[115.680707] Subtest basic: SUCCESS (0.002s)
[115.773574] [037/165] (893s left) gem_render_linear_blits (basic)
[116.004967] Starting subtest: basic
[116.108887] Subtest basic: SUCCESS (0.084s)
[116.198618] [038/165] (892s left) gem_render_tiled_blits (basic)
[116.437320] Starting subtest: basic
[116.562206] Subtest basic: SUCCESS (0.117s)
[116.653343] [039/165] (892s left) gem_ringfill (basic-all)
[117.160625] Starting subtest: basic-all
[118.339293] Subtest basic-all: SUCCESS (1.205s)
[118.476909] [040/165] (890s left) gem_softpin (allocator-basic)
[118.715960] Starting subtest: allocator-basic
[118.940381] Subtest allocator-basic: SUCCESS (0.248s)
[119.089805] [041/165] (890s left) gem_softpin (allocator-basic-reserve)
[119.318422] Starting subtest: allocator-basic-reserve
[119.539979] Subtest allocator-basic-reserve: SUCCESS (0.248s)
[119.690636] [042/165] (889s left) gem_softpin (safe-alignment)
[119.921295] Starting subtest: safe-alignment
[119.941151] Subtest safe-alignment: SUCCESS (0.033s)
[120.054923] [043/165] (889s left) gem_sync (basic-all)
[120.464831] Starting subtest: basic-all
[123.492643] Subtest basic-all: SUCCESS (3.042s)
[123.581263] [044/165] (885s left) gem_sync (basic-each)
[123.987176] Starting subtest: basic-each
[126.177489] Subtest basic-each: SUCCESS (2.356s)
[126.390455] [045/165] (883s left) gem_tiled_blits (basic)
[126.768869] Starting subtest: basic
[126.820812] Subtest basic: SUCCESS (0.049s)
[127.019507] [046/165] (882s left) gem_tiled_fence_blits (basic)
[127.587130] Starting subtest: basic
[127.632804] Subtest basic: SUCCESS (0.042s)
[127.831931] [047/165] (881s left) gem_tiled_pread_basic
[128.593861] [048/165] (881s left) gem_wait (busy@all-engines)
[128.854170] Starting subtest: busy
[128.877506] Starting dynamic subtest: all-engines
[129.376749] Dynamic subtest all-engines: SUCCESS (0.532s)
[129.400171] Subtest busy: SUCCESS (0.533s)
[129.648145] [049/165] (880s left) gem_wait (wait@all-engines)
[129.903576] Starting subtest: wait
[129.924047] Starting dynamic subtest: all-engines
[130.942296] Dynamic subtest all-engines: SUCCESS (1.044s)
[130.962936] Subtest wait: SUCCESS (1.045s)
[131.206528] [050/165] (878s left) i915_getparams_basic (basic-eu-total)
[131.438226] Starting subtest: basic-eu-total
[131.479183] Subtest basic-eu-total: SUCCESS (0.000s)
[131.571347] [051/165] (878s left) i915_getparams_basic (basic-subslice-total)
[131.802809] Starting subtest: basic-subslice-total
[131.845253] Subtest basic-subslice-total: SUCCESS (0.000s)
[131.935514] [052/165] (878s left) i915_hangman (error-state-basic)
[132.186076] Starting subtest: error-state-basic
[132.462109] Subtest error-state-basic: SUCCESS (0.292s)
[132.579413] [053/165] (877s left) i915_pciid
[132.925998] [054/165] (877s left) kms_addfb_basic (addfb25-4-tiled)
[133.315389] Starting subtest: addfb25-4-tiled
[133.335483] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[133.431251] [055/165] (877s left) kms_addfb_basic (addfb25-bad-modifier)
[133.662137] Starting subtest: addfb25-bad-modifier
[133.684389] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[133.856721] [056/165] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[134.086961] Starting subtest: addfb25-framebuffer-vs-set-tiling
[134.106533] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[134.293304] [057/165] (876s left) kms_addfb_basic (addfb25-modifier-no-flag)
[134.522518] Starting subtest: addfb25-modifier-no-flag
[134.541957] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[134.711534] [058/165] (876s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[134.941196] Starting subtest: addfb25-x-tiled-legacy
[134.962863] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[135.156607] [059/165] (875s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[135.387821] Starting subtest: addfb25-x-tiled-mismatch-legacy
[135.407476] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[135.576948] [060/165] (875s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[135.889284] Starting subtest: addfb25-yf-tiled-legacy
[135.911730] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[136.005173] [061/165] (874s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[136.321946] Starting subtest: addfb25-y-tiled-legacy
[136.342826] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[136.442431] [062/165] (874s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[136.759254] Starting subtest: addfb25-y-tiled-small-legacy
[136.781313] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.001s)
[136.872233] [063/165] (874s left) kms_addfb_basic (bad-pitch-0)
[137.099146] Starting subtest: bad-pitch-0
[137.118473] Subtest bad-pitch-0: SUCCESS (0.000s)
[137.293435] [064/165] (873s left) kms_addfb_basic (bad-pitch-1024)
[137.523617] Starting subtest: bad-pitch-1024
[137.545371] Subtest bad-pitch-1024: SUCCESS (0.000s)
[137.727701] [065/165] (873s left) kms_addfb_basic (bad-pitch-128)
[137.956713] Starting subtest: bad-pitch-128
[137.980819] Subtest bad-pitch-128: SUCCESS (0.000s)
[138.158614] [066/165] (873s left) kms_addfb_basic (bad-pitch-256)
[138.388280] Starting subtest: bad-pitch-256
[138.407664] Subtest bad-pitch-256: SUCCESS (0.000s)
[138.595357] [067/165] (872s left) kms_addfb_basic (bad-pitch-32)
[138.825514] Starting subtest: bad-pitch-32
[138.847476] Subtest bad-pitch-32: SUCCESS (0.000s)
[139.024676] [068/165] (872s left) kms_addfb_basic (bad-pitch-63)
[139.254041] Starting subtest: bad-pitch-63
[139.276307] Subtest bad-pitch-63: SUCCESS (0.000s)
[139.438948] [069/165] (872s left) kms_addfb_basic (bad-pitch-65536)
[139.669228] Starting subtest: bad-pitch-65536
[139.688775] Subtest bad-pitch-65536: SUCCESS (0.001s)
[139.857875] [070/165] (871s left) kms_addfb_basic (bad-pitch-999)
[140.086358] Starting subtest: bad-pitch-999
[140.105543] Subtest bad-pitch-999: SUCCESS (0.000s)
[140.276058] [071/165] (871s left) kms_addfb_basic (basic)
[140.532828] Starting subtest: basic
[140.558166] Subtest basic: SUCCESS (0.000s)
[140.737243] [072/165] (871s left) kms_addfb_basic (basic-x-tiled-legacy)
[141.004875] Starting subtest: basic-x-tiled-legacy
[141.032896] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[141.191449] [073/165] (870s left) kms_addfb_basic (basic-y-tiled-legacy)
[141.460691] Starting subtest: basic-y-tiled-legacy
[141.487926] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[141.644393] [074/165] (870s left) kms_addfb_basic (bo-too-small)
[141.960386] Starting subtest: bo-too-small
[141.982353] Subtest bo-too-small: SUCCESS (0.001s)
[142.075161] [075/165] (870s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[142.392671] Starting subtest: bo-too-small-due-to-tiling
[142.413475] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[142.511612] [076/165] (869s left) kms_addfb_basic (clobberred-modifier)
[142.743800] Starting subtest: clobberred-modifier
[142.765304] Subtest clobberred-modifier: SUCCESS (0.000s)
[142.941591] [077/165] (869s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[143.172456] Starting subtest: framebuffer-vs-set-tiling
[143.192050] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[143.360731] [078/165] (869s left) kms_addfb_basic (invalid-get-prop)
[143.593345] Starting subtest: invalid-get-prop
[143.614083] Subtest invalid-get-prop: SUCCESS (0.000s)
[143.793830] [079/165] (868s left) kms_addfb_basic (invalid-get-prop-any)
[144.022194] Starting subtest: invalid-get-prop-any
[144.044251] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[144.226991] [080/165] (868s left) kms_addfb_basic (invalid-set-prop)
[144.455970] Starting subtest: invalid-set-prop
[144.476792] Subtest invalid-set-prop: SUCCESS (0.000s)
[144.657893] [081/165] (868s left) kms_addfb_basic (invalid-set-prop-any)
[144.890370] Starting subtest: invalid-set-prop-any
[144.911334] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[145.076579] [082/165] (867s left) kms_addfb_basic (no-handle)
[145.306809] Starting subtest: no-handle
[145.328585] Subtest no-handle: SUCCESS (0.000s)
[145.507720] [083/165] (867s left) kms_addfb_basic (size-max)
[145.828346] Starting subtest: size-max
[145.849461] Subtest size-max: SUCCESS (0.000s)
[145.943450] [084/165] (867s left) kms_addfb_basic (small-bo)
[146.261544] Starting subtest: small-bo
[146.282356] Subtest small-bo: SUCCESS (0.000s)
[146.373777] [085/165] (866s left) kms_addfb_basic (tile-pitch-mismatch)
[146.607401] Starting subtest: tile-pitch-mismatch
[146.627681] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[146.807592] [086/165] (866s left) kms_addfb_basic (too-high)
[147.124842] Starting subtest: too-high
[147.144830] Subtest too-high: SUCCESS (0.002s)
[147.238884] [087/165] (865s left) kms_addfb_basic (too-wide)
[147.558617] Starting subtest: too-wide
[147.580789] Subtest too-wide: SUCCESS (0.000s)
[147.669910] [088/165] (865s left) kms_addfb_basic (unused-handle)
[147.900295] Starting subtest: unused-handle
[147.919996] Subtest unused-handle: SUCCESS (0.000s)
[148.093929] [089/165] (865s left) kms_addfb_basic (unused-modifier)
[148.321164] Starting subtest: unused-modifier
[148.341832] Subtest unused-modifier: SUCCESS (0.000s)
[148.528158] [090/165] (864s left) kms_addfb_basic (unused-offsets)
[148.768898] Starting subtest: unused-offsets
[148.792211] Subtest unused-offsets: SUCCESS (0.000s)
[148.964066] [091/165] (864s left) kms_addfb_basic (unused-pitches)
[149.212375] Starting subtest: unused-pitches
[149.238199] Subtest unused-pitches: SUCCESS (0.000s)
[149.837514] [092/165] (864s left) kms_busy (basic)
[150.154770] Starting subtest: basic
[150.177312] Starting dynamic subtest: flip
[151.127242] Dynamic subtest flip: SUCCESS (0.962s)
[151.193365] Starting dynamic subtest: modeset
[152.510295] Dynamic subtest modeset: SUCCESS (1.403s)
[152.532929] Subtest basic: SUCCESS (2.369s)
[152.905678] [093/165] (861s left) kms_prop_blob (basic)
[153.156213] Starting subtest: basic
[153.176174] Subtest basic: SUCCESS (0.000s)
[153.270353] [094/165] (861s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[153.592572] Starting subtest: basic-busy-flip-before-cursor-atomic
[153.634968] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[153.728248] [095/165] (860s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[154.024776] Starting subtest: basic-busy-flip-before-cursor-legacy
[154.065731] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[154.160248] [096/165] (860s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[154.481282] Starting subtest: basic-flip-after-cursor-atomic
[155.536579] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.054s)
[155.886749] [097/165] (858s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[156.187246] Starting subtest: basic-flip-after-cursor-legacy
[157.250100] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.066s)
[157.604748] [098/165] (857s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[157.921381] Starting subtest: basic-flip-after-cursor-varying-size
[158.991247] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.077s)
[159.355448] [099/165] (855s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[159.678377] Starting subtest: basic-flip-before-cursor-atomic
[160.750079] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.064s)
[161.115290] [100/165] (853s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[161.450315] Starting subtest: basic-flip-before-cursor-legacy
[162.485291] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.058s)
[162.844944] [101/165] (852s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[163.144030] Starting subtest: basic-flip-before-cursor-varying-size
[164.230791] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.077s)
[164.574494] [102/165] (850s left) kms_dsc (dsc-basic)
[164.903800] Subtest dsc-basic: SKIP (0.000s)
[164.998723] [103/165] (850s left) kms_flip (basic-flip-vs-dpms)
[165.329659] Starting subtest: basic-flip-vs-dpms
[165.357829] Starting dynamic subtest: A-DP1
[166.544205] Dynamic subtest A-DP1: SUCCESS (1.240s)
[166.582599] Starting dynamic subtest: B-DP1
[167.680994] Dynamic subtest B-DP1: SUCCESS (1.135s)
[167.720721] Starting dynamic subtest: C-DP1
[168.820539] Dynamic subtest C-DP1: SUCCESS (1.141s)
[168.840869] Subtest basic-flip-vs-dpms: SUCCESS (3.525s)
[169.245693] [104/165] (845s left) kms_flip (basic-flip-vs-modeset)
[169.563438] Starting subtest: basic-flip-vs-modeset
[169.584839] Starting dynamic subtest: A-DP1
[170.821808] Dynamic subtest A-DP1: SUCCESS (1.280s)
[170.862780] Starting dynamic subtest: B-DP1
[171.977034] Dynamic subtest B-DP1: SUCCESS (1.139s)
[172.015508] Starting dynamic subtest: C-DP1
[173.106554] Dynamic subtest C-DP1: SUCCESS (1.139s)
[173.128564] Subtest basic-flip-vs-modeset: SUCCESS (3.568s)
[173.496403] [105/165] (841s left) kms_flip (basic-flip-vs-wf_vblank)
[173.818500] Starting subtest: basic-flip-vs-wf_vblank
[173.838288] Starting dynamic subtest: A-DP1
[175.259460] Dynamic subtest A-DP1: SUCCESS (1.469s)
[175.301175] Starting dynamic subtest: B-DP1
[176.655424] Dynamic subtest B-DP1: SUCCESS (1.393s)
[176.696364] Starting dynamic subtest: C-DP1
[178.056092] Dynamic subtest C-DP1: SUCCESS (1.396s)
[178.075944] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.267s)
[178.526474] [106/165] (836s left) kms_flip (basic-plain-flip)
[178.873218] Starting subtest: basic-plain-flip
[178.899380] Starting dynamic subtest: A-DP1
[179.991529] Dynamic subtest A-DP1: SUCCESS (1.159s)
[180.030838] Starting dynamic subtest: B-DP1
[181.104217] Dynamic subtest B-DP1: SUCCESS (1.109s)
[181.144180] Starting dynamic subtest: C-DP1
[182.213077] Dynamic subtest C-DP1: SUCCESS (1.108s)
[182.234133] Subtest basic-plain-flip: SUCCESS (3.386s)
[182.673275] [107/165] (832s left) kms_force_connector_basic (force-connector-state)
[182.937464] Subtest force-connector-state: SKIP (0.000s)
[183.034305] [108/165] (832s left) kms_force_connector_basic (force-edid)
[183.278527] Subtest force-edid: SKIP (0.000s)
[183.372827] [109/165] (832s left) kms_force_connector_basic (force-load-detect)
[183.615266] Subtest force-load-detect: SKIP (0.000s)
[183.709984] [110/165] (832s left) kms_force_connector_basic (prune-stale-modes)
[183.958402] Subtest prune-stale-modes: SKIP (0.000s)
[184.055440] [111/165] (831s left) kms_frontbuffer_tracking (basic)
[184.450420] Starting subtest: basic
[187.453827] Subtest basic: SUCCESS (3.077s)
[187.603168] [112/165] (828s left) kms_hdmi_inject (inject-audio)
[187.865742] Subtest inject-audio: SKIP (0.000s)
[187.961097] [113/165] (828s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[188.293916] Starting subtest: compare-crc-sanitycheck-xr24
[188.315693] Starting dynamic subtest: pipe-A-DP-1
[188.715658] Dynamic subtest pipe-A-DP-1: SUCCESS (0.421s)
[188.755143] Starting dynamic subtest: pipe-B-DP-1
[189.323560] Dynamic subtest pipe-B-DP-1: SUCCESS (0.603s)
[189.364042] Starting dynamic subtest: pipe-C-DP-1
[189.942130] Dynamic subtest pipe-C-DP-1: SUCCESS (0.612s)
[189.969924] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.650s)
[190.303563] [114/165] (825s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[190.640673] Starting subtest: compare-crc-sanitycheck-nv12
[190.660151] Starting dynamic subtest: pipe-A-DP-1
[190.701543] Dynamic subtest pipe-A-DP-1: SKIP (0.001s)
[190.740913] Starting dynamic subtest: pipe-B-DP-1
[190.781249] Dynamic subtest pipe-B-DP-1: SKIP (0.001s)
[190.821313] Starting dynamic subtest: pipe-C-DP-1
[190.864221] Dynamic subtest pipe-C-DP-1: SKIP (0.001s)
[190.907311] Subtest compare-crc-sanitycheck-nv12: SKIP (0.016s)
[191.003266] [115/165] (825s left) kms_pipe_crc_basic (hang-read-crc)
[191.329741] Starting subtest: hang-read-crc
[191.349956] Starting dynamic subtest: pipe-A-DP-1
[192.769542] Dynamic subtest pipe-A-DP-1: SUCCESS (1.438s)
[192.807842] Starting dynamic subtest: pipe-B-DP-1
[194.406177] Dynamic subtest pipe-B-DP-1: SUCCESS (1.635s)
[194.459552] Starting dynamic subtest: pipe-C-DP-1
[196.044250] Dynamic subtest pipe-C-DP-1: SUCCESS (1.631s)
[196.065985] Subtest hang-read-crc: SUCCESS (4.717s)
[196.376087] [116/165] (819s left) kms_pipe_crc_basic (nonblocking-crc)
[196.699182] Starting subtest: nonblocking-crc
[196.720601] Starting dynamic subtest: pipe-A-DP-1
[197.264580] Dynamic subtest pipe-A-DP-1: SUCCESS (0.566s)
[197.306904] Starting dynamic subtest: pipe-B-DP-1
[198.035867] Dynamic subtest pipe-B-DP-1: SUCCESS (0.762s)
[198.073688] Starting dynamic subtest: pipe-C-DP-1
[198.803323] Dynamic subtest pipe-C-DP-1: SUCCESS (0.752s)
[198.830358] Subtest nonblocking-crc: SUCCESS (2.093s)
[199.157914] [117/165] (817s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[199.502920] Starting subtest: nonblocking-crc-frame-sequence
[199.535787] Starting dynamic subtest: pipe-A-DP-1
[200.077472] Dynamic subtest pipe-A-DP-1: SUCCESS (0.578s)
[200.116547] Starting dynamic subtest: pipe-B-DP-1
[200.816840] Dynamic subtest pipe-B-DP-1: SUCCESS (0.757s)
[200.859454] Starting dynamic subtest: pipe-C-DP-1
[201.612399] Dynamic subtest pipe-C-DP-1: SUCCESS (0.770s)
[201.631624] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.119s)
[201.954525] [118/165] (814s left) kms_pipe_crc_basic (read-crc)
[202.280868] Starting subtest: read-crc
[202.301929] Starting dynamic subtest: pipe-A-DP-1
[202.795909] Dynamic subtest pipe-A-DP-1: SUCCESS (0.515s)
[202.848372] Starting dynamic subtest: pipe-B-DP-1
[203.456250] Dynamic subtest pipe-B-DP-1: SUCCESS (0.674s)
[203.495981] Starting dynamic subtest: pipe-C-DP-1
[204.145570] Dynamic subtest pipe-C-DP-1: SUCCESS (0.683s)
[204.166897] Subtest read-crc: SUCCESS (1.887s)
[204.509504] [119/165] (812s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[204.839630] Starting subtest: read-crc-frame-sequence
[204.861222] Starting dynamic subtest: pipe-A-DP-1
[205.364368] Dynamic subtest pipe-A-DP-1: SUCCESS (0.525s)
[205.419646] Starting dynamic subtest: pipe-B-DP-1
[206.028575] Dynamic subtest pipe-B-DP-1: SUCCESS (0.678s)
[206.077440] Starting dynamic subtest: pipe-C-DP-1
[206.721105] Dynamic subtest pipe-C-DP-1: SUCCESS (0.686s)
[206.742604] Subtest read-crc-frame-sequence: SUCCESS (1.903s)
[207.081698] [120/165] (809s left) kms_pm_backlight (basic-brightness)
[207.427475] Subtest basic-brightness: SKIP (0.000s)
[207.546276] [121/165] (809s left) kms_psr (primary_page_flip)
[207.845629] Subtest primary_page_flip: SKIP (0.000s)
[207.965756] [122/165] (808s left) kms_psr (cursor_plane_move)
[208.246700] Subtest cursor_plane_move: SKIP (0.000s)
[208.360054] [123/165] (808s left) kms_psr (sprite_plane_onoff)
[208.633544] Subtest sprite_plane_onoff: SKIP (0.000s)
[208.730081] [124/165] (808s left) kms_psr (primary_mmap_gtt)
[208.983943] Subtest primary_mmap_gtt: SKIP (0.000s)
[209.077104] [125/165] (808s left) kms_setmode (basic-clone-single-crtc)
[209.311157] Starting subtest: basic-clone-single-crtc
[209.376271] Subtest basic-clone-single-crtc: SKIP (0.000s)
[209.472184] [126/165] (807s left) i915_pm_rpm (basic-pci-d3-state)
[211.350803] Starting subtest: basic-pci-d3-state
[212.044347] Subtest basic-pci-d3-state: SUCCESS (0.682s)
[212.277484] [127/165] (805s left) i915_pm_rpm (basic-rte)
[212.490390] Starting subtest: basic-rte
[214.875534] Subtest basic-rte: SUCCESS (2.391s)
[215.845722] [128/165] (801s left) i915_pm_rps (basic-api)
[216.091447] Starting subtest: basic-api
[216.113746] Subtest basic-api: SUCCESS (0.008s)
[216.231593] [129/165] (801s left) prime_self_import (basic-llseek-bad)
[216.449047] Starting subtest: basic-llseek-bad
[216.492997] Subtest basic-llseek-bad: SUCCESS (0.004s)
[216.587197] [130/165] (801s left) prime_self_import (basic-llseek-size)
[216.786742] Starting subtest: basic-llseek-size
[216.829671] Subtest basic-llseek-size: SUCCESS (0.007s)
[216.926203] [131/165] (800s left) prime_self_import (basic-with_fd_dup)
[217.133769] Starting subtest: basic-with_fd_dup
[217.175883] Subtest basic-with_fd_dup: SUCCESS (0.007s)
[217.267967] [132/165] (800s left) prime_self_import (basic-with_one_bo)
[217.483935] Starting subtest: basic-with_one_bo
[217.526539] Subtest basic-with_one_bo: SUCCESS (0.007s)
[217.622434] [133/165] (800s left) prime_self_import (basic-with_one_bo_two_files)
[217.863476] Starting subtest: basic-with_one_bo_two_files
[217.922207] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[218.035132] [134/165] (800s left) prime_self_import (basic-with_two_bos)
[218.260977] Starting subtest: basic-with_two_bos
[218.318303] Subtest basic-with_two_bos: SUCCESS (0.006s)
[218.438699] [135/165] (799s left) prime_vgem (basic-fence-flip)
[218.710044] Starting subtest: basic-fence-flip
[219.286297] Subtest basic-fence-flip: SUCCESS (0.603s)
[219.432964] [136/165] (798s left) prime_vgem (basic-fence-mmap)
[219.690860] Starting subtest: basic-fence-mmap
[219.737946] Subtest basic-fence-mmap: SUCCESS (0.073s)
[219.863957] [137/165] (798s left) prime_vgem (basic-fence-read)
[220.120288] Starting subtest: basic-fence-read
[220.198504] Subtest basic-fence-read: SUCCESS (0.112s)
[220.326899] [138/165] (798s left) prime_vgem (basic-gtt)
[220.563072] Starting subtest: basic-gtt
[220.582740] Subtest basic-gtt: SUCCESS (0.036s)
[220.698704] [139/165] (797s left) prime_vgem (basic-read)
[220.952048] Starting subtest: basic-read
[220.992852] Subtest basic-read: SUCCESS (0.057s)
[221.133211] [140/165] (797s left) prime_vgem (basic-write)
[221.386907] Starting subtest: basic-write
[221.409377] Subtest basic-write: SUCCESS (0.066s)
[221.528679] [141/165] (797s left) vgem_basic (setversion)
[221.756384] Starting subtest: setversion
[221.797532] Subtest setversion: SUCCESS (0.000s)
[221.921099] [142/165] (797s left) vgem_basic (create)
[222.157797] Starting subtest: create
[222.180527] Subtest create: SUCCESS (0.000s)
[222.276416] [143/165] (796s left) vgem_basic (debugfs)
[222.506945] Starting subtest: debugfs
[222.527507] Subtest debugfs: SUCCESS (0.001s)
[222.626911] [144/165] (796s left) vgem_basic (dmabuf-export)
[222.839291] Starting subtest: dmabuf-export
[222.884349] Subtest dmabuf-export: SUCCESS (0.004s)
[222.980779] [145/165] (796s left) vgem_basic (dmabuf-fence)
[223.213207] Starting subtest: dmabuf-fence
[223.233434] Subtest dmabuf-fence: SUCCESS (0.001s)
[223.332872] [146/165] (796s left) vgem_basic (dmabuf-fence-before)
[223.568539] Starting subtest: dmabuf-fence-before
[223.589444] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[223.688675] [147/165] (795s left) vgem_basic (dmabuf-mmap)
[223.918060] Starting subtest: dmabuf-mmap
[223.941041] Subtest dmabuf-mmap: SUCCESS (0.044s)
[224.041807] [148/165] (795s left) vgem_basic (mmap)
[224.275274] Starting subtest: mmap
[224.295441] Subtest mmap: SUCCESS (0.027s)
[224.392285] [149/165] (795s left) vgem_basic (second-client)
[224.603225] Starting subtest: second-client
[224.645819] Subtest second-client: SUCCESS (0.032s)
[224.740890] [150/165] (795s left) vgem_basic (sysfs)
[224.983232] Starting subtest: sysfs
[225.003466] Subtest sysfs: SUCCESS (0.002s)
[225.100426] [151/165] (794s left) core_hotunplug (unbind-rebind)
[225.434158] Starting subtest: unbind-rebind
[229.325374] Subtest unbind-rebind: SUCCESS (3.887s)
[229.421823] [152/165] (790s left) vgem_basic (unload)
[229.644647] Starting subtest: unload
[258.892240] Subtest unload: SUCCESS (29.072s)
[258.988803] [153/165] (761s left) i915_module_load (reload)
[259.207201] Starting subtest: reload
[262.922419] Subtest reload: SUCCESS (3.730s)
[263.055398] [154/165] (757s left) gem_lmem_swapping (basic)
[263.340205] Subtest basic: SKIP (0.000s)
[263.435147] [155/165] (756s left) gem_lmem_swapping (parallel-random-engines)
[263.688549] Subtest parallel-random-engines: SKIP (0.000s)
[263.784815] [156/165] (756s left) gem_lmem_swapping (random-engines)
[264.045981] Subtest random-engines: SKIP (0.000s)
[264.140479] [157/165] (756s left) gem_lmem_swapping (verify-random)
[264.395250] Subtest verify-random: SKIP (0.000s)
[264.489645] [158/165] (756s left) i915_pm_rpm (module-reload)
[266.657586] Starting subtest: module-reload
[277.441386] Subtest module-reload: SUCCESS (10.787s)
[277.535991] [159/165] (743s left) i915_selftest (live)
[277.776721] Starting subtest: live
[277.797557] Starting dynamic subtest: sanitycheck
[279.226991] Dynamic subtest sanitycheck: SUCCESS (1.446s)
[279.263473] Starting dynamic subtest: uncore
[280.870852] Dynamic subtest uncore: SUCCESS (1.642s)
[280.908355] Starting dynamic subtest: workarounds
[282.620757] Dynamic subtest workarounds: SUCCESS (1.745s)
[282.666758] Starting dynamic subtest: gt_engines
[284.785767] Dynamic subtest gt_engines: SUCCESS (2.161s)
[284.831328] Starting dynamic subtest: gt_timelines
[308.216806] Dynamic subtest gt_timelines: SUCCESS (23.425s)
[308.252248] Starting dynamic subtest: gt_contexts
[309.855369] Dynamic subtest gt_contexts: SUCCESS (1.634s)
[309.890093] Starting dynamic subtest: gt_lrc
[314.234152] Dynamic subtest gt_lrc: SUCCESS (4.375s)
[314.269479] Starting dynamic subtest: gt_mocs
[315.973824] Dynamic subtest gt_mocs: SUCCESS (1.737s)
[316.008693] Starting dynamic subtest: gt_pm
[322.983432] Dynamic subtest gt_pm: SUCCESS (7.004s)
[323.032264] Starting dynamic subtest: gt_heartbeat
[324.752197] Dynamic subtest gt_heartbeat: SUCCESS (1.765s)
[324.801093] Starting dynamic subtest: gt_tlb
[327.266681] Dynamic subtest gt_tlb: SUCCESS (2.508s)
[327.317141] Starting dynamic subtest: requests
[335.232190] Dynamic subtest requests: SUCCESS (7.963s)
[335.268782] Starting dynamic subtest: migrate
[340.042380] Dynamic subtest migrate: SUCCESS (4.809s)
[340.086095] Starting dynamic subtest: active
[341.539219] Dynamic subtest active: SUCCESS (1.493s)
[341.575442] Starting dynamic subtest: objects
[346.193348] Dynamic subtest objects: SUCCESS (4.650s)
[346.239632] Starting dynamic subtest: mman
[355.179331] Dynamic subtest mman: SUCCESS (8.980s)
[355.216139] Starting dynamic subtest: dmabuf
[356.814149] Dynamic subtest dmabuf: SUCCESS (1.632s)
[356.861896] Starting dynamic subtest: vma
[358.525535] Dynamic subtest vma: SUCCESS (1.704s)
[358.573117] Starting dynamic subtest: coherency
[362.835194] Dynamic subtest coherency: SUCCESS (4.308s)
[362.884540] Starting dynamic subtest: gtt
[372.111529] Dynamic subtest gtt: SUCCESS (9.274s)
[372.160475] Starting dynamic subtest: gem
[375.023594] Dynamic subtest gem: SUCCESS (2.910s)
[375.071346] Starting dynamic subtest: evict
[381.305047] Dynamic subtest evict: SUCCESS (6.277s)
[381.340091] Starting dynamic subtest: hugepages
[389.351116] Dynamic subtest hugepages: SUCCESS (8.041s)
[389.387704] Starting dynamic subtest: gem_contexts
[414.249503] Dynamic subtest gem_contexts: SUCCESS (24.725s)
[414.287066] Starting dynamic subtest: client
[415.645050] Dynamic subtest client: SUCCESS (1.561s)
[415.694537] Starting dynamic subtest: gem_migrate
[417.152267] Dynamic subtest gem_migrate: SUCCESS (1.505s)
[417.190797] Starting dynamic subtest: reset
[430.692683] Dynamic subtest reset: SUCCESS (13.536s)
[430.729072] Starting dynamic subtest: memory_region
[432.390516] Dynamic subtest memory_region: SUCCESS (1.695s)
[432.440569] Starting dynamic subtest: hangcheck
[457.127265] Dynamic subtest hangcheck: SUCCESS (24.734s)
[457.164062] Starting dynamic subtest: execlists
[469.503656] Dynamic subtest execlists: SUCCESS (12.371s)
[469.539745] Starting dynamic subtest: ring_submission
[470.992848] Dynamic subtest ring_submission: SUCCESS (1.484s)
[471.039795] Starting dynamic subtest: perf
[472.680153] Dynamic subtest perf: SUCCESS (1.684s)
[472.718137] Starting dynamic subtest: slpc
[474.170582] Dynamic subtest slpc: SUCCESS (1.490s)
[474.209322] Starting dynamic subtest: guc
[475.852558] Dynamic subtest guc: SUCCESS (1.679s)
[475.887960] Starting dynamic subtest: guc_multi_lrc
[477.394738] Dynamic subtest guc_multi_lrc: SUCCESS (1.532s)
[477.446727] Starting dynamic subtest: guc_hang
[479.049983] Dynamic subtest guc_hang: SUCCESS (1.657s)
[479.088100] Starting dynamic subtest: late_gt_pm
[480.794638] Dynamic subtest late_gt_pm: SUCCESS (1.739s)
[480.817101] Subtest live: SUCCESS (203.017s)
[480.909932] [160/165] (539s left) dmabuf (all-tests)
[481.122521] Starting subtest: all-tests
[481.142876] Starting dynamic subtest: sanitycheck
[481.210703] Dynamic subtest sanitycheck: SUCCESS (0.085s)
[481.247584] Starting dynamic subtest: dma_fence
[481.408208] Dynamic subtest dma_fence: SUCCESS (0.195s)
[481.443929] Starting dynamic subtest: dma_fence_chain
[504.762068] Dynamic subtest dma_fence_chain: SUCCESS (23.349s)
[504.803189] Starting dynamic subtest: dma_fence_unwrap
[504.844782] Dynamic subtest dma_fence_unwrap: SUCCESS (0.075s)
[504.887664] Starting dynamic subtest: dma_resv
[504.933381] Dynamic subtest dma_resv: SUCCESS (0.071s)
[504.953822] Subtest all-tests: SUCCESS (23.791s)
[505.047606] [161/165] (515s left) i915_suspend (basic-s2idle-without-i915)
[505.267531] Starting subtest: basic-s2idle-without-i915
[525.273406] Subtest basic-s2idle-without-i915: SUCCESS (5.014s)
[528.954436] [162/165] (510s left) i915_suspend (basic-s3-without-i915)
[529.169365] Starting subtest: basic-s3-without-i915
[548.153261] Subtest basic-s3-without-i915: SUCCESS (3.386s)
[550.821103] [163/165] (506s left) gem_exec_suspend (basic-s0)
[551.074733] Starting subtest: basic-S0
[551.097044] Starting dynamic subtest: smem
[572.874927] Dynamic subtest smem: SUCCESS (5.654s)
[572.896099] Subtest basic-S0: SUCCESS (5.657s)
[576.269115] [164/165] (500s left) gem_exec_suspend (basic-s3)
[576.504564] Starting subtest: basic-S3
[576.526531] Starting dynamic subtest: smem
[597.320682] Dynamic subtest smem: SUCCESS (5.717s)
[597.346035] Subtest basic-S3: SUCCESS (5.720s)
[601.714085] [165/165] (494s left) kms_pipe_crc_basic (suspend-read-crc)
[602.036064] Starting subtest: suspend-read-crc
[602.057265] Starting dynamic subtest: pipe-A-DP-1
[620.149677] Dynamic subtest pipe-A-DP-1: SUCCESS (2.453s)
[620.195248] Starting dynamic subtest: pipe-B-DP-1
[638.141010] Dynamic subtest pipe-B-DP-1: SUCCESS (2.419s)
[638.199899] Starting dynamic subtest: pipe-C-DP-1
[656.150122] Dynamic subtest pipe-C-DP-1: SUCCESS (2.576s)
[656.170089] Subtest suspend-read-crc: SUCCESS (7.463s)
[661.588805] Closing watchdogs
Done.