[66.686565] Initializing watchdogs
[66.686626]   /dev/watchdog0
[66.692739] [001/165] (960s left) i915_module_load (load)
[66.761907] Starting subtest: load
[68.972796] Subtest load: SUCCESS (2.209s)
[68.985818] [002/165] (958s left) core_auth (basic-auth)
[69.125862] Starting subtest: basic-auth
[69.128677] Subtest basic-auth: SUCCESS (0.004s)
[69.165755] [003/165] (958s left) debugfs_test (read_all_entries)
[69.251961] Starting subtest: read_all_entries
[69.423089] Subtest read_all_entries: SUCCESS (0.166s)
[69.439519] [004/165] (957s left) debugfs_test (basic-hwmon)
[69.520932] Starting subtest: basic-hwmon
[69.524229] Subtest basic-hwmon: SUCCESS (0.002s)
[69.547887] [005/165] (957s left) fbdev (eof)
[69.619307] Starting subtest: eof
[69.620513] Subtest eof: SUCCESS (0.000s)
[69.651542] [006/165] (957s left) fbdev (info)
[69.726432] Starting subtest: info
[69.728679] Subtest info: SUCCESS (0.000s)
[69.755818] [007/165] (957s left) fbdev (nullptr)
[69.829195] Starting subtest: nullptr
[69.831066] Subtest nullptr: SUCCESS (0.000s)
[69.855700] [008/165] (957s left) fbdev (read)
[69.924956] Starting subtest: read
[70.730336] Subtest read: SUCCESS (0.799s)
[70.753518] [009/165] (956s left) fbdev (write)
[70.855083] Starting subtest: write
[71.376646] Subtest write: SUCCESS (0.523s)
[71.408259] [010/165] (955s left) gem_basic (bad-close)
[71.498889] Starting subtest: bad-close
[71.503209] Subtest bad-close: SUCCESS (0.000s)
[71.519704] [011/165] (955s left) gem_basic (create-close)
[71.605811] Starting subtest: create-close
[71.609190] Subtest create-close: SUCCESS (0.000s)
[71.650907] [012/165] (955s left) gem_basic (create-fd-close)
[71.736120] Starting subtest: create-fd-close
[71.740052] Subtest create-fd-close: SUCCESS (0.000s)
[71.786600] [013/165] (955s left) gem_busy (busy@all-engines)
[71.898630] Starting subtest: busy
[71.900676] Starting dynamic subtest: all-engines
[72.025923] Dynamic subtest all-engines: SUCCESS (0.128s)
[72.027735] Subtest busy: SUCCESS (0.129s)
[72.405110] [014/165] (955s left) gem_close_race (basic-process)
[72.535113] Starting subtest: basic-process
[72.616912] Subtest basic-process: SUCCESS (0.082s)
[72.801842] [015/165] (954s left) gem_close_race (basic-threads)
[72.919772] Starting subtest: basic-threads
[74.579348] Subtest basic-threads: SUCCESS (1.660s)
[74.774037] [016/165] (952s left) gem_ctx_create (basic)
[74.876916] Starting subtest: basic
[74.878810] Subtest basic: SUCCESS (0.000s)
[75.026904] [017/165] (952s left) gem_ctx_create (basic-files)
[75.131345] Starting subtest: basic-files
[77.150585] Subtest basic-files: SUCCESS (2.017s)
[77.907414] [018/165] (949s left) gem_ctx_exec (basic)
[78.011605] Starting subtest: basic
[78.014918] Subtest basic: SUCCESS (0.004s)
[78.082690] [019/165] (949s left) gem_exec_basic (basic)
[78.174351] Starting subtest: basic
[78.176283] Starting dynamic subtest: rcs0-smem
[78.178247] Dynamic subtest rcs0-smem: SUCCESS (0.001s)
[78.187374] Starting dynamic subtest: bcs0-smem
[78.189352] Dynamic subtest bcs0-smem: SUCCESS (0.000s)
[78.194999] Starting dynamic subtest: vcs0-smem
[78.196784] Dynamic subtest vcs0-smem: SUCCESS (0.000s)
[78.201232] Starting dynamic subtest: vcs1-smem
[78.202745] Dynamic subtest vcs1-smem: SUCCESS (0.000s)
[78.207453] Starting dynamic subtest: vecs0-smem
[78.209190] Dynamic subtest vecs0-smem: SUCCESS (0.000s)
[78.213532] Starting dynamic subtest: vecs1-smem
[78.215345] Dynamic subtest vecs1-smem: SUCCESS (0.000s)
[78.219494] Starting dynamic subtest: ccs0-smem
[78.221005] Dynamic subtest ccs0-smem: SUCCESS (0.000s)
[78.225197] Starting dynamic subtest: ccs1-smem
[78.227193] Dynamic subtest ccs1-smem: SUCCESS (0.000s)
[78.231461] Starting dynamic subtest: ccs2-smem
[78.232692] Dynamic subtest ccs2-smem: SUCCESS (0.000s)
[78.237114] Starting dynamic subtest: ccs3-smem
[78.238822] Dynamic subtest ccs3-smem: SUCCESS (0.001s)
[78.243362] Starting dynamic subtest: rcs0-lmem0
[78.245044] Dynamic subtest rcs0-lmem0: SUCCESS (0.001s)
[78.249264] Starting dynamic subtest: bcs0-lmem0
[78.250952] Dynamic subtest bcs0-lmem0: SUCCESS (0.000s)
[78.255423] Starting dynamic subtest: vcs0-lmem0
[78.256887] Dynamic subtest vcs0-lmem0: SUCCESS (0.000s)
[78.261449] Starting dynamic subtest: vcs1-lmem0
[78.263037] Dynamic subtest vcs1-lmem0: SUCCESS (0.000s)
[78.267178] Starting dynamic subtest: vecs0-lmem0
[78.268322] Dynamic subtest vecs0-lmem0: SUCCESS (0.000s)
[78.272930] Starting dynamic subtest: vecs1-lmem0
[78.274816] Dynamic subtest vecs1-lmem0: SUCCESS (0.000s)
[78.279453] Starting dynamic subtest: ccs0-lmem0
[78.280737] Dynamic subtest ccs0-lmem0: SUCCESS (0.000s)
[78.285352] Starting dynamic subtest: ccs1-lmem0
[78.287041] Dynamic subtest ccs1-lmem0: SUCCESS (0.000s)
[78.291431] Starting dynamic subtest: ccs2-lmem0
[78.292826] Dynamic subtest ccs2-lmem0: SUCCESS (0.000s)
[78.297320] Starting dynamic subtest: ccs3-lmem0
[78.299018] Dynamic subtest ccs3-lmem0: SUCCESS (0.001s)
[78.300584] Subtest basic: SUCCESS (0.012s)
[78.362758] [020/165] (949s left) gem_exec_create (basic)
[78.470358] Starting subtest: basic
[78.472535] Starting dynamic subtest: smem
[80.590189] Dynamic subtest smem: SUCCESS (2.119s)
[80.603516] Starting dynamic subtest: lmem0
[82.721676] Dynamic subtest lmem0: SUCCESS (2.131s)
[82.723454] Subtest basic: SUCCESS (4.252s)
[82.871991] [021/165] (944s left) gem_exec_fence (basic-busy)
[83.123591] Starting subtest: basic-busy
[83.125649] Starting dynamic subtest: rcs0
[83.242101] Dynamic subtest rcs0: SUCCESS (0.119s)
[83.255631] Starting dynamic subtest: bcs0
[83.295341] Dynamic subtest bcs0: SUCCESS (0.052s)
[83.309575] Starting dynamic subtest: vcs0
[83.350512] Dynamic subtest vcs0: SUCCESS (0.055s)
[83.363771] Starting dynamic subtest: vcs1
[83.404376] Dynamic subtest vcs1: SUCCESS (0.054s)
[83.417720] Starting dynamic subtest: vecs0
[83.458116] Dynamic subtest vecs0: SUCCESS (0.054s)
[83.471920] Starting dynamic subtest: vecs1
[83.512297] Dynamic subtest vecs1: SUCCESS (0.054s)
[83.525785] Starting dynamic subtest: ccs0
[83.566439] Dynamic subtest ccs0: SUCCESS (0.054s)
[83.579871] Starting dynamic subtest: ccs1
[83.625302] Dynamic subtest ccs1: SUCCESS (0.059s)
[83.638418] Starting dynamic subtest: ccs2
[83.675215] Dynamic subtest ccs2: SUCCESS (0.050s)
[83.688663] Starting dynamic subtest: ccs3
[83.725098] Dynamic subtest ccs3: SUCCESS (0.050s)
[83.726781] Subtest basic-busy: SUCCESS (0.602s)
[85.282518] [022/165] (942s left) gem_exec_fence (basic-wait)
[85.552384] Starting subtest: basic-wait
[85.553919] Starting dynamic subtest: rcs0
[85.683683] Dynamic subtest rcs0: SUCCESS (0.131s)
[85.697306] Starting dynamic subtest: bcs0
[85.741287] Dynamic subtest bcs0: SUCCESS (0.057s)
[85.754393] Starting dynamic subtest: vcs0
[85.795425] Dynamic subtest vcs0: SUCCESS (0.054s)
[85.808715] Starting dynamic subtest: vcs1
[85.852401] Dynamic subtest vcs1: SUCCESS (0.056s)
[85.865966] Starting dynamic subtest: vecs0
[85.906266] Dynamic subtest vecs0: SUCCESS (0.054s)
[85.919866] Starting dynamic subtest: vecs1
[85.956138] Dynamic subtest vecs1: SUCCESS (0.050s)
[85.969666] Starting dynamic subtest: ccs0
[86.006326] Dynamic subtest ccs0: SUCCESS (0.049s)
[86.019897] Starting dynamic subtest: ccs1
[86.066318] Dynamic subtest ccs1: SUCCESS (0.059s)
[86.079429] Starting dynamic subtest: ccs2
[86.120464] Dynamic subtest ccs2: SUCCESS (0.054s)
[86.134388] Starting dynamic subtest: ccs3
[86.171427] Dynamic subtest ccs3: SUCCESS (0.051s)
[86.172846] Subtest basic-wait: SUCCESS (0.619s)
[87.677189] [023/165] (939s left) gem_exec_fence (basic-await)
[87.950716] Starting subtest: basic-await
[87.952660] Starting dynamic subtest: rcs0
[88.133433] Dynamic subtest rcs0: SUCCESS (0.183s)
[88.148328] Starting dynamic subtest: bcs0
[88.266509] Dynamic subtest bcs0: SUCCESS (0.133s)
[88.281083] Starting dynamic subtest: vcs0
[88.393258] Dynamic subtest vcs0: SUCCESS (0.126s)
[88.407630] Starting dynamic subtest: vcs1
[88.523804] Dynamic subtest vcs1: SUCCESS (0.130s)
[88.538305] Starting dynamic subtest: vecs0
[88.657241] Dynamic subtest vecs0: SUCCESS (0.133s)
[88.670907] Starting dynamic subtest: vecs1
[88.776569] Dynamic subtest vecs1: SUCCESS (0.119s)
[88.791483] Starting dynamic subtest: ccs0
[88.891939] Dynamic subtest ccs0: SUCCESS (0.116s)
[88.906135] Starting dynamic subtest: ccs1
[88.990723] Dynamic subtest ccs1: SUCCESS (0.098s)
[89.005996] Starting dynamic subtest: ccs2
[89.140616] Dynamic subtest ccs2: SUCCESS (0.150s)
[89.154295] Starting dynamic subtest: ccs3
[89.275198] Dynamic subtest ccs3: SUCCESS (0.134s)
[89.276115] Subtest basic-await: SUCCESS (1.325s)
[90.896971] [024/165] (936s left) gem_exec_fence (nb-await)
[91.143969] Starting subtest: nb-await
[91.146089] Starting dynamic subtest: rcs0
[91.260517] Dynamic subtest rcs0: SUCCESS (0.116s)
[91.276558] Starting dynamic subtest: bcs0
[91.322706] Dynamic subtest bcs0: SUCCESS (0.062s)
[91.338714] Starting dynamic subtest: vcs0
[91.386310] Dynamic subtest vcs0: SUCCESS (0.063s)
[91.401523] Starting dynamic subtest: vcs1
[91.449161] Dynamic subtest vcs1: SUCCESS (0.063s)
[91.463997] Starting dynamic subtest: vecs0
[91.512391] Dynamic subtest vecs0: SUCCESS (0.063s)
[91.527223] Starting dynamic subtest: vecs1
[91.576988] Dynamic subtest vecs1: SUCCESS (0.063s)
[91.591228] Starting dynamic subtest: ccs0
[91.638561] Dynamic subtest ccs0: SUCCESS (0.063s)
[91.651795] Starting dynamic subtest: ccs1
[91.701594] Dynamic subtest ccs1: SUCCESS (0.062s)
[91.714767] Starting dynamic subtest: ccs2
[91.763182] Dynamic subtest ccs2: SUCCESS (0.062s)
[91.776481] Starting dynamic subtest: ccs3
[91.825510] Dynamic subtest ccs3: SUCCESS (0.062s)
[91.827049] Subtest nb-await: SUCCESS (0.682s)
[93.338067] [025/165] (934s left) gem_exec_gttfill (basic)
[93.463877] Starting subtest: basic
[102.061606] Subtest basic: SUCCESS (8.597s)
[102.270996] [026/165] (925s left) gem_exec_parallel (engines)
[102.412878] Starting subtest: engines
[102.413851] Starting dynamic subtest: basic
[105.985070] Dynamic subtest basic: SUCCESS (3.572s)
[105.999999] Starting dynamic subtest: contexts
[110.773493] Dynamic subtest contexts: SUCCESS (4.787s)
[110.789228] Starting dynamic subtest: fds
[115.579220] Dynamic subtest fds: SUCCESS (4.805s)
[115.597679] Starting dynamic subtest: userptr
[118.585596] Dynamic subtest userptr: SUCCESS (3.006s)
[118.587149] Subtest engines: SUCCESS (16.173s)
[118.857752] [027/165] (908s left) gem_exec_store (basic)
[118.982688] Starting subtest: basic
[119.152290] Subtest basic: SUCCESS (0.169s)
[119.345029] [028/165] (908s left) gem_flink_basic (bad-flink)
[119.458199] Starting subtest: bad-flink
[119.464067] Subtest bad-flink: SUCCESS (0.000s)
[119.481932] [029/165] (908s left) gem_flink_basic (bad-open)
[119.574295] Starting subtest: bad-open
[119.578867] Subtest bad-open: SUCCESS (0.000s)
[119.597485] [030/165] (908s left) gem_flink_basic (basic)
[119.695418] Starting subtest: basic
[119.696874] Subtest basic: SUCCESS (0.000s)
[119.758855] [031/165] (908s left) gem_flink_basic (double-flink)
[119.853576] Starting subtest: double-flink
[119.854977] Subtest double-flink: SUCCESS (0.000s)
[119.905501] [032/165] (907s left) gem_flink_basic (flink-lifetime)
[120.021874] Starting subtest: flink-lifetime
[120.023378] Subtest flink-lifetime: SUCCESS (0.002s)
[120.071388] [033/165] (907s left) gem_huc_copy (huc-copy)
[120.229416] Starting subtest: huc-copy
[120.236459] Subtest huc-copy: SUCCESS (0.007s)
[120.311611] [034/165] (907s left) gem_linear_blits (basic)
[120.554735] Starting subtest: basic
[120.581053] Subtest basic: SUCCESS (0.027s)
[120.686943] [035/165] (907s left) gem_mmap (basic)
[120.831942] Subtest basic: SKIP (0.000s)
[120.850370] [036/165] (907s left) gem_mmap_gtt (basic)
[120.950335] Subtest basic: SKIP (0.000s)
[120.966489] [037/165] (907s left) gem_render_linear_blits (basic)
[121.092045] Starting subtest: basic
[121.173684] Subtest basic: SUCCESS (0.082s)
[121.244227] [038/165] (906s left) gem_render_tiled_blits (basic)
[121.365061] Subtest basic: SKIP (0.000s)
[121.386150] [039/165] (906s left) gem_ringfill (basic-all)
[121.885297] Starting subtest: basic-all
[123.294493] Subtest basic-all: SUCCESS (1.408s)
[123.376197] [040/165] (904s left) gem_softpin (allocator-basic)
[123.475926] Starting subtest: allocator-basic
[123.718878] Subtest allocator-basic: SUCCESS (0.242s)
[123.836803] [041/165] (904s left) gem_softpin (allocator-basic-reserve)
[123.953707] Starting subtest: allocator-basic-reserve
[124.194715] Subtest allocator-basic-reserve: SUCCESS (0.240s)
[124.285754] [042/165] (903s left) gem_softpin (safe-alignment)
[124.394049] Starting subtest: safe-alignment
[124.472179] Subtest safe-alignment: SUCCESS (0.078s)
[124.544486] [043/165] (903s left) gem_sync (basic-all)
[124.667821] Starting subtest: basic-all
[126.794597] Subtest basic-all: SUCCESS (2.126s)
[126.949278] [044/165] (901s left) gem_sync (basic-each)
[127.074959] Starting subtest: basic-each
[129.754643] Subtest basic-each: SUCCESS (2.680s)
[129.916167] [045/165] (898s left) gem_tiled_blits (basic)
[130.022878] Subtest basic: SKIP (0.000s)
[130.046492] [046/165] (898s left) gem_tiled_fence_blits (basic)
[130.143480] Subtest basic: SKIP (0.000s)
[130.176789] [047/165] (898s left) gem_tiled_pread_basic
[130.300723] [048/165] (897s left) gem_wait (busy@all-engines)
[130.410535] Starting subtest: busy
[130.411829] Starting dynamic subtest: all-engines
[131.000239] Dynamic subtest all-engines: SUCCESS (0.589s)
[131.001691] Subtest busy: SUCCESS (0.589s)
[131.253133] [049/165] (897s left) gem_wait (wait@all-engines)
[131.375936] Starting subtest: wait
[131.377584] Starting dynamic subtest: all-engines
[132.475506] Dynamic subtest all-engines: SUCCESS (1.099s)
[132.477057] Subtest wait: SUCCESS (1.099s)
[132.720656] [050/165] (895s left) i915_getparams_basic (basic-eu-total)
[132.813063] Starting subtest: basic-eu-total
[132.822381] Subtest basic-eu-total: SUCCESS (0.000s)
[132.833839] [051/165] (895s left) i915_getparams_basic (basic-subslice-total)
[132.938514] Starting subtest: basic-subslice-total
[132.945039] Subtest basic-subslice-total: SUCCESS (0.000s)
[132.973242] [052/165] (895s left) i915_hangman (error-state-basic)
[133.084828] Starting subtest: error-state-basic
[133.248434] Subtest error-state-basic: SUCCESS (0.163s)
[133.289865] [053/165] (895s left) i915_pciid
[133.401872] [054/165] (895s left) kms_addfb_basic (addfb25-4-tiled)
[133.494865] Subtest addfb25-4-tiled: SKIP (0.000s)
[133.523740] [055/165] (894s left) kms_addfb_basic (addfb25-bad-modifier)
[133.640253] Subtest addfb25-bad-modifier: SKIP (0.000s)
[133.666401] [056/165] (894s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[133.783087] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[133.806664] [057/165] (894s left) kms_addfb_basic (addfb25-modifier-no-flag)
[133.918033] Subtest addfb25-modifier-no-flag: SKIP (0.000s)
[133.946182] [058/165] (894s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[134.054067] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[134.090825] [059/165] (894s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[134.202998] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[134.216997] [060/165] (894s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[134.333934] Subtest addfb25-yf-tiled-legacy: SKIP (0.000s)
[134.347783] [061/165] (894s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[134.454694] Subtest addfb25-y-tiled-legacy: SKIP (0.000s)
[134.480154] [062/165] (894s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[134.601790] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[134.628874] [063/165] (894s left) kms_addfb_basic (bad-pitch-0)
[134.726788] Subtest bad-pitch-0: SKIP (0.000s)
[134.744635] [064/165] (893s left) kms_addfb_basic (bad-pitch-1024)
[134.855066] Subtest bad-pitch-1024: SKIP (0.000s)
[134.886323] [065/165] (893s left) kms_addfb_basic (bad-pitch-128)
[134.993063] Subtest bad-pitch-128: SKIP (0.000s)
[135.026902] [066/165] (893s left) kms_addfb_basic (bad-pitch-256)
[135.121037] Subtest bad-pitch-256: SKIP (0.000s)
[135.146979] [067/165] (893s left) kms_addfb_basic (bad-pitch-32)
[135.242065] Subtest bad-pitch-32: SKIP (0.000s)
[135.264391] [068/165] (893s left) kms_addfb_basic (bad-pitch-63)
[135.371963] Subtest bad-pitch-63: SKIP (0.000s)
[135.395473] [069/165] (893s left) kms_addfb_basic (bad-pitch-65536)
[135.488056] Subtest bad-pitch-65536: SKIP (0.000s)
[135.509795] [070/165] (893s left) kms_addfb_basic (bad-pitch-999)
[135.621045] Subtest bad-pitch-999: SKIP (0.000s)
[135.643100] [071/165] (893s left) kms_addfb_basic (basic)
[135.733063] Subtest basic: SKIP (0.000s)
[135.759994] [072/165] (893s left) kms_addfb_basic (basic-x-tiled-legacy)
[135.856896] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[135.877676] [073/165] (893s left) kms_addfb_basic (basic-y-tiled-legacy)
[135.968051] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[135.996103] [074/165] (892s left) kms_addfb_basic (bo-too-small)
[136.089562] Subtest bo-too-small: SKIP (0.000s)
[136.121139] [075/165] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[136.211955] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[136.241907] [076/165] (892s left) kms_addfb_basic (clobberred-modifier)
[136.332997] Subtest clobberred-modifier: SKIP (0.000s)
[136.354402] [077/165] (892s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[136.448022] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[136.479719] [078/165] (892s left) kms_addfb_basic (invalid-get-prop)
[136.586047] Subtest invalid-get-prop: SKIP (0.000s)
[136.618160] [079/165] (892s left) kms_addfb_basic (invalid-get-prop-any)
[136.738669] Subtest invalid-get-prop-any: SKIP (0.000s)
[136.767121] [080/165] (892s left) kms_addfb_basic (invalid-set-prop)
[136.862055] Subtest invalid-set-prop: SKIP (0.000s)
[136.888898] [081/165] (892s left) kms_addfb_basic (invalid-set-prop-any)
[137.001080] Subtest invalid-set-prop-any: SKIP (0.000s)
[137.026877] [082/165] (892s left) kms_addfb_basic (no-handle)
[137.123059] Subtest no-handle: SKIP (0.000s)
[137.154861] [083/165] (892s left) kms_addfb_basic (size-max)
[137.252588] Subtest size-max: SKIP (0.000s)
[137.276224] [084/165] (891s left) kms_addfb_basic (small-bo)
[137.366969] Subtest small-bo: SKIP (0.000s)
[137.400443] [085/165] (891s left) kms_addfb_basic (tile-pitch-mismatch)
[137.510389] Subtest tile-pitch-mismatch: SKIP (0.000s)
[137.543903] [086/165] (891s left) kms_addfb_basic (too-high)
[137.650058] Subtest too-high: SKIP (0.000s)
[137.680800] [087/165] (891s left) kms_addfb_basic (too-wide)
[137.776061] Subtest too-wide: SKIP (0.000s)
[137.797460] [088/165] (891s left) kms_addfb_basic (unused-handle)
[137.891926] Subtest unused-handle: SKIP (0.000s)
[137.907055] [089/165] (891s left) kms_addfb_basic (unused-modifier)
[138.010050] Subtest unused-modifier: SKIP (0.000s)
[138.036829] [090/165] (891s left) kms_addfb_basic (unused-offsets)
[138.132069] Subtest unused-offsets: SKIP (0.000s)
[138.153466] [091/165] (891s left) kms_addfb_basic (unused-pitches)
[138.244856] Subtest unused-pitches: SKIP (0.000s)
[138.274185] [092/165] (891s left) kms_busy (basic)
[138.365533] Subtest basic: SKIP (0.000s)
[138.426403] [093/165] (891s left) kms_prop_blob (basic)
[138.522037] Subtest basic: SKIP (0.000s)
[138.548574] [094/165] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[138.672035] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[138.703444] [095/165] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[138.816044] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[138.846717] [096/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[138.953065] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[138.997247] [097/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[139.086039] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[139.120416] [098/165] (890s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[139.230038] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[139.264518] [099/165] (890s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[139.376032] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[139.409144] [100/165] (890s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[139.504065] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[139.526764] [101/165] (890s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[139.618038] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[139.640564] [102/165] (890s left) kms_dsc (dsc-basic)
[139.737854] Subtest dsc-basic: SKIP (0.000s)
[139.770955] [103/165] (889s left) kms_flip (basic-flip-vs-dpms)
[139.865355] Starting subtest: basic-flip-vs-dpms
[139.867147] Subtest basic-flip-vs-dpms: SKIP (0.000s)
[139.921559] [104/165] (889s left) kms_flip (basic-flip-vs-modeset)
[140.028705] Starting subtest: basic-flip-vs-modeset
[140.030532] Subtest basic-flip-vs-modeset: SKIP (0.000s)
[140.086672] [105/165] (889s left) kms_flip (basic-flip-vs-wf_vblank)
[140.196238] Starting subtest: basic-flip-vs-wf_vblank
[140.198461] Subtest basic-flip-vs-wf_vblank: SKIP (0.000s)
[140.256780] [106/165] (889s left) kms_flip (basic-plain-flip)
[140.363192] Starting subtest: basic-plain-flip
[140.365190] Subtest basic-plain-flip: SKIP (0.000s)
[140.422243] [107/165] (889s left) kms_force_connector_basic (force-connector-state)
[140.507042] Subtest force-connector-state: SKIP (0.000s)
[140.523902] [108/165] (889s left) kms_force_connector_basic (force-edid)
[140.608518] Subtest force-edid: SKIP (0.000s)
[140.626250] [109/165] (889s left) kms_force_connector_basic (force-load-detect)
[140.711129] Subtest force-load-detect: SKIP (0.000s)
[140.740323] [110/165] (889s left) kms_force_connector_basic (prune-stale-modes)
[140.852047] Subtest prune-stale-modes: SKIP (0.000s)
[140.884805] [111/165] (889s left) kms_frontbuffer_tracking (basic)
[140.966032] Subtest basic: SKIP (0.000s)
[141.000306] [112/165] (888s left) kms_hdmi_inject (inject-audio)
[141.087056] Subtest inject-audio: SKIP (0.000s)
[141.106482] [113/165] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[141.212043] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[141.246102] [114/165] (888s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[141.353068] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[141.376547] [115/165] (888s left) kms_pipe_crc_basic (hang-read-crc)
[141.465029] Subtest hang-read-crc: SKIP (0.000s)
[141.497281] [116/165] (888s left) kms_pipe_crc_basic (nonblocking-crc)
[141.587328] Subtest nonblocking-crc: SKIP (0.000s)
[141.620235] [117/165] (888s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[141.729033] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[141.762504] [118/165] (888s left) kms_pipe_crc_basic (read-crc)
[141.852063] Subtest read-crc: SKIP (0.000s)
[141.884820] [119/165] (888s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[141.976923] Subtest read-crc-frame-sequence: SKIP (0.000s)
[142.000468] [120/165] (888s left) kms_pm_backlight (basic-brightness)
[142.106048] Subtest basic-brightness: SKIP (0.000s)
[142.137882] [121/165] (888s left) kms_pm_rpm (basic-pci-d3-state)
[142.238038] Subtest basic-pci-d3-state: SKIP (0.000s)
[142.267447] [122/165] (888s left) kms_pm_rpm (basic-rte)
[142.340430] Starting subtest: basic-rte
[142.357973] Subtest basic-rte: SKIP (0.012s)
[142.375111] [123/165] (887s left) kms_psr (primary_page_flip)
[142.471497] Subtest primary_page_flip: SKIP (0.000s)
[142.493764] [124/165] (887s left) kms_psr (cursor_plane_move)
[142.591060] Subtest cursor_plane_move: SKIP (0.000s)
[142.611566] [125/165] (887s left) kms_psr (sprite_plane_onoff)
[142.724610] Subtest sprite_plane_onoff: SKIP (0.000s)
[142.747485] [126/165] (887s left) kms_psr (primary_mmap_gtt)
[142.839930] Subtest primary_mmap_gtt: SKIP (0.000s)
[142.859290] [127/165] (887s left) kms_setmode (basic-clone-single-crtc)
[142.966052] Subtest basic-clone-single-crtc: SKIP (0.000s)
[142.989431] [128/165] (887s left) i915_pm_rps (basic-api)
[143.088765] Starting subtest: basic-api
[143.090659] Subtest basic-api: SKIP (0.000s)
[143.118125] [129/165] (887s left) prime_self_import (basic-llseek-bad)
[143.194647] Starting subtest: basic-llseek-bad
[143.207524] Subtest basic-llseek-bad: SUCCESS (0.013s)
[143.249830] [130/165] (887s left) prime_self_import (basic-llseek-size)
[143.321909] Starting subtest: basic-llseek-size
[143.332629] Subtest basic-llseek-size: SUCCESS (0.009s)
[143.384074] [131/165] (887s left) prime_self_import (basic-with_fd_dup)
[143.473212] Starting subtest: basic-with_fd_dup
[143.479525] Subtest basic-with_fd_dup: SUCCESS (0.010s)
[143.523539] [132/165] (886s left) prime_self_import (basic-with_one_bo)
[143.604596] Starting subtest: basic-with_one_bo
[143.624189] Subtest basic-with_one_bo: SUCCESS (0.018s)
[143.649280] [133/165] (886s left) prime_self_import (basic-with_one_bo_two_files)
[143.724342] Starting subtest: basic-with_one_bo_two_files
[143.737977] Subtest basic-with_one_bo_two_files: SUCCESS (0.014s)
[143.779024] [134/165] (886s left) prime_self_import (basic-with_two_bos)
[143.859208] Starting subtest: basic-with_two_bos
[143.870208] Subtest basic-with_two_bos: SUCCESS (0.012s)
[143.923657] [135/165] (886s left) prime_vgem (basic-fence-flip)
[144.045823] Starting subtest: basic-fence-flip
[144.048211] Subtest basic-fence-flip: SKIP (0.000s)
[144.108535] [136/165] (886s left) prime_vgem (basic-fence-mmap)
[144.228326] Starting subtest: basic-fence-mmap
[144.230431] Subtest basic-fence-mmap: SKIP (0.000s)
[144.286380] [137/165] (886s left) prime_vgem (basic-fence-read)
[144.382852] Starting subtest: basic-fence-read
[144.407485] Subtest basic-fence-read: SKIP (0.023s)
[144.451736] [138/165] (886s left) prime_vgem (basic-gtt)
[144.537940] Starting subtest: basic-gtt
[144.539665] Subtest basic-gtt: SKIP (0.000s)
[144.599169] [139/165] (886s left) prime_vgem (basic-read)
[144.716472] Starting subtest: basic-read
[144.725639] Subtest basic-read: SKIP (0.008s)
[144.783490] [140/165] (885s left) prime_vgem (basic-write)
[144.876511] Starting subtest: basic-write
[144.885511] Subtest basic-write: SKIP (0.008s)
[144.944655] [141/165] (885s left) vgem_basic (setversion)
[145.034037] Starting subtest: setversion
[145.038871] Subtest setversion: SUCCESS (0.000s)
[145.065907] [142/165] (885s left) vgem_basic (create)
[145.155557] Starting subtest: create
[145.158515] Subtest create: SUCCESS (0.000s)
[145.183052] [143/165] (885s left) vgem_basic (debugfs)
[145.272784] Starting subtest: debugfs
[145.275755] Subtest debugfs: SUCCESS (0.000s)
[145.295705] [144/165] (885s left) vgem_basic (dmabuf-export)
[145.371545] Starting subtest: dmabuf-export
[145.384498] Subtest dmabuf-export: SUCCESS (0.014s)
[145.437143] [145/165] (885s left) vgem_basic (dmabuf-fence)
[145.514496] Starting subtest: dmabuf-fence
[145.515379] Subtest dmabuf-fence: SUCCESS (0.000s)
[145.540769] [146/165] (885s left) vgem_basic (dmabuf-fence-before)
[145.614101] Starting subtest: dmabuf-fence-before
[145.616586] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[145.645788] [147/165] (885s left) vgem_basic (dmabuf-mmap)
[145.723451] Starting subtest: dmabuf-mmap
[145.734141] Subtest dmabuf-mmap: SUCCESS (0.012s)
[145.758432] [148/165] (885s left) vgem_basic (mmap)
[145.830875] Starting subtest: mmap
[145.853839] Subtest mmap: SUCCESS (0.023s)
[145.881367] [149/165] (884s left) vgem_basic (second-client)
[145.968112] Starting subtest: second-client
[145.970751] Subtest second-client: SUCCESS (0.003s)
[145.997364] [150/165] (884s left) vgem_basic (sysfs)
[146.098068] Starting subtest: sysfs
[146.100432] Subtest sysfs: SUCCESS (0.000s)
[146.112633] [151/165] (884s left) core_hotunplug (unbind-rebind)
[146.269780] Starting subtest: unbind-rebind
[150.560450] Subtest unbind-rebind: SUCCESS (4.288s)
[150.594726] [152/165] (880s left) vgem_basic (unload)
[150.659792] Starting subtest: unload
[179.544692] Subtest unload: SUCCESS (28.885s)
[179.615442] [153/165] (851s left) i915_module_load (reload)
[179.713846] Starting subtest: reload
[183.139112] Subtest reload: SUCCESS (3.425s)
[183.157082] [154/165] (847s left) gem_lmem_swapping (basic)
[186.244098] Starting subtest: basic
[186.245393] Starting dynamic subtest: lmem0
[227.816713] Dynamic subtest lmem0: SUCCESS (41.572s)
[227.818134] Subtest basic: SUCCESS (41.572s)
[230.161596] [155/165] (800s left) gem_lmem_swapping (parallel-random-engines)
[231.132226] Starting subtest: parallel-random-engines
[231.132820] Starting dynamic subtest: lmem0
[235.460082] Dynamic subtest lmem0: SUCCESS (4.326s)
[235.461577] Subtest parallel-random-engines: SUCCESS (4.327s)
[236.900175] [156/165] (794s left) gem_lmem_swapping (random-engines)
[237.812956] Starting subtest: random-engines
[237.814309] Starting dynamic subtest: lmem0
[239.182317] Dynamic subtest lmem0: SUCCESS (1.369s)
[239.183462] Subtest random-engines: SUCCESS (1.370s)
[240.504680] [157/165] (790s left) gem_lmem_swapping (verify-random)
[241.357649] Starting subtest: verify-random
[241.358893] Starting dynamic subtest: lmem0
[256.797610] Dynamic subtest lmem0: SUCCESS (15.439s)
[256.799028] Subtest verify-random: SUCCESS (15.440s)
[258.298165] [158/165] (772s left) i915_pm_rpm (module-reload)
[270.207592] Starting subtest: module-reload
[300.949808] Subtest module-reload: SUCCESS (30.741s)
[300.981847] [159/165] (730s left) i915_selftest (live)
[301.088633] Starting subtest: live
[301.089964] Starting dynamic subtest: sanitycheck
[303.595699] Dynamic subtest sanitycheck: SUCCESS (2.506s)
[303.608964] Starting dynamic subtest: uncore
[306.219755] Dynamic subtest uncore: SUCCESS (2.624s)
[306.233212] Starting dynamic subtest: workarounds
[310.584872] Dynamic subtest workarounds: SUCCESS (4.365s)
[310.598295] Starting dynamic subtest: gt_engines
[314.249103] Dynamic subtest gt_engines: SUCCESS (3.664s)
[314.263714] Starting dynamic subtest: gt_timelines
[339.813372] Dynamic subtest gt_timelines: SUCCESS (25.565s)
[339.826149] Starting dynamic subtest: gt_contexts
[342.295219] Dynamic subtest gt_contexts: SUCCESS (2.482s)
[342.308153] Starting dynamic subtest: gt_lrc
[351.622336] Dynamic subtest gt_lrc: SUCCESS (9.327s)
[351.635227] Starting dynamic subtest: gt_mocs
[355.307476] Dynamic subtest gt_mocs: SUCCESS (3.684s)
[355.321964] Starting dynamic subtest: gt_pm
[358.657644] Dynamic subtest gt_pm: SUCCESS (3.349s)
[358.671133] Starting dynamic subtest: gt_heartbeat
[361.360430] Dynamic subtest gt_heartbeat: SUCCESS (2.703s)
[361.373997] Starting dynamic subtest: gt_tlb
[377.625421] Dynamic subtest gt_tlb: SUCCESS (16.265s)
[377.639338] Starting dynamic subtest: requests
[398.345881] Dynamic subtest requests: SUCCESS (20.720s)
[398.360913] Starting dynamic subtest: migrate
[405.597414] Dynamic subtest migrate: SUCCESS (7.250s)
[405.612817] Starting dynamic subtest: active
[408.060783] Dynamic subtest active: SUCCESS (2.464s)
[408.073641] Starting dynamic subtest: objects
[412.042845] Dynamic subtest objects: SUCCESS (3.981s)
[412.055938] Starting dynamic subtest: mman
[422.167558] Dynamic subtest mman: SUCCESS (10.124s)
[422.183385] Starting dynamic subtest: dmabuf
[424.861049] Dynamic subtest dmabuf: SUCCESS (2.691s)
[424.874571] Starting dynamic subtest: vma
[427.457598] Dynamic subtest vma: SUCCESS (2.595s)
[427.472526] Starting dynamic subtest: coherency
[431.661678] Dynamic subtest coherency: SUCCESS (4.203s)
[431.675995] Starting dynamic subtest: gtt
[451.453986] Dynamic subtest gtt: SUCCESS (19.791s)
[451.470534] Starting dynamic subtest: gem
[454.249565] Dynamic subtest gem: SUCCESS (2.794s)
[454.264732] Starting dynamic subtest: evict
[458.983916] Dynamic subtest evict: SUCCESS (4.732s)
[458.999043] Starting dynamic subtest: hugepages
[478.395065] Dynamic subtest hugepages: SUCCESS (19.409s)
[478.410819] Starting dynamic subtest: gem_contexts
[527.094818] Dynamic subtest gem_contexts: SUCCESS (48.698s)
[527.111869] Starting dynamic subtest: client
[529.760853] Dynamic subtest client: SUCCESS (2.664s)
[529.777040] Starting dynamic subtest: gem_migrate
[534.245805] Dynamic subtest gem_migrate: SUCCESS (4.483s)
[534.260754] Starting dynamic subtest: reset
[536.906929] Dynamic subtest reset: SUCCESS (2.659s)
[536.920903] Starting dynamic subtest: memory_region
[541.054676] Dynamic subtest memory_region: SUCCESS (4.146s)
[541.072108] Starting dynamic subtest: hangcheck
[583.647982] Dynamic subtest hangcheck: SUCCESS (42.591s)
[583.664238] Starting dynamic subtest: execlists
[586.141955] Dynamic subtest execlists: SUCCESS (2.493s)
[586.158748] Starting dynamic subtest: ring_submission
[588.728412] Dynamic subtest ring_submission: SUCCESS (2.584s)
[588.743681] Starting dynamic subtest: perf
[591.397247] Dynamic subtest perf: SUCCESS (2.668s)
[591.411891] Starting dynamic subtest: slpc
[601.668831] Dynamic subtest slpc: SUCCESS (10.270s)
[601.684887] Starting dynamic subtest: guc
[605.697236] Dynamic subtest guc: SUCCESS (4.026s)
[605.711464] Starting dynamic subtest: guc_multi_lrc
[608.262116] Dynamic subtest guc_multi_lrc: SUCCESS (2.563s)
[608.276585] Starting dynamic subtest: guc_hang
[611.470975] Dynamic subtest guc_hang: SUCCESS (3.207s)
[611.484682] Starting dynamic subtest: late_gt_pm
[614.068423] Dynamic subtest late_gt_pm: SUCCESS (2.592s)
[614.069935] Subtest live: SUCCESS (312.976s)
[614.284584] [160/165] (416s left) dmabuf (all-tests)
[614.371054] Starting subtest: all-tests
[614.372667] Starting dynamic subtest: sanitycheck
[614.434073] Dynamic subtest sanitycheck: SUCCESS (0.066s)
[614.452861] Starting dynamic subtest: dma_fence
[614.616996] Dynamic subtest dma_fence: SUCCESS (0.180s)
[614.634417] Starting dynamic subtest: dma_fence_chain
[625.938849] Dynamic subtest dma_fence_chain: SUCCESS (11.319s)
[625.954236] Starting dynamic subtest: dma_fence_unwrap
[626.047632] Dynamic subtest dma_fence_unwrap: SUCCESS (0.107s)
[626.064198] Starting dynamic subtest: dma_resv
[626.162668] Dynamic subtest dma_resv: SUCCESS (0.113s)
[626.164075] Subtest all-tests: SUCCESS (11.796s)
[626.205239] [161/165] (404s left) i915_suspend (basic-s2idle-without-i915)
[626.301059] Starting subtest: basic-s2idle-without-i915
[647.440144] Subtest basic-s2idle-without-i915: SUCCESS (6.767s)
[657.526606] [162/165] (398s left) i915_suspend (basic-s3-without-i915)
[657.609444] Starting subtest: basic-s3-without-i915
[659.928182] Subtest basic-s3-without-i915: SKIP (2.316s)
[660.791600] [163/165] (394s left) gem_exec_suspend (basic-s0)
[660.903718] Starting subtest: basic-S0
[660.905221] Starting dynamic subtest: smem
[682.092590] Dynamic subtest smem: SUCCESS (7.755s)
[682.112319] Starting dynamic subtest: lmem0
[703.117068] Dynamic subtest lmem0: SUCCESS (7.745s)
[703.118325] Subtest basic-S0: SUCCESS (15.503s)
[712.321283] [164/165] (379s left) gem_exec_suspend (basic-s3)
[712.470143] Starting subtest: basic-S3
[712.471675] Starting dynamic subtest: smem
[734.122855] Dynamic subtest smem: SUCCESS (7.793s)
[734.141740] Starting dynamic subtest: lmem0
[755.016417] Dynamic subtest lmem0: SUCCESS (7.479s)
[755.017997] Subtest basic-S3: SUCCESS (15.275s)
[762.232464] [165/165] (363s left) kms_pipe_crc_basic (suspend-read-crc)
[762.354632] Subtest suspend-read-crc: SKIP (0.000s)
[762.366374] Closing watchdogs
Done.