[43.408230] Initializing watchdogs
[43.408444]   /dev/watchdog0
[43.434094] [001/165] (960s left) i915_module_load (load)
[43.884710] Starting subtest: load
[45.422469] Subtest load: SUCCESS (1.519s)
[45.517872] [002/165] (958s left) core_auth (basic-auth)
[45.727978] Starting subtest: basic-auth
[45.749501] Subtest basic-auth: SUCCESS (0.001s)
[45.828577] [003/165] (958s left) debugfs_test (read_all_entries)
[46.006437] Starting subtest: read_all_entries
[46.029917] Subtest read_all_entries: SUCCESS (0.049s)
[46.138842] [004/165] (958s left) debugfs_test (basic-hwmon)
[46.305140] Starting subtest: basic-hwmon
[46.343250] Subtest basic-hwmon: SKIP (0.000s)
[46.422366] [005/165] (957s left) fbdev (eof)
[46.580074] Starting subtest: eof
[46.599241] Subtest eof: SUCCESS (0.001s)
[46.704690] [006/165] (957s left) fbdev (info)
[46.874740] Starting subtest: info
[46.895978] Subtest info: SUCCESS (0.000s)
[46.997890] [007/165] (957s left) fbdev (nullptr)
[47.147124] Starting subtest: nullptr
[47.169102] Subtest nullptr: SUCCESS (0.000s)
[47.269040] [008/165] (957s left) fbdev (read)
[47.416291] Starting subtest: read
[47.689341] Subtest read: SUCCESS (0.277s)
[47.806173] [009/165] (956s left) fbdev (write)
[47.947169] Starting subtest: write
[48.095497] Subtest write: SUCCESS (0.151s)
[48.197091] [010/165] (956s left) gem_basic (bad-close)
[48.355252] Starting subtest: bad-close
[48.398484] Subtest bad-close: SUCCESS (0.000s)
[48.479737] [011/165] (956s left) gem_basic (create-close)
[48.662048] Starting subtest: create-close
[48.703125] Subtest create-close: SUCCESS (0.000s)
[48.777946] [012/165] (956s left) gem_basic (create-fd-close)
[48.960257] Starting subtest: create-fd-close
[48.998069] Subtest create-fd-close: SUCCESS (0.000s)
[49.085665] [013/165] (955s left) gem_busy (busy@all-engines)
[49.457332] Starting subtest: busy
[49.480403] Starting dynamic subtest: all-engines
[49.501382] Dynamic subtest all-engines: SUCCESS (0.033s)
[49.523610] Subtest busy: SUCCESS (0.034s)
[49.680486] [014/165] (955s left) gem_close_race (basic-process)
[49.864974] Starting subtest: basic-process
[49.913760] Subtest basic-process: SUCCESS (0.057s)
[50.100328] [015/165] (954s left) gem_close_race (basic-threads)
[50.293495] Starting subtest: basic-threads
[51.466179] Subtest basic-threads: SUCCESS (1.194s)
[51.675157] [016/165] (953s left) gem_ctx_create (basic)
[51.893308] Starting subtest: basic
[51.918510] Subtest basic: SUCCESS (0.000s)
[52.071574] [017/165] (953s left) gem_ctx_create (basic-files)
[52.267645] Starting subtest: basic-files
[54.288955] Subtest basic-files: SUCCESS (2.021s)
[54.527527] [018/165] (950s left) gem_ctx_exec (basic)
[54.708698] Starting subtest: basic
[54.728166] Subtest basic: SUCCESS (0.001s)
[54.809202] [019/165] (950s left) gem_exec_basic (basic)
[54.983453] Starting subtest: basic
[55.005221] Starting dynamic subtest: rcs0-smem
[55.027136] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[55.059055] Starting dynamic subtest: vcs0-smem
[55.081045] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[55.107466] Subtest basic: SUCCESS (0.001s)
[55.183590] [020/165] (950s left) gem_exec_create (basic)
[55.350039] Starting subtest: basic
[55.370967] Starting dynamic subtest: smem
[57.387666] Dynamic subtest smem: SUCCESS (2.049s)
[57.408861] Subtest basic: SUCCESS (2.049s)
[57.590617] [021/165] (947s left) gem_exec_fence (basic-busy)
[57.883046] Starting subtest: basic-busy
[57.904040] Starting dynamic subtest: rcs0
[57.945313] Dynamic subtest rcs0: SUCCESS (0.024s)
[57.975106] Starting dynamic subtest: vcs0
[58.013906] Dynamic subtest vcs0: SUCCESS (0.022s)
[58.035379] Subtest basic-busy: SUCCESS (0.046s)
[58.512281] [022/165] (947s left) gem_exec_fence (basic-wait)
[58.797869] Starting subtest: basic-wait
[58.817065] Starting dynamic subtest: rcs0
[58.836216] Dynamic subtest rcs0: SUCCESS (0.026s)
[58.868261] Starting dynamic subtest: vcs0
[58.890252] Dynamic subtest vcs0: SUCCESS (0.030s)
[58.911431] Subtest basic-wait: SUCCESS (0.056s)
[59.367374] [023/165] (946s left) gem_exec_fence (basic-await)
[59.667860] Starting subtest: basic-await
[59.686699] Starting dynamic subtest: rcs0
[59.743651] Dynamic subtest rcs0: SUCCESS (0.071s)
[59.771679] Starting dynamic subtest: vcs0
[59.813583] Dynamic subtest vcs0: SUCCESS (0.071s)
[59.832890] Subtest basic-await: SUCCESS (0.142s)
[60.326370] [024/165] (945s left) gem_exec_fence (nb-await)
[60.614385] Starting subtest: nb-await
[60.636238] Starting dynamic subtest: rcs0
[60.679151] Dynamic subtest rcs0: SUCCESS (0.054s)
[60.716092] Starting dynamic subtest: vcs0
[60.735637] Dynamic subtest vcs0: SUCCESS (0.053s)
[60.755118] Subtest nb-await: SUCCESS (0.107s)
[61.248379] [025/165] (944s left) gem_exec_gttfill (basic)
[61.427699] Starting subtest: basic
[71.017883] Subtest basic: SUCCESS (9.608s)
[71.242340] [026/165] (934s left) gem_exec_parallel (engines)
[71.551862] Starting subtest: engines
[71.573271] Starting dynamic subtest: basic
[73.161998] Dynamic subtest basic: SUCCESS (1.622s)
[73.191485] Starting dynamic subtest: contexts
[75.258104] Dynamic subtest contexts: SUCCESS (2.101s)
[75.285779] Starting dynamic subtest: fds
[75.324537] Dynamic subtest fds: SKIP (0.001s)
[75.350095] Starting dynamic subtest: userptr
[76.902715] Dynamic subtest userptr: SUCCESS (1.639s)
[76.924621] Subtest engines: SUCCESS (5.363s)
[77.104589] [027/165] (928s left) gem_exec_store (basic)
[77.352145] Starting subtest: basic
[77.373897] Subtest basic: SUCCESS (0.035s)
[77.522972] [028/165] (928s left) gem_flink_basic (bad-flink)
[77.706757] Starting subtest: bad-flink
[77.726130] Subtest bad-flink: SUCCESS (0.000s)
[77.804735] [029/165] (928s left) gem_flink_basic (bad-open)
[77.979367] Starting subtest: bad-open
[77.998358] Subtest bad-open: SUCCESS (0.000s)
[78.084545] [030/165] (928s left) gem_flink_basic (basic)
[78.243714] Starting subtest: basic
[78.265418] Subtest basic: SUCCESS (0.000s)
[78.353203] [031/165] (927s left) gem_flink_basic (double-flink)
[78.530809] Starting subtest: double-flink
[78.551668] Subtest double-flink: SUCCESS (0.000s)
[78.629948] [032/165] (927s left) gem_flink_basic (flink-lifetime)
[78.827633] Starting subtest: flink-lifetime
[78.846766] Subtest flink-lifetime: SUCCESS (0.001s)
[78.924053] [033/165] (927s left) gem_huc_copy (huc-copy)
[79.124723] Subtest huc-copy: SKIP (0.000s)
[79.208905] [034/165] (927s left) gem_linear_blits (basic)
[79.457714] Starting subtest: basic
[79.479847] Subtest basic: SUCCESS (0.014s)
[79.636778] [035/165] (926s left) gem_mmap (basic)
[79.922978] Starting subtest: basic
[80.021859] Subtest basic: SUCCESS (0.001s)
[80.116362] [036/165] (926s left) gem_mmap_gtt (basic)
[80.315182] Starting subtest: basic
[80.337162] Subtest basic: SUCCESS (0.001s)
[80.414628] [037/165] (926s left) gem_render_linear_blits (basic)
[80.608082] Starting subtest: basic
[80.707398] Subtest basic: SUCCESS (0.035s)
[80.788822] [038/165] (926s left) gem_render_tiled_blits (basic)
[80.959571] Starting subtest: basic
[81.079601] Subtest basic: SUCCESS (0.037s)
[81.168281] [039/165] (925s left) gem_ringfill (basic-all)
[81.445012] Starting subtest: basic-all
[82.514155] Subtest basic-all: SUCCESS (1.116s)
[82.620746] [040/165] (924s left) gem_softpin (allocator-basic)
[82.826045] Subtest allocator-basic: SKIP (0.000s)
[82.930509] [041/165] (924s left) gem_softpin (allocator-basic-reserve)
[83.142783] Subtest allocator-basic-reserve: SKIP (0.000s)
[83.248189] [042/165] (923s left) gem_softpin (safe-alignment)
[83.491279] Starting subtest: safe-alignment
[83.514467] Subtest safe-alignment: SUCCESS (0.010s)
[83.602834] [043/165] (923s left) gem_sync (basic-all)
[83.872460] Starting subtest: basic-all
[85.948526] Subtest basic-all: SUCCESS (2.159s)
[86.162546] [044/165] (921s left) gem_sync (basic-each)
[86.382594] Starting subtest: basic-each
[88.462345] Subtest basic-each: SUCCESS (2.126s)
[88.675116] [045/165] (918s left) gem_tiled_blits (basic)
[88.928731] Starting subtest: basic
[88.974056] Subtest basic: SUCCESS (0.031s)
[89.112983] [046/165] (918s left) gem_tiled_fence_blits (basic)
[89.516480] Starting subtest: basic
[89.544574] Subtest basic: SUCCESS (0.013s)
[89.683413] [047/165] (917s left) gem_tiled_pread_basic
[90.220403] [048/165] (917s left) gem_wait (busy@all-engines)
[90.415402] Starting subtest: busy
[90.433671] Starting dynamic subtest: all-engines
[90.931621] Dynamic subtest all-engines: SUCCESS (0.519s)
[90.952846] Subtest busy: SUCCESS (0.519s)
[91.193813] [049/165] (916s left) gem_wait (wait@all-engines)
[91.389254] Starting subtest: wait
[91.410856] Starting dynamic subtest: all-engines
[92.415099] Dynamic subtest all-engines: SUCCESS (1.024s)
[92.434308] Subtest wait: SUCCESS (1.024s)
[92.663075] [050/165] (915s left) i915_getparams_basic (basic-eu-total)
[92.823402] Starting subtest: basic-eu-total
[92.864088] Subtest basic-eu-total: SUCCESS (0.000s)
[92.945891] [051/165] (914s left) i915_getparams_basic (basic-subslice-total)
[93.131159] Starting subtest: basic-subslice-total
[93.179718] Subtest basic-subslice-total: SUCCESS (0.000s)
[93.262740] [052/165] (914s left) i915_hangman (error-state-basic)
[93.459056] Starting subtest: error-state-basic
[93.478085] Subtest error-state-basic: SUCCESS (0.004s)
[93.580694] [053/165] (914s left) i915_pciid
[93.860192] [054/165] (914s left) kms_addfb_basic (addfb25-4-tiled)
[94.077548] Starting subtest: addfb25-4-tiled
[94.098858] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[94.185957] [055/165] (913s left) kms_addfb_basic (addfb25-bad-modifier)
[94.364287] Starting subtest: addfb25-bad-modifier
[94.383716] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[94.464656] [056/165] (913s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[94.640088] Starting subtest: addfb25-framebuffer-vs-set-tiling
[94.658987] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[94.754651] [057/165] (913s left) kms_addfb_basic (addfb25-modifier-no-flag)
[94.930392] Starting subtest: addfb25-modifier-no-flag
[94.952799] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[95.035679] [058/165] (913s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[95.224114] Starting subtest: addfb25-x-tiled-legacy
[95.245071] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[95.325755] [059/165] (913s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[95.511298] Starting subtest: addfb25-x-tiled-mismatch-legacy
[95.530884] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[95.614655] [060/165] (912s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[95.811638] Starting subtest: addfb25-yf-tiled-legacy
[95.830736] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[95.941945] [061/165] (912s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[96.144978] Starting subtest: addfb25-y-tiled-legacy
[96.166860] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[96.251324] [062/165] (912s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[96.422131] Starting subtest: addfb25-y-tiled-small-legacy
[96.459872] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[96.541326] [063/165] (912s left) kms_addfb_basic (bad-pitch-0)
[96.719255] Starting subtest: bad-pitch-0
[96.738848] Subtest bad-pitch-0: SUCCESS (0.000s)
[96.826424] [064/165] (911s left) kms_addfb_basic (bad-pitch-1024)
[96.983530] Starting subtest: bad-pitch-1024
[97.004697] Subtest bad-pitch-1024: SUCCESS (0.000s)
[97.090256] [065/165] (911s left) kms_addfb_basic (bad-pitch-128)
[97.276077] Starting subtest: bad-pitch-128
[97.296856] Subtest bad-pitch-128: SUCCESS (0.000s)
[97.379762] [066/165] (911s left) kms_addfb_basic (bad-pitch-256)
[97.569233] Starting subtest: bad-pitch-256
[97.587880] Subtest bad-pitch-256: SUCCESS (0.000s)
[97.667836] [067/165] (911s left) kms_addfb_basic (bad-pitch-32)
[97.846397] Starting subtest: bad-pitch-32
[97.865499] Subtest bad-pitch-32: SUCCESS (0.000s)
[97.948333] [068/165] (911s left) kms_addfb_basic (bad-pitch-63)
[98.137197] Starting subtest: bad-pitch-63
[98.161189] Subtest bad-pitch-63: SUCCESS (0.000s)
[98.243893] [069/165] (910s left) kms_addfb_basic (bad-pitch-65536)
[98.424452] Starting subtest: bad-pitch-65536
[98.445502] Subtest bad-pitch-65536: SUCCESS (0.000s)
[98.524789] [070/165] (910s left) kms_addfb_basic (bad-pitch-999)
[98.714486] Starting subtest: bad-pitch-999
[98.733389] Subtest bad-pitch-999: SUCCESS (0.000s)
[98.812760] [071/165] (910s left) kms_addfb_basic (basic)
[99.000299] Starting subtest: basic
[99.019072] Subtest basic: SUCCESS (0.000s)
[99.102772] [072/165] (910s left) kms_addfb_basic (basic-x-tiled-legacy)
[99.297132] Starting subtest: basic-x-tiled-legacy
[99.318804] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[99.400271] [073/165] (910s left) kms_addfb_basic (basic-y-tiled-legacy)
[99.573282] Starting subtest: basic-y-tiled-legacy
[99.594226] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[99.673905] [074/165] (909s left) kms_addfb_basic (bo-too-small)
[99.870148] Starting subtest: bo-too-small
[99.889977] Subtest bo-too-small: SUCCESS (0.000s)
[99.972980] [075/165] (909s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[100.162710] Starting subtest: bo-too-small-due-to-tiling
[100.183646] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[100.271623] [076/165] (909s left) kms_addfb_basic (clobberred-modifier)
[100.454109] Starting subtest: clobberred-modifier
[100.474514] Subtest clobberred-modifier: SUCCESS (0.000s)
[100.564124] [077/165] (909s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[100.743712] Starting subtest: framebuffer-vs-set-tiling
[100.762809] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[100.846700] [078/165] (909s left) kms_addfb_basic (invalid-get-prop)
[101.019064] Starting subtest: invalid-get-prop
[101.037575] Subtest invalid-get-prop: SUCCESS (0.000s)
[101.118042] [079/165] (908s left) kms_addfb_basic (invalid-get-prop-any)
[101.298792] Starting subtest: invalid-get-prop-any
[101.320319] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[101.407890] [080/165] (908s left) kms_addfb_basic (invalid-set-prop)
[101.586387] Starting subtest: invalid-set-prop
[101.607704] Subtest invalid-set-prop: SUCCESS (0.000s)
[101.689699] [081/165] (908s left) kms_addfb_basic (invalid-set-prop-any)
[101.888549] Starting subtest: invalid-set-prop-any
[101.907788] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[101.989250] [082/165] (908s left) kms_addfb_basic (no-handle)
[102.173081] Starting subtest: no-handle
[102.192892] Subtest no-handle: SUCCESS (0.000s)
[102.275916] [083/165] (907s left) kms_addfb_basic (size-max)
[102.462398] Starting subtest: size-max
[102.484372] Subtest size-max: SUCCESS (0.000s)
[102.570549] [084/165] (907s left) kms_addfb_basic (small-bo)
[102.757654] Starting subtest: small-bo
[102.778937] Subtest small-bo: SUCCESS (0.000s)
[102.859108] [085/165] (907s left) kms_addfb_basic (tile-pitch-mismatch)
[103.051721] Starting subtest: tile-pitch-mismatch
[103.077334] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[103.175255] [086/165] (907s left) kms_addfb_basic (too-high)
[103.379278] Starting subtest: too-high
[103.402658] Subtest too-high: SUCCESS (0.001s)
[103.504275] [087/165] (907s left) kms_addfb_basic (too-wide)
[103.721521] Starting subtest: too-wide
[103.755732] Subtest too-wide: SUCCESS (0.000s)
[103.852856] [088/165] (906s left) kms_addfb_basic (unused-handle)
[104.060539] Starting subtest: unused-handle
[104.083090] Subtest unused-handle: SUCCESS (0.000s)
[104.187250] [089/165] (906s left) kms_addfb_basic (unused-modifier)
[104.418349] Starting subtest: unused-modifier
[104.445938] Subtest unused-modifier: SUCCESS (0.000s)
[104.552680] [090/165] (906s left) kms_addfb_basic (unused-offsets)
[104.754303] Starting subtest: unused-offsets
[104.781445] Subtest unused-offsets: SUCCESS (0.000s)
[104.877905] [091/165] (906s left) kms_addfb_basic (unused-pitches)
[105.087248] Starting subtest: unused-pitches
[105.113545] Subtest unused-pitches: SUCCESS (0.000s)
[105.227549] [092/165] (905s left) kms_busy (basic)
[105.403316] Starting subtest: basic
[105.422297] Starting dynamic subtest: flip
[106.168131] Dynamic subtest flip: SUCCESS (0.753s)
[106.197969] Starting dynamic subtest: modeset
[106.787028] Dynamic subtest modeset: SUCCESS (0.627s)
[106.807601] Subtest basic: SUCCESS (1.381s)
[106.962220] [093/165] (904s left) kms_prop_blob (basic)
[107.167298] Starting subtest: basic
[107.186415] Subtest basic: SUCCESS (0.000s)
[107.268205] [094/165] (903s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[107.470686] Starting subtest: basic-busy-flip-before-cursor-atomic
[108.465789] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.993s)
[108.638560] [095/165] (902s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[108.830223] Starting subtest: basic-busy-flip-before-cursor-legacy
[109.809872] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.989s)
[109.998700] [096/165] (901s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[110.198634] Starting subtest: basic-flip-after-cursor-atomic
[111.185588] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.981s)
[111.357040] [097/165] (900s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[111.530727] Starting subtest: basic-flip-after-cursor-legacy
[112.509856] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.980s)
[112.674613] [098/165] (898s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[112.862631] Starting subtest: basic-flip-after-cursor-varying-size
[113.852343] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.984s)
[114.012354] [099/165] (897s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[114.201410] Starting subtest: basic-flip-before-cursor-atomic
[115.176181] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.972s)
[115.335326] [100/165] (896s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[115.529023] Starting subtest: basic-flip-before-cursor-legacy
[116.490774] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.974s)
[116.655147] [101/165] (895s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[116.836256] Starting subtest: basic-flip-before-cursor-varying-size
[117.834339] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.984s)
[117.984804] [102/165] (893s left) kms_dsc (dsc-basic)
[118.194180] Subtest dsc-basic: SKIP (0.000s)
[118.280934] [103/165] (893s left) kms_flip (basic-flip-vs-dpms)
[118.481873] Starting subtest: basic-flip-vs-dpms
[118.502145] Starting dynamic subtest: A-VGA1
[119.783735] Dynamic subtest A-VGA1: SUCCESS (1.331s)
[119.815728] Starting dynamic subtest: B-VGA1
[121.023310] Dynamic subtest B-VGA1: SUCCESS (1.236s)
[121.043905] Subtest basic-flip-vs-dpms: SUCCESS (2.571s)
[121.195686] [104/165] (890s left) kms_flip (basic-flip-vs-modeset)
[121.410771] Starting subtest: basic-flip-vs-modeset
[121.432238] Starting dynamic subtest: A-VGA1
[122.730692] Dynamic subtest A-VGA1: SUCCESS (1.346s)
[122.767344] Starting dynamic subtest: B-VGA1
[123.996469] Dynamic subtest B-VGA1: SUCCESS (1.269s)
[124.015080] Subtest basic-flip-vs-modeset: SUCCESS (2.618s)
[124.176466] [105/165] (887s left) kms_flip (basic-flip-vs-wf_vblank)
[124.409416] Starting subtest: basic-flip-vs-wf_vblank
[124.431413] Starting dynamic subtest: A-VGA1
[125.898148] Dynamic subtest A-VGA1: SUCCESS (1.536s)
[125.927065] Starting dynamic subtest: B-VGA1
[127.407769] Dynamic subtest B-VGA1: SUCCESS (1.500s)
[127.431568] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.041s)
[127.641329] [106/165] (884s left) kms_flip (basic-plain-flip)
[127.890659] Starting subtest: basic-plain-flip
[127.920914] Starting dynamic subtest: A-VGA1
[129.085213] Dynamic subtest A-VGA1: SUCCESS (1.256s)
[129.684093] Starting dynamic subtest: B-VGA1
[130.296669] Dynamic subtest B-VGA1: SUCCESS (1.212s)
[130.322377] Subtest basic-plain-flip: SUCCESS (2.473s)
[130.543860] [107/165] (881s left) kms_force_connector_basic (force-connector-state)
[130.750267] Starting subtest: force-connector-state
[130.871835] Subtest force-connector-state: SUCCESS (0.119s)
[131.104407] [108/165] (881s left) kms_force_connector_basic (force-edid)
[131.319215] Starting subtest: force-edid
[131.344392] Subtest force-edid: SUCCESS (0.021s)
[131.444561] [109/165] (880s left) kms_force_connector_basic (force-load-detect)
[131.645158] Starting subtest: force-load-detect
[131.781753] Subtest force-load-detect: SUCCESS (0.161s)
[132.001097] [110/165] (880s left) kms_force_connector_basic (prune-stale-modes)
[132.205780] Starting subtest: prune-stale-modes
[132.227615] Subtest prune-stale-modes: SUCCESS (0.021s)
[132.358418] [111/165] (880s left) kms_frontbuffer_tracking (basic)
[132.610130] Starting subtest: basic
[134.798238] Subtest basic: SUCCESS (2.252s)
[134.933670] [112/165] (877s left) kms_hdmi_inject (inject-audio)
[135.148266] Starting subtest: inject-audio
[135.318923] Subtest inject-audio: SUCCESS (0.154s)
[135.563344] [113/165] (877s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[135.758377] Starting subtest: compare-crc-sanitycheck-xr24
[135.778554] Starting dynamic subtest: pipe-A-VGA-1
[136.082887] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.319s)
[136.112779] Starting dynamic subtest: pipe-B-VGA-1
[136.420210] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.334s)
[136.441917] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.656s)
[136.588337] [114/165] (876s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[136.771609] Starting subtest: compare-crc-sanitycheck-nv12
[136.791414] Starting dynamic subtest: pipe-A-VGA-1
[136.832377] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[136.867672] Starting dynamic subtest: pipe-B-VGA-1
[136.910908] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[136.951508] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s)
[137.039406] [115/165] (875s left) kms_pipe_crc_basic (hang-read-crc)
[137.222835] Starting subtest: hang-read-crc
[137.242714] Starting dynamic subtest: pipe-A-VGA-1
[138.089407] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.865s)
[138.116372] Starting dynamic subtest: pipe-B-VGA-1
[138.980104] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.888s)
[139.000782] Subtest hang-read-crc: SUCCESS (1.757s)
[139.134286] [116/165] (873s left) kms_pipe_crc_basic (nonblocking-crc)
[139.334556] Starting subtest: nonblocking-crc
[139.354517] Starting dynamic subtest: pipe-A-VGA-1
[139.838374] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.496s)
[139.867455] Starting dynamic subtest: pipe-B-VGA-1
[140.356702] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.521s)
[140.375900] Subtest nonblocking-crc: SUCCESS (1.022s)
[140.519213] [117/165] (872s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[140.709886] Starting subtest: nonblocking-crc-frame-sequence
[140.731941] Starting dynamic subtest: pipe-A-VGA-1
[141.202743] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.494s)
[141.232265] Starting dynamic subtest: pipe-B-VGA-1
[141.712880] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.504s)
[141.732728] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.003s)
[141.861962] [118/165] (871s left) kms_pipe_crc_basic (read-crc)
[142.042261] Starting subtest: read-crc
[142.064752] Starting dynamic subtest: pipe-A-VGA-1
[142.445059] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.404s)
[142.473553] Starting dynamic subtest: pipe-B-VGA-1
[142.892180] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.447s)
[142.913863] Subtest read-crc: SUCCESS (0.855s)
[143.051593] [119/165] (870s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[143.237558] Starting subtest: read-crc-frame-sequence
[143.257269] Starting dynamic subtest: pipe-A-VGA-1
[143.645436] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.411s)
[143.675714] Starting dynamic subtest: pipe-B-VGA-1
[144.093986] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.453s)
[144.113111] Subtest read-crc-frame-sequence: SUCCESS (0.869s)
[144.269513] [120/165] (868s left) kms_pm_backlight (basic-brightness)
[144.487504] Subtest basic-brightness: SKIP (0.000s)
[144.576569] [121/165] (868s left) kms_pm_rpm (basic-pci-d3-state)
[146.095646] Subtest basic-pci-d3-state: SKIP (0.000s)
[146.181690] [122/165] (867s left) kms_pm_rpm (basic-rte)
[146.345088] Starting subtest: basic-rte
[148.008289] Subtest basic-rte: SKIP (1.585s)
[148.132726] [123/165] (865s left) kms_psr (primary_page_flip)
[148.338653] Subtest primary_page_flip: SKIP (0.000s)
[148.421095] [124/165] (865s left) kms_psr (cursor_plane_move)
[148.662727] Subtest cursor_plane_move: SKIP (0.000s)
[148.767143] [125/165] (865s left) kms_psr (sprite_plane_onoff)
[148.997972] Subtest sprite_plane_onoff: SKIP (0.000s)
[149.102742] [126/165] (865s left) kms_psr (primary_mmap_gtt)
[149.354505] Subtest primary_mmap_gtt: SKIP (0.000s)
[149.464044] [127/165] (864s left) kms_setmode (basic-clone-single-crtc)
[149.656517] Starting subtest: basic-clone-single-crtc
[149.735465] Subtest basic-clone-single-crtc: SKIP (0.000s)
[149.835238] [128/165] (864s left) i915_pm_rps (basic-api)
[150.093428] Subtest basic-api: SKIP (0.000s)
[150.206379] [129/165] (864s left) prime_self_import (basic-llseek-bad)
[150.398335] Starting subtest: basic-llseek-bad
[150.439393] Subtest basic-llseek-bad: SUCCESS (0.002s)
[150.525170] [130/165] (864s left) prime_self_import (basic-llseek-size)
[150.682962] Starting subtest: basic-llseek-size
[150.731608] Subtest basic-llseek-size: SUCCESS (0.005s)
[150.815107] [131/165] (863s left) prime_self_import (basic-with_fd_dup)
[150.996766] Starting subtest: basic-with_fd_dup
[151.038134] Subtest basic-with_fd_dup: SUCCESS (0.003s)
[151.119075] [132/165] (863s left) prime_self_import (basic-with_one_bo)
[151.278627] Starting subtest: basic-with_one_bo
[151.318331] Subtest basic-with_one_bo: SUCCESS (0.003s)
[151.401607] [133/165] (863s left) prime_self_import (basic-with_one_bo_two_files)
[151.570871] Starting subtest: basic-with_one_bo_two_files
[151.619437] Subtest basic-with_one_bo_two_files: SUCCESS (0.005s)
[151.702327] [134/165] (863s left) prime_self_import (basic-with_two_bos)
[151.875695] Starting subtest: basic-with_two_bos
[151.922515] Subtest basic-with_two_bos: SUCCESS (0.004s)
[152.005247] [135/165] (863s left) prime_vgem (basic-fence-flip)
[152.226502] Starting subtest: basic-fence-flip
[152.552132] Subtest basic-fence-flip: SUCCESS (0.362s)
[152.683239] [136/165] (862s left) prime_vgem (basic-fence-mmap)
[152.891496] Starting subtest: basic-fence-mmap
[152.911534] Subtest basic-fence-mmap: SUCCESS (0.050s)
[153.020233] [137/165] (862s left) prime_vgem (basic-fence-read)
[153.246863] Starting subtest: basic-fence-read
[153.291064] Subtest basic-fence-read: SUCCESS (0.089s)
[153.394898] [138/165] (861s left) prime_vgem (basic-gtt)
[153.581915] Starting subtest: basic-gtt
[153.603542] Subtest basic-gtt: SUCCESS (0.026s)
[153.712252] [139/165] (861s left) prime_vgem (basic-read)
[153.945306] Starting subtest: basic-read
[153.964856] Subtest basic-read: SUCCESS (0.034s)
[154.080390] [140/165] (861s left) prime_vgem (basic-write)
[154.310915] Starting subtest: basic-write
[154.332496] Subtest basic-write: SUCCESS (0.037s)
[154.436423] [141/165] (861s left) vgem_basic (setversion)
[154.639415] Starting subtest: setversion
[154.679753] Subtest setversion: SUCCESS (0.000s)
[154.768510] [142/165] (860s left) vgem_basic (create)
[154.965213] Starting subtest: create
[154.987749] Subtest create: SUCCESS (0.000s)
[155.074032] [143/165] (860s left) vgem_basic (debugfs)
[155.243302] Starting subtest: debugfs
[155.264630] Subtest debugfs: SUCCESS (0.001s)
[155.350146] [144/165] (860s left) vgem_basic (dmabuf-export)
[155.544421] Starting subtest: dmabuf-export
[155.585687] Subtest dmabuf-export: SUCCESS (0.004s)
[155.662194] [145/165] (860s left) vgem_basic (dmabuf-fence)
[155.837512] Starting subtest: dmabuf-fence
[155.858292] Subtest dmabuf-fence: SUCCESS (0.001s)
[155.944759] [146/165] (860s left) vgem_basic (dmabuf-fence-before)
[156.139141] Starting subtest: dmabuf-fence-before
[156.161339] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[156.244450] [147/165] (859s left) vgem_basic (dmabuf-mmap)
[156.429359] Starting subtest: dmabuf-mmap
[156.454441] Subtest dmabuf-mmap: SUCCESS (0.026s)
[156.549631] [148/165] (859s left) vgem_basic (mmap)
[156.768811] Starting subtest: mmap
[156.789938] Subtest mmap: SUCCESS (0.019s)
[156.878646] [149/165] (859s left) vgem_basic (second-client)
[157.079343] Starting subtest: second-client
[157.123119] Subtest second-client: SUCCESS (0.033s)
[157.204770] [150/165] (859s left) vgem_basic (sysfs)
[157.395801] Starting subtest: sysfs
[157.415419] Subtest sysfs: SUCCESS (0.002s)
[157.497167] [151/165] (858s left) core_hotunplug (unbind-rebind)
[157.742428] Starting subtest: unbind-rebind
[160.555751] Subtest unbind-rebind: SUCCESS (2.818s)
[160.637866] [152/165] (855s left) vgem_basic (unload)
[160.793408] Starting subtest: unload
[189.931898] Subtest unload: SUCCESS (28.970s)
[190.015919] [153/165] (826s left) i915_module_load (reload)
[190.185262] Starting subtest: reload
[192.136257] Subtest reload: SUCCESS (1.959s)
[192.257201] [154/165] (824s left) gem_lmem_swapping (basic)
[192.482332] Subtest basic: SKIP (0.000s)
[192.564899] [155/165] (824s left) gem_lmem_swapping (parallel-random-engines)
[192.775168] Subtest parallel-random-engines: SKIP (0.000s)
[192.852534] [156/165] (824s left) gem_lmem_swapping (random-engines)
[193.051056] Subtest random-engines: SKIP (0.000s)
[193.153584] [157/165] (823s left) gem_lmem_swapping (verify-random)
[193.339619] Subtest verify-random: SKIP (0.000s)
[193.425037] [158/165] (823s left) i915_pm_rpm (module-reload)
[195.039767] Subtest module-reload: SKIP (0.000s)
[195.125748] [159/165] (822s left) i915_selftest (live)
[195.906094] Starting subtest: live
[195.924833] Starting dynamic subtest: sanitycheck
[196.615508] Dynamic subtest sanitycheck: SUCCESS (0.706s)
[196.643055] Starting dynamic subtest: uncore
[197.331083] Dynamic subtest uncore: SUCCESS (0.716s)
[197.356826] Starting dynamic subtest: workarounds
[198.037781] Dynamic subtest workarounds: SUCCESS (0.704s)
[198.063281] Starting dynamic subtest: gt_engines
[198.729032] Dynamic subtest gt_engines: SUCCESS (0.683s)
[198.760465] Starting dynamic subtest: gt_timelines
[203.561667] Dynamic subtest gt_timelines: SUCCESS (4.834s)
[203.603145] Starting dynamic subtest: gt_contexts
[204.283320] Dynamic subtest gt_contexts: SUCCESS (0.721s)
[204.311194] Starting dynamic subtest: gt_lrc
[205.010050] Dynamic subtest gt_lrc: SUCCESS (0.718s)
[205.040830] Starting dynamic subtest: gt_mocs
[205.709934] Dynamic subtest gt_mocs: SUCCESS (0.704s)
[205.738537] Starting dynamic subtest: gt_pm
[206.954301] Dynamic subtest gt_pm: SUCCESS (1.241s)
[206.989996] Starting dynamic subtest: gt_heartbeat
[207.731837] Dynamic subtest gt_heartbeat: SUCCESS (0.776s)
[207.762242] Starting dynamic subtest: gt_tlb
[208.392103] Dynamic subtest gt_tlb: SUCCESS (0.657s)
[208.424865] Starting dynamic subtest: requests
[212.681298] Dynamic subtest requests: SUCCESS (4.289s)
[212.713480] Starting dynamic subtest: migrate
[213.346941] Dynamic subtest migrate: SUCCESS (0.667s)
[213.373801] Starting dynamic subtest: active
[214.022046] Dynamic subtest active: SUCCESS (0.671s)
[214.053903] Starting dynamic subtest: objects
[216.102686] Dynamic subtest objects: SUCCESS (2.081s)
[216.135388] Starting dynamic subtest: mman
[222.176370] Dynamic subtest mman: SUCCESS (6.075s)
[222.203851] Starting dynamic subtest: dmabuf
[222.912145] Dynamic subtest dmabuf: SUCCESS (0.729s)
[222.939049] Starting dynamic subtest: vma
[223.627126] Dynamic subtest vma: SUCCESS (0.716s)
[223.660778] Starting dynamic subtest: coherency
[225.293702] Dynamic subtest coherency: SUCCESS (1.665s)
[225.322195] Starting dynamic subtest: gtt
[229.390933] Dynamic subtest gtt: SUCCESS (4.097s)
[229.423113] Starting dynamic subtest: gem
[230.147835] Dynamic subtest gem: SUCCESS (0.748s)
[230.174958] Starting dynamic subtest: evict
[230.841999] Dynamic subtest evict: SUCCESS (0.699s)
[230.869626] Starting dynamic subtest: hugepages
[231.529922] Dynamic subtest hugepages: SUCCESS (0.683s)
[231.557810] Starting dynamic subtest: gem_contexts
[235.349986] Dynamic subtest gem_contexts: SUCCESS (3.819s)
[235.382238] Starting dynamic subtest: client
[236.057170] Dynamic subtest client: SUCCESS (0.704s)
[236.084298] Starting dynamic subtest: gem_migrate
[236.780248] Dynamic subtest gem_migrate: SUCCESS (0.721s)
[236.810617] Starting dynamic subtest: reset
[237.583140] Dynamic subtest reset: SUCCESS (0.799s)
[237.610270] Starting dynamic subtest: memory_region
[238.318041] Dynamic subtest memory_region: SUCCESS (0.733s)
[238.345500] Starting dynamic subtest: hangcheck
[240.623087] Dynamic subtest hangcheck: SUCCESS (2.304s)
[240.652200] Starting dynamic subtest: execlists
[241.288470] Dynamic subtest execlists: SUCCESS (0.662s)
[241.319673] Starting dynamic subtest: ring_submission
[241.949995] Dynamic subtest ring_submission: SUCCESS (0.658s)
[241.977516] Starting dynamic subtest: perf
[242.659140] Dynamic subtest perf: SUCCESS (0.703s)
[242.685599] Starting dynamic subtest: slpc
[243.376962] Dynamic subtest slpc: SUCCESS (0.721s)
[243.408273] Starting dynamic subtest: guc
[244.085948] Dynamic subtest guc: SUCCESS (0.706s)
[244.112430] Starting dynamic subtest: guc_multi_lrc
[244.740463] Dynamic subtest guc_multi_lrc: SUCCESS (0.652s)
[244.769656] Starting dynamic subtest: guc_hang
[245.468687] Dynamic subtest guc_hang: SUCCESS (0.723s)
[245.495145] Starting dynamic subtest: late_gt_pm
[246.210443] Dynamic subtest late_gt_pm: SUCCESS (0.742s)
[246.232622] Subtest live: SUCCESS (50.329s)
[246.316780] [160/165] (771s left) dmabuf (all-tests)
[246.511615] Starting subtest: all-tests
[246.532770] Starting dynamic subtest: sanitycheck
[246.599214] Dynamic subtest sanitycheck: SUCCESS (0.091s)
[246.625343] Starting dynamic subtest: dma_fence
[246.786667] Dynamic subtest dma_fence: SUCCESS (0.182s)
[246.813039] Starting dynamic subtest: dma_fence_chain
[262.675249] Dynamic subtest dma_fence_chain: SUCCESS (15.888s)
[262.717534] Starting dynamic subtest: dma_fence_unwrap
[262.775052] Dynamic subtest dma_fence_unwrap: SUCCESS (0.071s)
[262.809456] Starting dynamic subtest: dma_resv
[262.832924] Dynamic subtest dma_resv: SUCCESS (0.069s)
[262.859519] Subtest all-tests: SUCCESS (16.314s)
[262.988983] [161/165] (754s left) i915_suspend (basic-s2idle-without-i915)
[263.194136] Starting subtest: basic-s2idle-without-i915
[280.482900] Subtest basic-s2idle-without-i915: SUCCESS (2.324s)
[286.662137] [162/165] (751s left) i915_suspend (basic-s3-without-i915)
[286.821139] Starting subtest: basic-s3-without-i915
[303.920500] Subtest basic-s3-without-i915: SUCCESS (2.152s)
[310.024856] [163/165] (749s left) gem_exec_suspend (basic-s0)
[310.215375] Starting subtest: basic-S0
[310.237116] Starting dynamic subtest: smem
[327.568760] Dynamic subtest smem: SUCCESS (2.063s)
[327.590627] Subtest basic-S0: SUCCESS (2.064s)
[330.970167] [164/165] (747s left) gem_exec_suspend (basic-s3)
[331.169469] Starting subtest: basic-S3
[331.190386] Starting dynamic subtest: smem
[348.680446] Dynamic subtest smem: SUCCESS (2.135s)
[348.699985] Subtest basic-S3: SUCCESS (2.138s)
[353.456976] [165/165] (744s left) kms_pipe_crc_basic (suspend-read-crc)
[353.647743] Starting subtest: suspend-read-crc
[353.666517] Starting dynamic subtest: pipe-A-VGA-1
[370.593093] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.742s)
[370.624703] Starting dynamic subtest: pipe-B-VGA-1
[387.567500] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.751s)
[387.586688] Subtest suspend-read-crc: SUCCESS (3.499s)
[391.703124] Closing watchdogs
Done.