[83.316606] Initializing watchdogs
[83.317210]   /dev/watchdog0
[83.339526] [001/165] (960s left) i915_module_load (load)
[83.789645] Starting subtest: load
[87.986360] Subtest load: SUCCESS (4.197s)
[88.141220] [002/165] (955s left) core_auth (basic-auth)
[89.127485] Starting subtest: basic-auth
[89.135139] Subtest basic-auth: SUCCESS (0.007s)
[89.298883] [003/165] (954s left) debugfs_test (read_all_entries)
[89.756602] Starting subtest: read_all_entries
[89.908731] Subtest read_all_entries: SUCCESS (0.152s)
[90.073717] [004/165] (954s left) debugfs_test (basic-hwmon)
[90.488476] Starting subtest: basic-hwmon
[90.496771] Subtest basic-hwmon: SKIP (0.000s)
[90.659440] [005/165] (953s left) fbdev (eof)
[91.070144] Starting subtest: eof
[91.074674] Subtest eof: SUCCESS (0.003s)
[91.207893] [006/165] (953s left) fbdev (info)
[91.640873] Starting subtest: info
[91.648188] Subtest info: SUCCESS (0.000s)
[91.776539] [007/165] (952s left) fbdev (nullptr)
[92.184344] Starting subtest: nullptr
[92.188886] Subtest nullptr: SUCCESS (0.000s)
[92.308599] [008/165] (952s left) fbdev (read)
[92.817462] Starting subtest: read
[93.147842] Subtest read: SUCCESS (0.330s)
[93.262593] [009/165] (951s left) fbdev (write)
[93.684155] Starting subtest: write
[93.882518] Subtest write: SUCCESS (0.198s)
[94.001437] [010/165] (950s left) gem_basic (bad-close)
[94.434677] Starting subtest: bad-close
[94.441246] Subtest bad-close: SUCCESS (0.000s)
[94.559362] [011/165] (950s left) gem_basic (create-close)
[94.979490] Starting subtest: create-close
[94.986102] Subtest create-close: SUCCESS (0.001s)
[95.121745] [012/165] (949s left) gem_basic (create-fd-close)
[95.539163] Starting subtest: create-fd-close
[95.545708] Subtest create-fd-close: SUCCESS (0.001s)
[95.673218] [013/165] (949s left) gem_busy (busy@all-engines)
[96.141253] Starting subtest: busy
[96.145858] Starting dynamic subtest: all-engines
[96.254236] Dynamic subtest all-engines: SUCCESS (0.113s)
[96.257507] Subtest busy: SUCCESS (0.116s)
[96.759851] [014/165] (948s left) gem_close_race (basic-process)
[97.254109] Starting subtest: basic-process
[97.456375] Subtest basic-process: SUCCESS (0.204s)
[97.731522] [015/165] (947s left) gem_close_race (basic-threads)
[98.195651] Starting subtest: basic-threads
[99.592100] Subtest basic-threads: SUCCESS (1.397s)
[99.860517] [016/165] (945s left) gem_ctx_create (basic)
[100.278395] Subtest basic: SKIP (0.000s)
[100.381805] [017/165] (944s left) gem_ctx_create (basic-files)
[100.790964] Subtest basic-files: SKIP (0.000s)
[100.881557] [018/165] (944s left) gem_ctx_exec (basic)
[101.283319] Subtest basic: SKIP (0.000s)
[101.398269] [019/165] (944s left) gem_exec_basic (basic)
[101.835899] Starting subtest: basic
[101.839549] Starting dynamic subtest: rcs0-smem
[101.842790] Dynamic subtest rcs0-smem: SUCCESS (0.002s)
[101.846255] Subtest basic: SUCCESS (0.005s)
[102.121769] [020/165] (943s left) gem_exec_create (basic)
[102.595682] Starting subtest: basic
[102.601277] Starting dynamic subtest: smem
[104.724963] Dynamic subtest smem: SUCCESS (2.130s)
[104.728487] Subtest basic: SUCCESS (2.132s)
[104.993764] [021/165] (940s left) gem_exec_fence (basic-busy)
[105.661510] Starting subtest: basic-busy
[105.665635] Starting dynamic subtest: rcs0
[105.698901] Dynamic subtest rcs0: SUCCESS (0.037s)
[105.702954] Subtest basic-busy: SUCCESS (0.040s)
[106.576660] [022/165] (939s left) gem_exec_fence (basic-wait)
[107.213413] Starting subtest: basic-wait
[107.217886] Starting dynamic subtest: rcs0
[107.247317] Dynamic subtest rcs0: SUCCESS (0.033s)
[107.250882] Subtest basic-wait: SUCCESS (0.035s)
[107.945838] [023/165] (937s left) gem_exec_fence (basic-await)
[108.591145] Starting subtest: basic-await
[108.595487] Starting dynamic subtest: rcs0
[108.699793] Dynamic subtest rcs0: SUCCESS (0.110s)
[108.703529] Subtest basic-await: SUCCESS (0.113s)
[109.394892] [024/165] (936s left) gem_exec_fence (nb-await)
[110.047597] Starting subtest: nb-await
[110.051895] Starting dynamic subtest: rcs0
[110.108657] Dynamic subtest rcs0: SUCCESS (0.063s)
[110.111658] Subtest nb-await: SUCCESS (0.065s)
[110.795306] [025/165] (935s left) gem_exec_gttfill (basic)
[111.266836] Starting subtest: basic
[124.122299] Subtest basic: SUCCESS (12.861s)
[124.451596] [026/165] (921s left) gem_exec_parallel (engines)
[125.356526] Starting subtest: engines
[125.362573] Starting dynamic subtest: basic
[129.007604] Dynamic subtest basic: SUCCESS (3.658s)
[129.054519] Starting dynamic subtest: contexts
[129.062277] Dynamic subtest contexts: SKIP (0.004s)
[129.098138] Starting dynamic subtest: fds
[129.103542] Dynamic subtest fds: SKIP (0.002s)
[129.137112] Starting dynamic subtest: userptr
[132.806499] Dynamic subtest userptr: SUCCESS (3.789s)
[132.810723] Subtest engines: SUCCESS (7.460s)
[133.122352] [027/165] (913s left) gem_exec_store (basic)
[133.634737] Starting subtest: basic
[133.680769] Subtest basic: SUCCESS (0.051s)
[133.979736] [028/165] (912s left) gem_flink_basic (bad-flink)
[134.407587] Starting subtest: bad-flink
[134.412915] Subtest bad-flink: SUCCESS (0.000s)
[134.556138] [029/165] (911s left) gem_flink_basic (bad-open)
[134.958113] Starting subtest: bad-open
[134.961659] Subtest bad-open: SUCCESS (0.000s)
[135.091195] [030/165] (911s left) gem_flink_basic (basic)
[135.493494] Starting subtest: basic
[135.497884] Subtest basic: SUCCESS (0.000s)
[135.634226] [031/165] (910s left) gem_flink_basic (double-flink)
[136.037597] Starting subtest: double-flink
[136.042390] Subtest double-flink: SUCCESS (0.001s)
[136.184903] [032/165] (910s left) gem_flink_basic (flink-lifetime)
[136.576248] Starting subtest: flink-lifetime
[136.582099] Subtest flink-lifetime: SUCCESS (0.006s)
[136.735437] [033/165] (909s left) gem_huc_copy (huc-copy)
[137.154631] Subtest huc-copy: SKIP (0.000s)
[137.265364] [034/165] (909s left) gem_linear_blits (basic)
[138.132688] Starting subtest: basic
[138.193264] Subtest basic: SUCCESS (0.058s)
[138.421261] [035/165] (908s left) gem_mmap (basic)
[139.106340] Starting subtest: basic
[139.122553] Subtest basic: SUCCESS (0.003s)
[139.252335] [036/165] (907s left) gem_mmap_gtt (basic)
[139.662258] Starting subtest: basic
[139.666754] Subtest basic: SUCCESS (0.003s)
[139.791553] [037/165] (907s left) gem_render_linear_blits (basic)
[140.207556] Starting subtest: basic
[140.335374] Subtest basic: SUCCESS (0.126s)
[140.456954] [038/165] (906s left) gem_render_tiled_blits (basic)
[140.873337] Starting subtest: basic
[141.011530] Subtest basic: SUCCESS (0.135s)
[141.145904] [039/165] (906s left) gem_ringfill (basic-all)
[141.604519] Starting subtest: basic-all
[142.795113] Subtest basic-all: SUCCESS (1.189s)
[142.938476] [040/165] (904s left) gem_softpin (allocator-basic)
[143.347648] Subtest allocator-basic: SKIP (0.000s)
[143.469133] [041/165] (903s left) gem_softpin (allocator-basic-reserve)
[143.875735] Subtest allocator-basic-reserve: SKIP (0.000s)
[144.001320] [042/165] (903s left) gem_softpin (safe-alignment)
[144.426591] Starting subtest: safe-alignment
[144.451647] Subtest safe-alignment: SUCCESS (0.031s)
[144.603580] [043/165] (902s left) gem_sync (basic-all)
[145.073316] Starting subtest: basic-all
[147.388279] Subtest basic-all: SUCCESS (2.315s)
[147.672953] [044/165] (899s left) gem_sync (basic-each)
[148.130333] Starting subtest: basic-each
[150.422444] Subtest basic-each: SUCCESS (2.293s)
[150.703896] [045/165] (896s left) gem_tiled_blits (basic)
[151.392602] Starting subtest: basic
[151.487584] Subtest basic: SUCCESS (0.092s)
[151.708197] [046/165] (896s left) gem_tiled_fence_blits (basic)
[152.696649] Starting subtest: basic
[152.769620] Subtest basic: SUCCESS (0.073s)
[152.988549] [047/165] (894s left) gem_tiled_pread_basic
[155.672739] [048/165] (892s left) gem_wait (busy@all-engines)
[156.174589] Starting subtest: busy
[156.178959] Starting dynamic subtest: all-engines
[156.706537] Dynamic subtest all-engines: SUCCESS (0.532s)
[156.710712] Subtest busy: SUCCESS (0.535s)
[157.106703] [049/165] (890s left) gem_wait (wait@all-engines)
[157.605627] Starting subtest: wait
[157.610275] Starting dynamic subtest: all-engines
[158.647116] Dynamic subtest all-engines: SUCCESS (1.043s)
[158.651933] Subtest wait: SUCCESS (1.045s)
[159.057302] [050/165] (889s left) i915_getparams_basic (basic-eu-total)
[159.463609] Starting subtest: basic-eu-total
[159.470432] Subtest basic-eu-total: SUCCESS (0.000s)
[159.587551] [051/165] (888s left) i915_getparams_basic (basic-subslice-total)
[159.992239] Starting subtest: basic-subslice-total
[159.999620] Subtest basic-subslice-total: SUCCESS (0.000s)
[160.120459] [052/165] (888s left) i915_hangman (error-state-basic)
[160.548303] Starting subtest: error-state-basic
[160.889386] Subtest error-state-basic: SUCCESS (0.337s)
[161.007174] [053/165] (887s left) i915_pciid
[161.559208] [054/165] (886s left) kms_addfb_basic (addfb25-4-tiled)
[162.042836] Starting subtest: addfb25-4-tiled
[162.046567] Subtest addfb25-4-tiled: SUCCESS (0.001s)
[162.193790] [055/165] (886s left) kms_addfb_basic (addfb25-bad-modifier)
[162.607705] Starting subtest: addfb25-bad-modifier
[162.610864] Subtest addfb25-bad-modifier: SUCCESS (0.002s)
[162.845940] [056/165] (885s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[163.251193] Starting subtest: addfb25-framebuffer-vs-set-tiling
[163.254703] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s)
[163.488424] [057/165] (885s left) kms_addfb_basic (addfb25-modifier-no-flag)
[163.887208] Starting subtest: addfb25-modifier-no-flag
[163.891359] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[164.058173] [058/165] (884s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[164.476162] Starting subtest: addfb25-x-tiled-legacy
[164.480249] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s)
[164.661170] [059/165] (884s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[165.073271] Starting subtest: addfb25-x-tiled-mismatch-legacy
[165.077592] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.001s)
[165.260819] [060/165] (883s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[165.712565] Starting subtest: addfb25-yf-tiled-legacy
[165.716255] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.002s)
[165.844853] [061/165] (883s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[166.291686] Starting subtest: addfb25-y-tiled-legacy
[166.295582] Subtest addfb25-y-tiled-legacy: SUCCESS (0.002s)
[166.453218] [062/165] (882s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[166.905787] Starting subtest: addfb25-y-tiled-small-legacy
[166.912666] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[167.044280] [063/165] (882s left) kms_addfb_basic (bad-pitch-0)
[167.472501] Starting subtest: bad-pitch-0
[167.476737] Subtest bad-pitch-0: SUCCESS (0.000s)
[167.749817] [064/165] (881s left) kms_addfb_basic (bad-pitch-1024)
[168.173733] Starting subtest: bad-pitch-1024
[168.178314] Subtest bad-pitch-1024: SUCCESS (0.000s)
[168.359779] [065/165] (881s left) kms_addfb_basic (bad-pitch-128)
[168.763438] Starting subtest: bad-pitch-128
[168.768284] Subtest bad-pitch-128: SUCCESS (0.000s)
[168.982994] [066/165] (880s left) kms_addfb_basic (bad-pitch-256)
[169.384116] Starting subtest: bad-pitch-256
[169.388413] Subtest bad-pitch-256: SUCCESS (0.000s)
[169.574125] [067/165] (880s left) kms_addfb_basic (bad-pitch-32)
[169.984557] Starting subtest: bad-pitch-32
[169.989380] Subtest bad-pitch-32: SUCCESS (0.000s)
[170.210167] [068/165] (879s left) kms_addfb_basic (bad-pitch-63)
[170.608650] Starting subtest: bad-pitch-63
[170.612484] Subtest bad-pitch-63: SUCCESS (0.000s)
[170.794791] [069/165] (879s left) kms_addfb_basic (bad-pitch-65536)
[171.190936] Starting subtest: bad-pitch-65536
[171.195255] Subtest bad-pitch-65536: SUCCESS (0.001s)
[171.415713] [070/165] (878s left) kms_addfb_basic (bad-pitch-999)
[171.811394] Starting subtest: bad-pitch-999
[171.815284] Subtest bad-pitch-999: SUCCESS (0.000s)
[171.993940] [071/165] (878s left) kms_addfb_basic (basic)
[172.387854] Starting subtest: basic
[172.392687] Subtest basic: SUCCESS (0.000s)
[172.576822] [072/165] (877s left) kms_addfb_basic (basic-x-tiled-legacy)
[172.982707] Starting subtest: basic-x-tiled-legacy
[172.987337] Subtest basic-x-tiled-legacy: SUCCESS (0.000s)
[173.179300] [073/165] (877s left) kms_addfb_basic (basic-y-tiled-legacy)
[173.581635] Starting subtest: basic-y-tiled-legacy
[173.585949] Subtest basic-y-tiled-legacy: SUCCESS (0.001s)
[173.789510] [074/165] (876s left) kms_addfb_basic (bo-too-small)
[174.223678] Starting subtest: bo-too-small
[174.228315] Subtest bo-too-small: SUCCESS (0.002s)
[174.360207] [075/165] (876s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[174.808822] Starting subtest: bo-too-small-due-to-tiling
[174.812842] Subtest bo-too-small-due-to-tiling: SUCCESS (0.002s)
[174.960807] [076/165] (875s left) kms_addfb_basic (clobberred-modifier)
[175.359408] Starting subtest: clobberred-modifier
[175.365300] Subtest clobberred-modifier: SUCCESS (0.001s)
[175.554297] [077/165] (875s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[175.966634] Starting subtest: framebuffer-vs-set-tiling
[175.970643] Subtest framebuffer-vs-set-tiling: SUCCESS (0.001s)
[176.161265] [078/165] (874s left) kms_addfb_basic (invalid-get-prop)
[176.575393] Starting subtest: invalid-get-prop
[176.579866] Subtest invalid-get-prop: SUCCESS (0.000s)
[176.761854] [079/165] (874s left) kms_addfb_basic (invalid-get-prop-any)
[177.162637] Starting subtest: invalid-get-prop-any
[177.166688] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[177.341384] [080/165] (873s left) kms_addfb_basic (invalid-set-prop)
[177.745868] Starting subtest: invalid-set-prop
[177.752133] Subtest invalid-set-prop: SUCCESS (0.000s)
[177.955483] [081/165] (873s left) kms_addfb_basic (invalid-set-prop-any)
[178.359816] Starting subtest: invalid-set-prop-any
[178.364131] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[178.560780] [082/165] (872s left) kms_addfb_basic (no-handle)
[178.968740] Starting subtest: no-handle
[178.973427] Subtest no-handle: SUCCESS (0.000s)
[179.158220] [083/165] (871s left) kms_addfb_basic (size-max)
[179.606978] Starting subtest: size-max
[179.610783] Subtest size-max: SUCCESS (0.001s)
[179.774164] [084/165] (871s left) kms_addfb_basic (small-bo)
[180.222125] Starting subtest: small-bo
[180.226202] Subtest small-bo: SUCCESS (0.000s)
[180.362782] [085/165] (870s left) kms_addfb_basic (tile-pitch-mismatch)
[180.767649] Starting subtest: tile-pitch-mismatch
[180.771619] Subtest tile-pitch-mismatch: SUCCESS (0.002s)
[180.953399] [086/165] (870s left) kms_addfb_basic (too-high)
[181.407636] Starting subtest: too-high
[181.413376] Subtest too-high: SUCCESS (0.004s)
[181.561466] [087/165] (869s left) kms_addfb_basic (too-wide)
[182.062734] Starting subtest: too-wide
[182.066453] Subtest too-wide: SUCCESS (0.000s)
[182.209853] [088/165] (869s left) kms_addfb_basic (unused-handle)
[182.605175] Starting subtest: unused-handle
[182.609577] Subtest unused-handle: SUCCESS (0.000s)
[182.811247] [089/165] (868s left) kms_addfb_basic (unused-modifier)
[183.216300] Starting subtest: unused-modifier
[183.220758] Subtest unused-modifier: SUCCESS (0.000s)
[183.397436] [090/165] (868s left) kms_addfb_basic (unused-offsets)
[183.797093] Starting subtest: unused-offsets
[183.801402] Subtest unused-offsets: SUCCESS (0.000s)
[184.003162] [091/165] (867s left) kms_addfb_basic (unused-pitches)
[184.409160] Starting subtest: unused-pitches
[184.414390] Subtest unused-pitches: SUCCESS (0.000s)
[184.596144] [092/165] (867s left) kms_busy (basic)
[185.053528] Starting subtest: basic
[185.062124] Starting dynamic subtest: flip
[186.499892] Dynamic subtest flip: SUCCESS (1.438s)
[186.545173] Starting dynamic subtest: modeset
[186.552463] Dynamic subtest modeset: SKIP (0.000s)
[186.556480] Subtest basic: SUCCESS (1.446s)
[186.779232] [093/165] (865s left) kms_prop_blob (basic)
[187.199750] Starting subtest: basic
[187.203431] Subtest basic: SUCCESS (0.000s)
[187.338259] [094/165] (864s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[187.803560] Starting subtest: basic-busy-flip-before-cursor-atomic
[187.817661] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.015s)
[187.970163] [095/165] (864s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[188.417851] Starting subtest: basic-busy-flip-before-cursor-legacy
[189.674510] Subtest basic-busy-flip-before-cursor-legacy: SUCCESS (1.256s)
[189.952531] [096/165] (862s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[190.414136] Starting subtest: basic-flip-after-cursor-atomic
[190.421677] Subtest basic-flip-after-cursor-atomic: SKIP (0.000s)
[190.556886] [097/165] (861s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[191.015269] Starting subtest: basic-flip-after-cursor-legacy
[192.265625] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.254s)
[192.531825] [098/165] (859s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[192.976634] Starting subtest: basic-flip-after-cursor-varying-size
[194.227385] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.254s)
[194.498155] [099/165] (858s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[194.954645] Starting subtest: basic-flip-before-cursor-atomic
[194.961783] Subtest basic-flip-before-cursor-atomic: SKIP (0.000s)
[195.088856] [100/165] (857s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[195.538303] Starting subtest: basic-flip-before-cursor-legacy
[196.793858] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.258s)
[197.065640] [101/165] (855s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[197.522277] Starting subtest: basic-flip-before-cursor-varying-size
[198.775485] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.254s)
[199.048243] [102/165] (853s left) kms_dsc (dsc-basic)
[199.498647] Subtest dsc-basic: SKIP (0.000s)
[199.625314] [103/165] (853s left) kms_flip (basic-flip-vs-dpms)
[200.097570] Starting subtest: basic-flip-vs-dpms
[200.102498] Starting dynamic subtest: A-VGA1
[201.798662] Dynamic subtest A-VGA1: SUCCESS (1.697s)
[201.845610] Starting dynamic subtest: B-VGA1
[203.301265] Dynamic subtest B-VGA1: SUCCESS (1.501s)
[203.305338] Subtest basic-flip-vs-dpms: SUCCESS (3.205s)
[203.707538] [104/165] (849s left) kms_flip (basic-flip-vs-modeset)
[204.214742] Starting subtest: basic-flip-vs-modeset
[204.219756] Starting dynamic subtest: A-VGA1
[205.772596] Dynamic subtest A-VGA1: SUCCESS (1.554s)
[205.821562] Starting dynamic subtest: B-VGA1
[207.095244] Dynamic subtest B-VGA1: SUCCESS (1.318s)
[207.108128] Subtest basic-flip-vs-modeset: SUCCESS (2.879s)
[207.466441] [105/165] (845s left) kms_flip (basic-flip-vs-wf_vblank)
[207.929755] Starting subtest: basic-flip-vs-wf_vblank
[207.933642] Starting dynamic subtest: A-VGA1
[209.811773] Dynamic subtest A-VGA1: SUCCESS (1.880s)
[209.857123] Starting dynamic subtest: B-VGA1
[211.490859] Dynamic subtest B-VGA1: SUCCESS (1.673s)
[211.496536] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.561s)
[211.920360] [106/165] (841s left) kms_flip (basic-plain-flip)
[212.363845] Starting subtest: basic-plain-flip
[212.368506] Starting dynamic subtest: A-VGA1
[213.956732] Dynamic subtest A-VGA1: SUCCESS (1.587s)
[214.002829] Starting dynamic subtest: B-VGA1
[215.342785] Dynamic subtest B-VGA1: SUCCESS (1.383s)
[215.349709] Subtest basic-plain-flip: SUCCESS (2.975s)
[215.753503] [107/165] (837s left) kms_force_connector_basic (force-connector-state)
[216.224511] Starting subtest: force-connector-state
[216.485489] Subtest force-connector-state: SUCCESS (0.253s)
[216.916680] [108/165] (836s left) kms_force_connector_basic (force-edid)
[217.377274] Starting subtest: force-edid
[217.475641] Subtest force-edid: SUCCESS (0.097s)
[217.733428] [109/165] (835s left) kms_force_connector_basic (force-load-detect)
[218.212155] Starting subtest: force-load-detect
[218.572567] Subtest force-load-detect: SUCCESS (0.358s)
[218.936829] [110/165] (834s left) kms_force_connector_basic (prune-stale-modes)
[219.404561] Starting subtest: prune-stale-modes
[219.501354] Subtest prune-stale-modes: SUCCESS (0.096s)
[219.737974] [111/165] (833s left) kms_frontbuffer_tracking (basic)
[220.225301] Subtest basic: SKIP (0.000s)
[220.332276] [112/165] (833s left) kms_hdmi_inject (inject-audio)
[220.778722] Subtest inject-audio: SKIP (0.000s)
[220.890286] [113/165] (833s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[221.332177] Starting subtest: compare-crc-sanitycheck-xr24
[221.336894] Starting dynamic subtest: pipe-A-VGA-1
[221.702714] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.367s)
[221.753672] Starting dynamic subtest: pipe-B-VGA-1
[222.181647] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.472s)
[222.186837] Subtest compare-crc-sanitycheck-xr24: SUCCESS (0.851s)
[222.455339] [114/165] (831s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[222.898538] Starting subtest: compare-crc-sanitycheck-nv12
[222.902824] Starting dynamic subtest: pipe-A-VGA-1
[222.911453] Dynamic subtest pipe-A-VGA-1: SKIP (0.001s)
[222.956486] Starting dynamic subtest: pipe-B-VGA-1
[222.963600] Dynamic subtest pipe-B-VGA-1: SKIP (0.001s)
[222.970238] Subtest compare-crc-sanitycheck-nv12: SKIP (0.013s)
[223.061887] [115/165] (831s left) kms_pipe_crc_basic (hang-read-crc)
[223.515663] Starting subtest: hang-read-crc
[223.519391] Starting dynamic subtest: pipe-A-VGA-1
[224.754753] Dynamic subtest pipe-A-VGA-1: SUCCESS (1.238s)
[224.802231] Starting dynamic subtest: pipe-B-VGA-1
[226.033823] Dynamic subtest pipe-B-VGA-1: SUCCESS (1.275s)
[226.038611] Subtest hang-read-crc: SUCCESS (2.523s)
[226.290086] [116/165] (827s left) kms_pipe_crc_basic (nonblocking-crc)
[226.740691] Starting subtest: nonblocking-crc
[226.747637] Starting dynamic subtest: pipe-A-VGA-1
[227.281913] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.543s)
[227.333751] Starting dynamic subtest: pipe-B-VGA-1
[227.995773] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.705s)
[228.000479] Subtest nonblocking-crc: SUCCESS (1.259s)
[228.255411] [117/165] (826s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[228.702125] Starting subtest: nonblocking-crc-frame-sequence
[228.706559] Starting dynamic subtest: pipe-A-VGA-1
[229.285169] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.582s)
[229.327793] Starting dynamic subtest: pipe-B-VGA-1
[229.961731] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.671s)
[229.966761] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.266s)
[230.231549] [118/165] (824s left) kms_pipe_crc_basic (read-crc)
[230.705295] Starting subtest: read-crc
[230.710097] Starting dynamic subtest: pipe-A-VGA-1
[231.201744] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.495s)
[231.253126] Starting dynamic subtest: pipe-B-VGA-1
[231.787506] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.581s)
[231.790921] Subtest read-crc: SUCCESS (1.089s)
[232.074183] [119/165] (822s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[232.547637] Starting subtest: read-crc-frame-sequence
[232.553695] Starting dynamic subtest: pipe-A-VGA-1
[233.047827] Dynamic subtest pipe-A-VGA-1: SUCCESS (0.497s)
[233.098512] Starting dynamic subtest: pipe-B-VGA-1
[233.673836] Dynamic subtest pipe-B-VGA-1: SUCCESS (0.621s)
[233.679226] Subtest read-crc-frame-sequence: SUCCESS (1.129s)
[233.995350] [120/165] (820s left) kms_pm_backlight (basic-brightness)
[234.447348] Subtest basic-brightness: SKIP (0.000s)
[234.555266] [121/165] (820s left) kms_pm_rpm (basic-pci-d3-state)
[246.439258] Subtest basic-pci-d3-state: SKIP (0.000s)
[246.539552] [122/165] (808s left) kms_pm_rpm (basic-rte)
[246.929866] Starting subtest: basic-rte
[258.426248] Subtest basic-rte: SKIP (11.474s)
[258.525596] [123/165] (796s left) kms_psr (psr-primary-page-flip)
[258.965673] Subtest psr-primary-page-flip: SKIP (0.000s)
[259.123949] [124/165] (795s left) kms_psr (psr-cursor-plane-move)
[259.622831] Subtest psr-cursor-plane-move: SKIP (0.000s)
[259.727439] [125/165] (795s left) kms_psr (psr-sprite-plane-onoff)
[260.208363] Subtest psr-sprite-plane-onoff: SKIP (0.000s)
[260.312712] [126/165] (794s left) kms_psr (psr-primary-mmap-gtt)
[260.805288] Subtest psr-primary-mmap-gtt: SKIP (0.000s)
[260.965238] [127/165] (794s left) kms_setmode (basic-clone-single-crtc)
[261.426881] Starting subtest: basic-clone-single-crtc
[261.441619] Subtest basic-clone-single-crtc: SKIP (0.000s)
[261.568759] [128/165] (793s left) i915_pm_rps (basic-api)
[262.006338] Subtest basic-api: SKIP (0.000s)
[262.125851] [129/165] (793s left) prime_self_import (basic-llseek-bad)
[262.528154] Starting subtest: basic-llseek-bad
[262.537946] Subtest basic-llseek-bad: SUCCESS (0.012s)
[262.681321] [130/165] (792s left) prime_self_import (basic-llseek-size)
[263.079758] Starting subtest: basic-llseek-size
[263.101153] Subtest basic-llseek-size: SUCCESS (0.022s)
[263.251629] [131/165] (792s left) prime_self_import (basic-with_fd_dup)
[263.669567] Starting subtest: basic-with_fd_dup
[263.685710] Subtest basic-with_fd_dup: SUCCESS (0.016s)
[263.816680] [132/165] (791s left) prime_self_import (basic-with_one_bo)
[264.206516] Starting subtest: basic-with_one_bo
[264.221119] Subtest basic-with_one_bo: SUCCESS (0.016s)
[264.356823] [133/165] (791s left) prime_self_import (basic-with_one_bo_two_files)
[264.747552] Starting subtest: basic-with_one_bo_two_files
[264.763453] Subtest basic-with_one_bo_two_files: SUCCESS (0.012s)
[264.900247] [134/165] (791s left) prime_self_import (basic-with_two_bos)
[265.281211] Starting subtest: basic-with_two_bos
[265.299683] Subtest basic-with_two_bos: SUCCESS (0.018s)
[265.447610] [135/165] (790s left) prime_vgem (basic-fence-flip)
[265.868731] Starting subtest: basic-fence-flip
[266.502238] Subtest basic-fence-flip: SUCCESS (0.631s)
[266.669823] [136/165] (789s left) prime_vgem (basic-fence-mmap)
[267.085635] Starting subtest: basic-fence-mmap
[267.261818] Subtest basic-fence-mmap: SUCCESS (0.175s)
[267.404510] [137/165] (788s left) prime_vgem (basic-fence-read)
[267.821665] Starting subtest: basic-fence-read
[268.131129] Subtest basic-fence-read: SUCCESS (0.309s)
[268.286931] [138/165] (788s left) prime_vgem (basic-gtt)
[268.718915] Starting subtest: basic-gtt
[268.795537] Subtest basic-gtt: SUCCESS (0.076s)
[268.959282] [139/165] (787s left) prime_vgem (basic-read)
[269.384236] Starting subtest: basic-read
[269.512478] Subtest basic-read: SUCCESS (0.129s)
[269.669916] [140/165] (786s left) prime_vgem (basic-write)
[270.102210] Starting subtest: basic-write
[270.242590] Subtest basic-write: SUCCESS (0.141s)
[270.384818] [141/165] (786s left) vgem_basic (setversion)
[270.799577] Starting subtest: setversion
[270.807531] Subtest setversion: SUCCESS (0.002s)
[270.917262] [142/165] (785s left) vgem_basic (create)
[271.315112] Starting subtest: create
[271.318677] Subtest create: SUCCESS (0.003s)
[271.432696] [143/165] (785s left) vgem_basic (debugfs)
[271.850445] Starting subtest: debugfs
[271.854311] Subtest debugfs: SUCCESS (0.003s)
[271.972454] [144/165] (784s left) vgem_basic (dmabuf-export)
[272.399427] Starting subtest: dmabuf-export
[272.407783] Subtest dmabuf-export: SUCCESS (0.010s)
[272.550650] [145/165] (784s left) vgem_basic (dmabuf-fence)
[272.967291] Starting subtest: dmabuf-fence
[272.971948] Subtest dmabuf-fence: SUCCESS (0.005s)
[273.100346] [146/165] (783s left) vgem_basic (dmabuf-fence-before)
[273.518594] Starting subtest: dmabuf-fence-before
[273.523287] Subtest dmabuf-fence-before: SUCCESS (0.003s)
[273.631598] [147/165] (783s left) vgem_basic (dmabuf-mmap)
[274.033489] Starting subtest: dmabuf-mmap
[274.115260] Subtest dmabuf-mmap: SUCCESS (0.083s)
[274.234680] [148/165] (782s left) vgem_basic (mmap)
[274.648709] Starting subtest: mmap
[274.704378] Subtest mmap: SUCCESS (0.057s)
[274.832915] [149/165] (782s left) vgem_basic (second-client)
[275.251246] Starting subtest: second-client
[275.284126] Subtest second-client: SUCCESS (0.034s)
[275.400221] [150/165] (782s left) vgem_basic (sysfs)
[275.802460] Starting subtest: sysfs
[275.806617] Subtest sysfs: SUCCESS (0.007s)
[275.934520] [151/165] (781s left) core_hotunplug (unbind-rebind)
[276.481310] Starting subtest: unbind-rebind
[280.899567] Subtest unbind-rebind: SUCCESS (4.418s)
[281.030986] [152/165] (776s left) vgem_basic (unload)
[281.444402] Starting subtest: unload
[310.807617] Subtest unload: SUCCESS (29.377s)
[311.059163] [153/165] (746s left) i915_module_load (reload)
[311.455781] Starting subtest: reload
[316.207185] Subtest reload: SUCCESS (4.752s)
[316.350396] [154/165] (741s left) gem_lmem_swapping (basic)
[317.202629] Subtest basic: SKIP (0.000s)
[317.457414] [155/165] (740s left) gem_lmem_swapping (parallel-random-engines)
[317.916882] Subtest parallel-random-engines: SKIP (0.000s)
[318.024881] [156/165] (740s left) gem_lmem_swapping (random-engines)
[318.468573] Subtest random-engines: SKIP (0.000s)
[318.574148] [157/165] (739s left) gem_lmem_swapping (verify-random)
[318.982546] Subtest verify-random: SKIP (0.000s)
[319.091809] [158/165] (739s left) i915_pm_rpm (module-reload)
[330.986643] Subtest module-reload: SKIP (0.000s)
[331.080280] [159/165] (727s left) i915_selftest (live)
[333.163453] Starting subtest: live
[333.167291] Starting dynamic subtest: sanitycheck
[335.406783] Dynamic subtest sanitycheck: SUCCESS (2.244s)
[335.437572] Starting dynamic subtest: uncore
[337.452363] Dynamic subtest uncore: SUCCESS (2.044s)
[337.484747] Starting dynamic subtest: workarounds
[339.508823] Dynamic subtest workarounds: SUCCESS (2.055s)
[339.539270] Starting dynamic subtest: gt_engines
[341.598911] Dynamic subtest gt_engines: SUCCESS (2.088s)
[341.636573] Starting dynamic subtest: gt_timelines
[352.690726] Dynamic subtest gt_timelines: SUCCESS (11.094s)
[352.720572] Starting dynamic subtest: gt_contexts
[354.790438] Dynamic subtest gt_contexts: SUCCESS (2.096s)
[354.827410] Starting dynamic subtest: gt_lrc
[356.926905] Dynamic subtest gt_lrc: SUCCESS (2.135s)
[356.958812] Starting dynamic subtest: gt_mocs
[358.966546] Dynamic subtest gt_mocs: SUCCESS (2.036s)
[358.997477] Starting dynamic subtest: gt_pm
[361.430358] Dynamic subtest gt_pm: SUCCESS (2.463s)
[361.469636] Starting dynamic subtest: gt_heartbeat
[363.522124] Dynamic subtest gt_heartbeat: SUCCESS (2.089s)
[363.553085] Starting dynamic subtest: gt_tlb
[365.600358] Dynamic subtest gt_tlb: SUCCESS (2.076s)
[365.638776] Starting dynamic subtest: requests
[370.300229] Dynamic subtest requests: SUCCESS (4.699s)
[370.331830] Starting dynamic subtest: migrate
[372.336731] Dynamic subtest migrate: SUCCESS (2.034s)
[372.367454] Starting dynamic subtest: active
[374.430457] Dynamic subtest active: SUCCESS (2.091s)
[374.469615] Starting dynamic subtest: objects
[377.536844] Dynamic subtest objects: SUCCESS (3.103s)
[377.576519] Starting dynamic subtest: mman
[389.347135] Dynamic subtest mman: SUCCESS (11.813s)
[389.386626] Starting dynamic subtest: dmabuf
[391.565874] Dynamic subtest dmabuf: SUCCESS (2.215s)
[391.599891] Starting dynamic subtest: vma
[393.642412] Dynamic subtest vma: SUCCESS (2.076s)
[393.680492] Starting dynamic subtest: coherency
[400.676385] Dynamic subtest coherency: SUCCESS (7.034s)
[400.715673] Starting dynamic subtest: gtt
[405.812555] Dynamic subtest gtt: SUCCESS (5.135s)
[405.851468] Starting dynamic subtest: gem
[407.946401] Dynamic subtest gem: SUCCESS (2.131s)
[407.976585] Starting dynamic subtest: evict
[410.066498] Dynamic subtest evict: SUCCESS (2.117s)
[410.097641] Starting dynamic subtest: hugepages
[412.091093] Dynamic subtest hugepages: SUCCESS (2.023s)
[412.123319] Starting dynamic subtest: gem_contexts
[414.184371] Dynamic subtest gem_contexts: SUCCESS (2.090s)
[414.215431] Starting dynamic subtest: client
[416.212582] Dynamic subtest client: SUCCESS (2.026s)
[416.242924] Starting dynamic subtest: gem_migrate
[418.271337] Dynamic subtest gem_migrate: SUCCESS (2.056s)
[418.301559] Starting dynamic subtest: reset
[420.885920] Dynamic subtest reset: SUCCESS (2.612s)
[420.917127] Starting dynamic subtest: memory_region
[422.946980] Dynamic subtest memory_region: SUCCESS (2.059s)
[422.977467] Starting dynamic subtest: hangcheck
[426.090422] Dynamic subtest hangcheck: SUCCESS (3.142s)
[426.124249] Starting dynamic subtest: execlists
[428.173538] Dynamic subtest execlists: SUCCESS (2.078s)
[428.203718] Starting dynamic subtest: ring_submission
[430.274485] Dynamic subtest ring_submission: SUCCESS (2.099s)
[430.313855] Starting dynamic subtest: perf
[432.363592] Dynamic subtest perf: SUCCESS (2.087s)
[432.394995] Starting dynamic subtest: slpc
[434.453383] Dynamic subtest slpc: SUCCESS (2.085s)
[434.483763] Starting dynamic subtest: guc
[436.488938] Dynamic subtest guc: SUCCESS (2.033s)
[436.538788] Starting dynamic subtest: guc_multi_lrc
[438.547881] Dynamic subtest guc_multi_lrc: SUCCESS (2.057s)
[438.589444] Starting dynamic subtest: guc_hang
[440.590381] Dynamic subtest guc_hang: SUCCESS (2.040s)
[440.627879] Starting dynamic subtest: late_gt_pm
[442.644745] Dynamic subtest late_gt_pm: SUCCESS (2.049s)
[442.648124] Subtest live: SUCCESS (109.538s)
[442.738540] [160/165] (615s left) dmabuf (all-tests)
[443.263468] Starting subtest: all-tests
[443.266917] Starting dynamic subtest: sanitycheck
[443.354589] Dynamic subtest sanitycheck: SUCCESS (0.096s)
[443.391124] Starting dynamic subtest: dma_fence
[443.582775] Dynamic subtest dma_fence: SUCCESS (0.224s)
[443.621981] Starting dynamic subtest: dma_fence_chain
[495.676425] Dynamic subtest dma_fence_chain: SUCCESS (52.115s)
[495.725688] Starting dynamic subtest: dma_fence_unwrap
[495.768517] Dynamic subtest dma_fence_unwrap: SUCCESS (0.089s)
[495.809355] Starting dynamic subtest: dma_resv
[495.883687] Dynamic subtest dma_resv: SUCCESS (0.105s)
[495.891254] Subtest all-tests: SUCCESS (52.652s)
[495.978827] [161/165] (562s left) i915_suspend (basic-s2idle-without-i915)
[496.371438] Starting subtest: basic-s2idle-without-i915
[518.474123] Subtest basic-s2idle-without-i915: SUCCESS (6.354s)
[520.782320] [162/165] (555s left) i915_suspend (basic-s3-without-i915)
[521.275698] Starting subtest: basic-s3-without-i915
[541.638716] Subtest basic-s3-without-i915: SUCCESS (4.377s)
[546.911437] [163/165] (550s left) gem_exec_suspend (basic-s0)
[547.400346] Starting subtest: basic-S0
[547.404465] Starting dynamic subtest: smem
[568.517324] Dynamic subtest smem: SUCCESS (5.971s)
[568.521014] Subtest basic-S0: SUCCESS (5.976s)
[570.835749] [164/165] (543s left) gem_exec_suspend (basic-s3)
[571.338457] Starting subtest: basic-S3
[571.342679] Starting dynamic subtest: smem
[593.827100] Dynamic subtest smem: SUCCESS (6.126s)
[593.831145] Subtest basic-S3: SUCCESS (6.131s)
[597.116623] [165/165] (537s left) kms_pipe_crc_basic (suspend-read-crc)
[597.617539] Starting subtest: suspend-read-crc
[597.629417] Starting dynamic subtest: pipe-A-VGA-1
[615.562588] Dynamic subtest pipe-A-VGA-1: SUCCESS (2.269s)
[615.627005] Starting dynamic subtest: pipe-B-VGA-1
[633.603436] Dynamic subtest pipe-B-VGA-1: SUCCESS (2.419s)
[633.607599] Subtest suspend-read-crc: SUCCESS (4.703s)
[637.880908] Closing watchdogs
Done.