[39.640642] Initializing watchdogs
[39.640863]   /dev/watchdog0
[39.673661] [001/161] (960s left) i915_module_load (load)
[39.863667] Starting subtest: load
[41.471134] Subtest load: SUCCESS (1.622s)
[41.617941] [002/161] (958s left) core_auth (basic-auth)
[41.847279] Starting subtest: basic-auth
[41.866132] Subtest basic-auth: SUCCESS (0.001s)
[41.940931] [003/161] (958s left) debugfs_test (read_all_entries)
[42.148415] Starting subtest: read_all_entries
[42.167256] Subtest read_all_entries: SUCCESS (0.049s)
[42.274351] [004/161] (958s left) debugfs_test (basic-hwmon)
[42.428964] Starting subtest: basic-hwmon
[42.470627] Subtest basic-hwmon: SKIP (0.000s)
[42.550531] [005/161] (957s left) debugfs_test (sysfs)
[42.738943] Starting subtest: sysfs
[42.757337] Subtest sysfs: SUCCESS (0.032s)
[42.854845] [006/161] (957s left) fbdev (eof)
[43.020192] Starting subtest: eof
[43.039400] Subtest eof: SUCCESS (0.001s)
[43.141099] [007/161] (957s left) fbdev (info)
[43.285488] Starting subtest: info
[43.306501] Subtest info: SUCCESS (0.000s)
[43.405698] [008/161] (957s left) fbdev (nullptr)
[43.589977] Starting subtest: nullptr
[43.611099] Subtest nullptr: SUCCESS (0.000s)
[43.704364] [009/161] (957s left) fbdev (read)
[43.865652] Starting subtest: read
[44.131110] Subtest read: SUCCESS (0.278s)
[44.229720] [010/161] (956s left) fbdev (write)
[44.365411] Starting subtest: write
[44.484634] Subtest write: SUCCESS (0.128s)
[44.579755] [011/161] (956s left) gem_basic (bad-close)
[44.769686] Starting subtest: bad-close
[44.806601] Subtest bad-close: SUCCESS (0.000s)
[44.889546] [012/161] (956s left) gem_basic (create-close)
[45.053424] Starting subtest: create-close
[45.092347] Subtest create-close: SUCCESS (0.000s)
[45.174501] [013/161] (955s left) gem_basic (create-fd-close)
[45.355529] Starting subtest: create-fd-close
[45.395798] Subtest create-fd-close: SUCCESS (0.000s)
[45.469950] [014/161] (955s left) gem_busy (busy@all-engines)
[45.642977] Starting subtest: busy
[45.661980] Starting dynamic subtest: all-engines
[45.680995] Dynamic subtest all-engines: SUCCESS (0.031s)
[45.699869] Subtest busy: SUCCESS (0.031s)
[46.031232] [015/161] (955s left) gem_close_race (basic-process)
[46.211725] Starting subtest: basic-process
[46.250746] Subtest basic-process: SUCCESS (0.055s)
[46.460533] [016/161] (954s left) gem_close_race (basic-threads)
[46.620190] Starting subtest: basic-threads
[47.878576] Subtest basic-threads: SUCCESS (1.267s)
[48.080088] [017/161] (953s left) gem_ctx_create (basic)
[48.275715] Starting subtest: basic
[48.294469] Subtest basic: SUCCESS (0.000s)
[48.468908] [018/161] (953s left) gem_ctx_create (basic-files)
[48.641209] Starting subtest: basic-files
[50.675887] Subtest basic-files: SUCCESS (2.026s)
[50.906423] [019/161] (950s left) gem_ctx_exec (basic)
[51.091880] Starting subtest: basic
[51.110548] Subtest basic: SUCCESS (0.002s)
[51.187998] [020/161] (950s left) gem_exec_basic (basic)
[51.378303] Starting subtest: basic
[51.398348] Starting dynamic subtest: rcs0-smem
[51.419629] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[51.453671] Starting dynamic subtest: vcs0-smem
[51.474275] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[51.495942] Subtest basic: SUCCESS (0.001s)
[51.572111] [021/161] (950s left) gem_exec_create (basic)
[51.757854] Starting subtest: basic
[51.776157] Starting dynamic subtest: smem
[53.801540] Dynamic subtest smem: SUCCESS (2.040s)
[53.822379] Subtest basic: SUCCESS (2.041s)
[53.989109] [022/161] (947s left) gem_exec_fence (basic-busy)
[54.272316] Starting subtest: basic-busy
[54.292725] Starting dynamic subtest: rcs0
[54.332712] Dynamic subtest rcs0: SUCCESS (0.018s)
[54.361527] Starting dynamic subtest: vcs0
[54.398541] Dynamic subtest vcs0: SUCCESS (0.021s)
[54.419997] Subtest basic-busy: SUCCESS (0.039s)
[54.902088] [023/161] (946s left) gem_exec_fence (basic-wait)
[55.190856] Starting subtest: basic-wait
[55.209828] Starting dynamic subtest: rcs0
[55.228244] Dynamic subtest rcs0: SUCCESS (0.024s)
[55.258867] Starting dynamic subtest: vcs0
[55.280608] Dynamic subtest vcs0: SUCCESS (0.027s)
[55.301997] Subtest basic-wait: SUCCESS (0.051s)
[55.754197] [024/161] (946s left) gem_exec_fence (basic-await)
[56.046820] Starting subtest: basic-await
[56.065235] Starting dynamic subtest: rcs0
[56.121984] Dynamic subtest rcs0: SUCCESS (0.077s)
[56.149801] Starting dynamic subtest: vcs0
[56.194481] Dynamic subtest vcs0: SUCCESS (0.074s)
[56.213601] Subtest basic-await: SUCCESS (0.152s)
[56.709351] [025/161] (945s left) gem_exec_fence (nb-await)
[57.000289] Starting subtest: nb-await
[57.021369] Starting dynamic subtest: rcs0
[57.063131] Dynamic subtest rcs0: SUCCESS (0.056s)
[57.094362] Starting dynamic subtest: vcs0
[57.113411] Dynamic subtest vcs0: SUCCESS (0.054s)
[57.132283] Subtest nb-await: SUCCESS (0.111s)
[57.626789] [026/161] (944s left) gem_exec_gttfill (basic)
[57.821182] Starting subtest: basic
[67.586860] Subtest basic: SUCCESS (9.788s)
[67.805531] [027/161] (934s left) gem_exec_parallel (engines)
[68.102631] Starting subtest: engines
[68.120765] Starting dynamic subtest: basic
[69.797452] Dynamic subtest basic: SUCCESS (1.709s)
[69.825631] Starting dynamic subtest: contexts
[71.810673] Dynamic subtest contexts: SUCCESS (2.021s)
[71.836339] Starting dynamic subtest: fds
[71.872927] Dynamic subtest fds: SKIP (0.001s)
[71.900445] Starting dynamic subtest: userptr
[73.528813] Dynamic subtest userptr: SUCCESS (1.714s)
[73.548846] Subtest engines: SUCCESS (5.446s)
[73.734450] [028/161] (928s left) gem_exec_store (basic)
[73.987937] Starting subtest: basic
[74.008707] Subtest basic: SUCCESS (0.050s)
[74.171441] [029/161] (928s left) gem_flink_basic (bad-flink)
[74.345226] Starting subtest: bad-flink
[74.365263] Subtest bad-flink: SUCCESS (0.000s)
[74.452029] [030/161] (927s left) gem_flink_basic (bad-open)
[74.630194] Starting subtest: bad-open
[74.650288] Subtest bad-open: SUCCESS (0.000s)
[74.727468] [031/161] (927s left) gem_flink_basic (basic)
[74.913214] Starting subtest: basic
[74.932242] Subtest basic: SUCCESS (0.000s)
[75.009487] [032/161] (927s left) gem_flink_basic (double-flink)
[75.195314] Starting subtest: double-flink
[75.214158] Subtest double-flink: SUCCESS (0.000s)
[75.297745] [033/161] (927s left) gem_flink_basic (flink-lifetime)
[75.465605] Starting subtest: flink-lifetime
[75.489120] Subtest flink-lifetime: SUCCESS (0.002s)
[75.568866] [034/161] (927s left) gem_huc_copy (huc-copy)
[75.779999] Subtest huc-copy: SKIP (0.000s)
[75.860893] [035/161] (926s left) gem_linear_blits (basic)
[76.112648] Starting subtest: basic
[76.133152] Subtest basic: SUCCESS (0.021s)
[76.288847] [036/161] (926s left) gem_mmap (basic)
[76.585896] Starting subtest: basic
[76.684772] Subtest basic: SUCCESS (0.001s)
[76.766448] [037/161] (926s left) gem_mmap_gtt (basic)
[76.947651] Starting subtest: basic
[76.967966] Subtest basic: SUCCESS (0.001s)
[77.054493] [038/161] (925s left) gem_render_linear_blits (basic)
[77.218776] Starting subtest: basic
[77.317424] Subtest basic: SUCCESS (0.035s)
[77.396789] [039/161] (925s left) gem_render_tiled_blits (basic)
[77.584376] Starting subtest: basic
[77.707705] Subtest basic: SUCCESS (0.039s)
[77.795470] [040/161] (925s left) gem_ringfill (basic-all)
[78.073766] Starting subtest: basic-all
[79.156533] Subtest basic-all: SUCCESS (1.116s)
[79.263139] [041/161] (923s left) gem_softpin (allocator-basic)
[79.467207] Subtest allocator-basic: SKIP (0.000s)
[79.576720] [042/161] (923s left) gem_softpin (allocator-basic-reserve)
[79.763103] Subtest allocator-basic-reserve: SKIP (0.000s)
[79.862342] [043/161] (923s left) gem_softpin (safe-alignment)
[80.089742] Starting subtest: safe-alignment
[80.108856] Subtest safe-alignment: SUCCESS (0.007s)
[80.188698] [044/161] (923s left) gem_sync (basic-all)
[80.412349] Starting subtest: basic-all
[82.447103] Subtest basic-all: SUCCESS (2.085s)
[82.660820] [045/161] (920s left) gem_sync (basic-each)
[82.866591] Starting subtest: basic-each
[84.882730] Subtest basic-each: SUCCESS (2.074s)
[85.090245] [046/161] (918s left) gem_tiled_blits (basic)
[85.356923] Starting subtest: basic
[85.408624] Subtest basic: SUCCESS (0.033s)
[85.586657] [047/161] (917s left) gem_tiled_fence_blits (basic)
[85.965759] Starting subtest: basic
[85.986570] Subtest basic: SUCCESS (0.014s)
[86.124253] [048/161] (917s left) gem_tiled_pread_basic
[86.679411] [049/161] (917s left) gem_wait (busy@all-engines)
[86.862577] Starting subtest: busy
[86.883174] Starting dynamic subtest: all-engines
[87.370233] Dynamic subtest all-engines: SUCCESS (0.507s)
[87.389397] Subtest busy: SUCCESS (0.507s)
[87.618122] [050/161] (916s left) gem_wait (wait@all-engines)
[87.813966] Starting subtest: wait
[87.833569] Starting dynamic subtest: all-engines
[88.836503] Dynamic subtest all-engines: SUCCESS (1.024s)
[88.856881] Subtest wait: SUCCESS (1.024s)
[89.090566] [051/161] (914s left) i915_getparams_basic (basic-eu-total)
[89.281741] Starting subtest: basic-eu-total
[89.321231] Subtest basic-eu-total: SUCCESS (0.000s)
[89.398369] [052/161] (914s left) i915_getparams_basic (basic-subslice-total)
[89.579187] Starting subtest: basic-subslice-total
[89.618385] Subtest basic-subslice-total: SUCCESS (0.000s)
[89.707381] [053/161] (914s left) i915_hangman (error-state-basic)
[89.917791] Starting subtest: error-state-basic
[89.938158] Subtest error-state-basic: SUCCESS (0.005s)
[90.032285] [054/161] (914s left) i915_pciid
[90.310241] [055/161] (913s left) kms_addfb_basic (addfb25-4-tiled)
[90.534542] Starting subtest: addfb25-4-tiled
[90.555040] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[90.640693] [056/161] (913s left) kms_addfb_basic (addfb25-bad-modifier)
[90.828894] Starting subtest: addfb25-bad-modifier
[90.849096] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[90.928314] [057/161] (913s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[91.106830] Starting subtest: addfb25-framebuffer-vs-set-tiling
[91.126934] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[91.208150] [058/161] (913s left) kms_addfb_basic (addfb25-modifier-no-flag)
[91.370648] Starting subtest: addfb25-modifier-no-flag
[91.390897] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[91.478275] [059/161] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[91.649030] Starting subtest: addfb25-x-tiled-legacy
[91.669725] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[91.749334] [060/161] (912s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[91.930905] Starting subtest: addfb25-x-tiled-mismatch-legacy
[91.950956] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[92.032358] [061/161] (912s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[92.216884] Starting subtest: addfb25-yf-tiled-legacy
[92.235397] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[92.323080] [062/161] (912s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[92.496128] Starting subtest: addfb25-y-tiled-legacy
[92.516087] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[92.607336] [063/161] (912s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[92.781217] Starting subtest: addfb25-y-tiled-small-legacy
[92.822212] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[92.900581] [064/161] (911s left) kms_addfb_basic (bad-pitch-0)
[93.102328] Starting subtest: bad-pitch-0
[93.121214] Subtest bad-pitch-0: SUCCESS (0.000s)
[93.199080] [065/161] (911s left) kms_addfb_basic (bad-pitch-1024)
[93.383343] Starting subtest: bad-pitch-1024
[93.402370] Subtest bad-pitch-1024: SUCCESS (0.000s)
[93.485669] [066/161] (911s left) kms_addfb_basic (bad-pitch-128)
[93.651055] Starting subtest: bad-pitch-128
[93.672604] Subtest bad-pitch-128: SUCCESS (0.000s)
[93.754328] [067/161] (911s left) kms_addfb_basic (bad-pitch-256)
[93.928380] Starting subtest: bad-pitch-256
[93.951728] Subtest bad-pitch-256: SUCCESS (0.000s)
[94.029956] [068/161] (911s left) kms_addfb_basic (bad-pitch-32)
[94.208275] Starting subtest: bad-pitch-32
[94.227158] Subtest bad-pitch-32: SUCCESS (0.000s)
[94.304370] [069/161] (910s left) kms_addfb_basic (bad-pitch-63)
[94.498209] Starting subtest: bad-pitch-63
[94.518272] Subtest bad-pitch-63: SUCCESS (0.000s)
[94.609180] [070/161] (910s left) kms_addfb_basic (bad-pitch-65536)
[94.808673] Starting subtest: bad-pitch-65536
[94.829954] Subtest bad-pitch-65536: SUCCESS (0.000s)
[94.910388] [071/161] (910s left) kms_addfb_basic (bad-pitch-999)
[95.107984] Starting subtest: bad-pitch-999
[95.126746] Subtest bad-pitch-999: SUCCESS (0.000s)
[95.208244] [072/161] (910s left) kms_addfb_basic (basic)
[95.380540] Starting subtest: basic
[95.400897] Subtest basic: SUCCESS (0.000s)
[95.483126] [073/161] (910s left) kms_addfb_basic (basic-x-tiled-legacy)
[95.657783] Starting subtest: basic-x-tiled-legacy
[95.679054] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[95.760579] [074/161] (909s left) kms_addfb_basic (basic-y-tiled-legacy)
[95.940994] Starting subtest: basic-y-tiled-legacy
[95.961146] Subtest basic-y-tiled-legacy: SUCCESS (0.000s)
[96.038922] [075/161] (909s left) kms_addfb_basic (bo-too-small)
[96.231198] Starting subtest: bo-too-small
[96.249599] Subtest bo-too-small: SUCCESS (0.000s)
[96.329500] [076/161] (909s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[96.512984] Starting subtest: bo-too-small-due-to-tiling
[96.534492] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[96.618415] [077/161] (909s left) kms_addfb_basic (clobberred-modifier)
[96.794095] Starting subtest: clobberred-modifier
[96.814425] Subtest clobberred-modifier: SUCCESS (0.000s)
[96.892882] [078/161] (909s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[97.070208] Starting subtest: framebuffer-vs-set-tiling
[97.089316] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[97.174947] [079/161] (908s left) kms_addfb_basic (invalid-get-prop)
[97.375711] Starting subtest: invalid-get-prop
[97.395977] Subtest invalid-get-prop: SUCCESS (0.000s)
[97.481642] [080/161] (908s left) kms_addfb_basic (invalid-get-prop-any)
[97.657041] Starting subtest: invalid-get-prop-any
[97.678262] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[97.759972] [081/161] (908s left) kms_addfb_basic (invalid-set-prop)
[97.942509] Starting subtest: invalid-set-prop
[97.962507] Subtest invalid-set-prop: SUCCESS (0.000s)
[98.041329] [082/161] (908s left) kms_addfb_basic (invalid-set-prop-any)
[98.220935] Starting subtest: invalid-set-prop-any
[98.239956] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[98.329197] [083/161] (907s left) kms_addfb_basic (no-handle)
[98.492875] Starting subtest: no-handle
[98.512301] Subtest no-handle: SUCCESS (0.000s)
[98.595667] [084/161] (907s left) kms_addfb_basic (size-max)
[98.777677] Starting subtest: size-max
[98.798816] Subtest size-max: SUCCESS (0.000s)
[98.879136] [085/161] (907s left) kms_addfb_basic (small-bo)
[99.072394] Starting subtest: small-bo
[99.092839] Subtest small-bo: SUCCESS (0.000s)
[99.171232] [086/161] (907s left) kms_addfb_basic (tile-pitch-mismatch)
[99.350113] Starting subtest: tile-pitch-mismatch
[99.369277] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[99.449947] [087/161] (907s left) kms_addfb_basic (too-high)
[99.649213] Starting subtest: too-high
[99.670442] Subtest too-high: SUCCESS (0.001s)
[99.752720] [088/161] (906s left) kms_addfb_basic (too-wide)
[99.932778] Starting subtest: too-wide
[99.953701] Subtest too-wide: SUCCESS (0.000s)
[100.031311] [089/161] (906s left) kms_addfb_basic (unused-handle)
[100.214564] Starting subtest: unused-handle
[100.233996] Subtest unused-handle: SUCCESS (0.000s)
[100.313567] [090/161] (906s left) kms_addfb_basic (unused-modifier)
[100.495226] Starting subtest: unused-modifier
[100.513789] Subtest unused-modifier: SUCCESS (0.000s)
[100.600609] [091/161] (906s left) kms_addfb_basic (unused-offsets)
[100.794768] Starting subtest: unused-offsets
[100.815672] Subtest unused-offsets: SUCCESS (0.000s)
[100.895956] [092/161] (906s left) kms_addfb_basic (unused-pitches)
[101.087309] Starting subtest: unused-pitches
[101.107551] Subtest unused-pitches: SUCCESS (0.000s)
[101.185067] [093/161] (905s left) kms_busy (basic)
[101.398401] Starting subtest: basic
[101.420255] Starting dynamic subtest: flip
[102.239833] Dynamic subtest flip: SUCCESS (0.868s)
[102.267791] Starting dynamic subtest: modeset
[102.888304] Dynamic subtest modeset: SUCCESS (0.661s)
[102.908785] Subtest basic: SUCCESS (1.530s)
[103.093803] [094/161] (904s left) kms_prop_blob (basic)
[103.300084] Starting subtest: basic
[103.321998] Subtest basic: SUCCESS (0.000s)
[103.402777] [095/161] (903s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[103.609858] Starting subtest: basic-busy-flip-before-cursor-atomic
[104.552136] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.975s)
[104.726745] [096/161] (902s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[104.905823] Starting subtest: basic-busy-flip-before-cursor-legacy
[105.890699] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.988s)
[106.066378] [097/161] (901s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[106.241900] Starting subtest: basic-flip-after-cursor-atomic
[107.193916] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.969s)
[107.363163] [098/161] (900s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[107.553129] Starting subtest: basic-flip-after-cursor-legacy
[108.519681] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.970s)
[108.681391] [099/161] (898s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[108.872381] Starting subtest: basic-flip-after-cursor-varying-size
[109.849498] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.992s)
[110.014926] [100/161] (897s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[110.199788] Starting subtest: basic-flip-before-cursor-atomic
[111.195222] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.982s)
[111.345646] [101/161] (896s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[111.521136] Starting subtest: basic-flip-before-cursor-legacy
[112.499985] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.984s)
[112.676968] [102/161] (895s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[112.872272] Starting subtest: basic-flip-before-cursor-varying-size
[113.850472] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.001s)
[114.019329] [103/161] (893s left) kms_dsc (dsc-basic)
[114.221056] Subtest dsc-basic: SKIP (0.000s)
[114.301126] [104/161] (893s left) kms_flip (basic-flip-vs-dpms)
[114.513025] Starting subtest: basic-flip-vs-dpms
[114.531925] Starting dynamic subtest: A-VGA1
[115.778135] Dynamic subtest A-VGA1: SUCCESS (1.292s)
[115.808443] Starting dynamic subtest: B-VGA1
[116.986051] Dynamic subtest B-VGA1: SUCCESS (1.203s)
[117.006355] Subtest basic-flip-vs-dpms: SUCCESS (2.498s)
[117.168240] [105/161] (890s left) kms_flip (basic-flip-vs-modeset)
[117.378331] Starting subtest: basic-flip-vs-modeset
[117.396846] Starting dynamic subtest: A-VGA1
[118.713361] Dynamic subtest A-VGA1: SUCCESS (1.348s)
[118.747835] Starting dynamic subtest: B-VGA1
[119.997112] Dynamic subtest B-VGA1: SUCCESS (1.282s)
[120.016372] Subtest basic-flip-vs-modeset: SUCCESS (2.633s)
[120.168927] [106/161] (887s left) kms_flip (basic-flip-vs-wf_vblank)
[120.379152] Starting subtest: basic-flip-vs-wf_vblank
[120.399615] Starting dynamic subtest: A-VGA1
[121.861895] Dynamic subtest A-VGA1: SUCCESS (1.531s)
[121.888076] Starting dynamic subtest: B-VGA1
[123.364903] Dynamic subtest B-VGA1: SUCCESS (1.503s)
[123.385205] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.038s)
[123.588568] [107/161] (884s left) kms_flip (basic-plain-flip)
[123.783109] Starting subtest: basic-plain-flip
[123.802913] Starting dynamic subtest: A-VGA1
[125.006864] Dynamic subtest A-VGA1: SUCCESS (1.251s)
[125.034938] Starting dynamic subtest: B-VGA1
[126.221873] Dynamic subtest B-VGA1: SUCCESS (1.216s)
[126.240972] Subtest basic-plain-flip: SUCCESS (2.472s)
[126.479965] [108/161] (881s left) kms_force_connector_basic (force-connector-state)
[126.701344] Starting subtest: force-connector-state
[126.782396] Subtest force-connector-state: SUCCESS (0.106s)
[127.024547] [109/161] (881s left) kms_force_connector_basic (force-edid)
[127.219782] Starting subtest: force-edid
[127.244947] Subtest force-edid: SUCCESS (0.024s)
[127.368663] [110/161] (880s left) kms_force_connector_basic (force-load-detect)
[127.581030] Starting subtest: force-load-detect
[127.731873] Subtest force-load-detect: SUCCESS (0.168s)
[127.914170] [111/161] (880s left) kms_force_connector_basic (prune-stale-modes)
[128.097154] Starting subtest: prune-stale-modes
[128.117754] Subtest prune-stale-modes: SUCCESS (0.016s)
[128.225120] [112/161] (880s left) kms_frontbuffer_tracking (basic)
[128.481555] Starting subtest: basic
[130.650870] Subtest basic: SUCCESS (2.259s)
[130.780616] [113/161] (877s left) kms_hdmi_inject (inject-audio)
[130.990969] Starting subtest: inject-audio
[131.173179] Subtest inject-audio: SUCCESS (0.154s)
[131.416364] [114/161] (877s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[131.599329] Starting subtest: compare-crc-sanitycheck-xr24
[131.617477] Starting dynamic subtest: pipe-A-VGA-1
[131.889181] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.296s)
[131.923111] Starting dynamic subtest: pipe-B-VGA-1
[132.253974] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.338s)
[132.274117] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.637s)
[132.404961] [115/161] (876s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[132.584750] Starting subtest: compare-crc-sanitycheck-nv12
[132.603893] Starting dynamic subtest: pipe-A-VGA-1
[132.643261] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[132.685560] Starting dynamic subtest: pipe-B-VGA-1
[132.727464] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[132.765266] Subtest compare-crc-sanitycheck-nv12: SKIP (0.003s)
[132.846030] [116/161] (875s left) kms_pipe_crc_basic (hang-read-crc)
[133.027812] Starting subtest: hang-read-crc
[133.049971] Starting dynamic subtest: pipe-A-VGA-1
[133.842275] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.837s)
[133.868531] Starting dynamic subtest: pipe-B-VGA-1
[134.746080] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.903s)
[134.764288] Subtest hang-read-crc: SUCCESS (1.742s)
[134.908488] [117/161] (873s left) kms_pipe_crc_basic (nonblocking-crc)
[135.095391] Starting subtest: nonblocking-crc
[135.116188] Starting dynamic subtest: pipe-A-VGA-1
[135.549490] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.466s)
[135.577917] Starting dynamic subtest: pipe-B-VGA-1
[136.044158] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.491s)
[136.064315] Subtest nonblocking-crc: SUCCESS (0.962s)
[136.202762] [118/161] (872s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[136.396176] Starting subtest: nonblocking-crc-frame-sequence
[136.415050] Starting dynamic subtest: pipe-A-VGA-1
[136.862252] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.475s)
[136.892582] Starting dynamic subtest: pipe-B-VGA-1
[137.354183] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.493s)
[137.372543] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.971s)
[137.523951] [119/161] (871s left) kms_pipe_crc_basic (read-crc)
[137.701119] Starting subtest: read-crc
[137.721195] Starting dynamic subtest: pipe-A-VGA-1
[138.129735] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.423s)
[138.157656] Starting dynamic subtest: pipe-B-VGA-1
[138.576984] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.447s)
[138.597281] Subtest read-crc: SUCCESS (0.872s)
[138.734486] [120/161] (870s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[138.932290] Starting subtest: read-crc-frame-sequence
[138.953896] Starting dynamic subtest: pipe-A-VGA-1
[139.345471] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.427s)
[139.374404] Starting dynamic subtest: pipe-B-VGA-1
[139.759600] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.426s)
[139.778186] Subtest read-crc-frame-sequence: SUCCESS (0.856s)
[139.914723] [121/161] (869s left) kms_pm_backlight (basic-brightness)
[140.110975] Subtest basic-brightness: SKIP (0.000s)
[140.192544] [122/161] (869s left) kms_pm_rpm (basic-pci-d3-state)
[141.745954] Subtest basic-pci-d3-state: SKIP (0.000s)
[141.833071] [123/161] (867s left) kms_pm_rpm (basic-rte)
[141.978076] Starting subtest: basic-rte
[143.602993] Subtest basic-rte: SKIP (1.581s)
[143.726184] [124/161] (865s left) kms_psr (psr-primary-page-flip)
[143.974762] Subtest psr-primary-page-flip: SKIP (0.000s)
[144.058027] [125/161] (865s left) kms_psr (psr-cursor-plane-move)
[144.284216] Subtest psr-cursor-plane-move: SKIP (0.000s)
[144.369477] [126/161] (865s left) kms_psr (psr-sprite-plane-onoff)
[144.569786] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[144.665358] [127/161] (865s left) kms_psr (psr-primary-mmap-gtt)
[144.878320] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[144.960933] [128/161] (864s left) kms_setmode (basic-clone-single-crtc)
[145.148570] Starting subtest: basic-clone-single-crtc
[145.204746] Subtest basic-clone-single-crtc: SKIP (0.000s)
[145.289452] [129/161] (864s left) i915_pm_rps (basic-api)
[145.483565] Subtest basic-api: SKIP (0.000s)
[145.567414] [130/161] (864s left) prime_self_import (basic-llseek-bad)
[145.723230] Starting subtest: basic-llseek-bad
[145.765134] Subtest basic-llseek-bad: SUCCESS (0.003s)
[145.844632] [131/161] (864s left) prime_self_import (basic-llseek-size)
[146.019201] Starting subtest: basic-llseek-size
[146.076888] Subtest basic-llseek-size: SUCCESS (0.007s)
[146.168965] [132/161] (863s left) prime_self_import (basic-with_fd_dup)
[146.368295] Starting subtest: basic-with_fd_dup
[146.419471] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[146.525477] [133/161] (863s left) prime_self_import (basic-with_one_bo)
[146.703577] Starting subtest: basic-with_one_bo
[146.755286] Subtest basic-with_one_bo: SUCCESS (0.005s)
[146.866061] [134/161] (863s left) prime_self_import (basic-with_one_bo_two_files)
[147.083654] Starting subtest: basic-with_one_bo_two_files
[147.134119] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[147.239541] [135/161] (863s left) prime_self_import (basic-with_two_bos)
[147.593194] Starting subtest: basic-with_two_bos
[147.645807] Subtest basic-with_two_bos: SUCCESS (0.004s)
[147.742383] [136/161] (862s left) prime_vgem (basic-fence-flip)
[147.981318] Starting subtest: basic-fence-flip
[148.296787] Subtest basic-fence-flip: SUCCESS (0.358s)
[148.451328] [137/161] (862s left) prime_vgem (basic-fence-mmap)
[148.675923] Starting subtest: basic-fence-mmap
[148.701432] Subtest basic-fence-mmap: SUCCESS (0.050s)
[148.829643] [138/161] (861s left) prime_vgem (basic-fence-read)
[149.053359] Starting subtest: basic-fence-read
[149.118827] Subtest basic-fence-read: SUCCESS (0.081s)
[149.257663] [139/161] (861s left) prime_vgem (basic-gtt)
[149.490916] Starting subtest: basic-gtt
[149.517432] Subtest basic-gtt: SUCCESS (0.027s)
[149.628345] [140/161] (861s left) prime_vgem (basic-read)
[149.846411] Starting subtest: basic-read
[149.865817] Subtest basic-read: SUCCESS (0.032s)
[149.970758] [141/161] (861s left) prime_vgem (basic-write)
[150.184518] Starting subtest: basic-write
[150.206406] Subtest basic-write: SUCCESS (0.043s)
[150.308869] [142/161] (860s left) vgem_basic (setversion)
[150.496791] Starting subtest: setversion
[150.536873] Subtest setversion: SUCCESS (0.000s)
[150.623229] [143/161] (860s left) vgem_basic (create)
[150.796970] Starting subtest: create
[150.818511] Subtest create: SUCCESS (0.000s)
[150.909572] [144/161] (860s left) vgem_basic (debugfs)
[151.097226] Starting subtest: debugfs
[151.117972] Subtest debugfs: SUCCESS (0.001s)
[151.202243] [145/161] (860s left) vgem_basic (dmabuf-export)
[151.390683] Starting subtest: dmabuf-export
[151.432120] Subtest dmabuf-export: SUCCESS (0.003s)
[151.515537] [146/161] (859s left) vgem_basic (dmabuf-fence)
[151.712060] Starting subtest: dmabuf-fence
[151.734342] Subtest dmabuf-fence: SUCCESS (0.001s)
[151.822414] [147/161] (859s left) vgem_basic (dmabuf-fence-before)
[152.014129] Starting subtest: dmabuf-fence-before
[152.035402] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[152.114295] [148/161] (859s left) vgem_basic (dmabuf-mmap)
[152.319613] Starting subtest: dmabuf-mmap
[152.339320] Subtest dmabuf-mmap: SUCCESS (0.032s)
[152.438694] [149/161] (859s left) vgem_basic (mmap)
[152.615215] Starting subtest: mmap
[152.637076] Subtest mmap: SUCCESS (0.026s)
[152.725284] [150/161] (858s left) vgem_basic (second-client)
[152.876976] Starting subtest: second-client
[152.920538] Subtest second-client: SUCCESS (0.033s)
[153.003111] [151/161] (858s left) vgem_basic (sysfs)
[153.211777] Starting subtest: sysfs
[153.231473] Subtest sysfs: SUCCESS (0.001s)
[153.314645] [152/161] (858s left) core_hotunplug (unbind-rebind)
[153.537298] Starting subtest: unbind-rebind
[156.386778] Subtest unbind-rebind: SUCCESS (2.852s)
[156.472732] [153/161] (855s left) vgem_basic (unload)
[156.647517] Starting subtest: unload
[185.779569] Subtest unload: SUCCESS (28.983s)
[185.862156] [154/161] (826s left) i915_module_load (reload)
[186.024435] Starting subtest: reload
[188.132355] Subtest reload: SUCCESS (2.104s)
[188.217145] [155/161] (823s left) gem_lmem_swapping (basic)
[188.445103] Subtest basic: SKIP (0.000s)
[188.526183] [156/161] (823s left) gem_lmem_swapping (parallel-random-engines)
[188.724557] Subtest parallel-random-engines: SKIP (0.000s)
[188.810090] [157/161] (823s left) gem_lmem_swapping (random-engines)
[188.977499] Subtest random-engines: SKIP (0.000s)
[189.060611] [158/161] (823s left) gem_lmem_swapping (verify-random)
[189.262348] Subtest verify-random: SKIP (0.000s)
[189.341085] [159/161] (823s left) i915_pm_rpm (module-reload)
[190.815964] Subtest module-reload: SKIP (0.000s)
[190.897799] [160/161] (821s left) i915_selftest (live)
[191.660333] Starting subtest: live
[191.681828] Starting dynamic subtest: sanitycheck
[192.361843] Dynamic subtest sanitycheck: SUCCESS (0.697s)
[192.391221] Starting dynamic subtest: uncore
[193.080281] Dynamic subtest uncore: SUCCESS (0.720s)
[193.108032] Starting dynamic subtest: workarounds
[193.759397] Dynamic subtest workarounds: SUCCESS (0.677s)
[193.784892] Starting dynamic subtest: gt_engines
[194.436677] Dynamic subtest gt_engines: SUCCESS (0.673s)
[194.465300] Starting dynamic subtest: gt_timelines
[198.831812] Dynamic subtest gt_timelines: SUCCESS (4.396s)
[198.858900] Starting dynamic subtest: gt_contexts
[199.502267] Dynamic subtest gt_contexts: SUCCESS (0.668s)
[199.533641] Starting dynamic subtest: gt_lrc
[200.162121] Dynamic subtest gt_lrc: SUCCESS (0.660s)
[200.187516] Starting dynamic subtest: gt_mocs
[200.825124] Dynamic subtest gt_mocs: SUCCESS (0.661s)
[200.851856] Starting dynamic subtest: gt_pm
[202.019712] Dynamic subtest gt_pm: SUCCESS (1.185s)
[202.054039] Starting dynamic subtest: gt_heartbeat
[202.727158] Dynamic subtest gt_heartbeat: SUCCESS (0.706s)
[202.762121] Starting dynamic subtest: gt_tlb
[203.432662] Dynamic subtest gt_tlb: SUCCESS (0.702s)
[203.467681] Starting dynamic subtest: requests
[207.828572] Dynamic subtest requests: SUCCESS (4.396s)
[207.861521] Starting dynamic subtest: migrate
[208.500769] Dynamic subtest migrate: SUCCESS (0.672s)
[208.537163] Starting dynamic subtest: active
[209.183255] Dynamic subtest active: SUCCESS (0.685s)
[209.210213] Starting dynamic subtest: objects
[211.234427] Dynamic subtest objects: SUCCESS (2.049s)
[211.262394] Starting dynamic subtest: mman
[217.201644] Dynamic subtest mman: SUCCESS (5.968s)
[217.229660] Starting dynamic subtest: dmabuf
[217.928790] Dynamic subtest dmabuf: SUCCESS (0.724s)
[217.955144] Starting dynamic subtest: vma
[218.604866] Dynamic subtest vma: SUCCESS (0.675s)
[218.631046] Starting dynamic subtest: coherency
[220.751877] Dynamic subtest coherency: SUCCESS (2.147s)
[220.782679] Starting dynamic subtest: gtt
[224.365952] Dynamic subtest gtt: SUCCESS (3.611s)
[224.398618] Starting dynamic subtest: gem
[225.150067] Dynamic subtest gem: SUCCESS (0.783s)
[225.178496] Starting dynamic subtest: evict
[225.809948] Dynamic subtest evict: SUCCESS (0.660s)
[225.835423] Starting dynamic subtest: hugepages
[226.494343] Dynamic subtest hugepages: SUCCESS (0.680s)
[226.522733] Starting dynamic subtest: gem_contexts
[230.225272] Dynamic subtest gem_contexts: SUCCESS (3.730s)
[230.253604] Starting dynamic subtest: client
[230.891101] Dynamic subtest client: SUCCESS (0.665s)
[230.918949] Starting dynamic subtest: gem_migrate
[231.616970] Dynamic subtest gem_migrate: SUCCESS (0.722s)
[231.644552] Starting dynamic subtest: reset
[232.441254] Dynamic subtest reset: SUCCESS (0.825s)
[232.467411] Starting dynamic subtest: memory_region
[233.187696] Dynamic subtest memory_region: SUCCESS (0.742s)
[233.215168] Starting dynamic subtest: hangcheck
[235.488541] Dynamic subtest hangcheck: SUCCESS (2.301s)
[235.517197] Starting dynamic subtest: execlists
[236.154604] Dynamic subtest execlists: SUCCESS (0.662s)
[236.184098] Starting dynamic subtest: ring_submission
[236.860176] Dynamic subtest ring_submission: SUCCESS (0.705s)
[236.886546] Starting dynamic subtest: perf
[237.512372] Dynamic subtest perf: SUCCESS (0.649s)
[237.540040] Starting dynamic subtest: slpc
[238.202287] Dynamic subtest slpc: SUCCESS (0.689s)
[238.228448] Starting dynamic subtest: guc
[238.904072] Dynamic subtest guc: SUCCESS (0.697s)
[238.931842] Starting dynamic subtest: guc_multi_lrc
[239.574146] Dynamic subtest guc_multi_lrc: SUCCESS (0.669s)
[239.602338] Starting dynamic subtest: guc_hang
[240.258781] Dynamic subtest guc_hang: SUCCESS (0.679s)
[240.287977] Starting dynamic subtest: late_gt_pm
[240.946987] Dynamic subtest late_gt_pm: SUCCESS (0.688s)
[240.966364] Subtest live: SUCCESS (49.313s)
[241.048776] [161/161] (771s left) dmabuf (all-tests)
[241.244826] Starting subtest: all-tests
[241.266121] Starting dynamic subtest: sanitycheck
[241.315946] Dynamic subtest sanitycheck: SUCCESS (0.075s)
[241.341559] Starting dynamic subtest: dma_fence
[241.498698] Dynamic subtest dma_fence: SUCCESS (0.179s)
[241.524874] Starting dynamic subtest: dma_fence_chain
[256.775268] Dynamic subtest dma_fence_chain: SUCCESS (15.282s)
[256.809971] Starting dynamic subtest: dma_fence_unwrap
[256.854217] Dynamic subtest dma_fence_unwrap: SUCCESS (0.078s)
[256.887089] Starting dynamic subtest: dma_resv
[256.944041] Dynamic subtest dma_resv: SUCCESS (0.085s)
[256.965362] Subtest all-tests: SUCCESS (15.711s)
[257.024782] Closing watchdogs
Done.