[46.521783] Initializing watchdogs
[46.521884]   /dev/watchdog0
[46.529285] [001/164] (960s left) i915_module_load (load)
[46.608133] Starting subtest: load
[47.619531] Subtest load: SUCCESS (1.011s)
[47.648331] [002/164] (959s left) core_auth (basic-auth)
[47.740447] Starting subtest: basic-auth
[47.741609] Subtest basic-auth: SUCCESS (0.001s)
[47.823931] [003/164] (959s left) debugfs_test (read_all_entries)
[47.930048] Starting subtest: read_all_entries
[48.021531] Subtest read_all_entries: SUCCESS (0.091s)
[48.128087] [004/164] (958s left) debugfs_test (basic-hwmon)
[48.216410] Starting subtest: basic-hwmon
[48.218391] Subtest basic-hwmon: SKIP (0.000s)
[48.331132] [005/164] (958s left) fbdev (eof)
[48.409475] Starting subtest: eof
[48.410595] Subtest eof: SUCCESS (0.001s)
[48.464244] [006/164] (958s left) fbdev (info)
[48.532142] Starting subtest: info
[48.533177] Subtest info: SUCCESS (0.000s)
[48.597069] [007/164] (958s left) fbdev (nullptr)
[48.676386] Starting subtest: nullptr
[48.677497] Subtest nullptr: SUCCESS (0.000s)
[48.730338] [008/164] (958s left) fbdev (read)
[48.809274] Starting subtest: read
[49.664427] Subtest read: SUCCESS (0.847s)
[49.715689] [009/164] (957s left) fbdev (write)
[49.792586] Starting subtest: write
[50.217987] Subtest write: SUCCESS (0.417s)
[50.265174] [010/164] (956s left) gem_basic (bad-close)
[50.334902] Starting subtest: bad-close
[50.336875] Subtest bad-close: SUCCESS (0.000s)
[50.402225] [011/164] (956s left) gem_basic (create-close)
[50.478682] Starting subtest: create-close
[50.480725] Subtest create-close: SUCCESS (0.000s)
[50.550681] [012/164] (956s left) gem_basic (create-fd-close)
[50.621400] Starting subtest: create-fd-close
[50.623361] Subtest create-fd-close: SUCCESS (0.000s)
[50.740302] [013/164] (956s left) gem_busy (busy@all-engines)
[50.826339] Starting subtest: busy
[50.827407] Starting dynamic subtest: all-engines
[50.889847] Dynamic subtest all-engines: SUCCESS (0.063s)
[50.890854] Subtest busy: SUCCESS (0.064s)
[51.331335] [014/164] (955s left) gem_close_race (basic-process)
[51.418125] Starting subtest: basic-process
[51.488369] Subtest basic-process: SUCCESS (0.070s)
[51.705518] [015/164] (955s left) gem_close_race (basic-threads)
[51.800401] Starting subtest: basic-threads
[53.009793] Subtest basic-threads: SUCCESS (1.209s)
[53.265095] [016/164] (954s left) gem_ctx_create (basic)
[53.358721] Starting subtest: basic
[53.359785] Subtest basic: SUCCESS (0.000s)
[53.604332] [017/164] (953s left) gem_ctx_create (basic-files)
[53.690520] Starting subtest: basic-files
[55.713291] Subtest basic-files: SUCCESS (2.023s)
[55.962573] [018/164] (951s left) gem_ctx_exec (basic)
[56.038116] Starting subtest: basic
[56.043381] Subtest basic: SUCCESS (0.005s)
[56.168292] [019/164] (951s left) gem_exec_basic (basic)
[56.255964] Starting subtest: basic
[56.257066] Starting dynamic subtest: rcs0-smem
[56.259068] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[56.267261] Starting dynamic subtest: bcs0-smem
[56.268137] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[56.275079] Starting dynamic subtest: vcs0-smem
[56.275958] Dynamic subtest vcs0-smem: SUCCESS (0.001s)
[56.283059] Starting dynamic subtest: vecs0-smem
[56.284197] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[56.285436] Subtest basic: SUCCESS (0.007s)
[56.518044] [020/164] (950s left) gem_exec_create (basic)
[56.603279] Starting subtest: basic
[56.604385] Starting dynamic subtest: smem
[58.653677] Dynamic subtest smem: SUCCESS (2.050s)
[58.654728] Subtest basic: SUCCESS (2.050s)
[58.850121] [021/164] (948s left) gem_exec_fence (basic-busy)
[59.087258] Starting subtest: basic-busy
[59.089403] Starting dynamic subtest: rcs0
[59.121956] Dynamic subtest rcs0: SUCCESS (0.034s)
[59.141156] Starting dynamic subtest: bcs0
[59.149519] Dynamic subtest bcs0: SUCCESS (0.027s)
[59.161327] Starting dynamic subtest: vcs0
[59.186378] Dynamic subtest vcs0: SUCCESS (0.034s)
[59.199840] Starting dynamic subtest: vecs0
[59.211582] Dynamic subtest vecs0: SUCCESS (0.028s)
[59.212925] Subtest basic-busy: SUCCESS (0.125s)
[60.007789] [022/164] (947s left) gem_exec_fence (basic-wait)
[60.245565] Starting subtest: basic-wait
[60.247441] Starting dynamic subtest: rcs0
[60.281930] Dynamic subtest rcs0: SUCCESS (0.036s)
[60.293323] Starting dynamic subtest: bcs0
[60.313654] Dynamic subtest bcs0: SUCCESS (0.032s)
[60.324836] Starting dynamic subtest: vcs0
[60.348365] Dynamic subtest vcs0: SUCCESS (0.032s)
[60.358301] Starting dynamic subtest: vecs0
[60.364478] Dynamic subtest vecs0: SUCCESS (0.019s)
[60.365662] Subtest basic-wait: SUCCESS (0.119s)
[61.048705] [023/164] (946s left) gem_exec_fence (basic-await)
[61.281291] Starting subtest: basic-await
[61.283097] Starting dynamic subtest: rcs0
[61.389244] Dynamic subtest rcs0: SUCCESS (0.108s)
[61.399354] Starting dynamic subtest: bcs0
[61.490618] Dynamic subtest bcs0: SUCCESS (0.101s)
[61.498478] Starting dynamic subtest: vcs0
[61.585289] Dynamic subtest vcs0: SUCCESS (0.094s)
[61.594612] Starting dynamic subtest: vecs0
[61.686099] Dynamic subtest vecs0: SUCCESS (0.100s)
[61.687243] Subtest basic-await: SUCCESS (0.405s)
[62.471314] [024/164] (945s left) gem_exec_fence (nb-await)
[62.692484] Starting subtest: nb-await
[62.694379] Starting dynamic subtest: rcs0
[62.762215] Dynamic subtest rcs0: SUCCESS (0.069s)
[62.774415] Starting dynamic subtest: bcs0
[62.833270] Dynamic subtest bcs0: SUCCESS (0.067s)
[62.879188] Starting dynamic subtest: vcs0
[62.943448] Dynamic subtest vcs0: SUCCESS (0.107s)
[62.988420] Starting dynamic subtest: vecs0
[63.045418] Dynamic subtest vecs0: SUCCESS (0.103s)
[63.049386] Subtest nb-await: SUCCESS (0.350s)
[63.790432] [025/164] (943s left) gem_exec_gttfill (basic)
[63.879258] Starting subtest: basic
[73.291291] Subtest basic: SUCCESS (9.403s)
[73.483930] [026/164] (934s left) gem_exec_parallel (engines)
[73.637037] Starting subtest: engines
[73.638104] Starting dynamic subtest: basic
[76.004428] Dynamic subtest basic: SUCCESS (2.369s)
[76.013233] Starting dynamic subtest: contexts
[79.812894] Dynamic subtest contexts: SUCCESS (3.802s)
[79.822892] Starting dynamic subtest: fds
[87.589620] Dynamic subtest fds: SUCCESS (7.783s)
[87.598934] Starting dynamic subtest: userptr
[89.874473] Dynamic subtest userptr: SUCCESS (2.285s)
[89.875558] Subtest engines: SUCCESS (16.240s)
[90.119362] [027/164] (917s left) gem_exec_store (basic)
[90.212325] Starting subtest: basic
[90.257540] Subtest basic: SUCCESS (0.045s)
[90.492810] [028/164] (917s left) gem_flink_basic (bad-flink)
[90.564079] Starting subtest: bad-flink
[90.565226] Subtest bad-flink: SUCCESS (0.000s)
[90.631234] [029/164] (917s left) gem_flink_basic (bad-open)
[90.704369] Starting subtest: bad-open
[90.705453] Subtest bad-open: SUCCESS (0.000s)
[90.788555] [030/164] (916s left) gem_flink_basic (basic)
[90.867898] Starting subtest: basic
[90.869096] Subtest basic: SUCCESS (0.000s)
[90.952951] [031/164] (916s left) gem_flink_basic (double-flink)
[91.024523] Starting subtest: double-flink
[91.025447] Subtest double-flink: SUCCESS (0.000s)
[91.097428] [032/164] (916s left) gem_flink_basic (flink-lifetime)
[91.171894] Starting subtest: flink-lifetime
[91.172882] Subtest flink-lifetime: SUCCESS (0.001s)
[91.290552] [033/164] (916s left) gem_huc_copy (huc-copy)
[91.373964] Starting subtest: huc-copy
[91.375918] Subtest huc-copy: SKIP (0.000s)
[91.511798] [034/164] (916s left) gem_linear_blits (basic)
[91.725396] Starting subtest: basic
[91.735082] Subtest basic: SUCCESS (0.010s)
[91.904326] [035/164] (915s left) gem_mmap (basic)
[92.030307] Starting subtest: basic
[92.035105] Subtest basic: SUCCESS (0.000s)
[92.119876] [036/164] (915s left) gem_mmap_gtt (basic)
[92.192583] Starting subtest: basic
[92.193684] Subtest basic: SUCCESS (0.001s)
[92.245780] [037/164] (915s left) gem_render_linear_blits (basic)
[92.325532] Starting subtest: basic
[92.366297] Subtest basic: SUCCESS (0.040s)
[92.413690] [038/164] (915s left) gem_render_tiled_blits (basic)
[92.491974] Starting subtest: basic
[92.534977] Subtest basic: SUCCESS (0.043s)
[92.579337] [039/164] (915s left) gem_ringfill (basic-all)
[92.838123] Starting subtest: basic-all
[94.004915] Subtest basic-all: SUCCESS (1.158s)
[94.114224] [040/164] (913s left) gem_softpin (allocator-basic)
[94.198149] Starting subtest: allocator-basic
[94.352255] Subtest allocator-basic: SUCCESS (0.145s)
[94.492438] [041/164] (913s left) gem_softpin (allocator-basic-reserve)
[94.569428] Starting subtest: allocator-basic-reserve
[94.711882] Subtest allocator-basic-reserve: SUCCESS (0.134s)
[94.848260] [042/164] (913s left) gem_softpin (safe-alignment)
[94.937053] Starting subtest: safe-alignment
[94.952141] Subtest safe-alignment: SUCCESS (0.015s)
[95.086444] [043/164] (912s left) gem_sync (basic-all)
[95.175958] Starting subtest: basic-all
[97.400491] Subtest basic-all: SUCCESS (2.224s)
[97.642349] [044/164] (910s left) gem_sync (basic-each)
[97.732166] Starting subtest: basic-each
[99.902508] Subtest basic-each: SUCCESS (2.170s)
[100.204793] [045/164] (907s left) gem_tiled_blits (basic)
[100.417056] Starting subtest: basic
[100.441823] Subtest basic: SUCCESS (0.024s)
[100.592321] [046/164] (907s left) gem_tiled_fence_blits (basic)
[100.859307] Starting subtest: basic
[100.869388] Subtest basic: SUCCESS (0.013s)
[101.027601] [047/164] (907s left) gem_tiled_pread_basic
[101.389189] [048/164] (906s left) gem_wait (busy@all-engines)
[101.484760] Starting subtest: busy
[101.485863] Starting dynamic subtest: all-engines
[102.017240] Dynamic subtest all-engines: SUCCESS (0.533s)
[102.018245] Subtest busy: SUCCESS (0.533s)
[102.311760] [049/164] (905s left) gem_wait (wait@all-engines)
[102.410209] Starting subtest: wait
[102.411212] Starting dynamic subtest: all-engines
[103.463227] Dynamic subtest all-engines: SUCCESS (1.050s)
[103.466669] Subtest wait: SUCCESS (1.051s)
[103.767244] [050/164] (904s left) i915_getparams_basic (basic-eu-total)
[103.842937] Starting subtest: basic-eu-total
[103.844761] Subtest basic-eu-total: SUCCESS (0.000s)
[103.915106] [051/164] (904s left) i915_getparams_basic (basic-subslice-total)
[103.995507] Starting subtest: basic-subslice-total
[103.997520] Subtest basic-subslice-total: SUCCESS (0.000s)
[104.059887] [052/164] (904s left) i915_hangman (error-state-basic)
[104.145303] Starting subtest: error-state-basic
[104.157536] Subtest error-state-basic: SUCCESS (0.012s)
[104.224873] [053/164] (904s left) i915_pciid
[104.360937] [054/164] (903s left) kms_addfb_basic (addfb25-4-tiled)
[104.481246] Starting subtest: addfb25-4-tiled
[104.482244] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[104.581406] [055/164] (903s left) kms_addfb_basic (addfb25-bad-modifier)
[104.660621] Starting subtest: addfb25-bad-modifier
[104.661754] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[104.791185] [056/164] (903s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[104.865212] Starting subtest: addfb25-framebuffer-vs-set-tiling
[104.866105] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[105.028229] [057/164] (903s left) kms_addfb_basic (addfb25-modifier-no-flag)
[105.102621] Starting subtest: addfb25-modifier-no-flag
[105.103654] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[105.232730] [058/164] (903s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[105.305162] Starting subtest: addfb25-x-tiled-legacy
[105.306058] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[105.438974] [059/164] (902s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[105.512484] Starting subtest: addfb25-x-tiled-mismatch-legacy
[105.513591] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s)
[105.657063] [060/164] (902s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[105.772033] Starting subtest: addfb25-yf-tiled-legacy
[105.773092] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[105.882948] [061/164] (902s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[106.005149] Starting subtest: addfb25-y-tiled-legacy
[106.006226] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[106.113116] [062/164] (902s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[106.241938] Starting subtest: addfb25-y-tiled-small-legacy
[106.242919] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s)
[106.351456] [063/164] (902s left) kms_addfb_basic (bad-pitch-0)
[106.428375] Starting subtest: bad-pitch-0
[106.429471] Subtest bad-pitch-0: SUCCESS (0.000s)
[106.567608] [064/164] (901s left) kms_addfb_basic (bad-pitch-1024)
[106.648860] Starting subtest: bad-pitch-1024
[106.649988] Subtest bad-pitch-1024: SUCCESS (0.000s)
[106.787820] [065/164] (901s left) kms_addfb_basic (bad-pitch-128)
[106.861414] Starting subtest: bad-pitch-128
[106.862468] Subtest bad-pitch-128: SUCCESS (0.000s)
[107.011055] [066/164] (901s left) kms_addfb_basic (bad-pitch-256)
[107.098724] Starting subtest: bad-pitch-256
[107.099825] Subtest bad-pitch-256: SUCCESS (0.000s)
[107.252707] [067/164] (901s left) kms_addfb_basic (bad-pitch-32)
[107.325689] Starting subtest: bad-pitch-32
[107.326805] Subtest bad-pitch-32: SUCCESS (0.000s)
[107.469041] [068/164] (901s left) kms_addfb_basic (bad-pitch-63)
[107.543371] Starting subtest: bad-pitch-63
[107.544460] Subtest bad-pitch-63: SUCCESS (0.000s)
[107.693134] [069/164] (900s left) kms_addfb_basic (bad-pitch-65536)
[107.779389] Starting subtest: bad-pitch-65536
[107.780496] Subtest bad-pitch-65536: SUCCESS (0.000s)
[107.931851] [070/164] (900s left) kms_addfb_basic (bad-pitch-999)
[108.004673] Starting subtest: bad-pitch-999
[108.006064] Subtest bad-pitch-999: SUCCESS (0.000s)
[108.171776] [071/164] (900s left) kms_addfb_basic (basic)
[108.246664] Starting subtest: basic
[108.247772] Subtest basic: SUCCESS (0.000s)
[108.386962] [072/164] (900s left) kms_addfb_basic (basic-x-tiled-legacy)
[108.464293] Starting subtest: basic-x-tiled-legacy
[108.465171] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[108.607954] [073/164] (900s left) kms_addfb_basic (basic-y-tiled-legacy)
[108.680968] Starting subtest: basic-y-tiled-legacy
[108.682039] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[108.823181] [074/164] (899s left) kms_addfb_basic (bo-too-small)
[108.931786] Starting subtest: bo-too-small
[108.932995] Subtest bo-too-small: SUCCESS (0.000s)
[109.046778] [075/164] (899s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[109.169663] Starting subtest: bo-too-small-due-to-tiling
[109.170770] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s)
[109.291654] [076/164] (899s left) kms_addfb_basic (clobberred-modifier)
[109.365236] Starting subtest: clobberred-modifier
[109.366171] Subtest clobberred-modifier: SUCCESS (0.000s)
[109.512347] [077/164] (899s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[109.585957] Starting subtest: framebuffer-vs-set-tiling
[109.587126] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[109.735817] [078/164] (899s left) kms_addfb_basic (invalid-get-prop)
[109.808495] Starting subtest: invalid-get-prop
[109.809605] Subtest invalid-get-prop: SUCCESS (0.000s)
[109.954778] [079/164] (898s left) kms_addfb_basic (invalid-get-prop-any)
[110.042754] Starting subtest: invalid-get-prop-any
[110.044102] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[110.213157] [080/164] (898s left) kms_addfb_basic (invalid-set-prop)
[110.300570] Starting subtest: invalid-set-prop
[110.301620] Subtest invalid-set-prop: SUCCESS (0.000s)
[110.474455] [081/164] (898s left) kms_addfb_basic (invalid-set-prop-any)
[110.549838] Starting subtest: invalid-set-prop-any
[110.550881] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[110.714412] [082/164] (898s left) kms_addfb_basic (no-handle)
[110.793099] Starting subtest: no-handle
[110.794138] Subtest no-handle: SUCCESS (0.000s)
[110.926108] [083/164] (898s left) kms_addfb_basic (size-max)
[111.034492] Starting subtest: size-max
[111.035578] Subtest size-max: SUCCESS (0.000s)
[111.134463] [084/164] (897s left) kms_addfb_basic (small-bo)
[111.246539] Starting subtest: small-bo
[111.247711] Subtest small-bo: SUCCESS (0.000s)
[111.352492] [085/164] (897s left) kms_addfb_basic (tile-pitch-mismatch)
[111.441210] Starting subtest: tile-pitch-mismatch
[111.442258] Subtest tile-pitch-mismatch: SUCCESS (0.000s)
[111.601546] [086/164] (897s left) kms_addfb_basic (too-high)
[111.729874] Starting subtest: too-high
[111.731053] Subtest too-high: SUCCESS (0.001s)
[111.851702] [087/164] (897s left) kms_addfb_basic (too-wide)
[111.970313] Starting subtest: too-wide
[111.971323] Subtest too-wide: SUCCESS (0.000s)
[112.068335] [088/164] (897s left) kms_addfb_basic (unused-handle)
[112.144400] Starting subtest: unused-handle
[112.145340] Subtest unused-handle: SUCCESS (0.000s)
[112.291056] [089/164] (896s left) kms_addfb_basic (unused-modifier)
[112.371393] Starting subtest: unused-modifier
[112.372473] Subtest unused-modifier: SUCCESS (0.000s)
[112.541408] [090/164] (896s left) kms_addfb_basic (unused-offsets)
[112.620805] Starting subtest: unused-offsets
[112.621844] Subtest unused-offsets: SUCCESS (0.000s)
[112.789614] [091/164] (896s left) kms_addfb_basic (unused-pitches)
[112.862188] Starting subtest: unused-pitches
[112.863229] Subtest unused-pitches: SUCCESS (0.000s)
[113.007969] [092/164] (896s left) kms_busy (basic)
[113.128309] Starting subtest: basic
[113.129459] Starting dynamic subtest: flip
[114.139798] Dynamic subtest flip: SUCCESS (1.008s)
[114.151931] Starting dynamic subtest: modeset
[117.979399] Dynamic subtest modeset: SUCCESS (3.841s)
[117.981503] Subtest basic: SUCCESS (4.851s)
[118.921702] [093/164] (890s left) kms_prop_blob (basic)
[118.998127] Starting subtest: basic
[118.999148] Subtest basic: SUCCESS (0.000s)
[119.075466] [094/164] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[119.182268] Starting subtest: basic-busy-flip-before-cursor-atomic
[119.184353] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[119.275384] [095/164] (890s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[119.383233] Starting subtest: basic-busy-flip-before-cursor-legacy
[119.385323] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[119.479875] [096/164] (889s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[119.593236] Starting subtest: basic-flip-after-cursor-atomic
[120.907637] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.313s)
[121.853462] [097/164] (887s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[121.969238] Starting subtest: basic-flip-after-cursor-legacy
[123.263760] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.291s)
[124.156127] [098/164] (885s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[124.263737] Starting subtest: basic-flip-after-cursor-varying-size
[125.545105] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.276s)
[126.460325] [099/164] (882s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[126.587979] Starting subtest: basic-flip-before-cursor-atomic
[127.942091] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.352s)
[128.883354] [100/164] (880s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[129.007075] Starting subtest: basic-flip-before-cursor-legacy
[130.340650] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.329s)
[131.232925] [101/164] (878s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[131.346204] Starting subtest: basic-flip-before-cursor-varying-size
[132.629291] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.279s)
[133.510055] [102/164] (875s left) kms_flip (basic-flip-vs-dpms)
[133.598962] Starting subtest: basic-flip-vs-dpms
[133.602660] Starting dynamic subtest: A-eDP1
[136.477580] Dynamic subtest A-eDP1: SUCCESS (2.870s)
[136.533521] Starting dynamic subtest: B-eDP1
[138.840542] Dynamic subtest B-eDP1: SUCCESS (2.353s)
[138.887219] Starting dynamic subtest: C-eDP1
[141.279811] Dynamic subtest C-eDP1: SUCCESS (2.434s)
[141.302778] Subtest basic-flip-vs-dpms: SUCCESS (7.696s)
[142.160935] [103/164] (867s left) kms_flip (basic-flip-vs-modeset)
[142.251410] Starting subtest: basic-flip-vs-modeset
[142.254477] Starting dynamic subtest: A-eDP1
[145.139836] Dynamic subtest A-eDP1: SUCCESS (2.877s)
[145.207638] Starting dynamic subtest: B-eDP1
[147.540117] Dynamic subtest B-eDP1: SUCCESS (2.392s)
[147.567550] Starting dynamic subtest: C-eDP1
[149.907464] Dynamic subtest C-eDP1: SUCCESS (2.365s)
[149.944103] Subtest basic-flip-vs-modeset: SUCCESS (7.681s)
[150.798148] [104/164] (858s left) kms_flip (basic-flip-vs-wf_vblank)
[150.886700] Starting subtest: basic-flip-vs-wf_vblank
[150.890967] Starting dynamic subtest: A-eDP1
[153.178677] Dynamic subtest A-eDP1: SUCCESS (2.288s)
[153.191346] Starting dynamic subtest: B-eDP1
[155.481500] Dynamic subtest B-eDP1: SUCCESS (2.301s)
[155.500365] Starting dynamic subtest: C-eDP1
[157.788613] Dynamic subtest C-eDP1: SUCCESS (2.306s)
[157.794487] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.908s)
[159.102603] [105/164] (850s left) kms_flip (basic-plain-flip)
[159.194689] Starting subtest: basic-plain-flip
[159.199727] Starting dynamic subtest: A-eDP1
[161.232867] Dynamic subtest A-eDP1: SUCCESS (2.017s)
[161.296927] Starting dynamic subtest: B-eDP1
[163.297142] Dynamic subtest B-eDP1: SUCCESS (2.062s)
[163.362744] Starting dynamic subtest: C-eDP1
[165.366121] Dynamic subtest C-eDP1: SUCCESS (2.064s)
[165.394559] Subtest basic-plain-flip: SUCCESS (6.198s)
[166.727357] [106/164] (842s left) kms_force_connector_basic (force-connector-state)
[166.834761] Starting subtest: force-connector-state
[167.322903] Subtest force-connector-state: SUCCESS (0.490s)
[168.541253] [107/164] (841s left) kms_force_connector_basic (force-edid)
[168.642531] Starting subtest: force-edid
[168.674489] Subtest force-edid: SUCCESS (0.033s)
[168.848965] [108/164] (840s left) kms_force_connector_basic (force-load-detect)
[168.948388] Starting subtest: force-load-detect
[168.950488] Subtest force-load-detect: SKIP (0.000s)
[169.097424] [109/164] (840s left) kms_force_connector_basic (prune-stale-modes)
[169.195869] Starting subtest: prune-stale-modes
[169.229431] Subtest prune-stale-modes: SUCCESS (0.034s)
[169.391248] [110/164] (840s left) kms_frontbuffer_tracking (basic)
[169.513954] Starting subtest: basic
[172.523995] Subtest basic: SUCCESS (3.010s)
[172.617535] [111/164] (837s left) kms_hdmi_inject (inject-audio)
[173.009110] Starting subtest: inject-audio
[173.135971] Subtest inject-audio: SUCCESS (0.128s)
[173.936857] [112/164] (835s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[174.053559] Starting subtest: compare-crc-sanitycheck-xr24
[174.055131] Starting dynamic subtest: pipe-A-eDP-1
[174.769358] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.711s)
[174.811614] Starting dynamic subtest: pipe-B-eDP-1
[176.168412] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.375s)
[176.212174] Starting dynamic subtest: pipe-C-eDP-1
[177.495200] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.308s)
[177.498421] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.437s)
[178.390266] [113/164] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[178.500081] Starting subtest: compare-crc-sanitycheck-nv12
[178.503206] Starting dynamic subtest: pipe-A-eDP-1
[178.505172] Dynamic subtest pipe-A-eDP-1: SKIP (0.001s)
[178.517034] Starting dynamic subtest: pipe-B-eDP-1
[178.518965] Dynamic subtest pipe-B-eDP-1: SKIP (0.001s)
[178.528030] Starting dynamic subtest: pipe-C-eDP-1
[178.529950] Dynamic subtest pipe-C-eDP-1: SKIP (0.001s)
[178.531884] Subtest compare-crc-sanitycheck-nv12: SKIP (0.009s)
[178.623602] [114/164] (831s left) kms_pipe_crc_basic (hang-read-crc)
[178.733540] Starting subtest: hang-read-crc
[178.735981] Starting dynamic subtest: pipe-A-eDP-1
[181.306809] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.569s)
[181.370103] Starting dynamic subtest: pipe-B-eDP-1
[184.595263] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.262s)
[184.657270] Starting dynamic subtest: pipe-C-eDP-1
[187.855494] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.237s)
[187.859324] Subtest hang-read-crc: SUCCESS (9.120s)
[188.791320] [115/164] (821s left) kms_pipe_crc_basic (nonblocking-crc)
[188.907145] Starting subtest: nonblocking-crc
[188.908213] Starting dynamic subtest: pipe-A-eDP-1
[189.982393] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.066s)
[190.057127] Starting dynamic subtest: pipe-B-eDP-1
[191.760924] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.767s)
[191.832431] Starting dynamic subtest: pipe-C-eDP-1
[193.498321] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.713s)
[193.501670] Subtest nonblocking-crc: SUCCESS (4.594s)
[194.425835] [116/164] (815s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[194.546298] Starting subtest: nonblocking-crc-frame-sequence
[194.549489] Starting dynamic subtest: pipe-A-eDP-1
[195.612503] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.060s)
[195.688998] Starting dynamic subtest: pipe-B-eDP-1
[197.403106] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.769s)
[197.480997] Starting dynamic subtest: pipe-C-eDP-1
[199.117473] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.694s)
[199.121406] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.569s)
[200.068986] [117/164] (809s left) kms_pipe_crc_basic (read-crc)
[200.205961] Starting subtest: read-crc
[200.208692] Starting dynamic subtest: pipe-A-eDP-1
[201.137470] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.923s)
[201.216057] Starting dynamic subtest: pipe-B-eDP-1
[202.789413] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.629s)
[202.854971] Starting dynamic subtest: pipe-C-eDP-1
[204.477178] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.657s)
[204.487219] Subtest read-crc: SUCCESS (4.264s)
[205.388032] [118/164] (804s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[205.504990] Starting subtest: read-crc-frame-sequence
[205.506885] Starting dynamic subtest: pipe-A-eDP-1
[206.467449] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.947s)
[206.538712] Starting dynamic subtest: pipe-B-eDP-1
[208.138590] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.654s)
[208.211212] Starting dynamic subtest: pipe-C-eDP-1
[209.805787] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.638s)
[209.808916] Subtest read-crc-frame-sequence: SUCCESS (4.301s)
[210.751919] [119/164] (799s left) kms_pm_backlight (basic-brightness)
[210.876724] Starting subtest: basic-brightness
[210.986677] Starting dynamic subtest: eDP-1
[211.583086] Dynamic subtest eDP-1: SUCCESS (0.592s)
[211.586915] Subtest basic-brightness: SUCCESS (0.707s)
[212.518090] [120/164] (797s left) kms_psr (primary_page_flip)
[212.639272] Starting subtest: primary_page_flip
[214.726698] Subtest primary_page_flip: SUCCESS (2.081s)
[215.678103] [121/164] (794s left) kms_psr (cursor_plane_move)
[215.808181] Starting subtest: cursor_plane_move
[217.825599] Subtest cursor_plane_move: SUCCESS (2.007s)
[218.745660] [122/164] (791s left) kms_psr (sprite_plane_onoff)
[218.860065] Starting subtest: sprite_plane_onoff
[220.968831] Subtest sprite_plane_onoff: SUCCESS (2.103s)
[221.886488] [123/164] (788s left) kms_psr (primary_mmap_gtt)
[222.003231] Starting subtest: primary_mmap_gtt
[224.142966] Subtest primary_mmap_gtt: SUCCESS (2.134s)
[225.039463] [124/164] (785s left) kms_setmode (basic-clone-single-crtc)
[225.116236] Starting subtest: basic-clone-single-crtc
[225.119456] Subtest basic-clone-single-crtc: SKIP (0.000s)
[225.194138] [125/164] (784s left) i915_pm_rpm (basic-pci-d3-state)
[226.952177] Starting subtest: basic-pci-d3-state
[231.394626] Subtest basic-pci-d3-state: SUCCESS (4.454s)
[231.552743] [126/164] (778s left) i915_pm_rpm (basic-rte)
[231.625150] Starting subtest: basic-rte
[237.820027] Subtest basic-rte: SUCCESS (6.189s)
[243.262309] [127/164] (766s left) i915_pm_rps (basic-api)
[243.342721] Starting subtest: basic-api
[243.347399] Subtest basic-api: SUCCESS (0.005s)
[243.434495] [128/164] (766s left) prime_self_import (basic-llseek-bad)
[243.513522] Starting subtest: basic-llseek-bad
[243.515695] Subtest basic-llseek-bad: SUCCESS (0.002s)
[243.604751] [129/164] (766s left) prime_self_import (basic-llseek-size)
[243.683740] Starting subtest: basic-llseek-size
[243.688345] Subtest basic-llseek-size: SUCCESS (0.003s)
[243.842273] [130/164] (766s left) prime_self_import (basic-with_fd_dup)
[243.910937] Starting subtest: basic-with_fd_dup
[243.914934] Subtest basic-with_fd_dup: SUCCESS (0.004s)
[244.050877] [131/164] (766s left) prime_self_import (basic-with_one_bo)
[244.121145] Starting subtest: basic-with_one_bo
[244.125750] Subtest basic-with_one_bo: SUCCESS (0.003s)
[244.236360] [132/164] (766s left) prime_self_import (basic-with_one_bo_two_files)
[244.308784] Starting subtest: basic-with_one_bo_two_files
[244.313831] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s)
[244.395140] [133/164] (765s left) prime_self_import (basic-with_two_bos)
[244.470210] Starting subtest: basic-with_two_bos
[244.474727] Subtest basic-with_two_bos: SUCCESS (0.003s)
[244.566511] [134/164] (765s left) prime_vgem (basic-fence-flip)
[244.657220] Starting subtest: basic-fence-flip
[245.133125] Subtest basic-fence-flip: SUCCESS (0.476s)
[245.230676] [135/164] (765s left) prime_vgem (basic-fence-mmap)
[245.330946] Starting subtest: basic-fence-mmap
[245.370183] Subtest basic-fence-mmap: SUCCESS (0.039s)
[245.479743] [136/164] (764s left) prime_vgem (basic-fence-read)
[245.584886] Starting subtest: basic-fence-read
[245.644034] Subtest basic-fence-read: SUCCESS (0.059s)
[245.749721] [137/164] (764s left) prime_vgem (basic-gtt)
[245.853881] Starting subtest: basic-gtt
[245.872288] Subtest basic-gtt: SUCCESS (0.018s)
[245.973594] [138/164] (764s left) prime_vgem (basic-read)
[246.092366] Starting subtest: basic-read
[246.119635] Subtest basic-read: SUCCESS (0.027s)
[246.222369] [139/164] (764s left) prime_vgem (basic-write)
[246.325451] Starting subtest: basic-write
[246.355733] Subtest basic-write: SUCCESS (0.030s)
[246.427196] [140/164] (764s left) vgem_basic (setversion)
[246.518070] Starting subtest: setversion
[246.520146] Subtest setversion: SUCCESS (0.000s)
[246.578262] [141/164] (764s left) vgem_basic (create)
[246.668380] Starting subtest: create
[246.669448] Subtest create: SUCCESS (0.000s)
[246.726461] [142/164] (763s left) vgem_basic (debugfs)
[246.801232] Starting subtest: debugfs
[246.802385] Subtest debugfs: SUCCESS (0.000s)
[246.861149] [143/164] (763s left) vgem_basic (dmabuf-export)
[246.935266] Starting subtest: dmabuf-export
[246.937215] Subtest dmabuf-export: SUCCESS (0.002s)
[247.033841] [144/164] (763s left) vgem_basic (dmabuf-fence)
[247.118138] Starting subtest: dmabuf-fence
[247.119264] Subtest dmabuf-fence: SUCCESS (0.001s)
[247.178538] [145/164] (763s left) vgem_basic (dmabuf-fence-before)
[247.268627] Starting subtest: dmabuf-fence-before
[247.269763] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[247.331067] [146/164] (763s left) vgem_basic (dmabuf-mmap)
[247.418309] Starting subtest: dmabuf-mmap
[247.437111] Subtest dmabuf-mmap: SUCCESS (0.019s)
[247.494453] [147/164] (763s left) vgem_basic (mmap)
[247.569129] Starting subtest: mmap
[247.581118] Subtest mmap: SUCCESS (0.013s)
[247.644911] [148/164] (763s left) vgem_basic (second-client)
[247.734776] Starting subtest: second-client
[247.768210] Subtest second-client: SUCCESS (0.033s)
[247.846530] [149/164] (762s left) vgem_basic (sysfs)
[247.935125] Starting subtest: sysfs
[247.936238] Subtest sysfs: SUCCESS (0.001s)
[247.994823] [150/164] (762s left) core_hotunplug (unbind-rebind)
[248.140763] Starting subtest: unbind-rebind
[252.466554] Subtest unbind-rebind: SUCCESS (4.326s)
[252.494854] [151/164] (758s left) vgem_basic (unload)
[252.574886] Starting subtest: unload
[281.673224] Subtest unload: SUCCESS (29.060s)
[281.788028] [152/164] (729s left) i915_module_load (reload)
[281.860803] Starting subtest: reload
[285.205735] Subtest reload: SUCCESS (3.344s)
[285.230872] [153/164] (725s left) gem_lmem_swapping (basic)
[285.374816] Subtest basic: SKIP (0.000s)
[285.424455] [154/164] (725s left) gem_lmem_swapping (parallel-random-engines)
[285.506335] Subtest parallel-random-engines: SKIP (0.000s)
[285.539423] [155/164] (725s left) gem_lmem_swapping (random-engines)
[285.619857] Subtest random-engines: SKIP (0.000s)
[285.655452] [156/164] (725s left) gem_lmem_swapping (verify-random)
[285.733676] Subtest verify-random: SKIP (0.000s)
[285.773289] [157/164] (725s left) i915_pm_rpm (module-reload)
[288.511247] Starting subtest: module-reload
[304.715041] Subtest module-reload: SUCCESS (16.201s)
[304.731164] [158/164] (706s left) i915_selftest (live)
[304.811883] Starting subtest: live
[304.813086] Starting dynamic subtest: sanitycheck
[306.518718] Dynamic subtest sanitycheck: SUCCESS (1.697s)
[306.526645] Starting dynamic subtest: uncore
[308.206550] Dynamic subtest uncore: SUCCESS (1.685s)
[308.214378] Starting dynamic subtest: workarounds
[310.092863] Dynamic subtest workarounds: SUCCESS (1.885s)
[310.102484] Starting dynamic subtest: gt_engines
[312.250763] Dynamic subtest gt_engines: SUCCESS (2.155s)
[312.262397] Starting dynamic subtest: gt_timelines
[322.161183] Dynamic subtest gt_timelines: SUCCESS (9.909s)
[322.179886] Starting dynamic subtest: gt_contexts
[323.991677] Dynamic subtest gt_contexts: SUCCESS (1.828s)
[323.999530] Starting dynamic subtest: gt_lrc
[328.165691] Dynamic subtest gt_lrc: SUCCESS (4.172s)
[328.173025] Starting dynamic subtest: gt_mocs
[329.997805] Dynamic subtest gt_mocs: SUCCESS (1.830s)
[330.008534] Starting dynamic subtest: gt_pm
[336.048787] Dynamic subtest gt_pm: SUCCESS (6.049s)
[336.056695] Starting dynamic subtest: gt_heartbeat
[337.842600] Dynamic subtest gt_heartbeat: SUCCESS (1.791s)
[337.850481] Starting dynamic subtest: gt_tlb
[340.728592] Dynamic subtest gt_tlb: SUCCESS (2.884s)
[340.735893] Starting dynamic subtest: requests
[348.148799] Dynamic subtest requests: SUCCESS (7.418s)
[348.157238] Starting dynamic subtest: migrate
[352.598565] Dynamic subtest migrate: SUCCESS (4.448s)
[352.606475] Starting dynamic subtest: active
[354.347772] Dynamic subtest active: SUCCESS (1.747s)
[354.359892] Starting dynamic subtest: objects
[357.166713] Dynamic subtest objects: SUCCESS (2.816s)
[357.174431] Starting dynamic subtest: mman
[362.270710] Dynamic subtest mman: SUCCESS (5.102s)
[362.278580] Starting dynamic subtest: dmabuf
[364.044849] Dynamic subtest dmabuf: SUCCESS (1.772s)
[364.058094] Starting dynamic subtest: vma
[365.763754] Dynamic subtest vma: SUCCESS (1.717s)
[365.772486] Starting dynamic subtest: coherency
[369.454811] Dynamic subtest coherency: SUCCESS (3.689s)
[369.462815] Starting dynamic subtest: gtt
[378.017774] Dynamic subtest gtt: SUCCESS (8.561s)
[378.030076] Starting dynamic subtest: gem
[379.944593] Dynamic subtest gem: SUCCESS (1.924s)
[379.958546] Starting dynamic subtest: evict
[383.142622] Dynamic subtest evict: SUCCESS (3.195s)
[383.150210] Starting dynamic subtest: hugepages
[390.167712] Dynamic subtest hugepages: SUCCESS (7.023s)
[390.175756] Starting dynamic subtest: gem_contexts
[404.659669] Dynamic subtest gem_contexts: SUCCESS (14.490s)
[404.670511] Starting dynamic subtest: client
[406.491594] Dynamic subtest client: SUCCESS (1.830s)
[406.499545] Starting dynamic subtest: gem_migrate
[408.223713] Dynamic subtest gem_migrate: SUCCESS (1.730s)
[408.231767] Starting dynamic subtest: reset
[410.672730] Dynamic subtest reset: SUCCESS (2.448s)
[410.683679] Starting dynamic subtest: memory_region
[412.378658] Dynamic subtest memory_region: SUCCESS (1.704s)
[412.386094] Starting dynamic subtest: hangcheck
[436.539032] Dynamic subtest hangcheck: SUCCESS (24.159s)
[436.552408] Starting dynamic subtest: execlists
[446.061764] Dynamic subtest execlists: SUCCESS (9.521s)
[446.069884] Starting dynamic subtest: ring_submission
[447.758949] Dynamic subtest ring_submission: SUCCESS (1.696s)
[447.771873] Starting dynamic subtest: perf
[449.615695] Dynamic subtest perf: SUCCESS (1.854s)
[449.623728] Starting dynamic subtest: slpc
[451.344730] Dynamic subtest slpc: SUCCESS (1.727s)
[451.355663] Starting dynamic subtest: guc
[453.097727] Dynamic subtest guc: SUCCESS (1.751s)
[453.105844] Starting dynamic subtest: guc_multi_lrc
[454.875779] Dynamic subtest guc_multi_lrc: SUCCESS (1.776s)
[454.887382] Starting dynamic subtest: guc_hang
[456.593955] Dynamic subtest guc_hang: SUCCESS (1.716s)
[456.603457] Starting dynamic subtest: late_gt_pm
[458.308651] Dynamic subtest late_gt_pm: SUCCESS (1.712s)
[458.309624] Subtest live: SUCCESS (153.489s)
[458.327926] [159/164] (552s left) dmabuf (all-tests)
[458.409814] Starting subtest: all-tests
[458.411497] Starting dynamic subtest: sanitycheck
[458.477960] Dynamic subtest sanitycheck: SUCCESS (0.067s)
[458.509732] Starting dynamic subtest: dma_fence
[458.670645] Dynamic subtest dma_fence: SUCCESS (0.187s)
[458.691111] Starting dynamic subtest: dma_fence_chain
[474.936061] Dynamic subtest dma_fence_chain: SUCCESS (16.254s)
[474.962998] Starting dynamic subtest: dma_fence_unwrap
[475.010268] Dynamic subtest dma_fence_unwrap: SUCCESS (0.079s)
[475.043860] Starting dynamic subtest: dma_resv
[475.086433] Dynamic subtest dma_resv: SUCCESS (0.072s)
[475.087593] Subtest all-tests: SUCCESS (16.678s)
[475.119760] [160/164] (535s left) i915_suspend (basic-s2idle-without-i915)
[475.197124] Starting subtest: basic-s2idle-without-i915
[497.375495] Subtest basic-s2idle-without-i915: SUCCESS (6.666s)
[499.729776] [161/164] (528s left) i915_suspend (basic-s3-without-i915)
[499.840846] Starting subtest: basic-s3-without-i915
[520.436142] Subtest basic-s3-without-i915: SUCCESS (4.276s)
[522.778082] [162/164] (524s left) gem_exec_suspend (basic-s0)
[522.902195] Starting subtest: basic-S0
[522.903196] Starting dynamic subtest: smem
[541.372059] Dynamic subtest smem: SUCCESS (3.209s)
[541.373057] Subtest basic-S0: SUCCESS (3.211s)
[543.607334] [163/164] (520s left) gem_exec_suspend (basic-s3)
[543.711587] Starting subtest: basic-S3
[543.712740] Starting dynamic subtest: smem
[564.239960] Dynamic subtest smem: SUCCESS (4.040s)
[564.241089] Subtest basic-S3: SUCCESS (4.042s)
[566.424898] [164/164] (516s left) kms_pipe_crc_basic (suspend-read-crc)
[566.552521] Starting subtest: suspend-read-crc
[566.553593] Starting dynamic subtest: pipe-A-eDP-1
[586.580970] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.676s)
[586.603006] Starting dynamic subtest: pipe-B-eDP-1
[607.840346] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.510s)
[607.888499] Starting dynamic subtest: pipe-C-eDP-1
[628.316385] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.961s)
[628.317637] Subtest suspend-read-crc: SUCCESS (12.174s)
[631.197719] Closing watchdogs
Done.