[54.091883] Initializing watchdogs
[54.092484]   /dev/watchdog0
[54.120195] [001/162] (960s left) i915_module_load (load)
[54.524994] Starting subtest: load
[58.453214] Subtest load: SUCCESS (3.929s)
[58.523205] [002/162] (956s left) core_auth (basic-auth)
[60.178790] Starting subtest: basic-auth
[60.185683] Subtest basic-auth: SUCCESS (0.003s)
[60.241350] [003/162] (954s left) debugfs_test (read_all_entries)
[60.648144] Starting subtest: read_all_entries
[61.773220] Subtest read_all_entries: SUCCESS (1.120s)
[61.972155] [004/162] (952s left) debugfs_test (basic-hwmon)
[62.370565] Starting subtest: basic-hwmon
[62.383806] Subtest basic-hwmon: SKIP (0.000s)
[62.554495] [005/162] (952s left) fbdev (eof)
[66.213777] Subtest eof: SKIP (0.000s)
[66.269944] [006/162] (948s left) fbdev (info)
[66.701600] Subtest info: SKIP (0.000s)
[66.757879] [007/162] (948s left) fbdev (nullptr)
[67.192716] Subtest nullptr: SKIP (0.000s)
[67.250598] [008/162] (947s left) fbdev (read)
[67.681623] Subtest read: SKIP (0.000s)
[67.736990] [009/162] (947s left) fbdev (write)
[68.174395] Subtest write: SKIP (0.000s)
[68.230191] [010/162] (947s left) gem_basic (bad-close)
[68.602241] Starting subtest: bad-close
[68.615780] Subtest bad-close: SUCCESS (0.000s)
[68.667823] [011/162] (946s left) gem_basic (create-close)
[69.054224] Starting subtest: create-close
[69.067405] Subtest create-close: SUCCESS (0.001s)
[69.140363] [012/162] (946s left) gem_basic (create-fd-close)
[69.522197] Starting subtest: create-fd-close
[69.535803] Subtest create-fd-close: SUCCESS (0.001s)
[69.609749] [013/162] (945s left) gem_busy (busy@all-engines)
[70.045444] Starting subtest: busy
[70.053249] Starting dynamic subtest: all-engines
[70.228684] Dynamic subtest all-engines: SUCCESS (0.187s)
[70.235532] Subtest busy: SUCCESS (0.187s)
[72.197076] [014/162] (943s left) gem_close_race (basic-process)
[72.638964] Starting subtest: basic-process
[72.731194] Subtest basic-process: SUCCESS (0.093s)
[72.924869] [015/162] (942s left) gem_close_race (basic-threads)
[73.360846] Starting subtest: basic-threads
[74.791839] Subtest basic-threads: SUCCESS (1.432s)
[74.979785] [016/162] (940s left) gem_ctx_create (basic)
[75.409523] Starting subtest: basic
[75.416304] Subtest basic: SUCCESS (0.000s)
[75.601869] [017/162] (940s left) gem_ctx_create (basic-files)
[76.019756] Starting subtest: basic-files
[78.087258] Subtest basic-files: SUCCESS (2.067s)
[79.251433] [018/162] (936s left) gem_ctx_exec (basic)
[79.650485] Starting subtest: basic
[79.666335] Subtest basic: SUCCESS (0.017s)
[79.770332] [019/162] (936s left) gem_exec_basic (basic)
[80.176670] Starting subtest: basic
[80.183517] Starting dynamic subtest: rcs0-smem
[80.190436] Dynamic subtest rcs0-smem: SUCCESS (0.005s)
[80.221360] Starting dynamic subtest: bcs0-smem
[80.228122] Dynamic subtest bcs0-smem: SUCCESS (0.002s)
[80.258135] Starting dynamic subtest: vcs0-smem
[80.264906] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[80.295681] Starting dynamic subtest: vcs1-smem
[80.302421] Dynamic subtest vcs1-smem: SUCCESS (0.002s)
[80.333288] Starting dynamic subtest: vecs0-smem
[80.340119] Dynamic subtest vecs0-smem: SUCCESS (0.002s)
[80.370160] Starting dynamic subtest: ccs0-smem
[80.376923] Dynamic subtest ccs0-smem: SUCCESS (0.003s)
[80.383600] Subtest basic: SUCCESS (0.021s)
[82.233452] [020/162] (933s left) gem_exec_create (basic)
[82.672275] Starting subtest: basic
[82.679232] Starting dynamic subtest: smem
[86.166872] Dynamic subtest smem: SUCCESS (3.493s)
[86.174119] Subtest basic: SUCCESS (3.494s)
[86.356535] [021/162] (929s left) gem_exec_fence (basic-busy)
[86.957140] Starting subtest: basic-busy
[86.964526] Starting dynamic subtest: rcs0
[87.021114] Dynamic subtest rcs0: SUCCESS (0.070s)
[87.053834] Starting dynamic subtest: bcs0
[87.078583] Dynamic subtest bcs0: SUCCESS (0.056s)
[87.113521] Starting dynamic subtest: vcs0
[87.134704] Dynamic subtest vcs0: SUCCESS (0.050s)
[87.164874] Starting dynamic subtest: vcs1
[87.178096] Dynamic subtest vcs1: SUCCESS (0.033s)
[87.207739] Starting dynamic subtest: vecs0
[87.221376] Dynamic subtest vecs0: SUCCESS (0.040s)
[87.251853] Starting dynamic subtest: ccs0
[87.265596] Dynamic subtest ccs0: SUCCESS (0.061s)
[87.272579] Subtest basic-busy: SUCCESS (0.314s)
[89.275413] [022/162] (926s left) gem_exec_fence (basic-wait)
[89.868435] Starting subtest: basic-wait
[89.876149] Starting dynamic subtest: rcs0
[89.940131] Dynamic subtest rcs0: SUCCESS (0.071s)
[89.976703] Starting dynamic subtest: bcs0
[89.995421] Dynamic subtest bcs0: SUCCESS (0.054s)
[90.029151] Starting dynamic subtest: vcs0
[90.036233] Dynamic subtest vcs0: SUCCESS (0.037s)
[90.066711] Starting dynamic subtest: vcs1
[90.081182] Dynamic subtest vcs1: SUCCESS (0.047s)
[90.113272] Starting dynamic subtest: vecs0
[90.120117] Dynamic subtest vecs0: SUCCESS (0.035s)
[90.151727] Starting dynamic subtest: ccs0
[90.186489] Dynamic subtest ccs0: SUCCESS (0.068s)
[90.193335] Subtest basic-wait: SUCCESS (0.317s)
[92.205990] [023/162] (924s left) gem_exec_fence (basic-await)
[92.802515] Starting subtest: basic-await
[92.809601] Starting dynamic subtest: rcs0
[93.049257] Dynamic subtest rcs0: SUCCESS (0.245s)
[93.080183] Starting dynamic subtest: bcs0
[93.267983] Dynamic subtest bcs0: SUCCESS (0.218s)
[93.299894] Starting dynamic subtest: vcs0
[93.486384] Dynamic subtest vcs0: SUCCESS (0.218s)
[93.520553] Starting dynamic subtest: vcs1
[93.698886] Dynamic subtest vcs1: SUCCESS (0.212s)
[93.731132] Starting dynamic subtest: vecs0
[93.901870] Dynamic subtest vecs0: SUCCESS (0.202s)
[93.928235] Starting dynamic subtest: ccs0
[94.098811] Dynamic subtest ccs0: SUCCESS (0.196s)
[94.104756] Subtest basic-await: SUCCESS (1.296s)
[96.227965] [024/162] (920s left) gem_exec_fence (nb-await)
[96.832545] Starting subtest: nb-await
[96.839261] Starting dynamic subtest: rcs0
[96.924340] Dynamic subtest rcs0: SUCCESS (0.100s)
[96.956434] Starting dynamic subtest: bcs0
[96.998739] Dynamic subtest bcs0: SUCCESS (0.075s)
[97.032407] Starting dynamic subtest: vcs0
[97.079904] Dynamic subtest vcs0: SUCCESS (0.080s)
[97.114345] Starting dynamic subtest: vcs1
[97.158158] Dynamic subtest vcs1: SUCCESS (0.080s)
[97.189732] Starting dynamic subtest: vecs0
[97.238435] Dynamic subtest vecs0: SUCCESS (0.078s)
[97.270128] Starting dynamic subtest: ccs0
[97.321175] Dynamic subtest ccs0: SUCCESS (0.081s)
[97.327966] Subtest nb-await: SUCCESS (0.496s)
[99.226234] [025/162] (917s left) gem_exec_gttfill (basic)
[99.667536] Starting subtest: basic
[110.452628] Subtest basic: SUCCESS (10.776s)
[110.615348] [026/162] (905s left) gem_exec_parallel (engines)
[111.085296] Starting subtest: engines
[111.091961] Starting dynamic subtest: basic
[114.135973] Dynamic subtest basic: SUCCESS (3.041s)
[114.176946] Starting dynamic subtest: contexts
[120.279930] Dynamic subtest contexts: SUCCESS (6.141s)
[120.318167] Starting dynamic subtest: fds
[125.621214] Dynamic subtest fds: SUCCESS (5.342s)
[125.663239] Starting dynamic subtest: userptr
[130.128817] Dynamic subtest userptr: SUCCESS (4.509s)
[130.137808] Subtest engines: SUCCESS (19.038s)
[130.389622] [027/162] (886s left) gem_exec_store (basic)
[130.825858] Starting subtest: basic
[132.171410] Subtest basic: SUCCESS (1.334s)
[132.360486] [028/162] (884s left) gem_flink_basic (bad-flink)
[132.721948] Starting subtest: bad-flink
[132.728857] Subtest bad-flink: SUCCESS (0.000s)
[132.792924] [029/162] (883s left) gem_flink_basic (bad-open)
[133.170221] Starting subtest: bad-open
[133.177114] Subtest bad-open: SUCCESS (0.000s)
[133.240899] [030/162] (883s left) gem_flink_basic (basic)
[133.622175] Starting subtest: basic
[133.628981] Subtest basic: SUCCESS (0.000s)
[133.712962] [031/162] (883s left) gem_flink_basic (double-flink)
[134.097902] Starting subtest: double-flink
[134.104892] Subtest double-flink: SUCCESS (0.000s)
[134.187724] [032/162] (882s left) gem_flink_basic (flink-lifetime)
[134.566184] Starting subtest: flink-lifetime
[134.573139] Subtest flink-lifetime: SUCCESS (0.007s)
[134.662169] [033/162] (882s left) gem_huc_copy (huc-copy)
[135.067256] Starting subtest: huc-copy
[135.082549] Subtest huc-copy: SUCCESS (0.015s)
[136.203362] [034/162] (880s left) gem_linear_blits (basic)
[137.079732] Starting subtest: basic
[137.102579] Subtest basic: SUCCESS (0.031s)
[137.237552] [035/162] (879s left) gem_mmap (basic)
[137.749459] Subtest basic: SKIP (0.000s)
[137.814094] [036/162] (879s left) gem_mmap_gtt (basic)
[138.218578] Subtest basic: SKIP (0.000s)
[138.278734] [037/162] (879s left) gem_render_linear_blits (basic)
[138.686575] Starting subtest: basic
[138.842682] Subtest basic: SUCCESS (0.153s)
[138.952405] [038/162] (878s left) gem_render_tiled_blits (basic)
[139.375512] Subtest basic: SKIP (0.000s)
[139.446354] [039/162] (878s left) gem_ringfill (basic-all)
[145.180779] Starting subtest: basic-all
[146.480095] Subtest basic-all: SUCCESS (1.305s)
[147.226330] [040/162] (870s left) gem_softpin (allocator-basic)
[147.612648] Starting subtest: allocator-basic
[148.181708] Subtest allocator-basic: SUCCESS (0.560s)
[148.363231] [041/162] (869s left) gem_softpin (allocator-basic-reserve)
[148.768415] Starting subtest: allocator-basic-reserve
[149.318479] Subtest allocator-basic-reserve: SUCCESS (0.547s)
[149.467579] [042/162] (868s left) gem_softpin (safe-alignment)
[149.875228] Starting subtest: safe-alignment
[149.966577] Subtest safe-alignment: SUCCESS (0.091s)
[151.244950] [043/162] (866s left) gem_sync (basic-all)
[151.693510] Starting subtest: basic-all
[155.143573] Subtest basic-all: SUCCESS (3.452s)
[155.336289] [044/162] (862s left) gem_sync (basic-each)
[155.769723] Starting subtest: basic-each
[159.174978] Subtest basic-each: SUCCESS (3.408s)
[159.365506] [045/162] (858s left) gem_tiled_blits (basic)
[159.767476] Subtest basic: SKIP (0.000s)
[159.831941] [046/162] (858s left) gem_tiled_fence_blits (basic)
[160.224150] Subtest basic: SKIP (0.000s)
[160.269554] [047/162] (857s left) gem_tiled_pread_basic
[160.713329] [048/162] (857s left) gem_wait (busy@all-engines)
[161.170726] Starting subtest: busy
[161.177830] Starting dynamic subtest: all-engines
[163.142203] Dynamic subtest all-engines: SUCCESS (1.963s)
[163.148977] Subtest busy: SUCCESS (1.964s)
[163.412941] [049/162] (854s left) gem_wait (wait@all-engines)
[163.867677] Starting subtest: wait
[163.874672] Starting dynamic subtest: all-engines
[165.189843] Dynamic subtest all-engines: SUCCESS (1.313s)
[165.196592] Subtest wait: SUCCESS (1.315s)
[165.458861] [050/162] (852s left) i915_getparams_basic (basic-eu-total)
[165.833957] Starting subtest: basic-eu-total
[165.847130] Subtest basic-eu-total: SUCCESS (0.000s)
[165.906118] [051/162] (852s left) i915_getparams_basic (basic-subslice-total)
[166.287801] Starting subtest: basic-subslice-total
[166.300674] Subtest basic-subslice-total: SUCCESS (0.000s)
[166.358689] [052/162] (852s left) i915_hangman (error-state-basic)
[166.785279] Starting subtest: error-state-basic
[167.841529] Subtest error-state-basic: SUCCESS (1.053s)
[167.933421] [053/162] (850s left) i915_pciid
[168.374303] [054/162] (850s left) kms_addfb_basic (addfb25-bad-modifier)
[168.764175] Starting subtest: addfb25-bad-modifier
[168.770979] Subtest addfb25-bad-modifier: SUCCESS (0.001s)
[168.990857] [055/162] (849s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[169.390064] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[169.623915] [056/162] (849s left) kms_addfb_basic (addfb25-modifier-no-flag)
[170.012226] Starting subtest: addfb25-modifier-no-flag
[170.018876] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[170.224597] [057/162] (848s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[170.606999] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[170.826236] [058/162] (848s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[171.227318] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[171.446144] [059/162] (847s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[171.961118] Starting subtest: addfb25-yf-tiled-legacy
[171.967864] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.001s)
[172.067126] [060/162] (847s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[172.575643] Starting subtest: addfb25-y-tiled-legacy
[172.582538] Subtest addfb25-y-tiled-legacy: SUCCESS (0.001s)
[172.678511] [061/162] (846s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[173.187170] Starting subtest: addfb25-y-tiled-small-legacy
[173.200666] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[173.291211] [062/162] (846s left) kms_addfb_basic (bad-pitch-0)
[173.664697] Starting subtest: bad-pitch-0
[173.671415] Subtest bad-pitch-0: SUCCESS (0.000s)
[173.904685] [063/162] (845s left) kms_addfb_basic (bad-pitch-1024)
[174.290512] Starting subtest: bad-pitch-1024
[174.297498] Subtest bad-pitch-1024: SUCCESS (0.000s)
[174.529111] [064/162] (845s left) kms_addfb_basic (bad-pitch-128)
[174.909462] Starting subtest: bad-pitch-128
[174.916372] Subtest bad-pitch-128: SUCCESS (0.000s)
[175.141655] [065/162] (844s left) kms_addfb_basic (bad-pitch-256)
[175.532167] Starting subtest: bad-pitch-256
[175.539135] Subtest bad-pitch-256: SUCCESS (0.000s)
[175.768549] [066/162] (843s left) kms_addfb_basic (bad-pitch-32)
[176.151396] Starting subtest: bad-pitch-32
[176.158557] Subtest bad-pitch-32: SUCCESS (0.000s)
[176.378140] [067/162] (843s left) kms_addfb_basic (bad-pitch-63)
[176.754668] Starting subtest: bad-pitch-63
[176.761595] Subtest bad-pitch-63: SUCCESS (0.000s)
[176.997606] [068/162] (842s left) kms_addfb_basic (bad-pitch-65536)
[177.379093] Starting subtest: bad-pitch-65536
[177.386113] Subtest bad-pitch-65536: SUCCESS (0.001s)
[177.616158] [069/162] (842s left) kms_addfb_basic (bad-pitch-999)
[177.991459] Starting subtest: bad-pitch-999
[177.998346] Subtest bad-pitch-999: SUCCESS (0.000s)
[178.219472] [070/162] (841s left) kms_addfb_basic (basic)
[178.600525] Starting subtest: basic
[178.607354] Subtest basic: SUCCESS (0.000s)
[178.846629] [071/162] (841s left) kms_addfb_basic (basic-x-tiled-legacy)
[179.232447] Starting subtest: basic-x-tiled-legacy
[179.246730] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[179.469717] [072/162] (840s left) kms_addfb_basic (basic-y-tiled-legacy)
[179.859224] Starting subtest: basic-y-tiled-legacy
[179.872812] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[180.098752] [073/162] (840s left) kms_addfb_basic (bo-too-small)
[180.623188] Starting subtest: bo-too-small
[180.632160] Subtest bo-too-small: SUCCESS (0.001s)
[180.713533] [074/162] (839s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[181.230224] Starting subtest: bo-too-small-due-to-tiling
[181.246760] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[181.346549] [075/162] (839s left) kms_addfb_basic (clobberred-modifier)
[181.733771] Starting subtest: clobberred-modifier
[181.746994] Subtest clobberred-modifier: SKIP (0.000s)
[181.987264] [076/162] (838s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[182.374114] Starting subtest: framebuffer-vs-set-tiling
[182.387192] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[182.601925] [077/162] (838s left) kms_addfb_basic (invalid-get-prop)
[182.974697] Starting subtest: invalid-get-prop
[182.981562] Subtest invalid-get-prop: SUCCESS (0.000s)
[183.217182] [078/162] (837s left) kms_addfb_basic (invalid-get-prop-any)
[183.597774] Starting subtest: invalid-get-prop-any
[183.604603] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[183.832612] [079/162] (837s left) kms_addfb_basic (invalid-set-prop)
[184.206283] Starting subtest: invalid-set-prop
[184.213745] Subtest invalid-set-prop: SUCCESS (0.000s)
[184.442670] [080/162] (836s left) kms_addfb_basic (invalid-set-prop-any)
[184.820234] Starting subtest: invalid-set-prop-any
[184.827689] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[185.084374] [081/162] (835s left) kms_addfb_basic (no-handle)
[185.458450] Starting subtest: no-handle
[185.465264] Subtest no-handle: SUCCESS (0.000s)
[185.687503] [082/162] (835s left) kms_addfb_basic (size-max)
[186.195261] Starting subtest: size-max
[186.201957] Subtest size-max: SUCCESS (0.000s)
[186.306414] [083/162] (834s left) kms_addfb_basic (small-bo)
[186.804366] Starting subtest: small-bo
[186.811367] Subtest small-bo: SUCCESS (0.000s)
[186.903830] [084/162] (834s left) kms_addfb_basic (tile-pitch-mismatch)
[187.283553] Starting subtest: tile-pitch-mismatch
[187.297307] Subtest tile-pitch-mismatch: SKIP (0.000s)
[187.506639] [085/162] (833s left) kms_addfb_basic (too-high)
[188.016327] Starting subtest: too-high
[188.023341] Subtest too-high: SUCCESS (0.003s)
[188.123821] [086/162] (833s left) kms_addfb_basic (too-wide)
[188.631145] Starting subtest: too-wide
[188.637941] Subtest too-wide: SUCCESS (0.000s)
[188.728507] [087/162] (832s left) kms_addfb_basic (unused-handle)
[189.108176] Starting subtest: unused-handle
[189.114895] Subtest unused-handle: SUCCESS (0.000s)
[189.352683] [088/162] (832s left) kms_addfb_basic (unused-modifier)
[189.736388] Starting subtest: unused-modifier
[189.743679] Subtest unused-modifier: SUCCESS (0.000s)
[189.960775] [089/162] (831s left) kms_addfb_basic (unused-offsets)
[190.342180] Starting subtest: unused-offsets
[190.349177] Subtest unused-offsets: SUCCESS (0.000s)
[190.596692] [090/162] (831s left) kms_addfb_basic (unused-pitches)
[190.967605] Starting subtest: unused-pitches
[190.974524] Subtest unused-pitches: SUCCESS (0.000s)
[191.208794] [091/162] (830s left) kms_busy (basic)
[191.735498] Subtest basic: SKIP (0.000s)
[191.804806] [092/162] (830s left) kms_prop_blob (basic)
[192.180813] Starting subtest: basic
[192.187677] Subtest basic: SUCCESS (0.000s)
[192.254452] [093/162] (829s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[192.797387] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[192.870697] [094/162] (829s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[193.426281] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[193.492295] [095/162] (828s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[194.041908] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[194.107702] [096/162] (828s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[194.649696] Subtest basic-flip-after-cursor-legacy: SKIP (0.000s)
[194.724298] [097/162] (827s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[195.279962] Subtest basic-flip-after-cursor-varying-size: SKIP (0.000s)
[195.356663] [098/162] (827s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[195.902361] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[195.967934] [099/162] (826s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[196.519843] Subtest basic-flip-before-cursor-legacy: SKIP (0.000s)
[196.592280] [100/162] (826s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[197.143073] Subtest basic-flip-before-cursor-varying-size: SKIP (0.000s)
[197.220905] [101/162] (825s left) kms_flip (basic-flip-vs-dpms)
[197.635666] Starting subtest: basic-flip-vs-dpms
[197.660445] Subtest basic-flip-vs-dpms: SKIP (0.025s)
[197.793401] [102/162] (825s left) kms_flip (basic-flip-vs-modeset)
[198.199143] Starting subtest: basic-flip-vs-modeset
[198.223129] Subtest basic-flip-vs-modeset: SKIP (0.025s)
[198.349663] [103/162] (824s left) kms_flip (basic-flip-vs-wf_vblank)
[198.767163] Starting subtest: basic-flip-vs-wf_vblank
[198.788570] Subtest basic-flip-vs-wf_vblank: SKIP (0.025s)
[198.912932] [104/162] (824s left) kms_flip (basic-plain-flip)
[199.325631] Starting subtest: basic-plain-flip
[199.349953] Subtest basic-plain-flip: SKIP (0.025s)
[199.481604] [105/162] (823s left) kms_force_connector_basic (force-connector-state)
[199.880566] Starting subtest: force-connector-state
[201.959439] Subtest force-connector-state: SUCCESS (2.078s)
[202.489469] [106/162] (820s left) kms_force_connector_basic (force-edid)
[202.852837] Starting subtest: force-edid
[203.157104] Subtest force-edid: SUCCESS (0.308s)
[203.364944] [107/162] (819s left) kms_force_connector_basic (force-load-detect)
[203.757400] Starting subtest: force-load-detect
[203.771309] Subtest force-load-detect: SKIP (0.000s)
[203.933092] [108/162] (819s left) kms_force_connector_basic (prune-stale-modes)
[204.327162] Starting subtest: prune-stale-modes
[204.555562] Subtest prune-stale-modes: SKIP (0.220s)
[204.761640] [109/162] (818s left) kms_frontbuffer_tracking (basic)
[205.286389] Subtest basic: SKIP (0.000s)
[205.399799] [110/162] (818s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[205.919231] Subtest compare-crc-sanitycheck-xr24: SKIP (0.000s)
[206.017742] [111/162] (817s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[206.538280] Subtest compare-crc-sanitycheck-nv12: SKIP (0.000s)
[206.638503] [112/162] (817s left) kms_pipe_crc_basic (hang-read-crc)
[207.149361] Subtest hang-read-crc: SKIP (0.000s)
[207.250650] [113/162] (816s left) kms_pipe_crc_basic (nonblocking-crc)
[207.763407] Subtest nonblocking-crc: SKIP (0.000s)
[207.864630] [114/162] (816s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[208.364808] Subtest nonblocking-crc-frame-sequence: SKIP (0.000s)
[208.465111] [115/162] (815s left) kms_pipe_crc_basic (read-crc)
[208.964280] Subtest read-crc: SKIP (0.000s)
[209.069451] [116/162] (815s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[209.589730] Subtest read-crc-frame-sequence: SKIP (0.000s)
[209.694896] [117/162] (814s left) kms_psr (primary_page_flip)
[210.081274] Subtest primary_page_flip: SKIP (0.000s)
[210.177644] [118/162] (814s left) kms_psr (cursor_plane_move)
[210.566214] Subtest cursor_plane_move: SKIP (0.000s)
[210.666360] [119/162] (813s left) kms_psr (sprite_plane_onoff)
[211.051578] Subtest sprite_plane_onoff: SKIP (0.000s)
[211.146571] [120/162] (813s left) kms_psr (primary_mmap_gtt)
[211.528500] Subtest primary_mmap_gtt: SKIP (0.000s)
[211.624350] [121/162] (812s left) kms_setmode (basic-clone-single-crtc)
[212.008748] Starting subtest: basic-clone-single-crtc
[212.031081] Subtest basic-clone-single-crtc: SKIP (0.002s)
[212.140459] [122/162] (812s left) i915_pm_backlight (basic-brightness)
[212.628818] Subtest basic-brightness: SKIP (0.000s)
[212.728610] [123/162] (811s left) i915_pm_rpm (basic-pci-d3-state)
[215.104129] Starting subtest: basic-pci-d3-state
[216.770666] Subtest basic-pci-d3-state: SUCCESS (1.665s)
[216.905193] [124/162] (807s left) i915_pm_rpm (basic-rte)
[217.281582] Starting subtest: basic-rte
[220.044815] Subtest basic-rte: SUCCESS (2.766s)
[220.808114] [125/162] (804s left) i915_pm_rps (basic-api)
[221.217064] Starting subtest: basic-api
[221.230621] Subtest basic-api: SKIP (0.001s)
[221.383664] [126/162] (803s left) prime_self_import (basic-llseek-bad)
[221.751254] Starting subtest: basic-llseek-bad
[221.765164] Subtest basic-llseek-bad: SUCCESS (0.009s)
[221.912273] [127/162] (803s left) prime_self_import (basic-llseek-size)
[222.297270] Starting subtest: basic-llseek-size
[222.310979] Subtest basic-llseek-size: SUCCESS (0.011s)
[222.451772] [128/162] (802s left) prime_self_import (basic-with_fd_dup)
[222.829095] Starting subtest: basic-with_fd_dup
[222.842297] Subtest basic-with_fd_dup: SUCCESS (0.014s)
[222.975451] [129/162] (802s left) prime_self_import (basic-with_one_bo)
[223.343782] Starting subtest: basic-with_one_bo
[223.358274] Subtest basic-with_one_bo: SUCCESS (0.013s)
[223.447418] [130/162] (801s left) prime_self_import (basic-with_one_bo_two_files)
[223.824660] Starting subtest: basic-with_one_bo_two_files
[223.838300] Subtest basic-with_one_bo_two_files: SUCCESS (0.013s)
[223.972553] [131/162] (801s left) prime_self_import (basic-with_two_bos)
[224.351886] Starting subtest: basic-with_two_bos
[224.365470] Subtest basic-with_two_bos: SUCCESS (0.015s)
[224.508050] [132/162] (801s left) prime_vgem (basic-fence-flip)
[224.947580] Starting subtest: basic-fence-flip
[225.076941] Subtest basic-fence-flip: SKIP (0.119s)
[225.197773] [133/162] (800s left) prime_vgem (basic-fence-mmap)
[225.629887] Starting subtest: basic-fence-mmap
[225.643428] Subtest basic-fence-mmap: SKIP (0.000s)
[225.781640] [134/162] (799s left) prime_vgem (basic-fence-read)
[226.220223] Starting subtest: basic-fence-read
[226.258058] Subtest basic-fence-read: SKIP (0.030s)
[226.399179] [135/162] (799s left) prime_vgem (basic-gtt)
[226.838702] Starting subtest: basic-gtt
[226.856798] Subtest basic-gtt: SKIP (0.000s)
[226.992466] [136/162] (798s left) prime_vgem (basic-read)
[227.420300] Starting subtest: basic-read
[227.455581] Subtest basic-read: SKIP (0.025s)
[227.591226] [137/162] (798s left) prime_vgem (basic-write)
[228.021279] Starting subtest: basic-write
[228.056394] Subtest basic-write: SKIP (0.026s)
[228.187423] [138/162] (797s left) vgem_basic (setversion)
[228.597158] Starting subtest: setversion
[228.611701] Subtest setversion: SUCCESS (0.000s)
[228.696149] [139/162] (797s left) vgem_basic (create)
[229.101193] Starting subtest: create
[229.108096] Subtest create: SUCCESS (0.001s)
[229.210308] [140/162] (797s left) vgem_basic (debugfs)
[229.610358] Starting subtest: debugfs
[229.617756] Subtest debugfs: SUCCESS (0.002s)
[229.721947] [141/162] (796s left) vgem_basic (dmabuf-export)
[230.121734] Starting subtest: dmabuf-export
[230.148389] Subtest dmabuf-export: SUCCESS (0.022s)
[230.287491] [142/162] (796s left) vgem_basic (dmabuf-fence)
[230.693961] Starting subtest: dmabuf-fence
[230.701069] Subtest dmabuf-fence: SUCCESS (0.003s)
[230.799885] [143/162] (795s left) vgem_basic (dmabuf-fence-before)
[231.194676] Starting subtest: dmabuf-fence-before
[231.201469] Subtest dmabuf-fence-before: SUCCESS (0.002s)
[231.300382] [144/162] (795s left) vgem_basic (dmabuf-mmap)
[231.710265] Starting subtest: dmabuf-mmap
[231.748613] Subtest dmabuf-mmap: SUCCESS (0.049s)
[231.863493] [145/162] (794s left) vgem_basic (mmap)
[232.267498] Starting subtest: mmap
[232.289742] Subtest mmap: SUCCESS (0.033s)
[232.403625] [146/162] (794s left) vgem_basic (second-client)
[232.807674] Starting subtest: second-client
[232.844568] Subtest second-client: SUCCESS (0.034s)
[232.949818] [147/162] (793s left) vgem_basic (sysfs)
[233.343764] Starting subtest: sysfs
[233.350894] Subtest sysfs: SUCCESS (0.002s)
[233.447699] [148/162] (793s left) core_hotunplug (unbind-rebind)
[233.952334] Starting subtest: unbind-rebind
[240.076609] Subtest unbind-rebind: SUCCESS (6.123s)
[240.173944] [149/162] (786s left) vgem_basic (unload)
[240.562508] Starting subtest: unload
[269.598214] Subtest unload: SUCCESS (29.033s)
[269.748909] [150/162] (757s left) i915_module_load (reload)
[270.121760] Starting subtest: reload
[276.582090] Subtest reload: SUCCESS (6.471s)
[276.645475] [151/162] (750s left) gem_lmem_swapping (basic)
[276.945666] Subtest basic: SKIP (0.000s)
[277.019593] [152/162] (750s left) gem_lmem_swapping (parallel-random-engines)
[277.420601] Subtest parallel-random-engines: SKIP (0.000s)
[277.494132] [153/162] (749s left) gem_lmem_swapping (random-engines)
[277.891117] Subtest random-engines: SKIP (0.000s)
[277.961416] [154/162] (749s left) gem_lmem_swapping (verify-random)
[278.367588] Subtest verify-random: SKIP (0.000s)
[278.444231] [155/162] (749s left) i915_pm_rpm (module-reload)
[280.766871] Starting subtest: module-reload
[295.563435] Subtest module-reload: SUCCESS (14.787s)
[295.625146] [156/162] (732s left) i915_selftest (live)
[296.014846] Starting subtest: live
[296.021976] Starting dynamic subtest: sanitycheck
[300.197183] Dynamic subtest sanitycheck: SUCCESS (4.174s)
[300.229776] Starting dynamic subtest: uncore
[304.273935] Dynamic subtest uncore: SUCCESS (4.076s)
[304.306887] Starting dynamic subtest: workarounds
[309.717916] Dynamic subtest workarounds: SUCCESS (5.443s)
[309.751066] Starting dynamic subtest: gt_engines
[314.336073] Dynamic subtest gt_engines: SUCCESS (4.617s)
[314.368649] Starting dynamic subtest: gt_timelines
[334.844330] Dynamic subtest gt_timelines: SUCCESS (20.503s)
[334.886468] Starting dynamic subtest: gt_contexts
[338.866569] Dynamic subtest gt_contexts: SUCCESS (4.020s)
[338.900813] Starting dynamic subtest: gt_lrc
[345.326734] Dynamic subtest gt_lrc: SUCCESS (6.459s)
[345.359585] Starting dynamic subtest: gt_mocs
[364.944406] Dynamic subtest gt_mocs: FAIL (18.584s)
[364.975527] Starting dynamic subtest: gt_pm
[368.882229] Dynamic subtest gt_pm: SUCCESS (4.969s)
[368.915529] Starting dynamic subtest: gt_heartbeat
[373.106125] Dynamic subtest gt_heartbeat: SUCCESS (4.222s)
[373.137824] Starting dynamic subtest: gt_tlb
[379.403761] Dynamic subtest gt_tlb: SUCCESS (6.296s)
[379.436765] Starting dynamic subtest: requests
[419.063837] Dynamic subtest requests: FAIL (38.916s)
[419.103851] Starting dynamic subtest: migrate
[427.452397] Dynamic subtest migrate: SUCCESS (9.127s)
[427.485505] Starting dynamic subtest: active
[431.566743] Dynamic subtest active: SUCCESS (4.111s)
[431.598535] Starting dynamic subtest: objects
[439.004165] Dynamic subtest objects: SUCCESS (7.434s)
[439.037643] Starting dynamic subtest: mman
[447.886123] Dynamic subtest mman: SUCCESS (8.877s)
[447.919648] Starting dynamic subtest: dmabuf
[452.125808] Dynamic subtest dmabuf: SUCCESS (4.237s)
[452.159566] Starting dynamic subtest: vma
[456.164762] Dynamic subtest vma: SUCCESS (4.034s)
[456.198526] Starting dynamic subtest: coherency
[463.748199] Dynamic subtest coherency: SUCCESS (7.584s)
[463.780970] Starting dynamic subtest: gtt
[476.316278] Dynamic subtest gtt: SUCCESS (12.564s)
[476.349807] Starting dynamic subtest: gem
[484.614948] Dynamic subtest gem: SUCCESS (8.297s)
[484.649866] Starting dynamic subtest: evict
[492.252134] Dynamic subtest evict: SUCCESS (7.635s)
[492.285849] Starting dynamic subtest: hugepages
[503.187239] Dynamic subtest hugepages: SUCCESS (10.932s)
[503.221301] Starting dynamic subtest: gem_contexts
[551.325056] Dynamic subtest gem_contexts: SUCCESS (48.132s)
[551.358842] Starting dynamic subtest: client
[555.419075] Dynamic subtest client: SUCCESS (4.092s)
[555.453183] Starting dynamic subtest: gem_migrate
[559.515182] Dynamic subtest gem_migrate: SUCCESS (4.092s)
[559.550123] Starting dynamic subtest: reset
[563.765442] Dynamic subtest reset: SUCCESS (4.243s)
[563.802145] Starting dynamic subtest: memory_region
[567.775268] Dynamic subtest memory_region: SUCCESS (4.012s)
[567.810535] Starting dynamic subtest: hangcheck
[586.750330] Dynamic subtest hangcheck: SUCCESS (18.965s)
[586.787312] Starting dynamic subtest: execlists
[590.919227] Dynamic subtest execlists: SUCCESS (4.165s)
[590.957702] Starting dynamic subtest: ring_submission
[595.110127] Dynamic subtest ring_submission: SUCCESS (4.190s)
[595.146302] Starting dynamic subtest: perf
[599.458165] Dynamic subtest perf: SUCCESS (4.344s)
[599.499195] Starting dynamic subtest: slpc
[615.450862] Dynamic subtest slpc: SUCCESS (15.989s)
[615.485264] Starting dynamic subtest: guc
[621.906519] Dynamic subtest guc: SUCCESS (6.448s)
[621.943130] Starting dynamic subtest: guc_multi_lrc
[626.081214] Dynamic subtest guc_multi_lrc: SUCCESS (4.171s)
[626.118788] Starting dynamic subtest: guc_hang
[630.997323] Dynamic subtest guc_hang: SUCCESS (4.915s)
[631.035192] Starting dynamic subtest: late_gt_pm
[635.259305] Dynamic subtest late_gt_pm: SUCCESS (4.258s)
[635.266165] Subtest live: FAIL (339.237s)
[635.535837] [157/162] (392s left) dmabuf (all-tests)
[635.915506] Starting subtest: all-tests
[635.922236] Starting dynamic subtest: sanitycheck
[635.995383] Dynamic subtest sanitycheck: SUCCESS (0.075s)
[636.035257] Starting dynamic subtest: dma_fence
[636.194515] Dynamic subtest dma_fence: SUCCESS (0.198s)
[636.220931] Starting dynamic subtest: dma_fence_chain
[647.652578] Dynamic subtest dma_fence_chain: SUCCESS (11.446s)
[647.686888] Starting dynamic subtest: dma_fence_unwrap
[647.735713] Dynamic subtest dma_fence_unwrap: SUCCESS (0.091s)
[647.761958] Starting dynamic subtest: dma_resv
[647.844828] Dynamic subtest dma_resv: SUCCESS (0.106s)
[647.854524] Subtest all-tests: SUCCESS (11.931s)
[647.924122] [158/162] (379s left) i915_suspend (basic-s2idle-without-i915)
[648.308318] Starting subtest: basic-s2idle-without-i915
[673.205764] Subtest basic-s2idle-without-i915: SUCCESS (24.896s)
[674.305144] [159/162] (354s left) i915_suspend (basic-s3-without-i915)
[674.683506] Starting subtest: basic-s3-without-i915
[676.950690] Subtest basic-s3-without-i915: SKIP (2.248s)
[679.823619] [160/162] (349s left) gem_exec_suspend (basic-s0)
[680.174292] Starting subtest: basic-S0
[680.181209] Starting dynamic subtest: smem
[707.142699] Dynamic subtest smem: SUCCESS (26.958s)
[707.149519] Subtest basic-S0: SUCCESS (26.961s)
[708.364482] [161/162] (321s left) gem_exec_suspend (basic-s3)
[708.799429] Starting subtest: basic-S3
[708.806214] Starting dynamic subtest: smem
[735.175803] Dynamic subtest smem: SUCCESS (26.367s)
[735.184400] Subtest basic-S3: SUCCESS (26.372s)
[735.374448] [162/162] (294s left) kms_pipe_crc_basic (suspend-read-crc)
[735.913621] Subtest suspend-read-crc: SKIP (0.000s)
[735.984148] Closing watchdogs
Done.