[36.927700] Initializing watchdogs
[36.927821]   /dev/watchdog0
[36.944182] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[36.952029] [001/162] (960s left) i915_module_load (load)
[37.003974] Starting subtest: load
[40.730276] Subtest load: SUCCESS (3.736s)
[40.771111] [FACT i915_module_load (load)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[40.772757] [FACT i915_module_load (load)] new: kernel.kmod_is_loaded.i915: true
[40.779998] [002/162] (956s left) core_auth (basic-auth)
[41.885102] Starting subtest: basic-auth
[41.890641] Subtest basic-auth: SUCCESS (0.003s)
[42.035948] [003/162] (955s left) core_debugfs (read-all-entries)
[42.099343] Starting subtest: read-all-entries
[42.193112] Subtest read-all-entries: SUCCESS (0.096s)
[42.283155] [004/162] (955s left) core_sysfs (read-all-entries)
[42.347318] Starting subtest: read-all-entries
[42.352678] Subtest read-all-entries: SUCCESS (0.004s)
[42.470301] [005/162] (955s left) fbdev (eof)
[42.528018] Starting subtest: eof
[42.533456] Subtest eof: SUCCESS (0.000s)
[42.596231] [006/162] (955s left) fbdev (info)
[42.643584] Starting subtest: info
[42.649084] Subtest info: SUCCESS (0.000s)
[42.712564] [007/162] (955s left) fbdev (nullptr)
[42.761061] Starting subtest: nullptr
[42.766445] Subtest nullptr: SUCCESS (0.000s)
[42.827929] [008/162] (954s left) fbdev (read)
[42.886980] Starting subtest: read
[43.397807] Subtest read: SUCCESS (0.507s)
[43.463657] [009/162] (954s left) fbdev (write)
[43.517498] Starting subtest: write
[43.876988] Subtest write: SUCCESS (0.348s)
[43.933017] [010/162] (953s left) gem_basic (bad-close)
[43.992455] Starting subtest: bad-close
[44.003359] Subtest bad-close: SUCCESS (0.000s)
[44.109702] [011/162] (953s left) gem_basic (create-close)
[44.172964] Starting subtest: create-close
[44.183868] Subtest create-close: SUCCESS (0.000s)
[44.303052] [012/162] (953s left) gem_basic (create-fd-close)
[44.359271] Starting subtest: create-fd-close
[44.370142] Subtest create-fd-close: SUCCESS (0.000s)
[44.471229] [013/162] (953s left) gem_busy (busy@all-engines)
[44.538076] Starting subtest: busy
[44.546731] Starting dynamic subtest: all-engines
[44.576054] Dynamic subtest all-engines: SUCCESS (0.036s)
[44.581636] Subtest busy: SUCCESS (0.037s)
[45.933973] [014/162] (952s left) gem_close_race (basic-process)
[46.013647] Starting subtest: basic-process
[46.068486] Subtest basic-process: SUCCESS (0.051s)
[46.268790] [015/162] (951s left) gem_close_race (basic-threads)
[46.345065] Starting subtest: basic-threads
[47.711723] Subtest basic-threads: SUCCESS (1.347s)
[47.912350] [016/162] (950s left) gem_ctx_create (basic)
[47.990021] Starting subtest: basic
[47.995578] Subtest basic: SUCCESS (0.000s)
[48.183033] [017/162] (950s left) gem_ctx_create (basic-files)
[48.253327] Starting subtest: basic-files
[50.288557] Subtest basic-files: SUCCESS (2.012s)
[51.912797] [018/162] (946s left) gem_ctx_exec (basic)
[51.968772] Starting subtest: basic
[51.974311] Subtest basic: SUCCESS (0.006s)
[52.098937] [019/162] (946s left) gem_exec_basic (basic)
[52.159079] Starting subtest: basic
[52.164566] Starting dynamic subtest: rcs0-smem
[52.170044] Dynamic subtest rcs0-smem: SUCCESS (0.003s)
[52.182191] Starting dynamic subtest: bcs0-smem
[52.187641] Dynamic subtest bcs0-smem: SUCCESS (0.001s)
[52.198031] Starting dynamic subtest: vcs0-smem
[52.203462] Dynamic subtest vcs0-smem: SUCCESS (0.002s)
[52.213853] Starting dynamic subtest: vcs1-smem
[52.219362] Dynamic subtest vcs1-smem: SUCCESS (0.001s)
[52.229977] Starting dynamic subtest: vecs0-smem
[52.235843] Dynamic subtest vecs0-smem: SUCCESS (0.001s)
[52.246377] Starting dynamic subtest: ccs0-smem
[52.251840] Dynamic subtest ccs0-smem: SUCCESS (0.002s)
[52.257175] Subtest basic: SUCCESS (0.011s)
[53.943937] [020/162] (944s left) gem_exec_create (basic)
[54.016057] Starting subtest: basic
[54.021470] Starting dynamic subtest: smem
[57.858343] Dynamic subtest smem: SUCCESS (3.817s)
[57.863939] Subtest basic: SUCCESS (3.818s)
[58.054775] [021/162] (940s left) gem_exec_fence (basic-busy)
[58.229667] Starting subtest: basic-busy
[58.235328] Starting dynamic subtest: rcs0
[58.285359] Dynamic subtest rcs0: SUCCESS (0.056s)
[58.296123] Starting dynamic subtest: bcs0
[58.335608] Dynamic subtest bcs0: SUCCESS (0.049s)
[58.347302] Starting dynamic subtest: vcs0
[58.386116] Dynamic subtest vcs0: SUCCESS (0.050s)
[58.397708] Starting dynamic subtest: vcs1
[58.435203] Dynamic subtest vcs1: SUCCESS (0.048s)
[58.446898] Starting dynamic subtest: vecs0
[58.485271] Dynamic subtest vecs0: SUCCESS (0.049s)
[58.496739] Starting dynamic subtest: ccs0
[58.536977] Dynamic subtest ccs0: SUCCESS (0.051s)
[58.542492] Subtest basic-busy: SUCCESS (0.307s)
[59.985452] [FACT gem_exec_fence (basic-busy)] new: kernel.kmod_is_loaded.vgem: true
[59.992032] [022/162] (938s left) gem_exec_fence (basic-wait)
[60.166345] Starting subtest: basic-wait
[60.172031] Starting dynamic subtest: rcs0
[60.240705] Dynamic subtest rcs0: SUCCESS (0.075s)
[60.252831] Starting dynamic subtest: bcs0
[60.291537] Dynamic subtest bcs0: SUCCESS (0.050s)
[60.304425] Starting dynamic subtest: vcs0
[60.339267] Dynamic subtest vcs0: SUCCESS (0.048s)
[60.351437] Starting dynamic subtest: vcs1
[60.391632] Dynamic subtest vcs1: SUCCESS (0.051s)
[60.407640] Starting dynamic subtest: vecs0
[60.441986] Dynamic subtest vecs0: SUCCESS (0.049s)
[60.454721] Starting dynamic subtest: ccs0
[60.492836] Dynamic subtest ccs0: SUCCESS (0.051s)
[60.502240] Subtest basic-wait: SUCCESS (0.327s)
[61.988621] [023/162] (936s left) gem_exec_fence (basic-await)
[62.174461] Starting subtest: basic-await
[62.180537] Starting dynamic subtest: rcs0
[62.250760] Dynamic subtest rcs0: SUCCESS (0.076s)
[62.271556] Starting dynamic subtest: bcs0
[62.323523] Dynamic subtest bcs0: SUCCESS (0.075s)
[62.336063] Starting dynamic subtest: vcs0
[62.395783] Dynamic subtest vcs0: SUCCESS (0.072s)
[62.409464] Starting dynamic subtest: vcs1
[62.467797] Dynamic subtest vcs1: SUCCESS (0.071s)
[62.482975] Starting dynamic subtest: vecs0
[62.540463] Dynamic subtest vecs0: SUCCESS (0.072s)
[62.560473] Starting dynamic subtest: ccs0
[62.612732] Dynamic subtest ccs0: SUCCESS (0.072s)
[62.618882] Subtest basic-await: SUCCESS (0.441s)
[63.957432] [024/162] (934s left) gem_exec_fence (nb-await)
[64.142330] Starting subtest: nb-await
[64.148107] Starting dynamic subtest: rcs0
[64.211135] Dynamic subtest rcs0: SUCCESS (0.069s)
[64.224467] Starting dynamic subtest: bcs0
[64.265087] Dynamic subtest bcs0: SUCCESS (0.057s)
[64.277855] Starting dynamic subtest: vcs0
[64.322200] Dynamic subtest vcs0: SUCCESS (0.056s)
[64.334976] Starting dynamic subtest: vcs1
[64.380675] Dynamic subtest vcs1: SUCCESS (0.057s)
[64.403112] Starting dynamic subtest: vecs0
[64.437316] Dynamic subtest vecs0: SUCCESS (0.057s)
[64.450295] Starting dynamic subtest: ccs0
[64.496587] Dynamic subtest ccs0: SUCCESS (0.056s)
[64.502298] Subtest nb-await: SUCCESS (0.355s)
[65.937692] [025/162] (932s left) gem_exec_gttfill (basic)
[66.003820] Starting subtest: basic
[68.612982] Subtest basic: SUCCESS (2.607s)
[68.823528] [026/162] (929s left) gem_exec_parallel (engines)
[68.923664] Starting subtest: engines
[68.929167] Starting dynamic subtest: basic
[70.850090] Dynamic subtest basic: SUCCESS (1.918s)
[70.869031] Starting dynamic subtest: contexts
[74.784610] Dynamic subtest contexts: SUCCESS (3.930s)
[74.797709] Starting dynamic subtest: fds
[77.287890] Dynamic subtest fds: SUCCESS (2.501s)
[77.302122] Starting dynamic subtest: userptr
[198.678548] Per-test timeout exceeded. Killing the current test with SIGQUIT.
[201.599445] Warning: kernel log ringbuffer underflow, some records lost.
[318.804077] Timeout. Killing the current test with SIGKILL.
[319.017892] Closing watchdogs
[319.021462] Initializing watchdogs
[319.021495]   /dev/watchdog0
[319.037359] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[319.044528] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[319.046455] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[319.046880] [FACT before any test] new: kernel.kmod_is_loaded.vgem: true
[319.053700] [027/162] (679s left) gem_exec_store (basic)
[319.879078] Starting subtest: basic
[319.975440] Subtest basic: SUCCESS (0.121s)
[320.177365] [028/162] (678s left) gem_flink_basic (bad-flink)
[320.244781] Starting subtest: bad-flink
[320.250285] Subtest bad-flink: SUCCESS (0.000s)
[320.350056] [029/162] (678s left) gem_flink_basic (bad-open)
[320.409971] Starting subtest: bad-open
[320.415461] Subtest bad-open: SUCCESS (0.000s)
[320.513853] [030/162] (678s left) gem_flink_basic (basic)
[320.578256] Starting subtest: basic
[320.583665] Subtest basic: SUCCESS (0.000s)
[320.708622] [031/162] (678s left) gem_flink_basic (double-flink)
[320.773202] Starting subtest: double-flink
[320.778674] Subtest double-flink: SUCCESS (0.000s)
[320.869807] [032/162] (678s left) gem_flink_basic (flink-lifetime)
[320.927196] Starting subtest: flink-lifetime
[320.932699] Subtest flink-lifetime: SUCCESS (0.002s)
[321.050270] [033/162] (677s left) gem_huc_copy (huc-copy)
[321.117012] Starting subtest: huc-copy
[321.122502] Subtest huc-copy: SUCCESS (0.003s)
[321.269724] [034/162] (677s left) gem_linear_blits (basic)
[321.513104] Starting subtest: basic
[321.524777] Subtest basic: SUCCESS (0.009s)
[321.635705] [035/162] (677s left) gem_mmap (basic)
[321.738907] Subtest basic: SKIP (0.000s)
[321.807840] [036/162] (677s left) gem_mmap_gtt (basic)
[321.885076] Subtest basic: SKIP (0.000s)
[321.943800] [037/162] (677s left) gem_render_linear_blits (basic)
[322.015500] Starting subtest: basic
[322.042479] Subtest basic: SUCCESS (0.024s)
[322.125482] [038/162] (677s left) gem_render_tiled_blits (basic)
[322.196595] Subtest basic: SKIP (0.000s)
[322.275469] [039/162] (676s left) gem_ringfill (basic-all)
[327.881486] Starting subtest: basic-all
[329.031270] Subtest basic-all: SUCCESS (1.153s)
[329.182664] [040/162] (670s left) gem_softpin (allocator-basic)
[329.260354] Starting subtest: allocator-basic
[329.324543] Subtest allocator-basic: SUCCESS (0.069s)
[329.450478] [041/162] (669s left) gem_softpin (allocator-basic-reserve)
[329.514769] Starting subtest: allocator-basic-reserve
[329.582762] Subtest allocator-basic-reserve: SUCCESS (0.069s)
[329.703576] [042/162] (669s left) gem_softpin (safe-alignment)
[329.785479] Starting subtest: safe-alignment
[329.805985] Subtest safe-alignment: SUCCESS (0.023s)
[330.934610] [043/162] (668s left) gem_sync (basic-all)
[331.029119] Starting subtest: basic-all
[334.913932] Subtest basic-all: SUCCESS (3.910s)
[335.103745] [044/162] (664s left) gem_sync (basic-each)
[335.203395] Starting subtest: basic-each
[337.402314] Subtest basic-each: SUCCESS (2.237s)
[337.597260] [045/162] (661s left) gem_tiled_blits (basic)
[337.668025] Subtest basic: SKIP (0.000s)
[337.720937] [046/162] (661s left) gem_tiled_fence_blits (basic)
[337.787143] Subtest basic: SKIP (0.000s)
[337.869588] [047/162] (661s left) gem_tiled_pread_basic (basic)
[337.939435] Subtest basic: SKIP (0.000s)
[337.992827] [048/162] (661s left) gem_wait (busy@all-engines)
[338.077446] Starting subtest: busy
[338.082949] Starting dynamic subtest: all-engines
[339.905967] Dynamic subtest all-engines: SUCCESS (1.820s)
[339.911928] Subtest busy: SUCCESS (1.822s)
[340.116746] [049/162] (659s left) gem_wait (wait@all-engines)
[340.182957] Starting subtest: wait
[340.188459] Starting dynamic subtest: all-engines
[341.890062] Dynamic subtest all-engines: SUCCESS (1.698s)
[341.896657] Subtest wait: SUCCESS (1.699s)
[342.103897] [050/162] (657s left) i915_getparams_basic (basic-eu-total)
[342.167936] Starting subtest: basic-eu-total
[342.178706] Subtest basic-eu-total: SUCCESS (0.000s)
[342.280265] [051/162] (657s left) i915_getparams_basic (basic-subslice-total)
[342.339757] Starting subtest: basic-subslice-total
[342.351065] Subtest basic-subslice-total: SUCCESS (0.000s)
[342.443498] [052/162] (657s left) i915_hangman (error-state-basic)
[342.526234] Starting subtest: error-state-basic
[342.641562] Subtest error-state-basic: SUCCESS (0.113s)
[342.745619] [053/162] (657s left) i915_pciid
[342.916902] [054/162] (657s left) intel_hwmon (hwmon-read)
[342.976394] Subtest hwmon-read: SKIP (0.000s)
[343.049459] [055/162] (656s left) intel_hwmon (hwmon-write)
[343.116010] Subtest hwmon-write: SKIP (0.000s)
[343.178662] [056/162] (656s left) kms_addfb_basic (addfb25-4-tiled)
[343.540726] Starting subtest: addfb25-4-tiled
[343.549628] Subtest addfb25-4-tiled: SUCCESS (0.000s)
[343.649465] [057/162] (656s left) kms_addfb_basic (addfb25-bad-modifier)
[343.965516] Starting subtest: addfb25-bad-modifier
[343.970984] Subtest addfb25-bad-modifier: SUCCESS (0.000s)
[344.073413] [058/162] (656s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling)
[344.378616] Subtest addfb25-framebuffer-vs-set-tiling: SKIP (0.000s)
[344.510008] [059/162] (655s left) kms_addfb_basic (addfb25-modifier-no-flag)
[344.852953] Starting subtest: addfb25-modifier-no-flag
[344.858413] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s)
[344.967983] [060/162] (655s left) kms_addfb_basic (addfb25-x-tiled-legacy)
[345.295752] Subtest addfb25-x-tiled-legacy: SKIP (0.000s)
[345.405871] [061/162] (654s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy)
[345.738200] Subtest addfb25-x-tiled-mismatch-legacy: SKIP (0.000s)
[345.857133] [062/162] (654s left) kms_addfb_basic (addfb25-yf-tiled-legacy)
[346.139792] Starting subtest: addfb25-yf-tiled-legacy
[346.145205] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s)
[346.252641] [063/162] (654s left) kms_addfb_basic (addfb25-y-tiled-legacy)
[346.584111] Starting subtest: addfb25-y-tiled-legacy
[346.589600] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s)
[346.714634] [064/162] (653s left) kms_addfb_basic (addfb25-y-tiled-small-legacy)
[347.080624] Starting subtest: addfb25-y-tiled-small-legacy
[347.091384] Subtest addfb25-y-tiled-small-legacy: SKIP (0.000s)
[347.199052] [065/162] (653s left) kms_addfb_basic (bad-pitch-0)
[347.257036] Starting subtest: bad-pitch-0
[347.262515] Subtest bad-pitch-0: SUCCESS (0.000s)
[347.633459] [066/162] (652s left) kms_addfb_basic (bad-pitch-1024)
[347.690414] Starting subtest: bad-pitch-1024
[347.696132] Subtest bad-pitch-1024: SUCCESS (0.000s)
[348.031033] [067/162] (652s left) kms_addfb_basic (bad-pitch-128)
[348.087712] Starting subtest: bad-pitch-128
[348.093325] Subtest bad-pitch-128: SUCCESS (0.000s)
[348.481509] [068/162] (652s left) kms_addfb_basic (bad-pitch-256)
[348.545038] Starting subtest: bad-pitch-256
[348.551128] Subtest bad-pitch-256: SUCCESS (0.000s)
[348.898450] [069/162] (651s left) kms_addfb_basic (bad-pitch-32)
[348.962127] Starting subtest: bad-pitch-32
[348.967717] Subtest bad-pitch-32: SUCCESS (0.000s)
[349.358509] [070/162] (651s left) kms_addfb_basic (bad-pitch-63)
[349.414036] Starting subtest: bad-pitch-63
[349.419529] Subtest bad-pitch-63: SUCCESS (0.000s)
[349.765415] [071/162] (650s left) kms_addfb_basic (bad-pitch-65536)
[349.825830] Starting subtest: bad-pitch-65536
[349.831426] Subtest bad-pitch-65536: SUCCESS (0.000s)
[350.219859] [072/162] (650s left) kms_addfb_basic (bad-pitch-999)
[350.271018] Starting subtest: bad-pitch-999
[350.276738] Subtest bad-pitch-999: SUCCESS (0.000s)
[350.647362] [073/162] (650s left) kms_addfb_basic (basic)
[350.700895] Starting subtest: basic
[350.706425] Subtest basic: SUCCESS (0.000s)
[351.103121] [074/162] (649s left) kms_addfb_basic (basic-x-tiled-legacy)
[351.161461] Starting subtest: basic-x-tiled-legacy
[351.172276] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[351.544405] [075/162] (649s left) kms_addfb_basic (basic-y-tiled-legacy)
[351.600124] Starting subtest: basic-y-tiled-legacy
[351.611096] Subtest basic-y-tiled-legacy: SKIP (0.000s)
[352.037193] [076/162] (648s left) kms_addfb_basic (bo-too-small)
[352.368100] Starting subtest: bo-too-small
[352.373468] Subtest bo-too-small: SUCCESS (0.000s)
[352.467126] [077/162] (648s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[352.829322] Starting subtest: bo-too-small-due-to-tiling
[352.840325] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[352.972069] [078/162] (648s left) kms_addfb_basic (clobberred-modifier)
[353.025518] Starting subtest: clobberred-modifier
[353.036626] Subtest clobberred-modifier: SKIP (0.000s)
[353.375541] [079/162] (647s left) kms_addfb_basic (framebuffer-vs-set-tiling)
[353.432148] Starting subtest: framebuffer-vs-set-tiling
[353.443118] Subtest framebuffer-vs-set-tiling: SKIP (0.000s)
[353.800236] [080/162] (647s left) kms_addfb_basic (invalid-get-prop)
[353.863058] Starting subtest: invalid-get-prop
[353.868728] Subtest invalid-get-prop: SUCCESS (0.000s)
[354.266628] [081/162] (646s left) kms_addfb_basic (invalid-get-prop-any)
[354.322634] Starting subtest: invalid-get-prop-any
[354.328204] Subtest invalid-get-prop-any: SUCCESS (0.000s)
[354.710369] [082/162] (646s left) kms_addfb_basic (invalid-set-prop)
[354.767088] Starting subtest: invalid-set-prop
[354.772501] Subtest invalid-set-prop: SUCCESS (0.000s)
[355.149621] [083/162] (646s left) kms_addfb_basic (invalid-set-prop-any)
[355.210389] Starting subtest: invalid-set-prop-any
[355.215792] Subtest invalid-set-prop-any: SUCCESS (0.000s)
[355.654870] [084/162] (645s left) kms_addfb_basic (no-handle)
[355.716542] Starting subtest: no-handle
[355.722122] Subtest no-handle: SUCCESS (0.000s)
[356.069194] [085/162] (645s left) kms_addfb_basic (size-max)
[356.359471] Starting subtest: size-max
[356.364988] Subtest size-max: SUCCESS (0.000s)
[356.481732] [086/162] (645s left) kms_addfb_basic (small-bo)
[356.758624] Starting subtest: small-bo
[356.763990] Subtest small-bo: SUCCESS (0.000s)
[356.882327] [087/162] (644s left) kms_addfb_basic (tile-pitch-mismatch)
[356.946598] Starting subtest: tile-pitch-mismatch
[356.957801] Subtest tile-pitch-mismatch: SKIP (0.000s)
[357.330360] [088/162] (644s left) kms_addfb_basic (too-high)
[357.618912] Starting subtest: too-high
[357.624515] Subtest too-high: SUCCESS (0.001s)
[357.729571] [089/162] (643s left) kms_addfb_basic (too-wide)
[358.049011] Starting subtest: too-wide
[358.054595] Subtest too-wide: SUCCESS (0.000s)
[358.161299] [090/162] (643s left) kms_addfb_basic (unused-handle)
[358.211913] Starting subtest: unused-handle
[358.217450] Subtest unused-handle: SUCCESS (0.000s)
[358.596687] [091/162] (643s left) kms_addfb_basic (unused-modifier)
[358.650422] Starting subtest: unused-modifier
[358.655893] Subtest unused-modifier: SUCCESS (0.000s)
[359.022073] [092/162] (642s left) kms_addfb_basic (unused-offsets)
[359.074932] Starting subtest: unused-offsets
[359.080395] Subtest unused-offsets: SUCCESS (0.000s)
[359.436385] [093/162] (642s left) kms_addfb_basic (unused-pitches)
[359.493490] Starting subtest: unused-pitches
[359.498981] Subtest unused-pitches: SUCCESS (0.000s)
[359.862589] [094/162] (641s left) kms_busy (basic)
[360.204908] Starting subtest: basic
[360.210399] Starting dynamic subtest: flip
[361.881596] Dynamic subtest flip: SUCCESS (1.671s)
[361.895443] Starting dynamic subtest: modeset
[365.287799] Dynamic subtest modeset: SUCCESS (3.405s)
[365.293391] Subtest basic: SUCCESS (5.078s)
[366.412558] [095/162] (635s left) kms_prop_blob (basic)
[366.479145] Starting subtest: basic
[366.484635] Subtest basic: SUCCESS (0.000s)
[366.622855] [096/162] (635s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[366.962119] Starting subtest: basic-busy-flip-before-cursor-atomic
[366.973083] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[367.141409] [097/162] (634s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[367.448418] Starting subtest: basic-busy-flip-before-cursor-legacy
[367.461751] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[367.621513] [098/162] (634s left) kms_cursor_legacy (basic-flip-after-cursor-atomic)
[367.994653] Starting subtest: basic-flip-after-cursor-atomic
[369.218727] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.226s)
[370.448325] [099/162] (631s left) kms_cursor_legacy (basic-flip-after-cursor-legacy)
[370.761787] Starting subtest: basic-flip-after-cursor-legacy
[372.048113] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.281s)
[373.263686] [100/162] (628s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size)
[373.591345] Starting subtest: basic-flip-after-cursor-varying-size
[374.871555] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.280s)
[376.033671] [101/162] (626s left) kms_cursor_legacy (basic-flip-before-cursor-atomic)
[376.362216] Starting subtest: basic-flip-before-cursor-atomic
[377.599278] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.239s)
[378.846909] [102/162] (623s left) kms_cursor_legacy (basic-flip-before-cursor-legacy)
[379.168414] Starting subtest: basic-flip-before-cursor-legacy
[380.456196] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.283s)
[381.664580] [103/162] (620s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size)
[381.978550] Starting subtest: basic-flip-before-cursor-varying-size
[383.240471] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.263s)
[384.450213] [104/162] (617s left) kms_dsc (dsc-basic)
[384.745107] Starting subtest: dsc-basic
[384.825809] Subtest dsc-basic: SKIP (0.001s)
[384.878298] [105/162] (617s left) kms_flip (basic-flip-vs-dpms)
[385.212040] Starting subtest: basic-flip-vs-dpms
[385.217603] Starting dynamic subtest: A-eDP1
[388.042817] Dynamic subtest A-eDP1: SUCCESS (2.829s)
[388.057416] Starting dynamic subtest: B-eDP1
[390.185422] Dynamic subtest B-eDP1: SUCCESS (2.145s)
[390.198330] Starting dynamic subtest: C-eDP1
[392.273029] Dynamic subtest C-eDP1: SUCCESS (2.079s)
[392.285291] Starting dynamic subtest: D-eDP1
[394.337129] Dynamic subtest D-eDP1: SUCCESS (2.070s)
[394.349731] Starting dynamic subtest: A-DP6
[395.302761] Dynamic subtest A-DP6: SUCCESS (0.958s)
[395.315161] Starting dynamic subtest: B-DP6
[396.244970] Dynamic subtest B-DP6: SUCCESS (0.947s)
[396.257144] Starting dynamic subtest: C-DP6
[397.165866] Dynamic subtest C-DP6: SUCCESS (0.920s)
[397.178787] Starting dynamic subtest: D-DP6
[398.097818] Dynamic subtest D-DP6: SUCCESS (0.925s)
[398.115057] Starting dynamic subtest: A-DP7
[399.041513] Dynamic subtest A-DP7: SUCCESS (0.944s)
[399.054339] Starting dynamic subtest: B-DP7
[399.998213] Dynamic subtest B-DP7: SUCCESS (0.953s)
[400.010516] Starting dynamic subtest: C-DP7
[400.915736] Dynamic subtest C-DP7: SUCCESS (0.918s)
[400.927736] Starting dynamic subtest: D-DP7
[401.832989] Dynamic subtest D-DP7: SUCCESS (0.916s)
[401.838472] Subtest basic-flip-vs-dpms: SUCCESS (16.622s)
[402.608383] [106/162] (599s left) kms_flip (basic-flip-vs-modeset)
[402.905650] Starting subtest: basic-flip-vs-modeset
[402.911189] Starting dynamic subtest: A-eDP1
[405.697753] Dynamic subtest A-eDP1: SUCCESS (2.788s)
[405.711827] Starting dynamic subtest: B-eDP1
[407.868492] Dynamic subtest B-eDP1: SUCCESS (2.168s)
[407.882778] Starting dynamic subtest: C-eDP1
[410.031345] Dynamic subtest C-eDP1: SUCCESS (2.163s)
[410.043541] Starting dynamic subtest: D-eDP1
[412.196951] Dynamic subtest D-eDP1: SUCCESS (2.165s)
[412.210941] Starting dynamic subtest: A-DP6
[413.152359] Dynamic subtest A-DP6: SUCCESS (0.956s)
[413.164861] Starting dynamic subtest: B-DP6
[414.113972] Dynamic subtest B-DP6: SUCCESS (0.961s)
[414.125979] Starting dynamic subtest: C-DP6
[415.048770] Dynamic subtest C-DP6: SUCCESS (0.932s)
[415.061222] Starting dynamic subtest: D-DP6
[415.987205] Dynamic subtest D-DP6: SUCCESS (0.937s)
[416.000294] Starting dynamic subtest: A-DP7
[416.942097] Dynamic subtest A-DP7: SUCCESS (0.957s)
[416.956590] Starting dynamic subtest: B-DP7
[417.906063] Dynamic subtest B-DP7: SUCCESS (0.961s)
[417.918675] Starting dynamic subtest: C-DP7
[418.832878] Dynamic subtest C-DP7: SUCCESS (0.923s)
[418.845586] Starting dynamic subtest: D-DP7
[419.756715] Dynamic subtest D-DP7: SUCCESS (0.926s)
[419.762103] Subtest basic-flip-vs-modeset: SUCCESS (16.854s)
[420.505119] [107/162] (582s left) kms_flip (basic-flip-vs-wf_vblank)
[420.817773] Starting subtest: basic-flip-vs-wf_vblank
[420.823343] Starting dynamic subtest: A-eDP1
[422.966042] Dynamic subtest A-eDP1: SUCCESS (2.150s)
[422.980619] Starting dynamic subtest: B-eDP1
[424.899047] Dynamic subtest B-eDP1: SUCCESS (1.929s)
[424.913104] Starting dynamic subtest: C-eDP1
[426.813103] Dynamic subtest C-eDP1: SUCCESS (1.908s)
[426.827024] Starting dynamic subtest: D-eDP1
[428.746465] Dynamic subtest D-eDP1: SUCCESS (1.931s)
[428.759474] Starting dynamic subtest: A-DP6
[430.142553] Dynamic subtest A-DP6: SUCCESS (1.403s)
[430.155993] Starting dynamic subtest: B-DP6
[431.451883] Dynamic subtest B-DP6: SUCCESS (1.307s)
[431.466227] Starting dynamic subtest: C-DP6
[432.757880] Dynamic subtest C-DP6: SUCCESS (1.295s)
[432.770628] Starting dynamic subtest: D-DP6
[434.051320] Dynamic subtest D-DP6: SUCCESS (1.295s)
[434.065991] Starting dynamic subtest: A-DP7
[435.336812] Dynamic subtest A-DP7: SUCCESS (1.291s)
[435.350538] Starting dynamic subtest: B-DP7
[436.649615] Dynamic subtest B-DP7: SUCCESS (1.311s)
[436.663346] Starting dynamic subtest: C-DP7
[437.946436] Dynamic subtest C-DP7: SUCCESS (1.291s)
[437.960920] Starting dynamic subtest: D-DP7
[439.245367] Dynamic subtest D-DP7: SUCCESS (1.297s)
[439.250847] Subtest basic-flip-vs-wf_vblank: SUCCESS (18.432s)
[440.151796] [108/162] (562s left) kms_flip (basic-plain-flip)
[440.465580] Starting subtest: basic-plain-flip
[440.471082] Starting dynamic subtest: A-eDP1
[442.354618] Dynamic subtest A-eDP1: SUCCESS (1.893s)
[442.368242] Starting dynamic subtest: B-eDP1
[443.993698] Dynamic subtest B-eDP1: SUCCESS (1.637s)
[444.006980] Starting dynamic subtest: C-eDP1
[445.629443] Dynamic subtest C-eDP1: SUCCESS (1.630s)
[445.642055] Starting dynamic subtest: D-eDP1
[447.253046] Dynamic subtest D-eDP1: SUCCESS (1.620s)
[447.267489] Starting dynamic subtest: A-DP6
[448.381558] Dynamic subtest A-DP6: SUCCESS (1.130s)
[448.395026] Starting dynamic subtest: B-DP6
[449.391889] Dynamic subtest B-DP6: SUCCESS (1.008s)
[449.404590] Starting dynamic subtest: C-DP6
[450.391929] Dynamic subtest C-DP6: SUCCESS (0.993s)
[450.405641] Starting dynamic subtest: D-DP6
[451.380006] Dynamic subtest D-DP6: SUCCESS (0.987s)
[451.391980] Starting dynamic subtest: A-DP7
[452.385910] Dynamic subtest A-DP7: SUCCESS (1.008s)
[452.398107] Starting dynamic subtest: B-DP7
[453.412927] Dynamic subtest B-DP7: SUCCESS (1.025s)
[453.426491] Starting dynamic subtest: C-DP7
[454.397287] Dynamic subtest C-DP7: SUCCESS (0.982s)
[454.411225] Starting dynamic subtest: D-DP7
[455.397918] Dynamic subtest D-DP7: SUCCESS (0.993s)
[455.403377] Subtest basic-plain-flip: SUCCESS (14.935s)
[456.272257] [109/162] (546s left) kms_force_connector_basic (force-connector-state)
[456.355409] Starting subtest: force-connector-state
[458.052731] Subtest force-connector-state: SUCCESS (1.695s)
[459.375717] [110/162] (543s left) kms_force_connector_basic (force-edid)
[459.457251] Starting subtest: force-edid
[459.748199] Subtest force-edid: SUCCESS (0.291s)
[460.218896] [111/162] (542s left) kms_force_connector_basic (force-load-detect)
[460.304501] Starting subtest: force-load-detect
[460.315557] Subtest force-load-detect: SKIP (0.000s)
[460.610445] [112/162] (542s left) kms_force_connector_basic (prune-stale-modes)
[460.680852] Starting subtest: prune-stale-modes
[461.040069] Subtest prune-stale-modes: SUCCESS (0.362s)
[461.562209] [113/162] (541s left) kms_frontbuffer_tracking (basic)
[461.918669] Starting subtest: basic
[466.057998] Subtest basic: SUCCESS (4.153s)
[466.564077] [114/162] (536s left) kms_hdmi_inject (inject-audio)
[467.654690] Starting subtest: inject-audio
[467.911294] Subtest inject-audio: SUCCESS (0.256s)
[468.918296] [115/162] (534s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[469.215791] Starting subtest: compare-crc-sanitycheck-xr24
[469.221307] Starting dynamic subtest: pipe-A-eDP-1
[470.726586] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.509s)
[470.740577] Starting dynamic subtest: pipe-B-DP-6
[471.390513] Dynamic subtest pipe-B-DP-6: SUCCESS (0.667s)
[471.403818] Starting dynamic subtest: pipe-C-DP-7
[472.018484] Dynamic subtest pipe-C-DP-7: SUCCESS (0.626s)
[472.031390] Starting dynamic subtest: pipe-D-DP-6
[472.661100] Dynamic subtest pipe-D-DP-6: SUCCESS (0.638s)
[472.666524] Subtest compare-crc-sanitycheck-xr24: SUCCESS (3.445s)
[473.384844] [116/162] (529s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12)
[473.688675] Starting subtest: compare-crc-sanitycheck-nv12
[473.694620] Starting dynamic subtest: pipe-A-eDP-1
[475.332479] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.638s)
[475.346662] Starting dynamic subtest: pipe-B-DP-6
[476.014792] Dynamic subtest pipe-B-DP-6: SUCCESS (0.685s)
[476.028673] Starting dynamic subtest: pipe-C-DP-7
[476.667183] Dynamic subtest pipe-C-DP-7: SUCCESS (0.652s)
[476.679379] Starting dynamic subtest: pipe-D-DP-6
[477.321982] Dynamic subtest pipe-D-DP-6: SUCCESS (0.652s)
[477.327412] Subtest compare-crc-sanitycheck-nv12: SUCCESS (3.633s)
[478.041468] [117/162] (525s left) kms_pipe_crc_basic (hang-read-crc)
[478.346669] Starting subtest: hang-read-crc
[478.352204] Starting dynamic subtest: pipe-A-eDP-1
[481.428497] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.076s)
[481.442908] Starting dynamic subtest: pipe-B-DP-6
[483.167480] Dynamic subtest pipe-B-DP-6: SUCCESS (1.738s)
[483.181456] Starting dynamic subtest: pipe-C-DP-7
[484.828965] Dynamic subtest pipe-C-DP-7: SUCCESS (1.663s)
[484.843406] Starting dynamic subtest: pipe-D-DP-6
[486.474620] Dynamic subtest pipe-D-DP-6: SUCCESS (1.644s)
[486.480134] Subtest hang-read-crc: SUCCESS (8.127s)
[487.288738] [118/162] (515s left) kms_pipe_crc_basic (nonblocking-crc)
[487.580172] Starting subtest: nonblocking-crc
[487.585637] Starting dynamic subtest: pipe-A-eDP-1
[489.294666] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.708s)
[489.311639] Starting dynamic subtest: pipe-B-DP-6
[490.148242] Dynamic subtest pipe-B-DP-6: SUCCESS (0.857s)
[490.160562] Starting dynamic subtest: pipe-C-DP-7
[490.954064] Dynamic subtest pipe-C-DP-7: SUCCESS (0.802s)
[490.967100] Starting dynamic subtest: pipe-D-DP-6
[491.759143] Dynamic subtest pipe-D-DP-6: SUCCESS (0.806s)
[491.764547] Subtest nonblocking-crc: SUCCESS (4.180s)
[492.504455] [119/162] (510s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence)
[492.794079] Starting subtest: nonblocking-crc-frame-sequence
[492.799577] Starting dynamic subtest: pipe-A-eDP-1
[494.457567] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.660s)
[494.470012] Starting dynamic subtest: pipe-B-DP-6
[495.313621] Dynamic subtest pipe-B-DP-6: SUCCESS (0.858s)
[495.326851] Starting dynamic subtest: pipe-C-DP-7
[496.125660] Dynamic subtest pipe-C-DP-7: SUCCESS (0.808s)
[496.139858] Starting dynamic subtest: pipe-D-DP-6
[496.927969] Dynamic subtest pipe-D-DP-6: SUCCESS (0.803s)
[496.933351] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.136s)
[497.749767] [120/162] (505s left) kms_pipe_crc_basic (read-crc)
[498.048938] Starting subtest: read-crc
[498.054345] Starting dynamic subtest: pipe-A-eDP-1
[499.674689] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.618s)
[499.694489] Starting dynamic subtest: pipe-B-DP-6
[500.450029] Dynamic subtest pipe-B-DP-6: SUCCESS (0.784s)
[500.462532] Starting dynamic subtest: pipe-C-DP-7
[501.191024] Dynamic subtest pipe-C-DP-7: SUCCESS (0.740s)
[501.203814] Starting dynamic subtest: pipe-D-DP-6
[501.932468] Dynamic subtest pipe-D-DP-6: SUCCESS (0.736s)
[501.938043] Subtest read-crc: SUCCESS (3.884s)
[502.761975] [121/162] (500s left) kms_pipe_crc_basic (read-crc-frame-sequence)
[503.051717] Starting subtest: read-crc-frame-sequence
[503.057139] Starting dynamic subtest: pipe-A-eDP-1
[504.666431] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.617s)
[504.680208] Starting dynamic subtest: pipe-B-DP-6
[505.460183] Dynamic subtest pipe-B-DP-6: SUCCESS (0.787s)
[505.472891] Starting dynamic subtest: pipe-C-DP-7
[506.193200] Dynamic subtest pipe-C-DP-7: SUCCESS (0.733s)
[506.205279] Starting dynamic subtest: pipe-D-DP-6
[506.935286] Dynamic subtest pipe-D-DP-6: SUCCESS (0.743s)
[506.940792] Subtest read-crc-frame-sequence: SUCCESS (3.886s)
[507.735994] [122/162] (495s left) kms_pm_backlight (basic-brightness)
[508.040619] Starting subtest: basic-brightness
[508.373930] Starting dynamic subtest: eDP-1
[508.693214] Dynamic subtest eDP-1: SUCCESS (0.317s)
[508.698717] Subtest basic-brightness: SUCCESS (0.655s)
[509.985418] [123/162] (493s left) kms_pm_rpm (basic-pci-d3-state)
[513.899393] Starting subtest: basic-pci-d3-state
[515.471069] Subtest basic-pci-d3-state: SUCCESS (1.575s)
[516.043227] [124/162] (487s left) kms_pm_rpm (basic-rte)
[516.085017] Starting subtest: basic-rte
[521.675755] Subtest basic-rte: SUCCESS (5.592s)
[524.139702] [125/162] (479s left) kms_psr (psr-primary-page-flip)
[524.446198] Starting subtest: psr-primary-page-flip
[524.451721] Starting dynamic subtest: eDP-1
[526.558923] Dynamic subtest eDP-1: SUCCESS (2.110s)
[526.564415] Subtest psr-primary-page-flip: SUCCESS (2.112s)
[527.699717] [126/162] (475s left) kms_psr (psr-cursor-plane-move)
[527.995235] Starting subtest: psr-cursor-plane-move
[528.000775] Starting dynamic subtest: eDP-1
[530.155909] Dynamic subtest eDP-1: SUCCESS (2.159s)
[530.161655] Subtest psr-cursor-plane-move: SUCCESS (2.160s)
[531.293362] [127/162] (472s left) kms_psr (psr-sprite-plane-onoff)
[531.594565] Starting subtest: psr-sprite-plane-onoff
[531.600111] Starting dynamic subtest: eDP-1
[533.802518] Dynamic subtest eDP-1: SUCCESS (2.208s)
[533.807922] Subtest psr-sprite-plane-onoff: SUCCESS (2.209s)
[535.088779] [128/162] (468s left) kms_psr (psr-primary-mmap-gtt)
[535.376633] Starting subtest: psr-primary-mmap-gtt
[535.382085] Starting dynamic subtest: eDP-1
[537.254925] Dynamic subtest eDP-1: SKIP (1.867s)
[537.265953] Subtest psr-primary-mmap-gtt: SKIP (1.870s)
[537.781340] [129/162] (465s left) kms_setmode (basic-clone-single-crtc)
[537.847584] Starting subtest: basic-clone-single-crtc
[539.055558] Subtest basic-clone-single-crtc: SKIP (1.202s)
[539.869574] [130/162] (463s left) i915_pm_rps (basic-api)
[539.939444] Starting subtest: basic-api
[539.950487] Subtest basic-api: SKIP (0.001s)
[540.081332] [131/162] (463s left) prime_self_import (basic-llseek-bad)
[540.126165] Starting subtest: basic-llseek-bad
[540.153567] Subtest basic-llseek-bad: SUCCESS (0.027s)
[540.275071] [132/162] (463s left) prime_self_import (basic-llseek-size)
[540.318797] Starting subtest: basic-llseek-size
[540.335945] Subtest basic-llseek-size: SUCCESS (0.016s)
[540.455612] [133/162] (463s left) prime_self_import (basic-with_fd_dup)
[540.504884] Starting subtest: basic-with_fd_dup
[540.515800] Subtest basic-with_fd_dup: SUCCESS (0.020s)
[540.647208] [134/162] (463s left) prime_self_import (basic-with_one_bo)
[540.694828] Starting subtest: basic-with_one_bo
[540.711362] Subtest basic-with_one_bo: SUCCESS (0.025s)
[540.857881] [135/162] (463s left) prime_self_import (basic-with_one_bo_two_files)
[540.905934] Starting subtest: basic-with_one_bo_two_files
[540.931555] Subtest basic-with_one_bo_two_files: SUCCESS (0.026s)
[541.063323] [136/162] (462s left) prime_self_import (basic-with_two_bos)
[541.113748] Starting subtest: basic-with_two_bos
[541.125466] Subtest basic-with_two_bos: SUCCESS (0.022s)
[541.244137] [137/162] (462s left) prime_vgem (basic-fence-flip)
[541.326569] Starting subtest: basic-fence-flip
[541.826749] Subtest basic-fence-flip: SUCCESS (0.502s)
[541.960366] [138/162] (462s left) prime_vgem (basic-fence-mmap)
[542.036262] Starting subtest: basic-fence-mmap
[542.046858] Subtest basic-fence-mmap: SKIP (0.000s)
[542.165582] [139/162] (461s left) prime_vgem (basic-fence-read)
[542.247582] Starting subtest: basic-fence-read
[542.258764] Subtest basic-fence-read: SKIP (0.006s)
[542.387915] [140/162] (461s left) prime_vgem (basic-gtt)
[542.472681] Starting subtest: basic-gtt
[542.483579] Subtest basic-gtt: SKIP (0.000s)
[542.609217] [141/162] (461s left) prime_vgem (basic-read)
[542.706108] Starting subtest: basic-read
[542.717694] Subtest basic-read: SKIP (0.005s)
[542.825693] [142/162] (461s left) prime_vgem (basic-write)
[542.905083] Starting subtest: basic-write
[542.918384] Subtest basic-write: SKIP (0.003s)
[543.022508] [143/162] (461s left) vgem_basic (setversion)
[543.073980] Starting subtest: setversion
[543.084810] Subtest setversion: SUCCESS (0.000s)
[543.141675] [144/162] (461s left) vgem_basic (create)
[543.206901] Starting subtest: create
[543.212372] Subtest create: SUCCESS (0.000s)
[543.273697] [145/162] (461s left) vgem_basic (debugfs)
[543.338407] Starting subtest: debugfs
[543.345174] Subtest debugfs: SUCCESS (0.000s)
[543.418968] [146/162] (461s left) vgem_basic (dmabuf-export)
[543.474968] Starting subtest: dmabuf-export
[543.499418] Subtest dmabuf-export: SUCCESS (0.027s)
[543.616424] [147/162] (460s left) vgem_basic (dmabuf-fence)
[543.675415] Starting subtest: dmabuf-fence
[543.680887] Subtest dmabuf-fence: SUCCESS (0.001s)
[543.749455] [148/162] (460s left) vgem_basic (dmabuf-fence-before)
[543.805296] Starting subtest: dmabuf-fence-before
[543.810714] Subtest dmabuf-fence-before: SUCCESS (0.000s)
[543.882827] [149/162] (460s left) vgem_basic (dmabuf-mmap)
[543.940638] Starting subtest: dmabuf-mmap
[543.946131] Subtest dmabuf-mmap: SUCCESS (0.008s)
[544.003789] [150/162] (460s left) vgem_basic (mmap)
[544.059011] Starting subtest: mmap
[544.064474] Subtest mmap: SUCCESS (0.005s)
[544.121129] [151/162] (460s left) vgem_basic (second-client)
[544.187819] Starting subtest: second-client
[544.222305] Subtest second-client: SUCCESS (0.035s)
[544.293347] [152/162] (460s left) vgem_basic (sysfs)
[544.355644] Starting subtest: sysfs
[544.361104] Subtest sysfs: SUCCESS (0.000s)
[544.431726] [153/162] (460s left) core_hotunplug (unbind-rebind)
[544.543943] Starting subtest: unbind-rebind
[552.315635] Subtest unbind-rebind: SUCCESS (7.776s)
[552.365322] [154/162] (452s left) vgem_basic (unload)
[552.413172] Starting subtest: unload
[581.477309] Subtest unload: SUCCESS (29.064s)
[581.605322] [155/162] (423s left) i915_module_load (reload)
[581.650056] Starting subtest: reload
[585.702925] Subtest reload: SUCCESS (4.051s)
[585.751643] [156/162] (419s left) gem_lmem_swapping (basic)
[585.816729] Subtest basic: SKIP (0.000s)
[585.864088] [157/162] (419s left) gem_lmem_swapping (parallel-random-engines)
[585.917841] Subtest parallel-random-engines: SKIP (0.000s)
[585.987348] [158/162] (419s left) gem_lmem_swapping (random-engines)
[586.041866] Subtest random-engines: SKIP (0.000s)
[586.086906] [159/162] (418s left) gem_lmem_swapping (verify-random)
[586.142253] Subtest verify-random: SKIP (0.000s)
[586.189144] [160/162] (418s left) i915_pm_rpm (module-reload)
[590.674477] Starting subtest: module-reload
[609.691685] Subtest module-reload: SUCCESS (19.010s)
[609.726317] [FACT i915_pm_rpm (module-reload)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[609.726980] [FACT i915_pm_rpm (module-reload)] deleted: kernel.kmod_is_loaded.i915: true
[609.736234] [161/162] (395s left) i915_selftest (live)
[609.792962] Starting subtest: live
[609.798728] Starting dynamic subtest: sanitycheck
[614.129507] Dynamic subtest sanitycheck: SUCCESS (4.331s)
[614.140895] Starting dynamic subtest: uncore
[618.370250] Dynamic subtest uncore: SUCCESS (4.240s)
[618.382835] Starting dynamic subtest: workarounds
[639.639644] Dynamic subtest workarounds: FAIL (20.288s)
[639.651633] Starting dynamic subtest: gt_engines
[643.231726] Dynamic subtest gt_engines: SUCCESS (4.569s)
[643.243929] Starting dynamic subtest: gt_timelines
[660.643248] Dynamic subtest gt_timelines: SUCCESS (17.409s)
[660.655464] Starting dynamic subtest: gt_contexts
[664.969661] Dynamic subtest gt_contexts: SUCCESS (4.324s)
[664.982040] Starting dynamic subtest: gt_lrc
[671.109358] Dynamic subtest gt_lrc: SUCCESS (6.138s)
[671.122100] Starting dynamic subtest: gt_mocs
[674.056749] Dynamic subtest gt_mocs: SUCCESS (2.946s)
[674.067720] Starting dynamic subtest: gt_pm
[680.810314] Dynamic subtest gt_pm: SUCCESS (6.748s)
[680.823024] Starting dynamic subtest: gt_heartbeat
[685.081495] Dynamic subtest gt_heartbeat: SUCCESS (4.273s)
[685.093857] Starting dynamic subtest: gt_tlb
[694.837440] Dynamic subtest gt_tlb: SUCCESS (9.754s)
[694.850462] Starting dynamic subtest: requests
[706.338967] Dynamic subtest requests: SUCCESS (11.500s)
[706.351467] Starting dynamic subtest: migrate
[714.013076] Dynamic subtest migrate: SUCCESS (7.672s)
[714.025332] Starting dynamic subtest: active
[718.341516] Dynamic subtest active: SUCCESS (4.327s)
[718.354199] Starting dynamic subtest: objects
[723.055835] Dynamic subtest objects: SUCCESS (4.709s)
[723.071390] Starting dynamic subtest: mman
[727.821387] Dynamic subtest mman: SUCCESS (4.767s)
[727.832955] Starting dynamic subtest: dmabuf
[732.264766] Dynamic subtest dmabuf: SUCCESS (4.442s)
[732.277143] Starting dynamic subtest: vma
[736.547943] Dynamic subtest vma: SUCCESS (4.282s)
[736.560817] Starting dynamic subtest: coherency
[741.662541] Dynamic subtest coherency: SUCCESS (5.112s)
[741.675023] Starting dynamic subtest: gtt
[751.059242] Dynamic subtest gtt: SUCCESS (9.392s)
[751.071664] Starting dynamic subtest: gem
[758.601949] Dynamic subtest gem: SUCCESS (7.544s)
[758.614431] Starting dynamic subtest: evict
[764.020566] Dynamic subtest evict: SUCCESS (5.424s)
[764.033141] Starting dynamic subtest: hugepages
[774.825112] Dynamic subtest hugepages: SUCCESS (10.795s)
[774.837812] Starting dynamic subtest: gem_contexts
[802.760234] Dynamic subtest gem_contexts: SUCCESS (27.933s)
[802.774308] Starting dynamic subtest: client
[807.168787] Dynamic subtest client: SUCCESS (4.408s)
[807.181769] Starting dynamic subtest: gem_migrate
[811.517324] Dynamic subtest gem_migrate: SUCCESS (4.346s)
[811.529924] Starting dynamic subtest: reset
[814.296166] Dynamic subtest reset: SUCCESS (2.777s)
[814.309105] Starting dynamic subtest: memory_region
[818.622073] Dynamic subtest memory_region: SUCCESS (4.324s)
[818.635977] Starting dynamic subtest: hangcheck
[831.567514] Dynamic subtest hangcheck: SUCCESS (12.942s)
[831.580580] Starting dynamic subtest: execlists
[835.892222] Dynamic subtest execlists: SUCCESS (4.321s)
[835.904886] Starting dynamic subtest: ring_submission
[840.197773] Dynamic subtest ring_submission: SUCCESS (4.306s)
[840.210069] Starting dynamic subtest: perf
[844.547499] Dynamic subtest perf: SUCCESS (4.349s)
[844.560119] Starting dynamic subtest: slpc
[858.504842] Dynamic subtest slpc: SUCCESS (13.950s)
[858.520620] Starting dynamic subtest: guc
[862.498333] Dynamic subtest guc: SUCCESS (3.997s)
[862.509437] Starting dynamic subtest: guc_multi_lrc
[866.805689] Dynamic subtest guc_multi_lrc: SUCCESS (4.305s)
[866.818371] Starting dynamic subtest: guc_hang
[871.634599] Dynamic subtest guc_hang: SUCCESS (4.827s)
[871.647035] Starting dynamic subtest: late_gt_pm
[875.984817] Dynamic subtest late_gt_pm: SUCCESS (4.349s)
[875.990490] Subtest live: FAIL (266.177s)
[876.030233] [162/162] (129s left) dmabuf (all-tests)
[876.073532] Starting subtest: all-tests
[876.079127] Starting dynamic subtest: sanitycheck
[876.147023] Dynamic subtest sanitycheck: SUCCESS (0.076s)
[876.161113] Starting dynamic subtest: dma_fence
[876.348580] Dynamic subtest dma_fence: SUCCESS (0.199s)
[876.361257] Starting dynamic subtest: dma_fence_chain
[885.730184] Dynamic subtest dma_fence_chain: SUCCESS (9.372s)
[885.743346] Starting dynamic subtest: dma_fence_unwrap
[885.812268] Dynamic subtest dma_fence_unwrap: SUCCESS (0.088s)
[885.822954] Starting dynamic subtest: dma_resv
[885.896801] Dynamic subtest dma_resv: SUCCESS (0.082s)
[885.902394] Subtest all-tests: SUCCESS (9.826s)
[885.934897] Closing watchdogs
results: parsing output: 0/ for test: i915_module_load
results: parsing output: 1/ for test: core_auth
results: parsing output: 2/ for test: core_debugfs
results: parsing output: 3/ for test: core_sysfs
results: parsing output: 4/ for test: fbdev
results: parsing output: 5/ for test: fbdev
results: parsing output: 6/ for test: fbdev
results: parsing output: 7/ for test: fbdev
results: parsing output: 8/ for test: fbdev
results: parsing output: 9/ for test: gem_basic
results: parsing output: 10/ for test: gem_basic
results: parsing output: 11/ for test: gem_basic
results: parsing output: 12/ for test: gem_busy
results: parsing output: 13/ for test: gem_close_race
results: parsing output: 14/ for test: gem_close_race
results: parsing output: 15/ for test: gem_ctx_create
results: parsing output: 16/ for test: gem_ctx_create
results: parsing output: 17/ for test: gem_ctx_exec
results: parsing output: 18/ for test: gem_exec_basic
results: parsing output: 19/ for test: gem_exec_create
results: parsing output: 20/ for test: gem_exec_fence
results: parsing output: 21/ for test: gem_exec_fence
results: parsing output: 22/ for test: gem_exec_fence
results: parsing output: 23/ for test: gem_exec_fence
results: parsing output: 24/ for test: gem_exec_gttfill
results: parsing output: 25/ for test: gem_exec_parallel
results: parsing output: 26/ for test: gem_exec_store
results: parsing output: 27/ for test: gem_flink_basic
results: parsing output: 28/ for test: gem_flink_basic
results: parsing output: 29/ for test: gem_flink_basic
results: parsing output: 30/ for test: gem_flink_basic
results: parsing output: 31/ for test: gem_flink_basic
results: parsing output: 32/ for test: gem_huc_copy
results: parsing output: 33/ for test: gem_linear_blits
results: parsing output: 34/ for test: gem_mmap
results: parsing output: 35/ for test: gem_mmap_gtt
results: parsing output: 36/ for test: gem_render_linear_blits
results: parsing output: 37/ for test: gem_render_tiled_blits
results: parsing output: 38/ for test: gem_ringfill
results: parsing output: 39/ for test: gem_softpin
results: parsing output: 40/ for test: gem_softpin
results: parsing output: 41/ for test: gem_softpin
results: parsing output: 42/ for test: gem_sync
results: parsing output: 43/ for test: gem_sync
results: parsing output: 44/ for test: gem_tiled_blits
results: parsing output: 45/ for test: gem_tiled_fence_blits
results: parsing output: 46/ for test: gem_tiled_pread_basic
results: parsing output: 47/ for test: gem_wait
results: parsing output: 48/ for test: gem_wait
results: parsing output: 49/ for test: i915_getparams_basic
results: parsing output: 50/ for test: i915_getparams_basic
results: parsing output: 51/ for test: i915_hangman
results: parsing output: 52/ for test: i915_pciid
results: parsing output: 53/ for test: intel_hwmon
results: parsing output: 54/ for test: intel_hwmon
results: parsing output: 55/ for test: kms_addfb_basic
results: parsing output: 56/ for test: kms_addfb_basic
results: parsing output: 57/ for test: kms_addfb_basic
results: parsing output: 58/ for test: kms_addfb_basic
results: parsing output: 59/ for test: kms_addfb_basic
results: parsing output: 60/ for test: kms_addfb_basic
results: parsing output: 61/ for test: kms_addfb_basic
results: parsing output: 62/ for test: kms_addfb_basic
results: parsing output: 63/ for test: kms_addfb_basic
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: kms_addfb_basic
results: parsing output: 66/ for test: kms_addfb_basic
results: parsing output: 67/ for test: kms_addfb_basic
results: parsing output: 68/ for test: kms_addfb_basic
results: parsing output: 69/ for test: kms_addfb_basic
results: parsing output: 70/ for test: kms_addfb_basic
results: parsing output: 71/ for test: kms_addfb_basic
results: parsing output: 72/ for test: kms_addfb_basic
results: parsing output: 73/ for test: kms_addfb_basic
results: parsing output: 74/ for test: kms_addfb_basic
results: parsing output: 75/ for test: kms_addfb_basic
results: parsing output: 76/ for test: kms_addfb_basic
results: parsing output: 77/ for test: kms_addfb_basic
results: parsing output: 78/ for test: kms_addfb_basic
results: parsing output: 79/ for test: kms_addfb_basic
results: parsing output: 80/ for test: kms_addfb_basic
results: parsing output: 81/ for test: kms_addfb_basic
results: parsing output: 82/ for test: kms_addfb_basic
results: parsing output: 83/ for test: kms_addfb_basic
results: parsing output: 84/ for test: kms_addfb_basic
results: parsing output: 85/ for test: kms_addfb_basic
results: parsing output: 86/ for test: kms_addfb_basic
results: parsing output: 87/ for test: kms_addfb_basic
results: parsing output: 88/ for test: kms_addfb_basic
results: parsing output: 89/ for test: kms_addfb_basic
results: parsing output: 90/ for test: kms_addfb_basic
results: parsing output: 91/ for test: kms_addfb_basic
results: parsing output: 92/ for test: kms_addfb_basic
results: parsing output: 93/ for test: kms_busy
results: parsing output: 94/ for test: kms_prop_blob
results: parsing output: 95/ for test: kms_cursor_legacy
results: parsing output: 96/ for test: kms_cursor_legacy
results: parsing output: 97/ for test: kms_cursor_legacy
results: parsing output: 98/ for test: kms_cursor_legacy
results: parsing output: 99/ for test: kms_cursor_legacy
results: parsing output: 100/ for test: kms_cursor_legacy
results: parsing output: 101/ for test: kms_cursor_legacy
results: parsing output: 102/ for test: kms_cursor_legacy
results: parsing output: 103/ for test: kms_dsc
results: parsing output: 104/ for test: kms_flip
results: parsing output: 105/ for test: kms_flip
results: parsing output: 106/ for test: kms_flip
results: parsing output: 107/ for test: kms_flip
results: parsing output: 108/ for test: kms_force_connector_basic
results: parsing output: 109/ for test: kms_force_connector_basic
results: parsing output: 110/ for test: kms_force_connector_basic
results: parsing output: 111/ for test: kms_force_connector_basic
results: parsing output: 112/ for test: kms_frontbuffer_tracking
results: parsing output: 113/ for test: kms_hdmi_inject
results: parsing output: 114/ for test: kms_pipe_crc_basic
results: parsing output: 115/ for test: kms_pipe_crc_basic
results: parsing output: 116/ for test: kms_pipe_crc_basic
results: parsing output: 117/ for test: kms_pipe_crc_basic
results: parsing output: 118/ for test: kms_pipe_crc_basic
results: parsing output: 119/ for test: kms_pipe_crc_basic
results: parsing output: 120/ for test: kms_pipe_crc_basic
results: parsing output: 121/ for test: kms_pm_backlight
results: parsing output: 122/ for test: kms_pm_rpm
results: parsing output: 123/ for test: kms_pm_rpm
results: parsing output: 124/ for test: kms_psr
results: parsing output: 125/ for test: kms_psr
results: parsing output: 126/ for test: kms_psr
results: parsing output: 127/ for test: kms_psr
results: parsing output: 128/ for test: kms_setmode
results: parsing output: 129/ for test: i915_pm_rps
results: parsing output: 130/ for test: prime_self_import
results: parsing output: 131/ for test: prime_self_import
results: parsing output: 132/ for test: prime_self_import
results: parsing output: 133/ for test: prime_self_import
results: parsing output: 134/ for test: prime_self_import
results: parsing output: 135/ for test: prime_self_import
results: parsing output: 136/ for test: prime_vgem
results: parsing output: 137/ for test: prime_vgem
results: parsing output: 138/ for test: prime_vgem
results: parsing output: 139/ for test: prime_vgem
results: parsing output: 140/ for test: prime_vgem
results: parsing output: 141/ for test: prime_vgem
results: parsing output: 142/ for test: vgem_basic
results: parsing output: 143/ for test: vgem_basic
results: parsing output: 144/ for test: vgem_basic
results: parsing output: 145/ for test: vgem_basic
results: parsing output: 146/ for test: vgem_basic
results: parsing output: 147/ for test: vgem_basic
results: parsing output: 148/ for test: vgem_basic
results: parsing output: 149/ for test: vgem_basic
results: parsing output: 150/ for test: vgem_basic
results: parsing output: 151/ for test: vgem_basic
results: parsing output: 152/ for test: core_hotunplug
results: parsing output: 153/ for test: vgem_basic
results: parsing output: 154/ for test: i915_module_load
results: parsing output: 155/ for test: gem_lmem_swapping
results: parsing output: 156/ for test: gem_lmem_swapping
results: parsing output: 157/ for test: gem_lmem_swapping
results: parsing output: 158/ for test: gem_lmem_swapping
results: parsing output: 159/ for test: i915_pm_rpm
results: parsing output: 160/ for test: i915_selftest
results: parsing output: 161/ for test: dmabuf
Done.