[34.895753] Initializing watchdogs
[34.895960]   /dev/watchdog0
[34.926564] [001/165] (960s left) i915_module_load (load)
[35.106069] Starting subtest: load
[36.641679] Subtest load: SUCCESS (1.515s)
[36.725115] [002/165] (958s left) core_auth (basic-auth)
[36.944603] Starting subtest: basic-auth
[36.966431] Subtest basic-auth: SUCCESS (0.001s)
[37.047581] [003/165] (958s left) debugfs_test (read_all_entries)
[37.229830] Starting subtest: read_all_entries
[37.251238] Subtest read_all_entries: SUCCESS (0.047s)
[37.366231] [004/165] (958s left) debugfs_test (basic-hwmon)
[37.565102] Starting subtest: basic-hwmon
[37.603766] Subtest basic-hwmon: SKIP (0.000s)
[37.686435] [005/165] (958s left) fbdev (eof)
[37.855101] Starting subtest: eof
[37.874632] Subtest eof: SUCCESS (0.001s)
[37.992760] [006/165] (957s left) fbdev (info)
[38.164182] Starting subtest: info
[38.185936] Subtest info: SUCCESS (0.000s)
[38.287610] [007/165] (957s left) fbdev (nullptr)
[38.440348] Starting subtest: nullptr
[38.461884] Subtest nullptr: SUCCESS (0.000s)
[38.561884] [008/165] (957s left) fbdev (read)
[38.705763] Starting subtest: read
[38.975537] Subtest read: SUCCESS (0.283s)
[39.071180] [009/165] (956s left) fbdev (write)
[39.235464] Starting subtest: write
[39.369773] Subtest write: SUCCESS (0.144s)
[39.472364] [010/165] (956s left) gem_basic (bad-close)
[39.651572] Starting subtest: bad-close
[39.694297] Subtest bad-close: SUCCESS (0.000s)
[39.769301] [011/165] (956s left) gem_basic (create-close)
[39.965331] Starting subtest: create-close
[40.005817] Subtest create-close: SUCCESS (0.000s)
[40.090252] [012/165] (956s left) gem_basic (create-fd-close)
[40.267819] Starting subtest: create-fd-close
[40.309770] Subtest create-fd-close: SUCCESS (0.000s)
[40.392153] [013/165] (955s left) gem_busy (busy@all-engines)
[40.578738] Starting subtest: busy
[40.598416] Starting dynamic subtest: all-engines
[40.631283] Dynamic subtest all-engines: SUCCESS (0.031s)
[40.656068] Subtest busy: SUCCESS (0.031s)
[40.976613] [014/165] (955s left) gem_close_race (basic-process)
[41.178664] Starting subtest: basic-process
[41.228798] Subtest basic-process: SUCCESS (0.051s)
[41.466159] [015/165] (955s left) gem_close_race (basic-threads)
[41.665628] Starting subtest: basic-threads
[42.805259] Subtest basic-threads: SUCCESS (1.172s)
[43.026459] [016/165] (953s left) gem_ctx_create (basic)
[43.201243] Starting subtest: basic
[43.222377] Subtest basic: SUCCESS (0.000s)
[43.412224] [017/165] (953s left) gem_ctx_create (basic-files)
[43.580065] Starting subtest: basic-files
[45.603723] Subtest basic-files: SUCCESS (2.025s)
[45.863254] [018/165] (950s left) gem_ctx_exec (basic)
[46.064558] Starting subtest: basic
[46.085760] Subtest basic: SUCCESS (0.001s)
[46.161224] [019/165] (950s left) gem_exec_basic (basic)
[46.347825] Starting subtest: basic
[46.367548] Starting dynamic subtest: rcs0-smem
[46.387097] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[46.417905] Starting dynamic subtest: vcs0-smem
[46.438059] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[46.459615] Subtest basic: SUCCESS (0.001s)
[46.540545] [020/165] (950s left) gem_exec_create (basic)
[46.707194] Starting subtest: basic
[46.727923] Starting dynamic subtest: smem
[48.761218] Dynamic subtest smem: SUCCESS (2.051s)
[48.780603] Subtest basic: SUCCESS (2.051s)
[48.971884] [021/165] (948s left) gem_exec_fence (basic-busy)
[49.273212] Starting subtest: basic-busy
[49.292423] Starting dynamic subtest: rcs0
[49.334895] Dynamic subtest rcs0: SUCCESS (0.023s)
[49.370903] Starting dynamic subtest: vcs0
[49.415106] Dynamic subtest vcs0: SUCCESS (0.026s)
[49.433925] Subtest basic-busy: SUCCESS (0.049s)
[49.889506] [022/165] (947s left) gem_exec_fence (basic-wait)
[50.203653] Starting subtest: basic-wait
[50.225062] Starting dynamic subtest: rcs0
[50.246712] Dynamic subtest rcs0: SUCCESS (0.022s)
[50.280657] Starting dynamic subtest: vcs0
[50.300776] Dynamic subtest vcs0: SUCCESS (0.020s)
[50.320224] Subtest basic-wait: SUCCESS (0.042s)
[50.754904] [023/165] (946s left) gem_exec_fence (basic-await)
[51.052445] Starting subtest: basic-await
[51.073811] Starting dynamic subtest: rcs0
[51.121480] Dynamic subtest rcs0: SUCCESS (0.075s)
[51.146258] Starting dynamic subtest: vcs0
[51.197941] Dynamic subtest vcs0: SUCCESS (0.077s)
[51.218635] Subtest basic-await: SUCCESS (0.153s)
[51.696282] [024/165] (945s left) gem_exec_fence (nb-await)
[51.952931] Starting subtest: nb-await
[51.976290] Starting dynamic subtest: rcs0
[52.018338] Dynamic subtest rcs0: SUCCESS (0.053s)
[52.047140] Starting dynamic subtest: vcs0
[52.066713] Dynamic subtest vcs0: SUCCESS (0.053s)
[52.087516] Subtest nb-await: SUCCESS (0.107s)
[52.567466] [025/165] (944s left) gem_exec_gttfill (basic)
[52.755037] Starting subtest: basic
[62.097982] Subtest basic: SUCCESS (9.368s)
[62.311936] [026/165] (935s left) gem_exec_parallel (engines)
[62.612573] Starting subtest: engines
[62.631234] Starting dynamic subtest: basic
[64.244330] Dynamic subtest basic: SUCCESS (1.648s)
[64.276398] Starting dynamic subtest: contexts
[66.206928] Dynamic subtest contexts: SUCCESS (1.971s)
[66.235106] Starting dynamic subtest: fds
[66.271694] Dynamic subtest fds: SKIP (0.001s)
[66.299620] Starting dynamic subtest: userptr
[68.680788] Dynamic subtest userptr: SUCCESS (2.462s)
[68.700201] Subtest engines: SUCCESS (6.083s)
[68.897315] [027/165] (928s left) gem_exec_store (basic)
[69.155196] Starting subtest: basic
[69.174871] Subtest basic: SUCCESS (0.028s)
[69.325842] [028/165] (928s left) gem_flink_basic (bad-flink)
[69.495095] Starting subtest: bad-flink
[69.516734] Subtest bad-flink: SUCCESS (0.000s)
[69.602816] [029/165] (927s left) gem_flink_basic (bad-open)
[69.767682] Starting subtest: bad-open
[69.790073] Subtest bad-open: SUCCESS (0.000s)
[69.872337] [030/165] (927s left) gem_flink_basic (basic)
[70.059615] Starting subtest: basic
[70.080779] Subtest basic: SUCCESS (0.000s)
[70.157184] [031/165] (927s left) gem_flink_basic (double-flink)
[70.345044] Starting subtest: double-flink
[70.364459] Subtest double-flink: SUCCESS (0.000s)
[70.466065] [032/165] (927s left) gem_flink_basic (flink-lifetime)
[70.630509] Starting subtest: flink-lifetime
[70.649601] Subtest flink-lifetime: SUCCESS (0.002s)
[70.734664] [033/165] (927s left) gem_huc_copy (huc-copy)
[70.935401] Subtest huc-copy: SKIP (0.000s)
[71.020597] [034/165] (926s left) gem_linear_blits (basic)
[71.272850] Starting subtest: basic
[71.292724] Subtest basic: SUCCESS (0.014s)
[71.457477] [035/165] (926s left) gem_mmap (basic)
[71.753499] Starting subtest: basic
[71.858535] Subtest basic: SUCCESS (0.001s)
[71.937049] [036/165] (926s left) gem_mmap_gtt (basic)
[72.134381] Starting subtest: basic
[72.153780] Subtest basic: SUCCESS (0.001s)
[72.233770] [037/165] (925s left) gem_render_linear_blits (basic)
[72.418842] Starting subtest: basic
[72.534511] Subtest basic: SUCCESS (0.041s)
[72.632140] [038/165] (925s left) gem_render_tiled_blits (basic)
[72.842294] Starting subtest: basic
[72.988739] Subtest basic: SUCCESS (0.043s)
[73.083514] [039/165] (925s left) gem_ringfill (basic-all)
[73.354894] Starting subtest: basic-all
[74.425416] Subtest basic-all: SUCCESS (1.108s)
[74.560711] [040/165] (923s left) gem_softpin (allocator-basic)
[74.809763] Subtest allocator-basic: SKIP (0.000s)
[74.934252] [041/165] (923s left) gem_softpin (allocator-basic-reserve)
[75.132497] Subtest allocator-basic-reserve: SKIP (0.000s)
[75.256566] [042/165] (923s left) gem_softpin (safe-alignment)
[75.466065] Starting subtest: safe-alignment
[75.485270] Subtest safe-alignment: SUCCESS (0.008s)
[75.561777] [043/165] (923s left) gem_sync (basic-all)
[75.818193] Starting subtest: basic-all
[78.122576] Subtest basic-all: SUCCESS (2.152s)
[78.228836] [044/165] (920s left) gem_sync (basic-each)
[78.455376] Starting subtest: basic-each
[80.505540] Subtest basic-each: SUCCESS (2.100s)
[80.708255] [045/165] (918s left) gem_tiled_blits (basic)
[80.955828] Starting subtest: basic
[80.994419] Subtest basic: SUCCESS (0.036s)
[81.136678] [046/165] (917s left) gem_tiled_fence_blits (basic)
[81.525129] Starting subtest: basic
[81.546829] Subtest basic: SUCCESS (0.015s)
[81.685422] [047/165] (917s left) gem_tiled_pread_basic
[82.219519] [048/165] (916s left) gem_wait (busy@all-engines)
[82.396839] Starting subtest: busy
[82.417683] Starting dynamic subtest: all-engines
[82.910960] Dynamic subtest all-engines: SUCCESS (0.519s)
[82.930527] Subtest busy: SUCCESS (0.519s)
[83.178357] [049/165] (916s left) gem_wait (wait@all-engines)
[83.359809] Starting subtest: wait
[83.381236] Starting dynamic subtest: all-engines
[84.373067] Dynamic subtest all-engines: SUCCESS (1.022s)
[84.392523] Subtest wait: SUCCESS (1.022s)
[84.630811] [050/165] (914s left) i915_getparams_basic (basic-eu-total)
[84.822080] Starting subtest: basic-eu-total
[84.861164] Subtest basic-eu-total: SUCCESS (0.000s)
[84.941953] [051/165] (914s left) i915_getparams_basic (basic-subslice-total)
[85.100323] Starting subtest: basic-subslice-total
[85.138671] Subtest basic-subslice-total: SUCCESS (0.000s)
[85.222842] [052/165] (914s left) i915_hangman (error-state-basic)
[85.406728] Starting subtest: error-state-basic
[85.428707] Subtest error-state-basic: SUCCESS (0.003s)
[85.528455] [053/165] (913s left) i915_pciid
[85.800109] [054/165] (913s left) kms_addfb_basic (addfb25-4-tiled)
[86.049368] Starting subtest: addfb25-4-tiled
[86.071421] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[86.155688] [055/165] (913s left) kms_addfb_basic (addfb25-bad-modifier)
[86.351361] Starting subtest: addfb25-bad-modifier
[86.372113] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[86.451421] [056/165] (913s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[86.638371] Starting subtest: addfb25-framebuffer-vs-set-tiling
[86.657773] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[86.739333] [057/165] (913s left) kms_addfb_basic (addfb25-modifier-no-flag)
[86.915793] Starting subtest: addfb25-modifier-no-flag
[86.942343] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[87.046557] [058/165] (912s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[87.228615] Starting subtest: addfb25-x-tiled-legacy
[87.249798] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[87.330082] [059/165] (912s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[87.535796] Starting subtest: addfb25-x-tiled-mismatch-legacy
[87.554815] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[87.634271] [060/165] (912s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[87.822885] Starting subtest: addfb25-yf-tiled-legacy
[87.842317] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[87.931675] [061/165] (912s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[88.119465] Starting subtest: addfb25-y-tiled-legacy
[88.141315] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[88.225495] [062/165] (911s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[88.409602] Starting subtest: addfb25-y-tiled-small-legacy
[88.450200] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[88.551463] [063/165] (911s left) kms_addfb_basic (bad-pitch-0)
[88.733663] Starting subtest: bad-pitch-0
[88.752820] Subtest bad-pitch-0: SUCCESS (0.000s)
[88.844776] [064/165] (911s left) kms_addfb_basic (bad-pitch-1024)
[89.027062] Starting subtest: bad-pitch-1024
[89.048770] Subtest bad-pitch-1024: SUCCESS (0.000s)
[89.131280] [065/165] (911s left) kms_addfb_basic (bad-pitch-128)
[89.317460] Starting subtest: bad-pitch-128
[89.338920] Subtest bad-pitch-128: SUCCESS (0.000s)
[89.419493] [066/165] (911s left) kms_addfb_basic (bad-pitch-256)
[89.611602] Starting subtest: bad-pitch-256
[89.630822] Subtest bad-pitch-256: SUCCESS (0.000s)
[89.712767] [067/165] (910s left) kms_addfb_basic (bad-pitch-32)
[89.892803] Starting subtest: bad-pitch-32
[89.911735] Subtest bad-pitch-32: SUCCESS (0.000s)
[90.001168] [068/165] (910s left) kms_addfb_basic (bad-pitch-63)
[90.182370] Starting subtest: bad-pitch-63
[90.204256] Subtest bad-pitch-63: SUCCESS (0.000s)
[90.289285] [069/165] (910s left) kms_addfb_basic (bad-pitch-65536)
[90.479464] Starting subtest: bad-pitch-65536
[90.500727] Subtest bad-pitch-65536: SUCCESS (0.000s)
[90.577389] [070/165] (910s left) kms_addfb_basic (bad-pitch-999)
[90.767222] Starting subtest: bad-pitch-999
[90.786904] Subtest bad-pitch-999: SUCCESS (0.000s)
[90.867290] [071/165] (910s left) kms_addfb_basic (basic)
[91.041619] Starting subtest: basic
[91.060158] Subtest basic: SUCCESS (0.000s)
[91.151195] [072/165] (909s left) kms_addfb_basic (basic-x-tiled-legacy)
[91.341320] Starting subtest: basic-x-tiled-legacy
[91.362730] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[91.446757] [073/165] (909s left) kms_addfb_basic (basic-y-tiled-legacy)
[91.631226] Starting subtest: basic-y-tiled-legacy
[91.650151] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[91.728240] [074/165] (909s left) kms_addfb_basic (bo-too-small)
[91.920248] Starting subtest: bo-too-small
[91.939818] Subtest bo-too-small: SUCCESS (0.000s)
[92.025156] [075/165] (909s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[92.201931] Starting subtest: bo-too-small-due-to-tiling
[92.222881] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[92.310241] [076/165] (908s left) kms_addfb_basic (clobberred-modifier)
[92.479422] Starting subtest: clobberred-modifier
[92.500337] Subtest clobberred-modifier: SUCCESS (0.000s)
[92.577652] [077/165] (908s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[92.762798] Starting subtest: framebuffer-vs-set-tiling
[92.781682] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[92.861123] [078/165] (908s left) kms_addfb_basic (invalid-get-prop)
[93.039086] Starting subtest: invalid-get-prop
[93.058028] Subtest invalid-get-prop: SUCCESS (0.000s)
[93.143411] [079/165] (908s left) kms_addfb_basic (invalid-get-prop-any)
[93.310059] Starting subtest: invalid-get-prop-any
[93.331376] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[93.416723] [080/165] (908s left) kms_addfb_basic (invalid-set-prop)
[93.610977] Starting subtest: invalid-set-prop
[93.632203] Subtest invalid-set-prop: SUCCESS (0.000s)
[93.714314] [081/165] (907s left) kms_addfb_basic (invalid-set-prop-any)
[93.901350] Starting subtest: invalid-set-prop-any
[93.920458] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[94.000864] [082/165] (907s left) kms_addfb_basic (no-handle)
[94.204852] Starting subtest: no-handle
[94.227087] Subtest no-handle: SUCCESS (0.000s)
[94.315730] [083/165] (907s left) kms_addfb_basic (size-max)
[94.510160] Starting subtest: size-max
[94.533733] Subtest size-max: SUCCESS (0.000s)
[94.627115] [084/165] (907s left) kms_addfb_basic (small-bo)
[94.836950] Starting subtest: small-bo
[94.861367] Subtest small-bo: SUCCESS (0.000s)
[94.954211] [085/165] (907s left) kms_addfb_basic (tile-pitch-mismatch)
[95.151167] Starting subtest: tile-pitch-mismatch
[95.175353] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[95.269198] [086/165] (906s left) kms_addfb_basic (too-high)
[95.457394] Starting subtest: too-high
[95.478514] Subtest too-high: SUCCESS (0.001s)
[95.574286] [087/165] (906s left) kms_addfb_basic (too-wide)
[95.763459] Starting subtest: too-wide
[95.788390] Subtest too-wide: SUCCESS (0.000s)
[95.889305] [088/165] (906s left) kms_addfb_basic (unused-handle)
[96.098436] Starting subtest: unused-handle
[96.121140] Subtest unused-handle: SUCCESS (0.000s)
[96.214322] [089/165] (906s left) kms_addfb_basic (unused-modifier)
[96.413182] Starting subtest: unused-modifier
[96.434683] Subtest unused-modifier: SUCCESS (0.000s)
[96.528609] [090/165] (905s left) kms_addfb_basic (unused-offsets)
[96.735316] Starting subtest: unused-offsets
[96.759129] Subtest unused-offsets: SUCCESS (0.000s)
[96.846823] [091/165] (905s left) kms_addfb_basic (unused-pitches)
[97.025469] Starting subtest: unused-pitches
[97.046441] Subtest unused-pitches: SUCCESS (0.000s)
[97.126804] [092/165] (905s left) kms_busy (basic)
[97.328833] Starting subtest: basic
[97.348168] Starting dynamic subtest: flip
[98.077798] Dynamic subtest flip: SUCCESS (0.753s)
[98.108157] Starting dynamic subtest: modeset
[98.703695] Dynamic subtest modeset: SUCCESS (0.635s)
[98.724327] Subtest basic: SUCCESS (1.390s)
[98.891386] [093/165] (903s left) kms_prop_blob (basic)
[99.097369] Starting subtest: basic
[99.119137] Subtest basic: SUCCESS (0.000s)
[99.200078] [094/165] (903s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[99.405786] Starting subtest: basic-busy-flip-before-cursor-atomic
[100.398196] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (0.992s)
[100.558228] [095/165] (902s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[100.732375] Starting subtest: basic-busy-flip-before-cursor-legacy
[101.715187] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (0.977s)
[101.884205] [096/165] (900s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[102.070251] Starting subtest: basic-flip-after-cursor-atomic
[103.058368] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.986s)
[103.222411] [097/165] (899s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[103.402057] Starting subtest: basic-flip-after-cursor-legacy
[104.339507] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.950s)
[104.508293] [098/165] (898s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[104.691519] Starting subtest: basic-flip-after-cursor-varying-size
[105.680205] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.987s)
[105.831340] [099/165] (897s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[106.032046] Starting subtest: basic-flip-before-cursor-atomic
[107.007135] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.973s)
[107.177673] [100/165] (895s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[107.362168] Starting subtest: basic-flip-before-cursor-legacy
[108.364194] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.005s)
[108.541052] [101/165] (894s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[108.731116] Starting subtest: basic-flip-before-cursor-varying-size
[109.727907] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.994s)
[109.909936] [102/165] (893s left) kms_dsc (dsc-basic)
[110.116969] Subtest dsc-basic: SKIP (0.000s)
[110.210322] [103/165] (893s left) kms_flip (basic-flip-vs-dpms)
[110.408973] Starting subtest: basic-flip-vs-dpms
[110.430462] Starting dynamic subtest: A-VGA1
[111.681464] Dynamic subtest A-VGA1: SUCCESS (1.303s)
[111.718856] Starting dynamic subtest: B-VGA1
[112.906836] Dynamic subtest B-VGA1: SUCCESS (1.224s)
[112.925513] Subtest basic-flip-vs-dpms: SUCCESS (2.529s)
[113.109936] [104/165] (890s left) kms_flip (basic-flip-vs-modeset)
[113.322502] Starting subtest: basic-flip-vs-modeset
[113.342194] Starting dynamic subtest: A-VGA1
[114.542729] Dynamic subtest A-VGA1: SUCCESS (1.250s)
[114.576960] Starting dynamic subtest: B-VGA1
[115.706336] Dynamic subtest B-VGA1: SUCCESS (1.165s)
[115.730079] Subtest basic-flip-vs-modeset: SUCCESS (2.418s)
[115.889225] [105/165] (887s left) kms_flip (basic-flip-vs-wf_vblank)
[116.108043] Starting subtest: basic-flip-vs-wf_vblank
[116.129400] Starting dynamic subtest: A-VGA1
[117.616546] Dynamic subtest A-VGA1: SUCCESS (1.549s)
[117.649202] Starting dynamic subtest: B-VGA1
[119.119394] Dynamic subtest B-VGA1: SUCCESS (1.502s)
[119.143177] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.055s)
[119.350838] [106/165] (884s left) kms_flip (basic-plain-flip)
[119.579834] Starting subtest: basic-plain-flip
[119.600845] Starting dynamic subtest: A-VGA1
[120.813802] Dynamic subtest A-VGA1: SUCCESS (1.279s)
[120.842144] Starting dynamic subtest: B-VGA1
[122.023274] Dynamic subtest B-VGA1: SUCCESS (1.213s)
[122.045209] Subtest basic-plain-flip: SUCCESS (2.497s)
[122.252999] [107/165] (881s left) kms_force_connector_basic (force-connector-state)
[122.458043] Starting subtest: force-connector-state
[122.570282] Subtest force-connector-state: SUCCESS (0.118s)
[122.762740] [108/165] (881s left) kms_force_connector_basic (force-edid)
[122.938120] Starting subtest: force-edid
[122.956869] Subtest force-edid: SUCCESS (0.021s)
[123.064159] [109/165] (880s left) kms_force_connector_basic (force-load-detect)
[123.239477] Starting subtest: force-load-detect
[123.393900] Subtest force-load-detect: SUCCESS (0.179s)
[123.604840] [110/165] (880s left) kms_force_connector_basic (prune-stale-modes)
[123.800607] Starting subtest: prune-stale-modes
[123.819749] Subtest prune-stale-modes: SUCCESS (0.020s)
[123.943516] [111/165] (880s left) kms_frontbuffer_tracking (basic)
[124.192831] Starting subtest: basic
[126.419258] Subtest basic: SUCCESS (2.291s)
[126.547274] [112/165] (877s left) kms_hdmi_inject (inject-audio)
[126.757577] Starting subtest: inject-audio
[126.956166] Subtest inject-audio: SUCCESS (0.170s)
[127.186579] [113/165] (876s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[127.376376] Starting subtest: compare-crc-sanitycheck-xr24
[127.395935] Starting dynamic subtest: pipe-A-VGA-1
[127.686340] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.317s)
[127.716026] Starting dynamic subtest: pipe-B-VGA-1
[128.037722] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.360s)
[128.058485] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.679s)
[128.213208] [114/165] (876s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[128.400728] Starting subtest: compare-crc-sanitycheck-nv12
[128.419514] Starting dynamic subtest: pipe-A-VGA-1
[128.457166] Dynamic subtest pipe-A-VGA-1: SKIP (0.000s)
[128.490643] Starting dynamic subtest: pipe-B-VGA-1
[128.540246] Dynamic subtest pipe-B-VGA-1: SKIP (0.000s)
[128.582555] Subtest compare-crc-sanitycheck-nv12: SKIP (0.004s)
[128.670130] [115/165] (875s left) kms_pipe_crc_basic (hang-read-crc)
[128.861464] Starting subtest: hang-read-crc
[128.881102] Starting dynamic subtest: pipe-A-VGA-1
[129.694959] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.835s)
[129.723223] Starting dynamic subtest: pipe-B-VGA-1
[130.568638] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.868s)
[130.587727] Subtest hang-read-crc: SUCCESS (1.706s)
[130.716485] [116/165] (873s left) kms_pipe_crc_basic (nonblocking-crc)
[130.893988] Starting subtest: nonblocking-crc
[130.915527] Starting dynamic subtest: pipe-A-VGA-1
[131.363801] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.476s)
[131.391036] Starting dynamic subtest: pipe-B-VGA-1
[131.864739] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.502s)
[131.885866] Subtest nonblocking-crc: SUCCESS (0.981s)
[132.023424] [117/165] (872s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[132.217818] Starting subtest: nonblocking-crc-frame-sequence
[132.237320] Starting dynamic subtest: pipe-A-VGA-1
[132.701815] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.483s)
[132.733063] Starting dynamic subtest: pipe-B-VGA-1
[133.214888] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.519s)
[133.233610] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.005s)
[133.379934] [118/165] (871s left) kms_pipe_crc_basic (read-crc)
[133.557319] Starting subtest: read-crc
[133.578711] Starting dynamic subtest: pipe-A-VGA-1
[133.990655] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.435s)
[134.021353] Starting dynamic subtest: pipe-B-VGA-1
[134.449772] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.454s)
[134.468897] Subtest read-crc: SUCCESS (0.893s)
[134.605756] [119/165] (870s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[134.780168] Starting subtest: read-crc-frame-sequence
[134.802180] Starting dynamic subtest: pipe-A-VGA-1
[135.180709] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.401s)
[135.209668] Starting dynamic subtest: pipe-B-VGA-1
[135.598690] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.424s)
[135.618513] Subtest read-crc-frame-sequence: SUCCESS (0.828s)
[135.754679] [120/165] (868s left) kms_pm_backlight (basic-brightness)
[135.960611] Subtest basic-brightness: SKIP (0.000s)
[136.041755] [121/165] (868s left) kms_psr (primary_page_flip)
[136.256161] Subtest primary_page_flip: SKIP (0.000s)
[136.339287] [122/165] (868s left) kms_psr (cursor_plane_move)
[136.541537] Subtest cursor_plane_move: SKIP (0.000s)
[136.621703] [123/165] (868s left) kms_psr (sprite_plane_onoff)
[136.849995] Subtest sprite_plane_onoff: SKIP (0.000s)
[136.960929] [124/165] (868s left) kms_psr (primary_mmap_gtt)
[137.198367] Subtest primary_mmap_gtt: SKIP (0.000s)
[137.293971] [125/165] (867s left) kms_setmode (basic-clone-single-crtc)
[137.511126] Starting subtest: basic-clone-single-crtc
[137.584196] Subtest basic-clone-single-crtc: SKIP (0.000s)
[137.683505] [126/165] (867s left) i915_pm_rpm (basic-pci-d3-state)
[139.282162] Subtest basic-pci-d3-state: SKIP (0.000s)
[139.368538] [127/165] (866s left) i915_pm_rpm (basic-rte)
[139.536323] Starting subtest: basic-rte
[141.162772] Subtest basic-rte: SKIP (1.569s)
[141.287791] [128/165] (864s left) i915_pm_rps (basic-api)
[141.503733] Subtest basic-api: SKIP (0.000s)
[141.595129] [129/165] (863s left) prime_self_import (basic-llseek-bad)
[141.772069] Starting subtest: basic-llseek-bad
[141.811136] Subtest basic-llseek-bad: SUCCESS (0.004s)
[141.891612] [130/165] (863s left) prime_self_import (basic-llseek-size)
[142.052113] Starting subtest: basic-llseek-size
[142.091983] Subtest basic-llseek-size: SUCCESS (0.004s)
[142.179282] [131/165] (863s left) prime_self_import (basic-with_fd_dup)
[142.343312] Starting subtest: basic-with_fd_dup
[142.386895] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[142.472102] [132/165] (863s left) prime_self_import (basic-with_one_bo)
[142.630731] Starting subtest: basic-with_one_bo
[142.673657] Subtest basic-with_one_bo: SUCCESS (0.004s)
[142.758611] [133/165] (863s left) prime_self_import (basic-with_one_bo_two_files)
[142.926436] Starting subtest: basic-with_one_bo_two_files
[142.965497] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[143.049683] [134/165] (862s left) prime_self_import (basic-with_two_bos)
[143.218228] Starting subtest: basic-with_two_bos
[143.267064] Subtest basic-with_two_bos: SUCCESS (0.009s)
[143.353300] [135/165] (862s left) prime_vgem (basic-fence-flip)
[143.552490] Starting subtest: basic-fence-flip
[143.908412] Subtest basic-fence-flip: SUCCESS (0.388s)
[144.050134] [136/165] (862s left) prime_vgem (basic-fence-mmap)
[144.271387] Starting subtest: basic-fence-mmap
[144.291049] Subtest basic-fence-mmap: SUCCESS (0.047s)
[144.393543] [137/165] (861s left) prime_vgem (basic-fence-read)
[144.597048] Starting subtest: basic-fence-read
[144.641458] Subtest basic-fence-read: SUCCESS (0.077s)
[144.743034] [138/165] (861s left) prime_vgem (basic-gtt)
[144.916552] Starting subtest: basic-gtt
[144.936105] Subtest basic-gtt: SUCCESS (0.026s)
[145.041507] [139/165] (861s left) prime_vgem (basic-read)
[145.235927] Starting subtest: basic-read
[145.254979] Subtest basic-read: SUCCESS (0.035s)
[145.362605] [140/165] (861s left) prime_vgem (basic-write)
[145.554190] Starting subtest: basic-write
[145.574900] Subtest basic-write: SUCCESS (0.037s)
[145.673373] [141/165] (860s left) vgem_basic (setversion)
[145.873705] Starting subtest: setversion
[145.911871] Subtest setversion: SUCCESS (0.000s)
[145.995080] [142/165] (860s left) vgem_basic (create)
[146.201326] Starting subtest: create
[146.222693] Subtest create: SUCCESS (0.000s)
[146.308501] [143/165] (860s left) vgem_basic (debugfs)
[146.502379] Starting subtest: debugfs
[146.522578] Subtest debugfs: SUCCESS (0.001s)
[146.623385] [144/165] (860s left) vgem_basic (dmabuf-export)
[146.806319] Starting subtest: dmabuf-export
[146.846046] Subtest dmabuf-export: SUCCESS (0.003s)
[146.939419] [145/165] (859s left) vgem_basic (dmabuf-fence)
[147.096471] Starting subtest: dmabuf-fence
[147.118236] Subtest dmabuf-fence: SUCCESS (0.001s)
[147.201929] [146/165] (859s left) vgem_basic (dmabuf-fence-before)
[147.382315] Starting subtest: dmabuf-fence-before
[147.403966] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[147.485281] [147/165] (859s left) vgem_basic (dmabuf-mmap)
[147.646084] Starting subtest: dmabuf-mmap
[147.667405] Subtest dmabuf-mmap: SUCCESS (0.031s)
[147.758978] [148/165] (859s left) vgem_basic (mmap)
[147.946614] Starting subtest: mmap
[147.966096] Subtest mmap: SUCCESS (0.021s)
[148.075592] [149/165] (859s left) vgem_basic (second-client)
[148.243353] Starting subtest: second-client
[148.286563] Subtest second-client: SUCCESS (0.033s)
[148.378932] [150/165] (858s left) vgem_basic (sysfs)
[148.557526] Starting subtest: sysfs
[148.578945] Subtest sysfs: SUCCESS (0.001s)
[148.665527] [151/165] (858s left) core_hotunplug (unbind-rebind)
[148.893784] Starting subtest: unbind-rebind
[151.778317] Subtest unbind-rebind: SUCCESS (2.880s)
[151.865968] [152/165] (855s left) vgem_basic (unload)
[152.036041] Starting subtest: unload
[181.143970] Subtest unload: SUCCESS (28.959s)
[181.231080] [153/165] (826s left) i915_module_load (reload)
[181.394982] Starting subtest: reload
[183.421853] Subtest reload: SUCCESS (2.028s)
[183.518083] [154/165] (824s left) gem_lmem_swapping (basic)
[183.756445] Subtest basic: SKIP (0.000s)
[183.840973] [155/165] (824s left) gem_lmem_swapping (parallel-random-engines)
[184.057141] Subtest parallel-random-engines: SKIP (0.000s)
[184.136819] [156/165] (823s left) gem_lmem_swapping (random-engines)
[184.352872] Subtest random-engines: SKIP (0.000s)
[184.441529] [157/165] (823s left) gem_lmem_swapping (verify-random)
[184.640218] Subtest verify-random: SKIP (0.000s)
[184.727427] [158/165] (823s left) i915_pm_rpm (module-reload)
[186.190997] Subtest module-reload: SKIP (0.000s)
[186.271942] [159/165] (821s left) i915_selftest (live)
[187.109276] Starting subtest: live
[187.130256] Starting dynamic subtest: sanitycheck
[187.827050] Dynamic subtest sanitycheck: SUCCESS (0.722s)
[187.854259] Starting dynamic subtest: uncore
[188.507357] Dynamic subtest uncore: SUCCESS (0.676s)
[188.534737] Starting dynamic subtest: workarounds
[189.282917] Dynamic subtest workarounds: SUCCESS (0.771s)
[189.316572] Starting dynamic subtest: gt_engines
[190.038876] Dynamic subtest gt_engines: SUCCESS (0.753s)
[190.072169] Starting dynamic subtest: gt_timelines
[194.996128] Dynamic subtest gt_timelines: SUCCESS (4.961s)
[195.024046] Starting dynamic subtest: gt_contexts
[195.751419] Dynamic subtest gt_contexts: SUCCESS (0.756s)
[195.777214] Starting dynamic subtest: gt_lrc
[196.477151] Dynamic subtest gt_lrc: SUCCESS (0.722s)
[196.504839] Starting dynamic subtest: gt_mocs
[197.145351] Dynamic subtest gt_mocs: SUCCESS (0.668s)
[197.171172] Starting dynamic subtest: gt_pm
[198.341292] Dynamic subtest gt_pm: SUCCESS (1.190s)
[198.371174] Starting dynamic subtest: gt_heartbeat
[199.097683] Dynamic subtest gt_heartbeat: SUCCESS (0.756s)
[199.129607] Starting dynamic subtest: gt_tlb
[199.867190] Dynamic subtest gt_tlb: SUCCESS (0.767s)
[199.898737] Starting dynamic subtest: requests
[204.241245] Dynamic subtest requests: SUCCESS (4.373s)
[204.268080] Starting dynamic subtest: migrate
[204.907472] Dynamic subtest migrate: SUCCESS (0.663s)
[204.935490] Starting dynamic subtest: active
[205.588423] Dynamic subtest active: SUCCESS (0.678s)
[205.614421] Starting dynamic subtest: objects
[207.701912] Dynamic subtest objects: SUCCESS (2.113s)
[207.729371] Starting dynamic subtest: mman
[213.804126] Dynamic subtest mman: SUCCESS (6.105s)
[213.831185] Starting dynamic subtest: dmabuf
[214.640473] Dynamic subtest dmabuf: SUCCESS (0.831s)
[214.666601] Starting dynamic subtest: vma
[215.306135] Dynamic subtest vma: SUCCESS (0.662s)
[215.333759] Starting dynamic subtest: coherency
[217.032165] Dynamic subtest coherency: SUCCESS (1.728s)
[217.058166] Starting dynamic subtest: gtt
[221.247276] Dynamic subtest gtt: SUCCESS (4.214s)
[221.278485] Starting dynamic subtest: gem
[221.999509] Dynamic subtest gem: SUCCESS (0.751s)
[222.028208] Starting dynamic subtest: evict
[222.698425] Dynamic subtest evict: SUCCESS (0.697s)
[222.728406] Starting dynamic subtest: hugepages
[223.351223] Dynamic subtest hugepages: SUCCESS (0.650s)
[223.383239] Starting dynamic subtest: gem_contexts
[227.088391] Dynamic subtest gem_contexts: SUCCESS (3.737s)
[227.117812] Starting dynamic subtest: client
[227.768041] Dynamic subtest client: SUCCESS (0.678s)
[227.798213] Starting dynamic subtest: gem_migrate
[228.458433] Dynamic subtest gem_migrate: SUCCESS (0.687s)
[228.486734] Starting dynamic subtest: reset
[229.249495] Dynamic subtest reset: SUCCESS (0.790s)
[229.275607] Starting dynamic subtest: memory_region
[229.910540] Dynamic subtest memory_region: SUCCESS (0.650s)
[229.938264] Starting dynamic subtest: hangcheck
[232.232533] Dynamic subtest hangcheck: SUCCESS (2.329s)
[232.259383] Starting dynamic subtest: execlists
[232.918499] Dynamic subtest execlists: SUCCESS (0.682s)
[232.949970] Starting dynamic subtest: ring_submission
[233.591102] Dynamic subtest ring_submission: SUCCESS (0.671s)
[233.622320] Starting dynamic subtest: perf
[234.262274] Dynamic subtest perf: SUCCESS (0.666s)
[234.289181] Starting dynamic subtest: slpc
[234.915169] Dynamic subtest slpc: SUCCESS (0.654s)
[234.942358] Starting dynamic subtest: guc
[235.560776] Dynamic subtest guc: SUCCESS (0.641s)
[235.587804] Starting dynamic subtest: guc_multi_lrc
[236.229366] Dynamic subtest guc_multi_lrc: SUCCESS (0.669s)
[236.256324] Starting dynamic subtest: guc_hang
[236.957306] Dynamic subtest guc_hang: SUCCESS (0.722s)
[236.984042] Starting dynamic subtest: late_gt_pm
[237.602398] Dynamic subtest late_gt_pm: SUCCESS (0.645s)
[237.624447] Subtest live: SUCCESS (50.523s)
[237.707529] [160/165] (770s left) dmabuf (all-tests)
[237.877303] Starting subtest: all-tests
[237.906418] Starting dynamic subtest: sanitycheck
[237.970259] Dynamic subtest sanitycheck: SUCCESS (0.080s)
[238.001056] Starting dynamic subtest: dma_fence
[238.139942] Dynamic subtest dma_fence: SUCCESS (0.177s)
[238.169730] Starting dynamic subtest: dma_fence_chain
[254.098081] Dynamic subtest dma_fence_chain: SUCCESS (15.971s)
[254.129974] Starting dynamic subtest: dma_fence_unwrap
[254.175194] Dynamic subtest dma_fence_unwrap: SUCCESS (0.071s)
[254.207111] Starting dynamic subtest: dma_resv
[254.251552] Dynamic subtest dma_resv: SUCCESS (0.070s)
[254.271775] Subtest all-tests: SUCCESS (16.381s)
[254.352788] [161/165] (753s left) i915_suspend (basic-s2idle-without-i915)
[254.503644] Starting subtest: basic-s2idle-without-i915
[272.522199] Subtest basic-s2idle-without-i915: SUCCESS (2.220s)
[282.648272] [162/165] (751s left) i915_suspend (basic-s3-without-i915)
[282.816862] Starting subtest: basic-s3-without-i915
[299.647592] Subtest basic-s3-without-i915: SUCCESS (1.971s)
[304.971312] [163/165] (749s left) gem_exec_suspend (basic-s0)
[305.189319] Starting subtest: basic-S0
[305.207931] Starting dynamic subtest: smem
[322.596400] Dynamic subtest smem: SUCCESS (2.060s)
[322.618360] Subtest basic-S0: SUCCESS (2.062s)
[325.618009] [164/165] (747s left) gem_exec_suspend (basic-s3)
[325.811607] Starting subtest: basic-S3
[325.831556] Starting dynamic subtest: smem
[342.614486] Dynamic subtest smem: SUCCESS (2.069s)
[342.636240] Subtest basic-S3: SUCCESS (2.071s)
[347.839176] [165/165] (744s left) kms_pipe_crc_basic (suspend-read-crc)
[348.024512] Starting subtest: suspend-read-crc
[348.045990] Starting dynamic subtest: pipe-A-VGA-1
[365.569210] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.732s)
[365.602114] Starting dynamic subtest: pipe-B-VGA-1
[382.610212] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.760s)
[382.631251] Subtest suspend-read-crc: SUCCESS (3.496s)
[385.733863] Closing watchdogs
Done.