[65.001373] Initializing watchdogs
[65.001724]   /dev/watchdog0
[65.019839] [001/165] (960s left) i915_module_load (load)
[65.281177] Starting subtest: load
[68.793054] Subtest load: SUCCESS (3.511s)
[68.928515] [002/165] (956s left) core_auth (basic-auth)
[69.662136] Starting subtest: basic-auth
[69.668103] Subtest basic-auth: SUCCESS (0.011s)
[69.827130] [003/165] (955s left) debugfs_test (read_all_entries)
[70.092256] Starting subtest: read_all_entries
[70.230854] Subtest read_all_entries: SUCCESS (0.140s)
[70.776673] [004/165] (955s left) debugfs_test (basic-hwmon)
[71.041868] Starting subtest: basic-hwmon
[71.046122] Subtest basic-hwmon: SKIP (0.000s)
[71.578762] [005/165] (954s left) fbdev (eof)
[71.827845] Starting subtest: eof
[71.830189] Subtest eof: SUCCESS (0.003s)
[71.923744] [006/165] (953s left) fbdev (info)
[72.139742] Starting subtest: info
[72.141344] Subtest info: SUCCESS (0.000s)
[72.241633] [007/165] (953s left) fbdev (nullptr)
[72.474332] Starting subtest: nullptr
[72.476889] Subtest nullptr: SUCCESS (0.000s)
[72.561180] [008/165] (953s left) fbdev (read)
[72.795426] Starting subtest: read
[74.878404] Subtest read: SUCCESS (2.076s)
[74.958638] [009/165] (951s left) fbdev (write)
[75.192612] Starting subtest: write
[76.259493] Subtest write: SUCCESS (1.059s)
[76.341291] [010/165] (949s left) gem_basic (bad-close)
[76.571644] Starting subtest: bad-close
[76.575692] Subtest bad-close: SUCCESS (0.000s)
[76.686821] [011/165] (949s left) gem_basic (create-close)
[76.917316] Starting subtest: create-close
[76.922763] Subtest create-close: SUCCESS (0.000s)
[77.024344] [012/165] (949s left) gem_basic (create-fd-close)
[77.259911] Starting subtest: create-fd-close
[77.265506] Subtest create-fd-close: SUCCESS (0.001s)
[77.360251] [013/165] (948s left) gem_busy (busy@all-engines)
[77.631960] Starting subtest: busy
[77.634661] Starting dynamic subtest: all-engines
[77.796607] Dynamic subtest all-engines: SUCCESS (0.162s)
[77.798464] Subtest busy: SUCCESS (0.165s)
[78.197444] [014/165] (948s left) gem_close_race (basic-process)
[78.484302] Starting subtest: basic-process
[78.623633] Subtest basic-process: SUCCESS (0.140s)
[78.865635] [015/165] (947s left) gem_close_race (basic-threads)
[79.148368] Starting subtest: basic-threads
[80.365515] Subtest basic-threads: SUCCESS (1.214s)
[80.593868] [016/165] (945s left) gem_ctx_create (basic)
[80.867114] Starting subtest: basic
[80.870132] Subtest basic: SUCCESS (0.000s)
[81.094181] [017/165] (945s left) gem_ctx_create (basic-files)
[81.367851] Starting subtest: basic-files
[83.428515] Subtest basic-files: SUCCESS (2.061s)
[83.656919] [018/165] (942s left) gem_ctx_exec (basic)
[83.894337] Starting subtest: basic
[83.911695] Subtest basic: SUCCESS (0.011s)
[84.032630] [019/165] (942s left) gem_exec_basic (basic)
[84.288432] Starting subtest: basic
[84.292977] Starting dynamic subtest: rcs0-smem
[84.294658] Dynamic subtest rcs0-smem: SUCCESS (0.004s)
[84.321808] Starting dynamic subtest: bcs0-smem
[84.323301] Dynamic subtest bcs0-smem: SUCCESS (0.003s)
[84.340598] Starting dynamic subtest: vcs0-smem
[84.343876] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[84.361143] Starting dynamic subtest: vecs0-smem
[84.362716] Dynamic subtest vecs0-smem: SUCCESS (0.003s)
[84.364228] Subtest basic: SUCCESS (0.017s)
[84.544316] [020/165] (942s left) gem_exec_create (basic)
[84.809457] Starting subtest: basic
[84.811260] Starting dynamic subtest: smem
[86.888106] Dynamic subtest smem: SUCCESS (2.079s)
[86.890971] Subtest basic: SUCCESS (2.080s)
[87.111308] [021/165] (939s left) gem_exec_fence (basic-busy)
[87.544409] Starting subtest: basic-busy
[87.546144] Starting dynamic subtest: rcs0
[87.567943] Dynamic subtest rcs0: SUCCESS (0.030s)
[87.605787] Starting dynamic subtest: bcs0
[87.609102] Dynamic subtest bcs0: SUCCESS (0.029s)
[87.635535] Starting dynamic subtest: vcs0
[87.640258] Dynamic subtest vcs0: SUCCESS (0.029s)
[87.661370] Starting dynamic subtest: vecs0
[87.664179] Dynamic subtest vecs0: SUCCESS (0.020s)
[87.665642] Subtest basic-busy: SUCCESS (0.111s)
[88.430365] [022/165] (938s left) gem_exec_fence (basic-wait)
[88.862568] Starting subtest: basic-wait
[88.866132] Starting dynamic subtest: rcs0
[88.879620] Dynamic subtest rcs0: SUCCESS (0.022s)
[88.913560] Starting dynamic subtest: bcs0
[88.916831] Dynamic subtest bcs0: SUCCESS (0.028s)
[88.954862] Starting dynamic subtest: vcs0
[88.956381] Dynamic subtest vcs0: SUCCESS (0.025s)
[88.977728] Starting dynamic subtest: vecs0
[88.979399] Dynamic subtest vecs0: SUCCESS (0.029s)
[88.980837] Subtest basic-wait: SUCCESS (0.108s)
[89.617295] [023/165] (937s left) gem_exec_fence (basic-await)
[90.046806] Starting subtest: basic-await
[90.049434] Starting dynamic subtest: rcs0
[90.237334] Dynamic subtest rcs0: SUCCESS (0.187s)
[90.259348] Starting dynamic subtest: bcs0
[90.408638] Dynamic subtest bcs0: SUCCESS (0.172s)
[90.427839] Starting dynamic subtest: vcs0
[90.594539] Dynamic subtest vcs0: SUCCESS (0.183s)
[90.614182] Starting dynamic subtest: vecs0
[90.774769] Dynamic subtest vecs0: SUCCESS (0.181s)
[90.777550] Subtest basic-await: SUCCESS (0.729s)
[91.429306] [024/165] (935s left) gem_exec_fence (nb-await)
[91.857690] Starting subtest: nb-await
[91.860709] Starting dynamic subtest: rcs0
[91.946569] Dynamic subtest rcs0: SUCCESS (0.088s)
[91.975737] Starting dynamic subtest: bcs0
[92.020600] Dynamic subtest bcs0: SUCCESS (0.075s)
[92.043549] Starting dynamic subtest: vcs0
[92.108387] Dynamic subtest vcs0: SUCCESS (0.084s)
[92.131183] Starting dynamic subtest: vecs0
[92.187745] Dynamic subtest vecs0: SUCCESS (0.081s)
[92.189703] Subtest nb-await: SUCCESS (0.332s)
[92.846293] [025/165] (934s left) gem_exec_gttfill (basic)
[93.114498] Starting subtest: basic
[94.979128] Subtest basic: SKIP (1.852s)
[95.232149] [026/165] (931s left) gem_exec_parallel (engines)
[95.664051] Starting subtest: engines
[95.666224] Starting dynamic subtest: basic
[101.190383] Dynamic subtest basic: SUCCESS (5.522s)
[101.222160] Starting dynamic subtest: contexts
[109.958354] Dynamic subtest contexts: SUCCESS (8.767s)
[109.987738] Starting dynamic subtest: fds
[122.719727] Dynamic subtest fds: SUCCESS (12.760s)
[122.743362] Starting dynamic subtest: userptr
[128.308299] Dynamic subtest userptr: SUCCESS (5.590s)
[128.310095] Subtest engines: SUCCESS (32.646s)
[128.589348] [027/165] (898s left) gem_exec_store (basic)
[128.868970] Starting subtest: basic
[128.934616] Subtest basic: SUCCESS (0.071s)
[129.166111] [028/165] (897s left) gem_flink_basic (bad-flink)
[129.398682] Starting subtest: bad-flink
[129.402458] Subtest bad-flink: SUCCESS (0.000s)
[129.497218] [029/165] (897s left) gem_flink_basic (bad-open)
[129.720457] Starting subtest: bad-open
[129.723870] Subtest bad-open: SUCCESS (0.000s)
[129.829426] [030/165] (897s left) gem_flink_basic (basic)
[130.063372] Starting subtest: basic
[130.067090] Subtest basic: SUCCESS (0.000s)
[130.179695] [031/165] (897s left) gem_flink_basic (double-flink)
[130.401901] Starting subtest: double-flink
[130.403993] Subtest double-flink: SUCCESS (0.001s)
[130.510884] [032/165] (896s left) gem_flink_basic (flink-lifetime)
[130.733839] Starting subtest: flink-lifetime
[130.739855] Subtest flink-lifetime: SUCCESS (0.006s)
[130.846197] [033/165] (896s left) gem_huc_copy (huc-copy)
[131.091854] Subtest huc-copy: SKIP (0.000s)
[131.177738] [034/165] (896s left) gem_linear_blits (basic)
[131.737076] Subtest basic: SKIP (0.000s)
[131.860581] [035/165] (895s left) gem_mmap (basic)
[132.249928] Starting subtest: basic
[132.256219] Subtest basic: SUCCESS (0.001s)
[132.364171] [036/165] (895s left) gem_mmap_gtt (basic)
[132.594389] Starting subtest: basic
[132.596034] Subtest basic: SUCCESS (0.004s)
[132.702940] [037/165] (894s left) gem_render_linear_blits (basic)
[132.949292] Starting subtest: basic
[133.061134] Subtest basic: SUCCESS (0.106s)
[133.135516] [038/165] (894s left) gem_render_tiled_blits (basic)
[133.379632] Starting subtest: basic
[133.532155] Subtest basic: SUCCESS (0.146s)
[133.601927] [039/165] (894s left) gem_ringfill (basic-all)
[134.021130] Starting subtest: basic-all
[135.379740] Subtest basic-all: SUCCESS (1.355s)
[135.484537] [040/165] (892s left) gem_softpin (allocator-basic)
[135.734796] Starting subtest: allocator-basic
[136.035863] Subtest allocator-basic: SUCCESS (0.300s)
[136.203261] [041/165] (891s left) gem_softpin (allocator-basic-reserve)
[136.445378] Starting subtest: allocator-basic-reserve
[136.745134] Subtest allocator-basic-reserve: SUCCESS (0.292s)
[136.918918] [042/165] (890s left) gem_softpin (safe-alignment)
[137.166050] Starting subtest: safe-alignment
[137.209634] Subtest safe-alignment: SUCCESS (0.043s)
[137.325572] [043/165] (890s left) gem_sync (basic-all)
[137.603622] Starting subtest: basic-all
[140.295930] Subtest basic-all: SUCCESS (2.690s)
[140.530288] [044/165] (887s left) gem_sync (basic-each)
[140.813607] Starting subtest: basic-each
[143.692644] Subtest basic-each: SUCCESS (2.881s)
[143.947936] [045/165] (884s left) gem_tiled_blits (basic)
[144.453618] Subtest basic: SKIP (0.000s)
[144.537091] [046/165] (883s left) gem_tiled_fence_blits (basic)
[145.178368] Starting subtest: basic
[145.231116] Subtest basic: SUCCESS (0.054s)
[145.379337] [047/165] (882s left) gem_tiled_pread_basic
[146.600724] [048/165] (881s left) gem_wait (busy@all-engines)
[146.897521] Starting subtest: busy
[146.900272] Starting dynamic subtest: all-engines
[147.422098] Dynamic subtest all-engines: SUCCESS (0.526s)
[147.425708] Subtest busy: SUCCESS (0.527s)
[147.731047] [049/165] (880s left) gem_wait (wait@all-engines)
[148.022296] Starting subtest: wait
[148.023949] Starting dynamic subtest: all-engines
[149.065143] Dynamic subtest all-engines: SUCCESS (1.046s)
[149.066804] Subtest wait: SUCCESS (1.047s)
[149.382541] [050/165] (878s left) i915_getparams_basic (basic-eu-total)
[149.611153] Starting subtest: basic-eu-total
[149.617931] Subtest basic-eu-total: SUCCESS (0.000s)
[149.714430] [051/165] (878s left) i915_getparams_basic (basic-subslice-total)
[149.944190] Starting subtest: basic-subslice-total
[149.948137] Subtest basic-subslice-total: SUCCESS (0.000s)
[150.046486] [052/165] (878s left) i915_hangman (error-state-basic)
[150.306285] Starting subtest: error-state-basic
[150.334471] Subtest error-state-basic: SUCCESS (0.028s)
[150.477379] [053/165] (878s left) i915_pciid
[150.809673] [054/165] (877s left) kms_addfb_basic (addfb25-4-tiled)
[151.483518] Starting subtest: addfb25-4-tiled
[151.485085] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[151.578817] [055/165] (877s left) kms_addfb_basic (addfb25-bad-modifier)
[151.815243] Starting subtest: addfb25-bad-modifier
[151.820182] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[152.362428] [056/165] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[152.608188] Starting subtest: addfb25-framebuffer-vs-set-tiling
[152.610526] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[153.146978] [057/165] (875s left) kms_addfb_basic (addfb25-modifier-no-flag)
[153.382332] Starting subtest: addfb25-modifier-no-flag
[153.385806] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[153.915824] [058/165] (874s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[154.148449] Starting subtest: addfb25-x-tiled-legacy
[154.151108] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[154.698991] [059/165] (874s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[154.930523] Starting subtest: addfb25-x-tiled-mismatch-legacy
[154.932114] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[155.468911] [060/165] (873s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[156.133786] Starting subtest: addfb25-yf-tiled-legacy
[156.138349] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.003s)
[156.247792] [061/165] (872s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[156.890181] Starting subtest: addfb25-y-tiled-legacy
[156.892732] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[156.998448] [062/165] (871s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[157.671139] Starting subtest: addfb25-y-tiled-small-legacy
[157.676376] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[157.780627] [063/165] (871s left) kms_addfb_basic (bad-pitch-0)
[158.008559] Starting subtest: bad-pitch-0
[158.011927] Subtest bad-pitch-0: SUCCESS (0.000s)
[158.562556] [064/165] (870s left) kms_addfb_basic (bad-pitch-1024)
[158.786984] Starting subtest: bad-pitch-1024
[158.789996] Subtest bad-pitch-1024: SUCCESS (0.000s)
[159.314461] [065/165] (869s left) kms_addfb_basic (bad-pitch-128)
[159.544427] Starting subtest: bad-pitch-128
[159.546299] Subtest bad-pitch-128: SUCCESS (0.000s)
[160.112481] [066/165] (869s left) kms_addfb_basic (bad-pitch-256)
[160.337073] Starting subtest: bad-pitch-256
[160.339883] Subtest bad-pitch-256: SUCCESS (0.000s)
[160.846753] [067/165] (868s left) kms_addfb_basic (bad-pitch-32)
[161.078307] Starting subtest: bad-pitch-32
[161.081309] Subtest bad-pitch-32: SUCCESS (0.000s)
[161.611761] [068/165] (867s left) kms_addfb_basic (bad-pitch-63)
[161.834992] Starting subtest: bad-pitch-63
[161.838961] Subtest bad-pitch-63: SUCCESS (0.000s)
[162.364383] [069/165] (866s left) kms_addfb_basic (bad-pitch-65536)
[162.600253] Starting subtest: bad-pitch-65536
[162.602138] Subtest bad-pitch-65536: SUCCESS (0.001s)
[163.130497] [070/165] (866s left) kms_addfb_basic (bad-pitch-999)
[163.356286] Starting subtest: bad-pitch-999
[163.359762] Subtest bad-pitch-999: SUCCESS (0.000s)
[163.914211] [071/165] (865s left) kms_addfb_basic (basic)
[164.140552] Starting subtest: basic
[164.142988] Subtest basic: SUCCESS (0.000s)
[164.680521] [072/165] (864s left) kms_addfb_basic (basic-x-tiled-legacy)
[164.909292] Starting subtest: basic-x-tiled-legacy
[164.912125] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[165.513613] [073/165] (864s left) kms_addfb_basic (basic-y-tiled-legacy)
[165.744442] Starting subtest: basic-y-tiled-legacy
[165.747466] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[166.280905] [074/165] (863s left) kms_addfb_basic (bo-too-small)
[166.928152] Starting subtest: bo-too-small
[166.929751] Subtest bo-too-small: SUCCESS (0.001s)
[167.047856] [075/165] (862s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[167.690818] Starting subtest: bo-too-small-due-to-tiling
[167.694519] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[167.797142] [076/165] (861s left) kms_addfb_basic (clobberred-modifier)
[168.022160] Starting subtest: clobberred-modifier
[168.025192] Subtest clobberred-modifier: SUCCESS (0.000s)
[168.564829] [077/165] (861s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[168.798097] Starting subtest: framebuffer-vs-set-tiling
[168.799595] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[169.347249] [078/165] (860s left) kms_addfb_basic (invalid-get-prop)
[169.575196] Starting subtest: invalid-get-prop
[169.576677] Subtest invalid-get-prop: SUCCESS (0.000s)
[170.098608] [079/165] (859s left) kms_addfb_basic (invalid-get-prop-any)
[170.327569] Starting subtest: invalid-get-prop-any
[170.329657] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[170.862696] [080/165] (859s left) kms_addfb_basic (invalid-set-prop)
[171.090491] Starting subtest: invalid-set-prop
[171.093132] Subtest invalid-set-prop: SUCCESS (0.000s)
[171.629322] [081/165] (858s left) kms_addfb_basic (invalid-set-prop-any)
[171.851624] Starting subtest: invalid-set-prop-any
[171.854071] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[172.380419] [082/165] (857s left) kms_addfb_basic (no-handle)
[172.609400] Starting subtest: no-handle
[172.610879] Subtest no-handle: SUCCESS (0.000s)
[173.147412] [083/165] (856s left) kms_addfb_basic (size-max)
[173.790857] Starting subtest: size-max
[173.794524] Subtest size-max: SUCCESS (0.000s)
[173.916088] [084/165] (856s left) kms_addfb_basic (small-bo)
[174.601608] Starting subtest: small-bo
[174.604851] Subtest small-bo: SUCCESS (0.000s)
[174.713978] [085/165] (855s left) kms_addfb_basic (tile-pitch-mismatch)
[174.947324] Starting subtest: tile-pitch-mismatch
[174.949887] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[175.513767] [086/165] (854s left) kms_addfb_basic (too-high)
[176.154698] Starting subtest: too-high
[176.157537] Subtest too-high: SUCCESS (0.005s)
[176.263569] [087/165] (854s left) kms_addfb_basic (too-wide)
[176.904329] Starting subtest: too-wide
[176.907096] Subtest too-wide: SUCCESS (0.000s)
[177.012801] [088/165] (853s left) kms_addfb_basic (unused-handle)
[177.246666] Starting subtest: unused-handle
[177.250180] Subtest unused-handle: SUCCESS (0.000s)
[177.812541] [089/165] (852s left) kms_addfb_basic (unused-modifier)
[178.041182] Starting subtest: unused-modifier
[178.042766] Subtest unused-modifier: SUCCESS (0.000s)
[178.580581] [090/165] (851s left) kms_addfb_basic (unused-offsets)
[178.803928] Starting subtest: unused-offsets
[178.806162] Subtest unused-offsets: SUCCESS (0.000s)
[179.331553] [091/165] (851s left) kms_addfb_basic (unused-pitches)
[179.557854] Starting subtest: unused-pitches
[179.561529] Subtest unused-pitches: SUCCESS (0.000s)
[180.079266] [092/165] (850s left) kms_busy (basic)
[180.716725] Starting subtest: basic
[180.718964] Starting dynamic subtest: flip
[181.871553] Dynamic subtest flip: SUCCESS (1.151s)
[181.921152] Starting dynamic subtest: modeset
[184.130151] Dynamic subtest modeset: SUCCESS (2.258s)
[184.131668] Subtest basic: SUCCESS (3.415s)
[184.692254] [093/165] (845s left) kms_prop_blob (basic)
[184.927198] Starting subtest: basic
[184.928945] Subtest basic: SUCCESS (0.000s)
[185.036173] [094/165] (845s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[185.739899] Starting subtest: basic-busy-flip-before-cursor-atomic
[186.955133] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.209s)
[187.462820] [095/165] (843s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[188.141983] Starting subtest: basic-busy-flip-before-cursor-legacy
[189.412390] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.271s)
[189.917950] [096/165] (840s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[190.550129] Starting subtest: basic-flip-after-cursor-atomic
[191.799593] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.248s)
[192.524857] [097/165] (838s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[193.212888] Starting subtest: basic-flip-after-cursor-legacy
[194.386090] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.161s)
[194.843798] [098/165] (836s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[195.517482] Starting subtest: basic-flip-after-cursor-varying-size
[196.717284] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.188s)
[197.213326] [099/165] (833s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[197.872158] Starting subtest: basic-flip-before-cursor-atomic
[199.092320] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.220s)
[199.619567] [100/165] (831s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[200.296481] Starting subtest: basic-flip-before-cursor-legacy
[201.476805] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.178s)
[202.000912] [101/165] (829s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[202.691277] Starting subtest: basic-flip-before-cursor-varying-size
[203.923977] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.233s)
[204.453412] [102/165] (826s left) kms_dsc (dsc-basic)
[205.156498] Subtest dsc-basic: SKIP (0.000s)
[205.238275] [103/165] (825s left) kms_flip (basic-flip-vs-dpms)
[205.709890] Starting subtest: basic-flip-vs-dpms
[205.732242] Starting dynamic subtest: C-HDMI-A2
[208.492893] Dynamic subtest C-HDMI-A2: SUCCESS (2.760s)
[208.494522] Subtest basic-flip-vs-dpms: SUCCESS (2.786s)
[208.975095] [104/165] (822s left) kms_flip (basic-flip-vs-modeset)
[209.441569] Starting subtest: basic-flip-vs-modeset
[209.459461] Starting dynamic subtest: C-HDMI-A2
[212.210379] Dynamic subtest C-HDMI-A2: SUCCESS (2.735s)
[212.214735] Subtest basic-flip-vs-modeset: SUCCESS (2.760s)
[212.936684] [105/165] (818s left) kms_flip (basic-flip-vs-wf_vblank)
[213.445200] Starting subtest: basic-flip-vs-wf_vblank
[213.467567] Starting dynamic subtest: C-HDMI-A2
[216.574380] Dynamic subtest C-HDMI-A2: SUCCESS (3.104s)
[216.578113] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.133s)
[216.745754] [106/165] (814s left) kms_flip (basic-plain-flip)
[217.217854] Starting subtest: basic-plain-flip
[217.233881] Starting dynamic subtest: C-HDMI-A2
[219.872384] Dynamic subtest C-HDMI-A2: SUCCESS (2.636s)
[219.873616] Subtest basic-plain-flip: SUCCESS (2.663s)
[220.056954] [107/165] (811s left) kms_force_connector_basic (force-connector-state)
[220.413921] Starting subtest: force-connector-state
[221.281381] Subtest force-connector-state: SUCCESS (0.865s)
[222.611578] [108/165] (808s left) kms_force_connector_basic (force-edid)
[222.956021] Starting subtest: force-edid
[223.038115] Subtest force-edid: SUCCESS (0.084s)
[223.844492] [109/165] (807s left) kms_force_connector_basic (force-load-detect)
[224.205166] Starting subtest: force-load-detect
[224.210441] Subtest force-load-detect: SKIP (0.000s)
[224.778325] [110/165] (806s left) kms_force_connector_basic (prune-stale-modes)
[225.123559] Starting subtest: prune-stale-modes
[225.199113] Subtest prune-stale-modes: SUCCESS (0.069s)
[225.995311] [111/165] (805s left) kms_frontbuffer_tracking (basic)
[226.750692] Starting subtest: basic
[230.938832] Subtest basic: SUCCESS (4.185s)
[231.082341] [112/165] (800s left) kms_hdmi_inject (inject-audio)
[231.447702] Starting subtest: inject-audio
[232.014332] Subtest inject-audio: FAIL (0.518s)
[232.975682] [113/165] (798s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[233.695576] Starting subtest: compare-crc-sanitycheck-xr24
[233.698974] Starting dynamic subtest: pipe-C-HDMI-A-2
[234.232847] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.526s)
[234.244055] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.536s)
[234.768659] [114/165] (797s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[235.468899] Starting subtest: compare-crc-sanitycheck-nv12
[235.476720] Starting dynamic subtest: pipe-C-HDMI-A-2
[235.481503] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.002s)
[235.487687] Subtest compare-crc-sanitycheck-nv12: SKIP (0.019s)
[235.601176] [115/165] (796s left) kms_pipe_crc_basic (hang-read-crc)
[236.308088] Starting subtest: hang-read-crc
[236.311139] Starting dynamic subtest: pipe-C-HDMI-A-2
[237.951116] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.638s)
[237.954133] Subtest hang-read-crc: SUCCESS (1.650s)
[238.462532] [116/165] (793s left) kms_pipe_crc_basic (nonblocking-crc)
[239.161350] Starting subtest: nonblocking-crc
[239.163942] Starting dynamic subtest: pipe-C-HDMI-A-2
[239.860190] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.693s)
[239.861804] Subtest nonblocking-crc: SUCCESS (0.705s)
[240.298870] [117/165] (791s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[241.000253] Starting subtest: nonblocking-crc-frame-sequence
[241.001807] Starting dynamic subtest: pipe-C-HDMI-A-2
[241.743681] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.740s)
[241.747065] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.753s)
[242.217885] [118/165] (789s left) kms_pipe_crc_basic (read-crc)
[242.934370] Starting subtest: read-crc
[242.938606] Starting dynamic subtest: pipe-C-HDMI-A-2
[243.568307] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.624s)
[243.570573] Subtest read-crc: SUCCESS (0.638s)
[244.091615] [119/165] (788s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[244.811074] Starting subtest: read-crc-frame-sequence
[244.813937] Starting dynamic subtest: pipe-C-HDMI-A-2
[245.436084] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.621s)
[245.438322] Subtest read-crc-frame-sequence: SUCCESS (0.636s)
[245.968729] [120/165] (786s left) kms_pm_backlight (basic-brightness)
[246.687523] Subtest basic-brightness: SKIP (0.000s)
[246.757332] [121/165] (785s left) kms_psr (primary_page_flip)
[246.993260] Subtest primary_page_flip: SKIP (0.000s)
[247.059291] [122/165] (785s left) kms_psr (cursor_plane_move)
[247.294444] Subtest cursor_plane_move: SKIP (0.000s)
[247.356648] [123/165] (785s left) kms_psr (sprite_plane_onoff)
[247.583448] Subtest sprite_plane_onoff: SKIP (0.000s)
[247.658673] [124/165] (784s left) kms_psr (primary_mmap_gtt)
[247.896959] Subtest primary_mmap_gtt: SKIP (0.000s)
[247.977433] [125/165] (784s left) kms_setmode (basic-clone-single-crtc)
[248.210143] Starting subtest: basic-clone-single-crtc
[248.214223] Subtest basic-clone-single-crtc: SKIP (0.001s)
[248.351580] [126/165] (784s left) i915_pm_rpm (basic-pci-d3-state)
[250.732084] Starting subtest: basic-pci-d3-state
[251.104932] Subtest basic-pci-d3-state: SUCCESS (0.354s)
[251.444099] [127/165] (781s left) i915_pm_rpm (basic-rte)
[251.676894] Starting subtest: basic-rte
[254.564046] Subtest basic-rte: SUCCESS (2.880s)
[255.612216] [128/165] (777s left) i915_pm_rps (basic-api)
[255.862127] Starting subtest: basic-api
[255.878516] Subtest basic-api: SUCCESS (0.014s)
[256.003965] [129/165] (776s left) prime_self_import (basic-llseek-bad)
[256.228870] Starting subtest: basic-llseek-bad
[256.235556] Subtest basic-llseek-bad: SUCCESS (0.007s)
[256.345171] [130/165] (776s left) prime_self_import (basic-llseek-size)
[256.567915] Starting subtest: basic-llseek-size
[256.580432] Subtest basic-llseek-size: SUCCESS (0.010s)
[256.702598] [131/165] (776s left) prime_self_import (basic-with_fd_dup)
[256.930212] Starting subtest: basic-with_fd_dup
[256.942700] Subtest basic-with_fd_dup: SUCCESS (0.012s)
[257.053977] [132/165] (775s left) prime_self_import (basic-with_one_bo)
[257.277118] Starting subtest: basic-with_one_bo
[257.288372] Subtest basic-with_one_bo: SUCCESS (0.011s)
[257.401736] [133/165] (775s left) prime_self_import (basic-with_one_bo_two_files)
[257.620145] Starting subtest: basic-with_one_bo_two_files
[257.636220] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[257.744389] [134/165] (775s left) prime_self_import (basic-with_two_bos)
[257.962101] Starting subtest: basic-with_two_bos
[257.973958] Subtest basic-with_two_bos: SUCCESS (0.012s)
[258.079727] [135/165] (775s left) prime_vgem (basic-fence-flip)
[258.347675] Starting subtest: basic-fence-flip
[259.138324] Subtest basic-fence-flip: SKIP (0.788s)
[259.280763] [136/165] (773s left) prime_vgem (basic-fence-mmap)
[259.549719] Starting subtest: basic-fence-mmap
[259.662600] Subtest basic-fence-mmap: SUCCESS (0.112s)
[259.783869] [137/165] (773s left) prime_vgem (basic-fence-read)
[260.045295] Starting subtest: basic-fence-read
[260.225125] Subtest basic-fence-read: SUCCESS (0.179s)
[260.349364] [138/165] (772s left) prime_vgem (basic-gtt)
[260.612539] Starting subtest: basic-gtt
[260.664833] Subtest basic-gtt: SUCCESS (0.047s)
[260.779969] [139/165] (772s left) prime_vgem (basic-read)
[261.042314] Starting subtest: basic-read
[261.130666] Subtest basic-read: SUCCESS (0.080s)
[261.244383] [140/165] (772s left) prime_vgem (basic-write)
[261.511705] Starting subtest: basic-write
[261.609208] Subtest basic-write: SUCCESS (0.095s)
[261.728483] [141/165] (771s left) vgem_basic (setversion)
[261.977450] Starting subtest: setversion
[261.980934] Subtest setversion: SUCCESS (0.002s)
[262.083244] [142/165] (771s left) vgem_basic (create)
[262.340716] Starting subtest: create
[262.343306] Subtest create: SUCCESS (0.001s)
[262.429246] [143/165] (771s left) vgem_basic (debugfs)
[262.673966] Starting subtest: debugfs
[262.677659] Subtest debugfs: SUCCESS (0.001s)
[262.764956] [144/165] (770s left) vgem_basic (dmabuf-export)
[263.008639] Starting subtest: dmabuf-export
[263.014271] Subtest dmabuf-export: SUCCESS (0.007s)
[263.126304] [145/165] (770s left) vgem_basic (dmabuf-fence)
[263.375727] Starting subtest: dmabuf-fence
[263.377404] Subtest dmabuf-fence: SUCCESS (0.002s)
[263.469616] [146/165] (770s left) vgem_basic (dmabuf-fence-before)
[263.706714] Starting subtest: dmabuf-fence-before
[263.708453] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[263.793293] [147/165] (770s left) vgem_basic (dmabuf-mmap)
[264.024103] Starting subtest: dmabuf-mmap
[264.072233] Subtest dmabuf-mmap: SUCCESS (0.044s)
[264.171381] [148/165] (769s left) vgem_basic (mmap)
[264.406455] Starting subtest: mmap
[264.436826] Subtest mmap: SUCCESS (0.031s)
[264.532384] [149/165] (769s left) vgem_basic (second-client)
[264.779708] Starting subtest: second-client
[264.804912] Subtest second-client: SUCCESS (0.029s)
[264.910338] [150/165] (769s left) vgem_basic (sysfs)
[265.156175] Starting subtest: sysfs
[265.161937] Subtest sysfs: SUCCESS (0.004s)
[265.268852] [151/165] (768s left) core_hotunplug (unbind-rebind)
[265.609107] Starting subtest: unbind-rebind
[270.441821] Subtest unbind-rebind: SUCCESS (4.831s)
[270.531884] [152/165] (763s left) vgem_basic (unload)
[270.769683] Starting subtest: unload
[299.930931] Subtest unload: SUCCESS (29.157s)
[300.133940] [153/165] (734s left) i915_module_load (reload)
[300.359097] Starting subtest: reload
[305.108491] Subtest reload: SUCCESS (4.743s)
[305.183537] [154/165] (729s left) gem_lmem_swapping (basic)
[305.739934] Subtest basic: SKIP (0.000s)
[305.931557] [155/165] (728s left) gem_lmem_swapping (parallel-random-engines)
[306.232674] Subtest parallel-random-engines: SKIP (0.000s)
[306.319831] [156/165] (728s left) gem_lmem_swapping (random-engines)
[306.565352] Subtest random-engines: SKIP (0.000s)
[306.633149] [157/165] (727s left) gem_lmem_swapping (verify-random)
[306.908996] Subtest verify-random: SKIP (0.000s)
[306.981935] [158/165] (727s left) i915_pm_rpm (module-reload)
[309.689395] Starting subtest: module-reload
[323.650029] Subtest module-reload: SUCCESS (13.961s)
[323.704762] [159/165] (711s left) i915_selftest (live)
[323.965384] Starting subtest: live
[323.966840] Starting dynamic subtest: sanitycheck
[325.839977] Dynamic subtest sanitycheck: SUCCESS (1.875s)
[325.859095] Starting dynamic subtest: uncore
[327.531571] Dynamic subtest uncore: SUCCESS (1.688s)
[327.551179] Starting dynamic subtest: workarounds
[329.432751] Dynamic subtest workarounds: SUCCESS (1.894s)
[329.455676] Starting dynamic subtest: gt_engines
[331.604191] Dynamic subtest gt_engines: SUCCESS (2.163s)
[331.623544] Starting dynamic subtest: gt_timelines
[360.462950] Dynamic subtest gt_timelines: SUCCESS (28.858s)
[360.483877] Starting dynamic subtest: gt_contexts
[362.476666] Dynamic subtest gt_contexts: SUCCESS (2.010s)
[362.503743] Starting dynamic subtest: gt_lrc
[367.620854] Dynamic subtest gt_lrc: SUCCESS (5.132s)
[367.639996] Starting dynamic subtest: gt_mocs
[369.297095] Dynamic subtest gt_mocs: SUCCESS (1.673s)
[369.332835] Starting dynamic subtest: gt_pm
[372.291385] Dynamic subtest gt_pm: SUCCESS (2.991s)
[372.312122] Starting dynamic subtest: gt_heartbeat
[374.328122] Dynamic subtest gt_heartbeat: SUCCESS (2.031s)
[374.347836] Starting dynamic subtest: gt_tlb
[376.519578] Dynamic subtest gt_tlb: SUCCESS (2.187s)
[376.542314] Starting dynamic subtest: requests
[384.897248] Dynamic subtest requests: SUCCESS (8.374s)
[384.916283] Starting dynamic subtest: migrate
[390.228156] Dynamic subtest migrate: SUCCESS (5.328s)
[390.247769] Starting dynamic subtest: active
[392.187670] Dynamic subtest active: SUCCESS (1.956s)
[392.209347] Starting dynamic subtest: objects
[395.913876] Dynamic subtest objects: SUCCESS (3.718s)
[395.933051] Starting dynamic subtest: mman
[405.757133] Dynamic subtest mman: SUCCESS (9.838s)
[405.776685] Starting dynamic subtest: dmabuf
[407.632068] Dynamic subtest dmabuf: SUCCESS (1.869s)
[407.667469] Starting dynamic subtest: vma
[409.378304] Dynamic subtest vma: SUCCESS (1.743s)
[409.398488] Starting dynamic subtest: coherency
[414.799129] Dynamic subtest coherency: SUCCESS (5.417s)
[414.818727] Starting dynamic subtest: gtt
[424.112525] Dynamic subtest gtt: SUCCESS (9.310s)
[424.132855] Starting dynamic subtest: gem
[426.907450] Dynamic subtest gem: SUCCESS (2.790s)
[426.926640] Starting dynamic subtest: evict
[434.914841] Dynamic subtest evict: SUCCESS (8.005s)
[434.939730] Starting dynamic subtest: hugepages
[437.147873] Dynamic subtest hugepages: SUCCESS (2.222s)
[437.167261] Starting dynamic subtest: gem_contexts
[461.439147] Dynamic subtest gem_contexts: SUCCESS (24.286s)
[461.458545] Starting dynamic subtest: client
[463.401602] Dynamic subtest client: SUCCESS (1.961s)
[463.422096] Starting dynamic subtest: gem_migrate
[465.141266] Dynamic subtest gem_migrate: SUCCESS (1.735s)
[465.166510] Starting dynamic subtest: reset
[474.997057] Dynamic subtest reset: SUCCESS (9.848s)
[475.016696] Starting dynamic subtest: memory_region
[476.793688] Dynamic subtest memory_region: SUCCESS (1.788s)
[476.823988] Starting dynamic subtest: hangcheck
[501.878974] Dynamic subtest hangcheck: SUCCESS (25.081s)
[501.899272] Starting dynamic subtest: execlists
[513.538447] Dynamic subtest execlists: SUCCESS (11.657s)
[513.557999] Starting dynamic subtest: ring_submission
[515.425424] Dynamic subtest ring_submission: SUCCESS (1.836s)
[515.475082] Starting dynamic subtest: perf
[517.580306] Dynamic subtest perf: SUCCESS (2.193s)
[517.599959] Starting dynamic subtest: slpc
[519.394991] Dynamic subtest slpc: SUCCESS (1.811s)
[519.415171] Starting dynamic subtest: guc
[521.266391] Dynamic subtest guc: SUCCESS (1.865s)
[521.286302] Starting dynamic subtest: guc_multi_lrc
[523.029465] Dynamic subtest guc_multi_lrc: SUCCESS (1.756s)
[523.088247] Starting dynamic subtest: guc_hang
[524.848680] Dynamic subtest guc_hang: SUCCESS (1.818s)
[524.895324] Starting dynamic subtest: late_gt_pm
[526.700236] Dynamic subtest late_gt_pm: SUCCESS (1.839s)
[526.703231] Subtest live: SUCCESS (202.741s)
[526.767929] [160/165] (508s left) dmabuf (all-tests)
[527.005370] Starting subtest: all-tests
[527.009539] Starting dynamic subtest: sanitycheck
[527.073123] Dynamic subtest sanitycheck: SUCCESS (0.069s)
[527.106415] Starting dynamic subtest: dma_fence
[527.286670] Dynamic subtest dma_fence: SUCCESS (0.205s)
[527.330223] Starting dynamic subtest: dma_fence_chain
[558.333512] Dynamic subtest dma_fence_chain: SUCCESS (31.034s)
[558.373982] Starting dynamic subtest: dma_fence_unwrap
[558.409320] Dynamic subtest dma_fence_unwrap: SUCCESS (0.077s)
[558.457459] Starting dynamic subtest: dma_resv
[558.491737] Dynamic subtest dma_resv: SUCCESS (0.073s)
[558.496742] Subtest all-tests: SUCCESS (31.494s)
[558.555392] [161/165] (476s left) i915_suspend (basic-s2idle-without-i915)
[558.782435] Starting subtest: basic-s2idle-without-i915
[582.327464] Subtest basic-s2idle-without-i915: SUCCESS (8.536s)
[588.170345] [162/165] (466s left) i915_suspend (basic-s3-without-i915)
[588.405227] Starting subtest: basic-s3-without-i915
[610.322322] Subtest basic-s3-without-i915: SUCCESS (6.734s)
[613.289010] [163/165] (459s left) gem_exec_suspend (basic-s0)
[613.588055] Starting subtest: basic-S0
[613.591596] Starting dynamic subtest: smem
[637.981663] Dynamic subtest smem: SUCCESS (8.817s)
[637.988777] Subtest basic-S0: SUCCESS (8.824s)
[644.221209] [164/165] (449s left) gem_exec_suspend (basic-s3)
[644.493863] Starting subtest: basic-S3
[644.496575] Starting dynamic subtest: smem
[668.947982] Dynamic subtest smem: SUCCESS (9.072s)
[668.951698] Subtest basic-S3: SUCCESS (9.076s)
[671.175489] [165/165] (440s left) kms_pipe_crc_basic (suspend-read-crc)
[671.861384] Starting subtest: suspend-read-crc
[671.862841] Starting dynamic subtest: pipe-C-HDMI-A-2
[692.764807] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.353s)
[692.768066] Subtest suspend-read-crc: SUCCESS (5.367s)
[698.110460] Closing watchdogs
Done.