[48.674440] Initializing watchdogs
[48.674631]   /dev/watchdog0
[48.685864] [001/165] (960s left) i915_module_load (load)
[48.803348] Starting subtest: load
[50.588594] Subtest load: SUCCESS (1.786s)
[50.624654] [002/165] (958s left) core_auth (basic-auth)
[50.827181] Starting subtest: basic-auth
[50.830661] Subtest basic-auth: SUCCESS (0.001s)
[50.915449] [003/165] (958s left) debugfs_test (read_all_entries)
[51.092795] Starting subtest: read_all_entries
[51.191086] Subtest read_all_entries: SUCCESS (0.099s)
[51.330739] [004/165] (957s left) debugfs_test (basic-hwmon)
[51.440580] Starting subtest: basic-hwmon
[51.444185] Subtest basic-hwmon: SKIP (0.000s)
[51.580509] [005/165] (957s left) fbdev (eof)
[51.692628] Starting subtest: eof
[51.693673] Subtest eof: SUCCESS (0.001s)
[51.749209] [006/165] (957s left) fbdev (info)
[51.849538] Starting subtest: info
[51.850833] Subtest info: SUCCESS (0.000s)
[51.917296] [007/165] (957s left) fbdev (nullptr)
[52.029895] Starting subtest: nullptr
[52.031598] Subtest nullptr: SUCCESS (0.000s)
[52.083862] [008/165] (957s left) fbdev (read)
[52.197350] Starting subtest: read
[53.719459] Subtest read: SUCCESS (1.529s)
[53.783212] [009/165] (955s left) fbdev (write)
[53.890366] Starting subtest: write
[54.678119] Subtest write: SUCCESS (0.788s)
[54.733586] [010/165] (954s left) gem_basic (bad-close)
[54.839341] Starting subtest: bad-close
[54.841922] Subtest bad-close: SUCCESS (0.000s)
[54.942359] [011/165] (954s left) gem_basic (create-close)
[55.045599] Starting subtest: create-close
[55.047847] Subtest create-close: SUCCESS (0.000s)
[55.133763] [012/165] (954s left) gem_basic (create-fd-close)
[55.238430] Starting subtest: create-fd-close
[55.240833] Subtest create-fd-close: SUCCESS (0.002s)
[55.317595] [013/165] (954s left) gem_busy (busy@all-engines)
[55.447276] Starting subtest: busy
[55.448765] Starting dynamic subtest: all-engines
[55.523407] Dynamic subtest all-engines: SUCCESS (0.074s)
[55.524934] Subtest busy: SUCCESS (0.074s)
[55.868609] [014/165] (953s left) gem_close_race (basic-process)
[56.002055] Starting subtest: basic-process
[56.078582] Subtest basic-process: SUCCESS (0.078s)
[56.293326] [015/165] (953s left) gem_close_race (basic-threads)
[56.448721] Starting subtest: basic-threads
[57.633302] Subtest basic-threads: SUCCESS (1.183s)
[57.817962] [016/165] (951s left) gem_ctx_create (basic)
[57.941542] Starting subtest: basic
[57.943516] Subtest basic: SUCCESS (0.000s)
[58.135268] [017/165] (951s left) gem_ctx_create (basic-files)
[58.257558] Starting subtest: basic-files
[60.285818] Subtest basic-files: SUCCESS (2.029s)
[60.501080] [018/165] (949s left) gem_ctx_exec (basic)
[60.609440] Starting subtest: basic
[60.616806] Subtest basic: SUCCESS (0.005s)
[60.698520] [019/165] (949s left) gem_exec_basic (basic)
[60.814440] Starting subtest: basic
[60.815860] Starting dynamic subtest: rcs0-smem
[60.818998] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[60.834059] Starting dynamic subtest: bcs0-smem
[60.835274] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[60.845151] Starting dynamic subtest: vcs0-smem
[60.846889] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[60.857562] Starting dynamic subtest: vecs0-smem
[60.858746] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[60.860187] Subtest basic: SUCCESS (0.009s)
[61.033358] [020/165] (948s left) gem_exec_create (basic)
[61.155913] Starting subtest: basic
[61.159341] Starting dynamic subtest: smem
[63.206257] Dynamic subtest smem: SUCCESS (2.048s)
[63.207934] Subtest basic: SUCCESS (2.049s)
[63.402133] [021/165] (946s left) gem_exec_fence (basic-busy)
[63.660097] Starting subtest: basic-busy
[63.661166] Starting dynamic subtest: rcs0
[63.672546] Dynamic subtest rcs0: SUCCESS (0.018s)
[63.682448] Starting dynamic subtest: bcs0
[63.695336] Dynamic subtest bcs0: SUCCESS (0.021s)
[63.705197] Starting dynamic subtest: vcs0
[63.719812] Dynamic subtest vcs0: SUCCESS (0.021s)
[63.730723] Starting dynamic subtest: vecs0
[63.733069] Dynamic subtest vecs0: SUCCESS (0.015s)
[63.735079] Subtest basic-busy: SUCCESS (0.078s)
[64.384204] [022/165] (945s left) gem_exec_fence (basic-wait)
[64.637260] Starting subtest: basic-wait
[64.638372] Starting dynamic subtest: rcs0
[64.658667] Dynamic subtest rcs0: SUCCESS (0.021s)
[64.672841] Starting dynamic subtest: bcs0
[64.674234] Dynamic subtest bcs0: SUCCESS (0.016s)
[64.688174] Starting dynamic subtest: vcs0
[64.689286] Dynamic subtest vcs0: SUCCESS (0.014s)
[64.700777] Starting dynamic subtest: vecs0
[64.705168] Dynamic subtest vecs0: SUCCESS (0.019s)
[64.706309] Subtest basic-wait: SUCCESS (0.071s)
[65.283833] [023/165] (944s left) gem_exec_fence (basic-await)
[65.537899] Starting subtest: basic-await
[65.538974] Starting dynamic subtest: rcs0
[65.649771] Dynamic subtest rcs0: SUCCESS (0.112s)
[65.662507] Starting dynamic subtest: bcs0
[65.759098] Dynamic subtest bcs0: SUCCESS (0.110s)
[65.771933] Starting dynamic subtest: vcs0
[65.869085] Dynamic subtest vcs0: SUCCESS (0.110s)
[65.881731] Starting dynamic subtest: vecs0
[65.983091] Dynamic subtest vecs0: SUCCESS (0.113s)
[65.984262] Subtest basic-await: SUCCESS (0.446s)
[66.568360] [024/165] (943s left) gem_exec_fence (nb-await)
[66.824683] Starting subtest: nb-await
[66.825825] Starting dynamic subtest: rcs0
[66.891416] Dynamic subtest rcs0: SUCCESS (0.067s)
[66.901800] Starting dynamic subtest: bcs0
[66.962208] Dynamic subtest bcs0: SUCCESS (0.068s)
[66.974327] Starting dynamic subtest: vcs0
[67.026179] Dynamic subtest vcs0: SUCCESS (0.063s)
[67.038073] Starting dynamic subtest: vecs0
[67.087179] Dynamic subtest vecs0: SUCCESS (0.064s)
[67.090058] Subtest nb-await: SUCCESS (0.265s)
[67.667285] [025/165] (942s left) gem_exec_gttfill (basic)
[67.792120] Starting subtest: basic
[77.536558] Subtest basic: SUCCESS (9.744s)
[77.721196] [026/165] (932s left) gem_exec_parallel (engines)
[77.955128] Starting subtest: engines
[77.956172] Starting dynamic subtest: basic
[80.745074] Dynamic subtest basic: SUCCESS (2.790s)
[80.760201] Starting dynamic subtest: contexts
[84.359807] Dynamic subtest contexts: SUCCESS (3.612s)
[84.373504] Starting dynamic subtest: fds
[93.505922] Dynamic subtest fds: SUCCESS (9.145s)
[93.519029] Starting dynamic subtest: userptr
[96.338145] Dynamic subtest userptr: SUCCESS (2.834s)
[96.339441] Subtest engines: SUCCESS (18.382s)
[96.534869] [027/165] (913s left) gem_exec_store (basic)
[96.663712] Starting subtest: basic
[96.712040] Subtest basic: SUCCESS (0.048s)
[96.905171] [028/165] (913s left) gem_flink_basic (bad-flink)
[97.011297] Starting subtest: bad-flink
[97.012393] Subtest bad-flink: SUCCESS (0.000s)
[97.086244] [029/165] (912s left) gem_flink_basic (bad-open)
[97.190953] Starting subtest: bad-open
[97.192250] Subtest bad-open: SUCCESS (0.000s)
[97.269473] [030/165] (912s left) gem_flink_basic (basic)
[97.373390] Starting subtest: basic
[97.374581] Subtest basic: SUCCESS (0.000s)
[97.453602] [031/165] (912s left) gem_flink_basic (double-flink)
[97.559054] Starting subtest: double-flink
[97.562237] Subtest double-flink: SUCCESS (0.000s)
[97.652414] [032/165] (912s left) gem_flink_basic (flink-lifetime)
[97.757775] Starting subtest: flink-lifetime
[97.760459] Subtest flink-lifetime: SUCCESS (0.003s)
[97.836040] [033/165] (912s left) gem_huc_copy (huc-copy)
[97.947528] Starting subtest: huc-copy
[97.949884] Subtest huc-copy: SKIP (0.000s)
[98.035590] [034/165] (912s left) gem_linear_blits (basic)
[98.318284] Starting subtest: basic
[98.331843] Subtest basic: SUCCESS (0.014s)
[98.467089] [035/165] (911s left) gem_mmap (basic)
[98.673744] Starting subtest: basic
[98.680299] Subtest basic: SUCCESS (0.001s)
[98.754307] [036/165] (911s left) gem_mmap_gtt (basic)
[98.861900] Starting subtest: basic
[98.862973] Subtest basic: SUCCESS (0.001s)
[98.922340] [037/165] (911s left) gem_render_linear_blits (basic)
[99.032515] Starting subtest: basic
[99.093990] Subtest basic: SUCCESS (0.058s)
[99.139686] [038/165] (911s left) gem_render_tiled_blits (basic)
[99.251700] Starting subtest: basic
[99.323945] Subtest basic: SUCCESS (0.071s)
[99.372931] [039/165] (910s left) gem_ringfill (basic-all)
[99.688278] Starting subtest: basic-all
[100.879691] Subtest basic-all: SUCCESS (1.189s)
[100.987378] [040/165] (909s left) gem_softpin (allocator-basic)
[101.134204] Starting subtest: allocator-basic
[101.539473] Subtest allocator-basic: SUCCESS (0.391s)
[101.685962] [041/165] (908s left) gem_softpin (allocator-basic-reserve)
[101.855312] Starting subtest: allocator-basic-reserve
[102.243356] Subtest allocator-basic-reserve: SUCCESS (0.385s)
[102.317843] [042/165] (908s left) gem_softpin (safe-alignment)
[102.446587] Starting subtest: safe-alignment
[102.470835] Subtest safe-alignment: SUCCESS (0.021s)
[102.567048] [043/165] (907s left) gem_sync (basic-all)
[102.716080] Starting subtest: basic-all
[104.889972] Subtest basic-all: SUCCESS (2.174s)
[105.087090] [044/165] (905s left) gem_sync (basic-each)
[105.211944] Starting subtest: basic-each
[107.515524] Subtest basic-each: SUCCESS (2.306s)
[107.702520] [045/165] (902s left) gem_tiled_blits (basic)
[107.985806] Starting subtest: basic
[108.019813] Subtest basic: SUCCESS (0.034s)
[108.150207] [046/165] (902s left) gem_tiled_fence_blits (basic)
[108.524572] Starting subtest: basic
[108.554415] Subtest basic: SUCCESS (0.030s)
[108.697493] [047/165] (901s left) gem_tiled_pread_basic
[109.219884] [048/165] (901s left) gem_wait (busy@all-engines)
[109.358120] Starting subtest: busy
[109.359275] Starting dynamic subtest: all-engines
[109.882111] Dynamic subtest all-engines: SUCCESS (0.522s)
[109.883171] Subtest busy: SUCCESS (0.522s)
[110.104435] [049/165] (900s left) gem_wait (wait@all-engines)
[110.237276] Starting subtest: wait
[110.238909] Starting dynamic subtest: all-engines
[111.274218] Dynamic subtest all-engines: SUCCESS (1.034s)
[111.275293] Subtest wait: SUCCESS (1.035s)
[111.503910] [050/165] (899s left) i915_getparams_basic (basic-eu-total)
[111.611692] Starting subtest: basic-eu-total
[111.614044] Subtest basic-eu-total: SUCCESS (0.000s)
[111.686369] [051/165] (898s left) i915_getparams_basic (basic-subslice-total)
[111.791503] Starting subtest: basic-subslice-total
[111.793997] Subtest basic-subslice-total: SUCCESS (0.000s)
[111.869909] [052/165] (898s left) i915_hangman (error-state-basic)
[111.996960] Starting subtest: error-state-basic
[112.009085] Subtest error-state-basic: SUCCESS (0.013s)
[112.086088] [053/165] (898s left) i915_pciid
[112.268930] [054/165] (898s left) kms_addfb_basic (addfb25-4-tiled)
[112.444033] Starting subtest: addfb25-4-tiled
[112.445193] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[112.516795] [055/165] (898s left) kms_addfb_basic (addfb25-bad-modifier)
[112.622552] Starting subtest: addfb25-bad-modifier
[112.624105] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[112.767430] [056/165] (898s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[112.873176] Starting subtest: addfb25-framebuffer-vs-set-tiling
[112.874255] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[113.017652] [057/165] (897s left) kms_addfb_basic (addfb25-modifier-no-flag)
[113.122450] Starting subtest: addfb25-modifier-no-flag
[113.123601] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[113.267243] [058/165] (897s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[113.375640] Starting subtest: addfb25-x-tiled-legacy
[113.377769] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[113.517219] [059/165] (897s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[113.622477] Starting subtest: addfb25-x-tiled-mismatch-legacy
[113.623634] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[113.767195] [060/165] (897s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[113.930410] Starting subtest: addfb25-yf-tiled-legacy
[113.931625] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[114.000609] [061/165] (896s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[114.170144] Starting subtest: addfb25-y-tiled-legacy
[114.172204] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[114.251425] [062/165] (896s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[114.419204] Starting subtest: addfb25-y-tiled-small-legacy
[114.420907] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[114.500766] [063/165] (896s left) kms_addfb_basic (bad-pitch-0)
[114.608392] Starting subtest: bad-pitch-0
[114.609514] Subtest bad-pitch-0: SUCCESS (0.000s)
[114.751140] [064/165] (896s left) kms_addfb_basic (bad-pitch-1024)
[114.857338] Starting subtest: bad-pitch-1024
[114.858401] Subtest bad-pitch-1024: SUCCESS (0.000s)
[115.000462] [065/165] (896s left) kms_addfb_basic (bad-pitch-128)
[115.107450] Starting subtest: bad-pitch-128
[115.109762] Subtest bad-pitch-128: SUCCESS (0.000s)
[115.250390] [066/165] (895s left) kms_addfb_basic (bad-pitch-256)
[115.358082] Starting subtest: bad-pitch-256
[115.359194] Subtest bad-pitch-256: SUCCESS (0.000s)
[115.500991] [067/165] (895s left) kms_addfb_basic (bad-pitch-32)
[115.609067] Starting subtest: bad-pitch-32
[115.611887] Subtest bad-pitch-32: SUCCESS (0.000s)
[115.751353] [068/165] (895s left) kms_addfb_basic (bad-pitch-63)
[115.857461] Starting subtest: bad-pitch-63
[115.858555] Subtest bad-pitch-63: SUCCESS (0.000s)
[115.984103] [069/165] (895s left) kms_addfb_basic (bad-pitch-65536)
[116.090206] Starting subtest: bad-pitch-65536
[116.092886] Subtest bad-pitch-65536: SUCCESS (0.001s)
[116.234562] [070/165] (894s left) kms_addfb_basic (bad-pitch-999)
[116.339875] Starting subtest: bad-pitch-999
[116.341056] Subtest bad-pitch-999: SUCCESS (0.000s)
[116.484516] [071/165] (894s left) kms_addfb_basic (basic)
[116.590105] Starting subtest: basic
[116.591184] Subtest basic: SUCCESS (0.000s)
[116.734424] [072/165] (894s left) kms_addfb_basic (basic-x-tiled-legacy)
[116.838112] Starting subtest: basic-x-tiled-legacy
[116.839166] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[116.984251] [073/165] (894s left) kms_addfb_basic (basic-y-tiled-legacy)
[117.097594] Starting subtest: basic-y-tiled-legacy
[117.098780] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[117.234286] [074/165] (894s left) kms_addfb_basic (bo-too-small)
[117.402658] Starting subtest: bo-too-small
[117.403881] Subtest bo-too-small: SUCCESS (0.000s)
[117.484232] [075/165] (893s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[117.650622] Starting subtest: bo-too-small-due-to-tiling
[117.653376] Subtest bo-too-small-due-to-tiling: SUCCESS (0.001s)
[117.734254] [076/165] (893s left) kms_addfb_basic (clobberred-modifier)
[117.838857] Starting subtest: clobberred-modifier
[117.840153] Subtest clobberred-modifier: SUCCESS (0.000s)
[117.983747] [077/165] (893s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[118.092578] Starting subtest: framebuffer-vs-set-tiling
[118.093767] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[118.234228] [078/165] (893s left) kms_addfb_basic (invalid-get-prop)
[118.343057] Starting subtest: invalid-get-prop
[118.344138] Subtest invalid-get-prop: SUCCESS (0.000s)
[118.484231] [079/165] (892s left) kms_addfb_basic (invalid-get-prop-any)
[118.589854] Starting subtest: invalid-get-prop-any
[118.590958] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[118.734169] [080/165] (892s left) kms_addfb_basic (invalid-set-prop)
[118.836788] Starting subtest: invalid-set-prop
[118.839838] Subtest invalid-set-prop: SUCCESS (0.000s)
[118.985545] [081/165] (892s left) kms_addfb_basic (invalid-set-prop-any)
[119.090143] Starting subtest: invalid-set-prop-any
[119.091771] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[119.233719] [082/165] (892s left) kms_addfb_basic (no-handle)
[119.342024] Starting subtest: no-handle
[119.344594] Subtest no-handle: SUCCESS (0.000s)
[119.483555] [083/165] (892s left) kms_addfb_basic (size-max)
[119.657630] Starting subtest: size-max
[119.659709] Subtest size-max: SUCCESS (0.000s)
[119.734427] [084/165] (891s left) kms_addfb_basic (small-bo)
[119.902441] Starting subtest: small-bo
[119.904938] Subtest small-bo: SUCCESS (0.000s)
[119.983880] [085/165] (891s left) kms_addfb_basic (tile-pitch-mismatch)
[120.090858] Starting subtest: tile-pitch-mismatch
[120.091939] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[120.234445] [086/165] (891s left) kms_addfb_basic (too-high)
[120.407087] Starting subtest: too-high
[120.408358] Subtest too-high: SUCCESS (0.002s)
[120.484654] [087/165] (891s left) kms_addfb_basic (too-wide)
[120.647417] Starting subtest: too-wide
[120.648526] Subtest too-wide: SUCCESS (0.000s)
[120.734436] [088/165] (890s left) kms_addfb_basic (unused-handle)
[120.840758] Starting subtest: unused-handle
[120.843762] Subtest unused-handle: SUCCESS (0.000s)
[120.983865] [089/165] (890s left) kms_addfb_basic (unused-modifier)
[121.090321] Starting subtest: unused-modifier
[121.092871] Subtest unused-modifier: SUCCESS (0.000s)
[121.233658] [090/165] (890s left) kms_addfb_basic (unused-offsets)
[121.339247] Starting subtest: unused-offsets
[121.340785] Subtest unused-offsets: SUCCESS (0.000s)
[121.484096] [091/165] (890s left) kms_addfb_basic (unused-pitches)
[121.591925] Starting subtest: unused-pitches
[121.593042] Subtest unused-pitches: SUCCESS (0.000s)
[121.734319] [092/165] (890s left) kms_busy (basic)
[121.901572] Starting subtest: basic
[121.912418] Starting dynamic subtest: flip
[122.778031] Dynamic subtest flip: SUCCESS (0.869s)
[122.794171] Starting dynamic subtest: modeset
[124.085850] Dynamic subtest modeset: SUCCESS (1.302s)
[124.086988] Subtest basic: SUCCESS (2.175s)
[124.280620] [093/165] (887s left) kms_prop_blob (basic)
[124.389944] Starting subtest: basic
[124.392316] Subtest basic: SUCCESS (0.000s)
[124.462172] [094/165] (887s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[124.631143] Starting subtest: basic-busy-flip-before-cursor-atomic
[124.633353] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[124.711282] [095/165] (887s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[124.875197] Starting subtest: basic-busy-flip-before-cursor-legacy
[124.877618] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[124.944292] [096/165] (886s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[125.108093] Starting subtest: basic-flip-after-cursor-atomic
[126.267632] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.156s)
[126.440965] [097/165] (885s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[126.606327] Starting subtest: basic-flip-after-cursor-legacy
[127.795052] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.190s)
[127.956248] [098/165] (884s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[128.122117] Starting subtest: basic-flip-after-cursor-varying-size
[129.328194] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.199s)
[129.488644] [099/165] (882s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[129.647823] Starting subtest: basic-flip-before-cursor-atomic
[130.810866] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.163s)
[130.959832] [100/165] (881s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[131.128711] Starting subtest: basic-flip-before-cursor-legacy
[132.277129] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.150s)
[132.434229] [101/165] (879s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[132.602649] Starting subtest: basic-flip-before-cursor-varying-size
[133.804724] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.202s)
[133.954587] [102/165] (878s left) kms_dsc (dsc-basic)
[134.125620] Subtest dsc-basic: SKIP (0.000s)
[134.173569] [103/165] (877s left) kms_flip (basic-flip-vs-dpms)
[134.317734] Starting subtest: basic-flip-vs-dpms
[134.322982] Starting dynamic subtest: A-HDMI-A2
[135.580102] Dynamic subtest A-HDMI-A2: SUCCESS (1.254s)
[135.597431] Starting dynamic subtest: B-HDMI-A2
[136.548627] Dynamic subtest B-HDMI-A2: SUCCESS (0.965s)
[136.564060] Starting dynamic subtest: C-HDMI-A2
[137.521047] Dynamic subtest C-HDMI-A2: SUCCESS (0.971s)
[137.523761] Subtest basic-flip-vs-dpms: SUCCESS (3.201s)
[137.724039] [104/165] (874s left) kms_flip (basic-flip-vs-modeset)
[137.875037] Starting subtest: basic-flip-vs-modeset
[137.882579] Starting dynamic subtest: A-HDMI-A2
[139.163136] Dynamic subtest A-HDMI-A2: SUCCESS (1.279s)
[139.183042] Starting dynamic subtest: B-HDMI-A2
[140.155966] Dynamic subtest B-HDMI-A2: SUCCESS (0.982s)
[140.185974] Starting dynamic subtest: C-HDMI-A2
[141.152053] Dynamic subtest C-HDMI-A2: SUCCESS (0.999s)
[141.155219] Subtest basic-flip-vs-modeset: SUCCESS (3.272s)
[141.357815] [105/165] (870s left) kms_flip (basic-flip-vs-wf_vblank)
[141.513050] Starting subtest: basic-flip-vs-wf_vblank
[141.516251] Starting dynamic subtest: A-HDMI-A2
[142.944197] Dynamic subtest A-HDMI-A2: SUCCESS (1.420s)
[142.957606] Starting dynamic subtest: B-HDMI-A2
[144.279626] Dynamic subtest B-HDMI-A2: SUCCESS (1.337s)
[144.295743] Starting dynamic subtest: C-HDMI-A2
[145.630072] Dynamic subtest C-HDMI-A2: SUCCESS (1.349s)
[145.631160] Subtest basic-flip-vs-wf_vblank: SUCCESS (4.120s)
[145.972221] [106/165] (866s left) kms_flip (basic-plain-flip)
[146.123117] Starting subtest: basic-plain-flip
[146.124183] Starting dynamic subtest: A-HDMI-A2
[147.255790] Dynamic subtest A-HDMI-A2: SUCCESS (1.131s)
[147.273421] Starting dynamic subtest: B-HDMI-A2
[148.295764] Dynamic subtest B-HDMI-A2: SUCCESS (1.038s)
[148.312336] Starting dynamic subtest: C-HDMI-A2
[149.335910] Dynamic subtest C-HDMI-A2: SUCCESS (1.035s)
[149.337822] Subtest basic-plain-flip: SUCCESS (3.216s)
[149.675629] [107/165] (862s left) kms_force_connector_basic (force-connector-state)
[149.873060] Starting subtest: force-connector-state
[150.321685] Subtest force-connector-state: SUCCESS (0.444s)
[150.757210] [108/165] (861s left) kms_force_connector_basic (force-edid)
[150.958288] Starting subtest: force-edid
[151.029634] Subtest force-edid: SUCCESS (0.070s)
[151.306388] [109/165] (861s left) kms_force_connector_basic (force-load-detect)
[151.494906] Starting subtest: force-load-detect
[151.499599] Subtest force-load-detect: SKIP (0.000s)
[151.740110] [110/165] (860s left) kms_force_connector_basic (prune-stale-modes)
[151.927615] Starting subtest: prune-stale-modes
[151.973733] Subtest prune-stale-modes: SUCCESS (0.045s)
[152.256712] [111/165] (860s left) kms_frontbuffer_tracking (basic)
[152.448826] Starting subtest: basic
[155.231053] Subtest basic: SUCCESS (2.782s)
[155.325927] [112/165] (857s left) kms_hdmi_inject (inject-audio)
[155.646195] Starting subtest: inject-audio
[155.867209] Subtest inject-audio: SUCCESS (0.215s)
[156.227905] [113/165] (856s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[156.403870] Starting subtest: compare-crc-sanitycheck-xr24
[156.405295] Starting dynamic subtest: pipe-A-HDMI-A-2
[156.954044] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.547s)
[156.970773] Starting dynamic subtest: pipe-B-HDMI-A-2
[157.505175] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.543s)
[157.524931] Starting dynamic subtest: pipe-C-HDMI-A-2
[158.050887] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.536s)
[158.051996] Subtest compare-crc-sanitycheck-xr24: SUCCESS (1.646s)
[158.228931] [114/165] (854s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[158.398239] Starting subtest: compare-crc-sanitycheck-nv12
[158.399305] Starting dynamic subtest: pipe-A-HDMI-A-2
[159.041733] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.636s)
[159.057598] Starting dynamic subtest: pipe-B-HDMI-A-2
[159.658053] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.615s)
[159.683216] Starting dynamic subtest: pipe-C-HDMI-A-2
[160.282297] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.611s)
[160.283970] Subtest compare-crc-sanitycheck-nv12: SUCCESS (1.886s)
[160.442428] [115/165] (852s left) kms_pipe_crc_basic (hang-read-crc)
[160.618743] Starting subtest: hang-read-crc
[160.619888] Starting dynamic subtest: pipe-A-HDMI-A-2
[161.936053] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (1.315s)
[161.951927] Starting dynamic subtest: pipe-B-HDMI-A-2
[163.184896] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (1.242s)
[163.200525] Starting dynamic subtest: pipe-C-HDMI-A-2
[164.488860] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.301s)
[164.489963] Subtest hang-read-crc: SUCCESS (3.876s)
[164.647718] [116/165] (847s left) kms_pipe_crc_basic (nonblocking-crc)
[164.818116] Starting subtest: nonblocking-crc
[164.819194] Starting dynamic subtest: pipe-A-HDMI-A-2
[165.549938] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.729s)
[165.572293] Starting dynamic subtest: pipe-B-HDMI-A-2
[166.259173] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.704s)
[166.279056] Starting dynamic subtest: pipe-C-HDMI-A-2
[166.967802] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.699s)
[166.969927] Subtest nonblocking-crc: SUCCESS (2.150s)
[167.121187] [117/165] (845s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[167.287840] Starting subtest: nonblocking-crc-frame-sequence
[167.296716] Starting dynamic subtest: pipe-A-HDMI-A-2
[168.001080] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.711s)
[168.022086] Starting dynamic subtest: pipe-B-HDMI-A-2
[168.709314] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.698s)
[168.730605] Starting dynamic subtest: pipe-C-HDMI-A-2
[169.425253] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.712s)
[169.426391] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.140s)
[169.584542] [118/165] (843s left) kms_pipe_crc_basic (read-crc)
[169.757601] Starting subtest: read-crc
[169.758785] Starting dynamic subtest: pipe-A-HDMI-A-2
[170.421840] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.661s)
[170.440078] Starting dynamic subtest: pipe-B-HDMI-A-2
[171.111054] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.679s)
[171.127934] Starting dynamic subtest: pipe-C-HDMI-A-2
[171.738882] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.624s)
[171.741142] Subtest read-crc: SUCCESS (1.986s)
[171.907205] [119/165] (840s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[172.075459] Starting subtest: read-crc-frame-sequence
[172.081338] Starting dynamic subtest: pipe-A-HDMI-A-2
[172.742845] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (0.662s)
[172.764964] Starting dynamic subtest: pipe-B-HDMI-A-2
[173.391206] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (0.641s)
[173.411523] Starting dynamic subtest: pipe-C-HDMI-A-2
[174.014638] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.614s)
[174.016074] Subtest read-crc-frame-sequence: SUCCESS (1.940s)
[174.168874] [120/165] (838s left) kms_pm_backlight (basic-brightness)
[174.342496] Subtest basic-brightness: SKIP (0.000s)
[174.389134] [121/165] (838s left) kms_pm_rpm (basic-pci-d3-state)
[176.201776] Starting subtest: basic-pci-d3-state
[176.607446] Subtest basic-pci-d3-state: SUCCESS (0.402s)
[176.848858] [122/165] (835s left) kms_pm_rpm (basic-rte)
[176.956200] Starting subtest: basic-rte
[178.943437] Subtest basic-rte: SUCCESS (1.982s)
[179.685017] [123/165] (833s left) kms_psr (primary_page_flip)
[179.796057] Subtest primary_page_flip: SKIP (0.000s)
[179.840220] [124/165] (832s left) kms_psr (cursor_plane_move)
[179.946900] Subtest cursor_plane_move: SKIP (0.000s)
[179.989541] [125/165] (832s left) kms_psr (sprite_plane_onoff)
[180.094643] Subtest sprite_plane_onoff: SKIP (0.000s)
[180.139671] [126/165] (832s left) kms_psr (primary_mmap_gtt)
[180.247452] Subtest primary_mmap_gtt: SKIP (0.000s)
[180.289996] [127/165] (832s left) kms_setmode (basic-clone-single-crtc)
[180.395234] Starting subtest: basic-clone-single-crtc
[180.399061] Subtest basic-clone-single-crtc: SKIP (0.000s)
[180.469516] [128/165] (832s left) i915_pm_rps (basic-api)
[180.589782] Starting subtest: basic-api
[180.596242] Subtest basic-api: SUCCESS (0.008s)
[180.684953] [129/165] (832s left) prime_self_import (basic-llseek-bad)
[180.789222] Starting subtest: basic-llseek-bad
[180.791746] Subtest basic-llseek-bad: SUCCESS (0.005s)
[180.886131] [130/165] (832s left) prime_self_import (basic-llseek-size)
[180.988584] Starting subtest: basic-llseek-size
[180.995356] Subtest basic-llseek-size: SUCCESS (0.005s)
[181.085780] [131/165] (831s left) prime_self_import (basic-with_fd_dup)
[181.187455] Starting subtest: basic-with_fd_dup
[181.195234] Subtest basic-with_fd_dup: SUCCESS (0.007s)
[181.286366] [132/165] (831s left) prime_self_import (basic-with_one_bo)
[181.390067] Starting subtest: basic-with_one_bo
[181.397245] Subtest basic-with_one_bo: SUCCESS (0.008s)
[181.490554] [133/165] (831s left) prime_self_import (basic-with_one_bo_two_files)
[181.594349] Starting subtest: basic-with_one_bo_two_files
[181.596598] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[181.685923] [134/165] (831s left) prime_self_import (basic-with_two_bos)
[181.795176] Starting subtest: basic-with_two_bos
[181.799221] Subtest basic-with_two_bos: SUCCESS (0.005s)
[181.886844] [135/165] (831s left) prime_vgem (basic-fence-flip)
[182.015823] Starting subtest: basic-fence-flip
[182.490175] Subtest basic-fence-flip: SUCCESS (0.471s)
[182.588279] [136/165] (830s left) prime_vgem (basic-fence-mmap)
[182.715112] Starting subtest: basic-fence-mmap
[182.770897] Subtest basic-fence-mmap: SUCCESS (0.056s)
[182.851840] [137/165] (830s left) prime_vgem (basic-fence-read)
[182.983694] Starting subtest: basic-fence-read
[183.079488] Subtest basic-fence-read: SUCCESS (0.096s)
[183.169197] [138/165] (830s left) prime_vgem (basic-gtt)
[183.296896] Starting subtest: basic-gtt
[183.330623] Subtest basic-gtt: SUCCESS (0.031s)
[183.419680] [139/165] (829s left) prime_vgem (basic-read)
[183.547345] Starting subtest: basic-read
[183.596906] Subtest basic-read: SUCCESS (0.048s)
[183.686302] [140/165] (829s left) prime_vgem (basic-write)
[183.815184] Starting subtest: basic-write
[183.869164] Subtest basic-write: SUCCESS (0.055s)
[183.952258] [141/165] (829s left) vgem_basic (setversion)
[184.072394] Starting subtest: setversion
[184.075475] Subtest setversion: SUCCESS (0.000s)
[184.134754] [142/165] (829s left) vgem_basic (create)
[184.258638] Starting subtest: create
[184.259826] Subtest create: SUCCESS (0.001s)
[184.319552] [143/165] (829s left) vgem_basic (debugfs)
[184.441135] Starting subtest: debugfs
[184.442337] Subtest debugfs: SUCCESS (0.001s)
[184.501564] [144/165] (828s left) vgem_basic (dmabuf-export)
[184.621990] Starting subtest: dmabuf-export
[184.631078] Subtest dmabuf-export: SUCCESS (0.005s)
[184.718658] [145/165] (828s left) vgem_basic (dmabuf-fence)
[184.841076] Starting subtest: dmabuf-fence
[184.842254] Subtest dmabuf-fence: SUCCESS (0.002s)
[184.904172] [146/165] (828s left) vgem_basic (dmabuf-fence-before)
[185.022224] Starting subtest: dmabuf-fence-before
[185.023770] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[185.086643] [147/165] (828s left) vgem_basic (dmabuf-mmap)
[185.206143] Starting subtest: dmabuf-mmap
[185.234678] Subtest dmabuf-mmap: SUCCESS (0.030s)
[185.304141] [148/165] (828s left) vgem_basic (mmap)
[185.423250] Starting subtest: mmap
[185.440716] Subtest mmap: SUCCESS (0.019s)
[185.501368] [149/165] (828s left) vgem_basic (second-client)
[185.623949] Starting subtest: second-client
[185.655206] Subtest second-client: SUCCESS (0.031s)
[185.718907] [150/165] (827s left) vgem_basic (sysfs)
[185.839176] Starting subtest: sysfs
[185.840289] Subtest sysfs: SUCCESS (0.001s)
[185.903837] [151/165] (827s left) core_hotunplug (unbind-rebind)
[186.072156] Starting subtest: unbind-rebind
[189.469616] Subtest unbind-rebind: SUCCESS (3.395s)
[189.503304] [152/165] (824s left) vgem_basic (unload)
[189.623137] Starting subtest: unload
[218.595822] Subtest unload: SUCCESS (28.971s)
[218.720611] [153/165] (794s left) i915_module_load (reload)
[218.822114] Starting subtest: reload
[221.315861] Subtest reload: SUCCESS (2.491s)
[221.402629] [154/165] (792s left) gem_lmem_swapping (basic)
[221.702019] Subtest basic: SKIP (0.000s)
[221.786674] [155/165] (792s left) gem_lmem_swapping (parallel-random-engines)
[221.952766] Subtest parallel-random-engines: SKIP (0.000s)
[221.997987] [156/165] (791s left) gem_lmem_swapping (random-engines)
[222.111354] Subtest random-engines: SKIP (0.000s)
[222.166105] [157/165] (791s left) gem_lmem_swapping (verify-random)
[222.280413] Subtest verify-random: SKIP (0.000s)
[222.333046] [158/165] (791s left) i915_pm_rpm (module-reload)
[224.311881] Starting subtest: module-reload
[231.851034] Subtest module-reload: SUCCESS (7.539s)
[231.880142] [159/165] (782s left) i915_selftest (live)
[232.012237] Starting subtest: live
[232.014828] Starting dynamic subtest: sanitycheck
[233.007591] Dynamic subtest sanitycheck: SUCCESS (0.994s)
[233.021364] Starting dynamic subtest: uncore
[233.847663] Dynamic subtest uncore: SUCCESS (0.835s)
[233.859168] Starting dynamic subtest: workarounds
[234.861272] Dynamic subtest workarounds: SUCCESS (1.010s)
[234.871915] Starting dynamic subtest: gt_engines
[236.307626] Dynamic subtest gt_engines: SUCCESS (1.443s)
[236.318694] Starting dynamic subtest: gt_timelines
[249.259794] Dynamic subtest gt_timelines: SUCCESS (12.950s)
[249.270810] Starting dynamic subtest: gt_contexts
[250.207480] Dynamic subtest gt_contexts: SUCCESS (0.945s)
[250.218275] Starting dynamic subtest: gt_lrc
[253.587756] Dynamic subtest gt_lrc: SUCCESS (3.378s)
[253.598466] Starting dynamic subtest: gt_mocs
[254.558234] Dynamic subtest gt_mocs: SUCCESS (0.967s)
[254.569145] Starting dynamic subtest: gt_pm
[262.308719] Dynamic subtest gt_pm: SUCCESS (7.749s)
[262.320092] Starting dynamic subtest: gt_heartbeat
[263.286749] Dynamic subtest gt_heartbeat: SUCCESS (0.974s)
[263.297766] Starting dynamic subtest: gt_tlb
[265.137162] Dynamic subtest gt_tlb: SUCCESS (1.847s)
[265.148146] Starting dynamic subtest: requests
[272.302145] Dynamic subtest requests: SUCCESS (7.163s)
[272.313849] Starting dynamic subtest: migrate
[275.995656] Dynamic subtest migrate: SUCCESS (3.691s)
[276.007160] Starting dynamic subtest: active
[277.022294] Dynamic subtest active: SUCCESS (1.023s)
[277.033326] Starting dynamic subtest: objects
[279.925218] Dynamic subtest objects: SUCCESS (2.900s)
[279.936267] Starting dynamic subtest: mman
[286.709346] Dynamic subtest mman: SUCCESS (6.783s)
[286.720427] Starting dynamic subtest: dmabuf
[287.598396] Dynamic subtest dmabuf: SUCCESS (0.887s)
[287.609434] Starting dynamic subtest: vma
[288.445092] Dynamic subtest vma: SUCCESS (0.844s)
[288.456409] Starting dynamic subtest: coherency
[291.289582] Dynamic subtest coherency: SUCCESS (2.842s)
[291.300383] Starting dynamic subtest: gtt
[299.531951] Dynamic subtest gtt: SUCCESS (8.240s)
[299.543482] Starting dynamic subtest: gem
[300.480318] Dynamic subtest gem: SUCCESS (0.945s)
[300.491357] Starting dynamic subtest: evict
[303.607479] Dynamic subtest evict: SUCCESS (3.124s)
[303.618736] Starting dynamic subtest: hugepages
[310.999348] Dynamic subtest hugepages: SUCCESS (7.389s)
[311.013200] Starting dynamic subtest: gem_contexts
[327.883186] Dynamic subtest gem_contexts: SUCCESS (16.881s)
[327.897649] Starting dynamic subtest: client
[328.933152] Dynamic subtest client: SUCCESS (1.047s)
[328.944641] Starting dynamic subtest: gem_migrate
[329.733837] Dynamic subtest gem_migrate: SUCCESS (0.799s)
[329.747173] Starting dynamic subtest: reset
[334.790217] Dynamic subtest reset: SUCCESS (5.051s)
[334.801470] Starting dynamic subtest: memory_region
[335.778867] Dynamic subtest memory_region: SUCCESS (0.987s)
[335.792381] Starting dynamic subtest: hangcheck
[359.866363] Dynamic subtest hangcheck: SUCCESS (24.084s)
[359.877582] Starting dynamic subtest: execlists
[369.708238] Dynamic subtest execlists: SUCCESS (9.837s)
[369.719765] Starting dynamic subtest: ring_submission
[370.687184] Dynamic subtest ring_submission: SUCCESS (0.978s)
[370.698356] Starting dynamic subtest: perf
[371.601214] Dynamic subtest perf: SUCCESS (0.909s)
[371.612849] Starting dynamic subtest: slpc
[372.457622] Dynamic subtest slpc: SUCCESS (0.856s)
[372.469221] Starting dynamic subtest: guc
[373.423295] Dynamic subtest guc: SUCCESS (0.963s)
[373.434689] Starting dynamic subtest: guc_multi_lrc
[374.420419] Dynamic subtest guc_multi_lrc: SUCCESS (0.995s)
[374.432071] Starting dynamic subtest: guc_hang
[375.194024] Dynamic subtest guc_hang: SUCCESS (0.771s)
[375.205287] Starting dynamic subtest: late_gt_pm
[376.039177] Dynamic subtest late_gt_pm: SUCCESS (0.843s)
[376.040311] Subtest live: SUCCESS (144.028s)
[376.073190] [160/165] (637s left) dmabuf (all-tests)
[376.184990] Starting subtest: all-tests
[376.191980] Starting dynamic subtest: sanitycheck
[376.254811] Dynamic subtest sanitycheck: SUCCESS (0.067s)
[376.271614] Starting dynamic subtest: dma_fence
[376.444753] Dynamic subtest dma_fence: SUCCESS (0.182s)
[376.458028] Starting dynamic subtest: dma_fence_chain
[394.208917] Dynamic subtest dma_fence_chain: SUCCESS (17.764s)
[394.225178] Starting dynamic subtest: dma_fence_unwrap
[394.269044] Dynamic subtest dma_fence_unwrap: SUCCESS (0.055s)
[394.289207] Starting dynamic subtest: dma_resv
[394.325896] Dynamic subtest dma_resv: SUCCESS (0.056s)
[394.329114] Subtest all-tests: SUCCESS (18.142s)
[394.357444] [161/165] (619s left) i915_suspend (basic-s2idle-without-i915)
[394.460839] Starting subtest: basic-s2idle-without-i915
[413.173439] Subtest basic-s2idle-without-i915: SUCCESS (4.120s)
[417.442604] [162/165] (615s left) i915_suspend (basic-s3-without-i915)
[417.552252] Starting subtest: basic-s3-without-i915
[436.862736] Subtest basic-s3-without-i915: SUCCESS (2.464s)
[439.908706] [163/165] (611s left) gem_exec_suspend (basic-s0)
[440.047999] Starting subtest: basic-S0
[440.050846] Starting dynamic subtest: smem
[459.676851] Dynamic subtest smem: SUCCESS (4.365s)
[459.678067] Subtest basic-S0: SUCCESS (4.368s)
[464.841785] [164/165] (607s left) gem_exec_suspend (basic-s3)
[464.965882] Starting subtest: basic-S3
[464.967078] Starting dynamic subtest: smem
[486.319164] Dynamic subtest smem: SUCCESS (4.094s)
[486.320595] Subtest basic-S3: SUCCESS (4.096s)
[489.352952] [165/165] (602s left) kms_pipe_crc_basic (suspend-read-crc)
[489.520934] Starting subtest: suspend-read-crc
[489.522198] Starting dynamic subtest: pipe-A-HDMI-A-2
[509.231891] Dynamic subtest pipe-A-HDMI-A-2: SUCCESS (2.092s)
[509.246828] Starting dynamic subtest: pipe-B-HDMI-A-2
[528.236544] Dynamic subtest pipe-B-HDMI-A-2: SUCCESS (2.339s)
[528.251723] Starting dynamic subtest: pipe-C-HDMI-A-2
[547.225627] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (2.540s)
[547.226682] Subtest suspend-read-crc: SUCCESS (6.984s)
[552.276191] Closing watchdogs
Done.