[55.549454] Initializing watchdogs
[55.549738]   /dev/watchdog0
[55.565600] [001/165] (960s left) i915_module_load (load)
[56.183570] Starting subtest: load
[59.866056] Subtest load: SUCCESS (3.684s)
[60.013571] [002/165] (956s left) core_auth (basic-auth)
[60.834122] Starting subtest: basic-auth
[60.838157] Subtest basic-auth: SUCCESS (0.007s)
[60.955940] [003/165] (955s left) debugfs_test (read_all_entries)
[61.332698] Starting subtest: read_all_entries
[61.484158] Subtest read_all_entries: SUCCESS (0.152s)
[61.999563] [004/165] (954s left) debugfs_test (basic-hwmon)
[62.235969] Starting subtest: basic-hwmon
[62.240125] Subtest basic-hwmon: SKIP (0.000s)
[62.749249] [005/165] (953s left) fbdev (eof)
[62.985111] Starting subtest: eof
[62.987144] Subtest eof: SUCCESS (0.004s)
[63.066835] [006/165] (953s left) fbdev (info)
[63.284631] Starting subtest: info
[63.286187] Subtest info: SUCCESS (0.000s)
[63.384851] [007/165] (953s left) fbdev (nullptr)
[63.618611] Starting subtest: nullptr
[63.619977] Subtest nullptr: SUCCESS (0.000s)
[63.719707] [008/165] (952s left) fbdev (read)
[63.955517] Starting subtest: read
[66.048526] Subtest read: SUCCESS (2.088s)
[66.128737] [009/165] (950s left) fbdev (write)
[66.351741] Starting subtest: write
[67.425228] Subtest write: SUCCESS (1.068s)
[67.500385] [010/165] (949s left) gem_basic (bad-close)
[67.725656] Starting subtest: bad-close
[67.728898] Subtest bad-close: SUCCESS (0.000s)
[67.817695] [011/165] (948s left) gem_basic (create-close)
[68.036241] Starting subtest: create-close
[68.039236] Subtest create-close: SUCCESS (0.000s)
[68.148131] [012/165] (948s left) gem_basic (create-fd-close)
[68.376251] Starting subtest: create-fd-close
[68.380665] Subtest create-fd-close: SUCCESS (0.002s)
[68.485170] [013/165] (948s left) gem_busy (busy@all-engines)
[68.756639] Starting subtest: busy
[68.761091] Starting dynamic subtest: all-engines
[68.921600] Dynamic subtest all-engines: SUCCESS (0.164s)
[68.923353] Subtest busy: SUCCESS (0.167s)
[69.340714] [014/165] (947s left) gem_close_race (basic-process)
[69.617156] Starting subtest: basic-process
[69.749882] Subtest basic-process: SUCCESS (0.135s)
[69.963440] [015/165] (947s left) gem_close_race (basic-threads)
[70.244134] Starting subtest: basic-threads
[71.470613] Subtest basic-threads: SUCCESS (1.228s)
[71.722473] [016/165] (945s left) gem_ctx_create (basic)
[71.988640] Starting subtest: basic
[71.990384] Subtest basic: SUCCESS (0.000s)
[72.216174] [017/165] (944s left) gem_ctx_create (basic-files)
[72.481060] Starting subtest: basic-files
[74.537649] Subtest basic-files: SUCCESS (2.058s)
[75.090764] [018/165] (942s left) gem_ctx_exec (basic)
[75.320405] Starting subtest: basic
[75.330214] Subtest basic: SUCCESS (0.010s)
[75.448345] [019/165] (941s left) gem_exec_basic (basic)
[75.708633] Starting subtest: basic
[75.710974] Starting dynamic subtest: rcs0-smem
[75.718545] Dynamic subtest rcs0-smem: SUCCESS (0.008s)
[75.745794] Starting dynamic subtest: bcs0-smem
[75.747231] Dynamic subtest bcs0-smem: SUCCESS (0.006s)
[75.764637] Starting dynamic subtest: vcs0-smem
[75.766111] Dynamic subtest vcs0-smem: SUCCESS (0.003s)
[75.782666] Starting dynamic subtest: vecs0-smem
[75.784181] Dynamic subtest vecs0-smem: SUCCESS (0.005s)
[75.785590] Subtest basic: SUCCESS (0.029s)
[75.970298] [020/165] (941s left) gem_exec_create (basic)
[76.233571] Starting subtest: basic
[76.237684] Starting dynamic subtest: smem
[78.315061] Dynamic subtest smem: SUCCESS (2.084s)
[78.318878] Subtest basic: SUCCESS (2.085s)
[78.557830] [021/165] (938s left) gem_exec_fence (basic-busy)
[78.986785] Starting subtest: basic-busy
[78.989466] Starting dynamic subtest: rcs0
[79.012322] Dynamic subtest rcs0: SUCCESS (0.027s)
[79.043126] Starting dynamic subtest: bcs0
[79.047959] Dynamic subtest bcs0: SUCCESS (0.023s)
[79.084651] Starting dynamic subtest: vcs0
[79.088815] Dynamic subtest vcs0: SUCCESS (0.027s)
[79.109228] Starting dynamic subtest: vecs0
[79.113490] Dynamic subtest vecs0: SUCCESS (0.026s)
[79.115141] Subtest basic-busy: SUCCESS (0.106s)
[79.882925] [022/165] (937s left) gem_exec_fence (basic-wait)
[80.332906] Starting subtest: basic-wait
[80.339163] Starting dynamic subtest: rcs0
[80.361466] Dynamic subtest rcs0: SUCCESS (0.026s)
[80.386290] Starting dynamic subtest: bcs0
[80.394352] Dynamic subtest bcs0: SUCCESS (0.030s)
[80.419597] Starting dynamic subtest: vcs0
[80.421412] Dynamic subtest vcs0: SUCCESS (0.024s)
[80.443376] Starting dynamic subtest: vecs0
[80.444744] Dynamic subtest vecs0: SUCCESS (0.022s)
[80.446759] Subtest basic-wait: SUCCESS (0.106s)
[81.071208] [023/165] (936s left) gem_exec_fence (basic-await)
[81.493786] Starting subtest: basic-await
[81.495989] Starting dynamic subtest: rcs0
[81.681407] Dynamic subtest rcs0: SUCCESS (0.186s)
[81.703749] Starting dynamic subtest: bcs0
[81.856550] Dynamic subtest bcs0: SUCCESS (0.170s)
[81.875777] Starting dynamic subtest: vcs0
[82.043319] Dynamic subtest vcs0: SUCCESS (0.185s)
[82.062679] Starting dynamic subtest: vecs0
[82.219340] Dynamic subtest vecs0: SUCCESS (0.178s)
[82.222138] Subtest basic-await: SUCCESS (0.727s)
[82.895334] [024/165] (934s left) gem_exec_fence (nb-await)
[83.322582] Starting subtest: nb-await
[83.325271] Starting dynamic subtest: rcs0
[83.402822] Dynamic subtest rcs0: SUCCESS (0.082s)
[83.431834] Starting dynamic subtest: bcs0
[83.482961] Dynamic subtest bcs0: SUCCESS (0.077s)
[83.508639] Starting dynamic subtest: vcs0
[83.557221] Dynamic subtest vcs0: SUCCESS (0.075s)
[83.582506] Starting dynamic subtest: vecs0
[83.635418] Dynamic subtest vecs0: SUCCESS (0.079s)
[83.636993] Subtest nb-await: SUCCESS (0.315s)
[84.268188] [025/165] (933s left) gem_exec_gttfill (basic)
[84.537287] Starting subtest: basic
[86.800997] Subtest basic: SKIP (2.256s)
[87.061687] [026/165] (930s left) gem_exec_parallel (engines)
[87.494093] Starting subtest: engines
[87.497099] Starting dynamic subtest: basic
[92.830117] Dynamic subtest basic: SUCCESS (5.341s)
[92.865733] Starting dynamic subtest: contexts
[101.113490] Dynamic subtest contexts: SUCCESS (8.273s)
[101.144490] Starting dynamic subtest: fds
[113.962679] Dynamic subtest fds: SUCCESS (12.854s)
[113.989630] Starting dynamic subtest: userptr
[119.136075] Dynamic subtest userptr: SUCCESS (5.172s)
[119.137984] Subtest engines: SUCCESS (31.647s)
[119.423070] [027/165] (898s left) gem_exec_store (basic)
[119.686084] Starting subtest: basic
[119.749112] Subtest basic: SUCCESS (0.066s)
[119.969587] [028/165] (897s left) gem_flink_basic (bad-flink)
[120.192256] Starting subtest: bad-flink
[120.193898] Subtest bad-flink: SUCCESS (0.000s)
[120.289657] [029/165] (897s left) gem_flink_basic (bad-open)
[120.513563] Starting subtest: bad-open
[120.517808] Subtest bad-open: SUCCESS (0.000s)
[120.626961] [030/165] (897s left) gem_flink_basic (basic)
[120.853476] Starting subtest: basic
[120.855291] Subtest basic: SUCCESS (0.000s)
[120.970984] [031/165] (896s left) gem_flink_basic (double-flink)
[121.196573] Starting subtest: double-flink
[121.198918] Subtest double-flink: SUCCESS (0.000s)
[121.309614] [032/165] (896s left) gem_flink_basic (flink-lifetime)
[121.529983] Starting subtest: flink-lifetime
[121.536611] Subtest flink-lifetime: SUCCESS (0.005s)
[121.657145] [033/165] (896s left) gem_huc_copy (huc-copy)
[121.901145] Subtest huc-copy: SKIP (0.000s)
[121.982471] [034/165] (896s left) gem_linear_blits (basic)
[122.552926] Subtest basic: SKIP (0.000s)
[122.660294] [035/165] (895s left) gem_mmap (basic)
[123.038965] Starting subtest: basic
[123.050897] Subtest basic: SUCCESS (0.002s)
[123.153471] [036/165] (895s left) gem_mmap_gtt (basic)
[123.374486] Starting subtest: basic
[123.380153] Subtest basic: SUCCESS (0.004s)
[123.495165] [037/165] (894s left) gem_render_linear_blits (basic)
[123.731229] Starting subtest: basic
[123.843102] Subtest basic: SUCCESS (0.107s)
[123.913345] [038/165] (894s left) gem_render_tiled_blits (basic)
[124.154490] Starting subtest: basic
[124.282307] Subtest basic: SUCCESS (0.124s)
[124.361592] [039/165] (893s left) gem_ringfill (basic-all)
[124.782304] Starting subtest: basic-all
[126.058834] Subtest basic-all: SUCCESS (1.273s)
[126.172087] [040/165] (892s left) gem_softpin (allocator-basic)
[126.418430] Starting subtest: allocator-basic
[126.720710] Subtest allocator-basic: SUCCESS (0.296s)
[126.884638] [041/165] (891s left) gem_softpin (allocator-basic-reserve)
[127.125743] Starting subtest: allocator-basic-reserve
[127.419759] Subtest allocator-basic-reserve: SUCCESS (0.287s)
[127.590451] [042/165] (890s left) gem_softpin (safe-alignment)
[127.837314] Starting subtest: safe-alignment
[127.891122] Subtest safe-alignment: SUCCESS (0.051s)
[128.004840] [043/165] (890s left) gem_sync (basic-all)
[128.287575] Starting subtest: basic-all
[131.018569] Subtest basic-all: SUCCESS (2.732s)
[131.252294] [044/165] (887s left) gem_sync (basic-each)
[131.520204] Starting subtest: basic-each
[134.354898] Subtest basic-each: SUCCESS (2.835s)
[134.588518] [045/165] (884s left) gem_tiled_blits (basic)
[135.107089] Subtest basic: SKIP (0.000s)
[135.201752] [046/165] (883s left) gem_tiled_fence_blits (basic)
[135.849582] Starting subtest: basic
[135.903791] Subtest basic: SUCCESS (0.052s)
[136.046126] [047/165] (882s left) gem_tiled_pread_basic
[137.254217] [048/165] (881s left) gem_wait (busy@all-engines)
[137.553846] Starting subtest: busy
[137.556807] Starting dynamic subtest: all-engines
[138.094653] Dynamic subtest all-engines: SUCCESS (0.541s)
[138.097540] Subtest busy: SUCCESS (0.542s)
[138.410445] [049/165] (880s left) gem_wait (wait@all-engines)
[138.704380] Starting subtest: wait
[138.707771] Starting dynamic subtest: all-engines
[139.738712] Dynamic subtest all-engines: SUCCESS (1.036s)
[139.740095] Subtest wait: SUCCESS (1.036s)
[140.035883] [050/165] (878s left) i915_getparams_basic (basic-eu-total)
[140.281191] Starting subtest: basic-eu-total
[140.284494] Subtest basic-eu-total: SUCCESS (0.000s)
[140.386978] [051/165] (878s left) i915_getparams_basic (basic-subslice-total)
[140.611525] Starting subtest: basic-subslice-total
[140.615751] Subtest basic-subslice-total: SUCCESS (0.000s)
[140.725956] [052/165] (878s left) i915_hangman (error-state-basic)
[141.057218] Starting subtest: error-state-basic
[141.100202] Subtest error-state-basic: SUCCESS (0.038s)
[141.257109] [053/165] (877s left) i915_pciid
[141.604311] [054/165] (877s left) kms_addfb_basic (addfb25-4-tiled)
[142.347451] Starting subtest: addfb25-4-tiled
[142.350654] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[142.470916] [055/165] (876s left) kms_addfb_basic (addfb25-bad-modifier)
[142.707584] Starting subtest: addfb25-bad-modifier
[142.710251] Subtest addfb25-bad-modifier: SUCCESS (0.003s)
[143.254214] [056/165] (876s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[143.491699] Starting subtest: addfb25-framebuffer-vs-set-tiling
[143.494948] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[144.021214] [057/165] (875s left) kms_addfb_basic (addfb25-modifier-no-flag)
[144.255786] Starting subtest: addfb25-modifier-no-flag
[144.258132] Subtest addfb25-modifier-no-flag: SUCCESS (0.001s)
[144.824319] [058/165] (874s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[145.053891] Starting subtest: addfb25-x-tiled-legacy
[145.055911] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[145.588525] [059/165] (873s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[145.823236] Starting subtest: addfb25-x-tiled-mismatch-legacy
[145.825992] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[146.356593] [060/165] (873s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[146.998792] Starting subtest: addfb25-yf-tiled-legacy
[147.001250] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[147.105268] [061/165] (872s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[147.753109] Starting subtest: addfb25-y-tiled-legacy
[147.755849] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[147.854755] [062/165] (871s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[148.617076] Starting subtest: addfb25-y-tiled-small-legacy
[148.621471] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[148.747174] [063/165] (870s left) kms_addfb_basic (bad-pitch-0)
[148.972804] Starting subtest: bad-pitch-0
[148.975537] Subtest bad-pitch-0: SUCCESS (0.000s)
[149.503884] [064/165] (870s left) kms_addfb_basic (bad-pitch-1024)
[149.726733] Starting subtest: bad-pitch-1024
[149.728880] Subtest bad-pitch-1024: SUCCESS (0.000s)
[150.271467] [065/165] (869s left) kms_addfb_basic (bad-pitch-128)
[150.500562] Starting subtest: bad-pitch-128
[150.503904] Subtest bad-pitch-128: SUCCESS (0.000s)
[151.040652] [066/165] (868s left) kms_addfb_basic (bad-pitch-256)
[151.268745] Starting subtest: bad-pitch-256
[151.271924] Subtest bad-pitch-256: SUCCESS (0.000s)
[151.837191] [067/165] (868s left) kms_addfb_basic (bad-pitch-32)
[152.067736] Starting subtest: bad-pitch-32
[152.069163] Subtest bad-pitch-32: SUCCESS (0.000s)
[152.588429] [068/165] (867s left) kms_addfb_basic (bad-pitch-63)
[152.816985] Starting subtest: bad-pitch-63
[152.819834] Subtest bad-pitch-63: SUCCESS (0.000s)
[153.446651] [069/165] (866s left) kms_addfb_basic (bad-pitch-65536)
[153.681518] Starting subtest: bad-pitch-65536
[153.686191] Subtest bad-pitch-65536: SUCCESS (0.003s)
[154.237627] [070/165] (865s left) kms_addfb_basic (bad-pitch-999)
[154.467510] Starting subtest: bad-pitch-999
[154.469827] Subtest bad-pitch-999: SUCCESS (0.000s)
[154.987604] [071/165] (865s left) kms_addfb_basic (basic)
[155.210138] Starting subtest: basic
[155.211625] Subtest basic: SUCCESS (0.000s)
[155.754270] [072/165] (864s left) kms_addfb_basic (basic-x-tiled-legacy)
[155.983711] Starting subtest: basic-x-tiled-legacy
[155.987288] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[156.505288] [073/165] (863s left) kms_addfb_basic (basic-y-tiled-legacy)
[156.733714] Starting subtest: basic-y-tiled-legacy
[156.738141] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[157.270805] [074/165] (862s left) kms_addfb_basic (bo-too-small)
[157.945372] Starting subtest: bo-too-small
[157.946993] Subtest bo-too-small: SUCCESS (0.002s)
[158.070859] [075/165] (862s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[158.715972] Starting subtest: bo-too-small-due-to-tiling
[158.717578] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[158.820593] [076/165] (861s left) kms_addfb_basic (clobberred-modifier)
[159.043406] Starting subtest: clobberred-modifier
[159.047619] Subtest clobberred-modifier: SUCCESS (0.000s)
[159.587237] [077/165] (860s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[159.811297] Starting subtest: framebuffer-vs-set-tiling
[159.813693] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s)
[160.338584] [078/165] (860s left) kms_addfb_basic (invalid-get-prop)
[160.570305] Starting subtest: invalid-get-prop
[160.571807] Subtest invalid-get-prop: SUCCESS (0.000s)
[161.104177] [079/165] (859s left) kms_addfb_basic (invalid-get-prop-any)
[161.334270] Starting subtest: invalid-get-prop-any
[161.335628] Subtest invalid-get-prop-any: SUCCESS (0.001s)
[161.874302] [080/165] (858s left) kms_addfb_basic (invalid-set-prop)
[162.106511] Starting subtest: invalid-set-prop
[162.108803] Subtest invalid-set-prop: SUCCESS (0.000s)
[162.654126] [081/165] (857s left) kms_addfb_basic (invalid-set-prop-any)
[162.875305] Starting subtest: invalid-set-prop-any
[162.876666] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[163.388928] [082/165] (857s left) kms_addfb_basic (no-handle)
[163.619867] Starting subtest: no-handle
[163.622926] Subtest no-handle: SUCCESS (0.000s)
[164.199260] [083/165] (856s left) kms_addfb_basic (size-max)
[164.855126] Starting subtest: size-max
[164.858132] Subtest size-max: SUCCESS (0.000s)
[164.954959] [084/165] (855s left) kms_addfb_basic (small-bo)
[165.602594] Starting subtest: small-bo
[165.605322] Subtest small-bo: SUCCESS (0.000s)
[165.704659] [085/165] (855s left) kms_addfb_basic (tile-pitch-mismatch)
[165.932534] Starting subtest: tile-pitch-mismatch
[165.935062] Subtest tile-pitch-mismatch: SUCCESS (0.001s)
[166.471087] [086/165] (854s left) kms_addfb_basic (too-high)
[167.109181] Starting subtest: too-high
[167.120814] Subtest too-high: SUCCESS (0.006s)
[167.220609] [087/165] (853s left) kms_addfb_basic (too-wide)
[167.894742] Starting subtest: too-wide
[167.897154] Subtest too-wide: SUCCESS (0.000s)
[168.004460] [088/165] (853s left) kms_addfb_basic (unused-handle)
[168.233615] Starting subtest: unused-handle
[168.237447] Subtest unused-handle: SUCCESS (0.000s)
[168.772768] [089/165] (852s left) kms_addfb_basic (unused-modifier)
[168.998744] Starting subtest: unused-modifier
[169.001961] Subtest unused-modifier: SUCCESS (0.000s)
[169.539639] [090/165] (851s left) kms_addfb_basic (unused-offsets)
[169.765540] Starting subtest: unused-offsets
[169.767208] Subtest unused-offsets: SUCCESS (0.000s)
[170.286042] [091/165] (850s left) kms_addfb_basic (unused-pitches)
[170.514189] Starting subtest: unused-pitches
[170.517874] Subtest unused-pitches: SUCCESS (0.000s)
[171.042344] [092/165] (850s left) kms_busy (basic)
[171.703315] Starting subtest: basic
[171.716564] Starting dynamic subtest: flip
[172.742540] Dynamic subtest flip: SUCCESS (1.035s)
[172.800757] Starting dynamic subtest: modeset
[174.866104] Dynamic subtest modeset: SUCCESS (2.120s)
[174.883688] Subtest basic: SUCCESS (3.160s)
[175.472486] [093/165] (845s left) kms_prop_blob (basic)
[175.704478] Starting subtest: basic
[175.708472] Subtest basic: SUCCESS (0.000s)
[175.815903] [094/165] (845s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[176.471762] Starting subtest: basic-busy-flip-before-cursor-atomic
[177.663900] Subtest basic-busy-flip-before-cursor-atomic: SUCCESS (1.193s)
[178.158913] [095/165] (843s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[178.840694] Starting subtest: basic-busy-flip-before-cursor-legacy
[180.150046] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.307s)
[180.651766] [096/165] (840s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[181.318969] Starting subtest: basic-flip-after-cursor-atomic
[182.522446] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.200s)
[183.053792] [097/165] (838s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[183.739950] Starting subtest: basic-flip-after-cursor-legacy
[184.984041] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.239s)
[185.494831] [098/165] (836s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[186.204898] Starting subtest: basic-flip-after-cursor-varying-size
[187.405710] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.200s)
[187.901745] [099/165] (833s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[188.591097] Starting subtest: basic-flip-before-cursor-atomic
[189.745173] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.160s)
[190.242827] [100/165] (831s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[190.915199] Starting subtest: basic-flip-before-cursor-legacy
[192.101702] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.195s)
[192.600145] [101/165] (829s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[193.283898] Starting subtest: basic-flip-before-cursor-varying-size
[194.462505] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.186s)
[194.938930] [102/165] (826s left) kms_dsc (dsc-basic)
[195.627102] Subtest dsc-basic: SKIP (0.000s)
[195.708498] [103/165] (826s left) kms_flip (basic-flip-vs-dpms)
[196.178073] Starting subtest: basic-flip-vs-dpms
[196.198837] Starting dynamic subtest: C-HDMI-A2
[198.918067] Dynamic subtest C-HDMI-A2: SUCCESS (2.704s)
[198.928087] Subtest basic-flip-vs-dpms: SUCCESS (2.734s)
[199.390280] [104/165] (822s left) kms_flip (basic-flip-vs-modeset)
[199.867108] Starting subtest: basic-flip-vs-modeset
[199.883151] Starting dynamic subtest: C-HDMI-A2
[202.931191] Dynamic subtest C-HDMI-A2: SUCCESS (3.032s)
[202.938223] Subtest basic-flip-vs-modeset: SUCCESS (3.057s)
[203.490455] [105/165] (818s left) kms_flip (basic-flip-vs-wf_vblank)
[203.955953] Starting subtest: basic-flip-vs-wf_vblank
[203.969606] Starting dynamic subtest: C-HDMI-A2
[206.960182] Dynamic subtest C-HDMI-A2: SUCCESS (2.988s)
[206.961613] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.008s)
[207.141123] [106/165] (814s left) kms_flip (basic-plain-flip)
[207.623899] Starting subtest: basic-plain-flip
[207.634500] Starting dynamic subtest: C-HDMI-A2
[210.196262] Dynamic subtest C-HDMI-A2: SUCCESS (2.556s)
[210.198844] Subtest basic-plain-flip: SUCCESS (2.577s)
[210.370769] [107/165] (811s left) kms_force_connector_basic (force-connector-state)
[210.728928] Starting subtest: force-connector-state
[211.622510] Subtest force-connector-state: SUCCESS (0.891s)
[212.934495] [108/165] (809s left) kms_force_connector_basic (force-edid)
[213.279203] Starting subtest: force-edid
[213.365543] Subtest force-edid: SUCCESS (0.099s)
[214.133729] [109/165] (808s left) kms_force_connector_basic (force-load-detect)
[214.519043] Starting subtest: force-load-detect
[214.528521] Subtest force-load-detect: SKIP (0.000s)
[215.052626] [110/165] (807s left) kms_force_connector_basic (prune-stale-modes)
[215.419207] Starting subtest: prune-stale-modes
[215.535297] Subtest prune-stale-modes: SUCCESS (0.118s)
[216.333964] [111/165] (806s left) kms_frontbuffer_tracking (basic)
[217.067754] Starting subtest: basic
[221.210628] Subtest basic: SUCCESS (4.145s)
[221.351335] [112/165] (801s left) kms_hdmi_inject (inject-audio)
[221.705429] Starting subtest: inject-audio
[222.284387] Subtest inject-audio: FAIL (0.539s)
[223.117208] [113/165] (799s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[223.842490] Starting subtest: compare-crc-sanitycheck-xr24
[223.853053] Starting dynamic subtest: pipe-C-HDMI-A-2
[224.371101] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.511s)
[224.378651] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.526s)
[224.905754] [114/165] (797s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[225.589305] Starting subtest: compare-crc-sanitycheck-nv12
[225.598611] Starting dynamic subtest: pipe-C-HDMI-A-2
[225.602826] Dynamic subtest pipe-C-HDMI-A-2: SKIP (0.003s)
[225.611690] Subtest compare-crc-sanitycheck-nv12: SKIP (0.023s)
[225.721787] [115/165] (796s left) kms_pipe_crc_basic (hang-read-crc)
[226.444958] Starting subtest: hang-read-crc
[226.446695] Starting dynamic subtest: pipe-C-HDMI-A-2
[228.010971] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (1.566s)
[228.018992] Subtest hang-read-crc: SUCCESS (1.579s)
[228.476724] [116/165] (794s left) kms_pipe_crc_basic (nonblocking-crc)
[229.177706] Starting subtest: nonblocking-crc
[229.187792] Starting dynamic subtest: pipe-C-HDMI-A-2
[229.877044] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.690s)
[229.879813] Subtest nonblocking-crc: SUCCESS (0.704s)
[230.359435] [117/165] (792s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[231.054984] Starting subtest: nonblocking-crc-frame-sequence
[231.070950] Starting dynamic subtest: pipe-C-HDMI-A-2
[231.753726] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.691s)
[231.758666] Subtest nonblocking-crc-frame-sequence: SUCCESS (0.699s)
[232.256218] [118/165] (790s left) kms_pipe_crc_basic (read-crc)
[232.989748] Starting subtest: read-crc
[232.991979] Starting dynamic subtest: pipe-C-HDMI-A-2
[233.636393] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.639s)
[233.637956] Subtest read-crc: SUCCESS (0.652s)
[234.082268] [119/165] (788s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[234.755888] Starting subtest: read-crc-frame-sequence
[234.769040] Starting dynamic subtest: pipe-C-HDMI-A-2
[235.407993] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (0.641s)
[235.417188] Subtest read-crc-frame-sequence: SUCCESS (0.655s)
[235.884798] [120/165] (786s left) kms_pm_backlight (basic-brightness)
[236.562434] Subtest basic-brightness: SKIP (0.000s)
[236.662541] [121/165] (786s left) kms_psr (primary_page_flip)
[236.894271] Subtest primary_page_flip: SKIP (0.000s)
[236.978306] [122/165] (786s left) kms_psr (cursor_plane_move)
[237.212474] Subtest cursor_plane_move: SKIP (0.000s)
[237.275578] [123/165] (785s left) kms_psr (sprite_plane_onoff)
[237.508174] Subtest sprite_plane_onoff: SKIP (0.000s)
[237.577641] [124/165] (785s left) kms_psr (primary_mmap_gtt)
[237.809364] Subtest primary_mmap_gtt: SKIP (0.000s)
[237.892195] [125/165] (785s left) kms_setmode (basic-clone-single-crtc)
[238.124642] Starting subtest: basic-clone-single-crtc
[238.131483] Subtest basic-clone-single-crtc: SKIP (0.001s)
[238.235245] [126/165] (784s left) i915_pm_rpm (basic-pci-d3-state)
[240.599386] Starting subtest: basic-pci-d3-state
[240.973416] Subtest basic-pci-d3-state: SUCCESS (0.365s)
[241.290566] [127/165] (781s left) i915_pm_rpm (basic-rte)
[241.519245] Starting subtest: basic-rte
[243.965956] Subtest basic-rte: SUCCESS (2.433s)
[245.028718] [128/165] (778s left) i915_pm_rps (basic-api)
[245.272609] Starting subtest: basic-api
[245.290285] Subtest basic-api: SUCCESS (0.013s)
[245.390422] [129/165] (778s left) prime_self_import (basic-llseek-bad)
[245.615423] Starting subtest: basic-llseek-bad
[245.619903] Subtest basic-llseek-bad: SUCCESS (0.008s)
[245.739362] [130/165] (777s left) prime_self_import (basic-llseek-size)
[245.964667] Starting subtest: basic-llseek-size
[245.976865] Subtest basic-llseek-size: SUCCESS (0.011s)
[246.092965] [131/165] (777s left) prime_self_import (basic-with_fd_dup)
[246.315724] Starting subtest: basic-with_fd_dup
[246.327316] Subtest basic-with_fd_dup: SUCCESS (0.010s)
[246.441287] [132/165] (777s left) prime_self_import (basic-with_one_bo)
[246.665370] Starting subtest: basic-with_one_bo
[246.679135] Subtest basic-with_one_bo: SUCCESS (0.013s)
[246.784656] [133/165] (776s left) prime_self_import (basic-with_one_bo_two_files)
[247.003850] Starting subtest: basic-with_one_bo_two_files
[247.015580] Subtest basic-with_one_bo_two_files: SUCCESS (0.009s)
[247.123149] [134/165] (776s left) prime_self_import (basic-with_two_bos)
[247.339128] Starting subtest: basic-with_two_bos
[247.356667] Subtest basic-with_two_bos: SUCCESS (0.016s)
[247.478317] [135/165] (776s left) prime_vgem (basic-fence-flip)
[247.738920] Starting subtest: basic-fence-flip
[248.526064] Subtest basic-fence-flip: SKIP (0.782s)
[248.673740] [136/165] (775s left) prime_vgem (basic-fence-mmap)
[248.941589] Starting subtest: basic-fence-mmap
[249.056087] Subtest basic-fence-mmap: SUCCESS (0.111s)
[249.178134] [137/165] (774s left) prime_vgem (basic-fence-read)
[249.443563] Starting subtest: basic-fence-read
[249.625274] Subtest basic-fence-read: SUCCESS (0.181s)
[249.749980] [138/165] (774s left) prime_vgem (basic-gtt)
[250.004849] Starting subtest: basic-gtt
[250.058841] Subtest basic-gtt: SUCCESS (0.050s)
[250.174281] [139/165] (773s left) prime_vgem (basic-read)
[250.421074] Starting subtest: basic-read
[250.504905] Subtest basic-read: SUCCESS (0.079s)
[250.625956] [140/165] (773s left) prime_vgem (basic-write)
[250.877166] Starting subtest: basic-write
[250.977399] Subtest basic-write: SUCCESS (0.098s)
[251.099899] [141/165] (773s left) vgem_basic (setversion)
[251.339291] Starting subtest: setversion
[251.344234] Subtest setversion: SUCCESS (0.000s)
[251.440280] [142/165] (772s left) vgem_basic (create)
[251.669722] Starting subtest: create
[251.673841] Subtest create: SUCCESS (0.001s)
[251.765625] [143/165] (772s left) vgem_basic (debugfs)
[252.006157] Starting subtest: debugfs
[252.007937] Subtest debugfs: SUCCESS (0.002s)
[252.094691] [144/165] (772s left) vgem_basic (dmabuf-export)
[252.350492] Starting subtest: dmabuf-export
[252.355079] Subtest dmabuf-export: SUCCESS (0.007s)
[252.458541] [145/165] (771s left) vgem_basic (dmabuf-fence)
[252.683567] Starting subtest: dmabuf-fence
[252.687471] Subtest dmabuf-fence: SUCCESS (0.002s)
[252.774147] [146/165] (771s left) vgem_basic (dmabuf-fence-before)
[253.021440] Starting subtest: dmabuf-fence-before
[253.023595] Subtest dmabuf-fence-before: SUCCESS (0.001s)
[253.109889] [147/165] (771s left) vgem_basic (dmabuf-mmap)
[253.356619] Starting subtest: dmabuf-mmap
[253.402105] Subtest dmabuf-mmap: SUCCESS (0.044s)
[253.489586] [148/165] (771s left) vgem_basic (mmap)
[253.720573] Starting subtest: mmap
[253.751105] Subtest mmap: SUCCESS (0.031s)
[253.840267] [149/165] (770s left) vgem_basic (second-client)
[254.072566] Starting subtest: second-client
[254.101577] Subtest second-client: SUCCESS (0.032s)
[254.209498] [150/165] (770s left) vgem_basic (sysfs)
[254.454594] Starting subtest: sysfs
[254.457290] Subtest sysfs: SUCCESS (0.002s)
[254.557969] [151/165] (770s left) core_hotunplug (unbind-rebind)
[254.904651] Starting subtest: unbind-rebind
[259.716851] Subtest unbind-rebind: SUCCESS (4.812s)
[259.791181] [152/165] (764s left) vgem_basic (unload)
[260.027772] Starting subtest: unload
[289.162457] Subtest unload: SUCCESS (29.128s)
[289.380630] [153/165] (735s left) i915_module_load (reload)
[289.607480] Starting subtest: reload
[294.369729] Subtest reload: SUCCESS (4.762s)
[294.583432] [154/165] (730s left) gem_lmem_swapping (basic)
[295.101052] Subtest basic: SKIP (0.000s)
[295.181337] [155/165] (729s left) gem_lmem_swapping (parallel-random-engines)
[295.420478] Subtest parallel-random-engines: SKIP (0.000s)
[295.496211] [156/165] (729s left) gem_lmem_swapping (random-engines)
[295.745543] Subtest random-engines: SKIP (0.000s)
[295.811413] [157/165] (729s left) gem_lmem_swapping (verify-random)
[296.050928] Subtest verify-random: SKIP (0.000s)
[296.128342] [158/165] (729s left) i915_pm_rpm (module-reload)
[298.888452] Starting subtest: module-reload
[312.819128] Subtest module-reload: SUCCESS (13.931s)
[312.870927] [159/165] (712s left) i915_selftest (live)
[313.121299] Starting subtest: live
[313.122995] Starting dynamic subtest: sanitycheck
[314.909980] Dynamic subtest sanitycheck: SUCCESS (1.788s)
[314.958269] Starting dynamic subtest: uncore
[316.758931] Dynamic subtest uncore: SUCCESS (1.840s)
[316.783216] Starting dynamic subtest: workarounds
[318.732608] Dynamic subtest workarounds: SUCCESS (1.965s)
[318.751809] Starting dynamic subtest: gt_engines
[320.994553] Dynamic subtest gt_engines: SUCCESS (2.257s)
[321.016294] Starting dynamic subtest: gt_timelines
[349.190222] Dynamic subtest gt_timelines: SUCCESS (28.190s)
[349.209320] Starting dynamic subtest: gt_contexts
[351.140065] Dynamic subtest gt_contexts: SUCCESS (1.946s)
[351.159324] Starting dynamic subtest: gt_lrc
[356.162070] Dynamic subtest gt_lrc: SUCCESS (5.016s)
[356.182231] Starting dynamic subtest: gt_mocs
[357.916290] Dynamic subtest gt_mocs: SUCCESS (1.749s)
[357.964243] Starting dynamic subtest: gt_pm
[360.885425] Dynamic subtest gt_pm: SUCCESS (2.963s)
[360.906748] Starting dynamic subtest: gt_heartbeat
[362.790352] Dynamic subtest gt_heartbeat: SUCCESS (1.900s)
[362.809373] Starting dynamic subtest: gt_tlb
[364.930467] Dynamic subtest gt_tlb: SUCCESS (2.135s)
[364.949739] Starting dynamic subtest: requests
[373.258437] Dynamic subtest requests: SUCCESS (8.324s)
[373.278266] Starting dynamic subtest: migrate
[378.508069] Dynamic subtest migrate: SUCCESS (5.245s)
[378.528655] Starting dynamic subtest: active
[380.465627] Dynamic subtest active: SUCCESS (1.956s)
[380.489389] Starting dynamic subtest: objects
[384.280674] Dynamic subtest objects: SUCCESS (3.803s)
[384.299935] Starting dynamic subtest: mman
[394.600905] Dynamic subtest mman: SUCCESS (10.316s)
[394.621372] Starting dynamic subtest: dmabuf
[396.558361] Dynamic subtest dmabuf: SUCCESS (1.954s)
[396.577820] Starting dynamic subtest: vma
[398.354175] Dynamic subtest vma: SUCCESS (1.786s)
[398.374976] Starting dynamic subtest: coherency
[403.796935] Dynamic subtest coherency: SUCCESS (5.439s)
[403.816792] Starting dynamic subtest: gtt
[413.144843] Dynamic subtest gtt: SUCCESS (9.345s)
[413.167945] Starting dynamic subtest: gem
[415.853440] Dynamic subtest gem: SUCCESS (2.701s)
[415.872870] Starting dynamic subtest: evict
[423.670432] Dynamic subtest evict: SUCCESS (7.812s)
[423.689761] Starting dynamic subtest: hugepages
[425.932242] Dynamic subtest hugepages: SUCCESS (2.257s)
[425.953750] Starting dynamic subtest: gem_contexts
[450.639184] Dynamic subtest gem_contexts: SUCCESS (24.699s)
[450.661206] Starting dynamic subtest: client
[452.443429] Dynamic subtest client: SUCCESS (1.798s)
[452.493547] Starting dynamic subtest: gem_migrate
[454.314202] Dynamic subtest gem_migrate: SUCCESS (1.869s)
[454.339795] Starting dynamic subtest: reset
[463.834986] Dynamic subtest reset: SUCCESS (9.517s)
[463.854445] Starting dynamic subtest: memory_region
[465.594463] Dynamic subtest memory_region: SUCCESS (1.754s)
[465.613911] Starting dynamic subtest: hangcheck
[490.733045] Dynamic subtest hangcheck: SUCCESS (25.134s)
[490.752576] Starting dynamic subtest: execlists
[503.854175] Dynamic subtest execlists: SUCCESS (13.117s)
[503.876527] Starting dynamic subtest: ring_submission
[505.671157] Dynamic subtest ring_submission: SUCCESS (1.808s)
[505.707758] Starting dynamic subtest: perf
[507.845191] Dynamic subtest perf: SUCCESS (2.175s)
[507.869515] Starting dynamic subtest: slpc
[509.769270] Dynamic subtest slpc: SUCCESS (1.913s)
[509.788657] Starting dynamic subtest: guc
[511.573768] Dynamic subtest guc: SUCCESS (1.802s)
[511.599120] Starting dynamic subtest: guc_multi_lrc
[513.389098] Dynamic subtest guc_multi_lrc: SUCCESS (1.803s)
[513.442736] Starting dynamic subtest: guc_hang
[515.167176] Dynamic subtest guc_hang: SUCCESS (1.771s)
[515.228642] Starting dynamic subtest: late_gt_pm
[517.098924] Dynamic subtest late_gt_pm: SUCCESS (1.928s)
[517.101681] Subtest live: SUCCESS (203.981s)
[517.160231] [160/165] (508s left) dmabuf (all-tests)
[517.398620] Starting subtest: all-tests
[517.404100] Starting dynamic subtest: sanitycheck
[517.466381] Dynamic subtest sanitycheck: SUCCESS (0.066s)
[517.504549] Starting dynamic subtest: dma_fence
[517.659566] Dynamic subtest dma_fence: SUCCESS (0.190s)
[517.708499] Starting dynamic subtest: dma_fence_chain
[548.402896] Dynamic subtest dma_fence_chain: SUCCESS (30.729s)
[548.427122] Starting dynamic subtest: dma_fence_unwrap
[548.480890] Dynamic subtest dma_fence_unwrap: SUCCESS (0.079s)
[548.533580] Starting dynamic subtest: dma_resv
[548.561430] Dynamic subtest dma_resv: SUCCESS (0.067s)
[548.563132] Subtest all-tests: SUCCESS (31.166s)
[548.622952] [161/165] (476s left) i915_suspend (basic-s2idle-without-i915)
[548.840084] Starting subtest: basic-s2idle-without-i915
[571.463671] Subtest basic-s2idle-without-i915: SUCCESS (8.608s)
[577.131985] [162/165] (467s left) i915_suspend (basic-s3-without-i915)
[577.372895] Starting subtest: basic-s3-without-i915
[599.131413] Subtest basic-s3-without-i915: SUCCESS (6.724s)
[601.998606] [163/165] (459s left) gem_exec_suspend (basic-s0)
[602.294733] Starting subtest: basic-S0
[602.296518] Starting dynamic subtest: smem
[625.915213] Dynamic subtest smem: SUCCESS (8.767s)
[625.916663] Subtest basic-S0: SUCCESS (8.771s)
[631.179355] [164/165] (450s left) gem_exec_suspend (basic-s3)
[631.463113] Starting subtest: basic-S3
[631.465319] Starting dynamic subtest: smem
[655.640590] Dynamic subtest smem: SUCCESS (9.212s)
[655.642091] Subtest basic-S3: SUCCESS (9.217s)
[658.856042] [165/165] (440s left) kms_pipe_crc_basic (suspend-read-crc)
[659.588166] Starting subtest: suspend-read-crc
[659.591410] Starting dynamic subtest: pipe-C-HDMI-A-2
[680.675497] Dynamic subtest pipe-C-HDMI-A-2: SUCCESS (5.272s)
[680.677082] Subtest suspend-read-crc: SUCCESS (5.286s)
[686.007506] Closing watchdogs
Done.