[56.509281] Initializing watchdogs [56.509329] /dev/watchdog0 [56.524066] [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] [56.528479] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [56.530706] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [56.533895] [001/131] (960s left) syncobj_timeline (etime-single-wait-all-for-submit-available-unsubmitted) [56.647876] Starting subtest: etime-single-wait-all-for-submit-available-unsubmitted [56.749858] Subtest etime-single-wait-all-for-submit-available-unsubmitted: SUCCESS (0.102s) [56.830688] [002/131] (960s left) gem_exec_balancer (invalid-balancer) [56.895501] Starting subtest: invalid-balancer [57.611746] Subtest invalid-balancer: SUCCESS (0.715s) [57.873788] [003/131] (959s left) kms_cursor_crc (cursor-onscreen-128x42) [58.080321] Starting subtest: cursor-onscreen-128x42 [58.121714] Subtest cursor-onscreen-128x42: SKIP (0.037s) [58.310752] [004/131] (958s left) syncobj_timeline (single-wait-all-for-submit-available-signaled) [58.379645] Starting subtest: single-wait-all-for-submit-available-signaled [58.381902] Subtest single-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [58.477395] [005/131] (958s left) syncobj_timeline (wait-any-interrupted) [58.537027] Starting subtest: wait-any-interrupted [58.646546] Subtest wait-any-interrupted: SUCCESS (0.109s) [58.711964] [006/131] (958s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [58.759138] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [58.862823] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.104s) [58.930607] [007/131] (958s left) fbdev (pan) [58.963454] Starting subtest: pan [58.986911] Subtest pan: SUCCESS (0.025s) [59.048070] [008/131] (958s left) gem_render_copy_redux (interruptible) [59.107526] Starting subtest: interruptible [59.476447] Subtest interruptible: SUCCESS (0.369s) [59.586215] [009/131] (957s left) kms_big_fb (x-tiled-16bpp-rotate-180) [59.699755] Starting subtest: x-tiled-16bpp-rotate-180 [61.060476] Subtest x-tiled-16bpp-rotate-180: SUCCESS (1.362s) [61.185256] [010/131] (956s left) kms_pm_backlight (fade-with-suspend) [61.287343] Starting subtest: fade-with-suspend [77.603630] Starting dynamic subtest: eDP-1 [80.273210] Dynamic subtest eDP-1: SUCCESS (2.670s) [80.275157] Subtest fade-with-suspend: SUCCESS (3.945s) [81.062320] [011/131] (951s left) kms_ccs (crc-primary-suspend-4-tiled-mtl-rc-ccs-cc) [81.160456] Starting subtest: crc-primary-suspend-4-tiled-mtl-rc-ccs-cc [81.163430] Starting dynamic subtest: pipe-A-eDP-1 [97.809300] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.366s) [97.821037] Starting dynamic subtest: pipe-B-eDP-1 [114.686125] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.357s) [114.694209] Starting dynamic subtest: pipe-C-eDP-1 [131.667030] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.810s) [131.676173] Starting dynamic subtest: pipe-D-eDP-1 [148.656574] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.190s) [148.659072] Subtest crc-primary-suspend-4-tiled-mtl-rc-ccs-cc: SUCCESS (8.725s) [149.856917] [012/131] (941s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-move) [149.962612] Starting subtest: fbc-2p-primscrn-spr-indfb-move [149.967154] Subtest fbc-2p-primscrn-spr-indfb-move: SKIP (0.000s) [150.047433] [013/131] (941s left) syncobj_wait (wait-all-for-submit-delayed-submit) [150.101541] Starting subtest: wait-all-for-submit-delayed-submit [150.205279] Subtest wait-all-for-submit-delayed-submit: SUCCESS (0.104s) [150.272944] [014/131] (940s left) gem_exec_fence (syncobj-timeline-unused-fence) [150.820883] Starting subtest: syncobj-timeline-unused-fence [150.826009] Subtest syncobj-timeline-unused-fence: SUCCESS (0.006s) [151.785090] [FACT gem_exec_fence (syncobj-timeline-unused-fence)] new: kernel.kmod_is_loaded.vgem: true [151.788003] [015/131] (939s left) perf (buffer-fill) [151.894949] Starting subtest: buffer-fill [151.897167] Starting dynamic subtest: 0-rcs0 [154.199914] Dynamic subtest 0-rcs0: SUCCESS (2.303s) [154.207363] Starting dynamic subtest: 1-vecs0 [158.627072] Dynamic subtest 1-vecs0: SUCCESS (4.426s) [158.629505] Subtest buffer-fill: SUCCESS (6.730s) [158.669047] [016/131] (932s left) gem_mmap_gtt (pf-nonblock) [158.733909] Subtest pf-nonblock: SKIP (0.000s) [158.797968] [017/131] (932s left) i915_query (query-topology-known-pci-ids) [158.850177] Starting subtest: query-topology-known-pci-ids [158.854515] Subtest query-topology-known-pci-ids: SKIP (0.000s) [158.959095] [018/131] (932s left) gen7_exec_parse (basic-offset) [159.029557] Subtest basic-offset: SKIP (0.000s) [159.115569] [019/131] (932s left) kms_frontbuffer_tracking (fbc-indfb-scaledprimary) [159.222753] Starting subtest: fbc-indfb-scaledprimary [163.263868] Subtest fbc-indfb-scaledprimary: SUCCESS (4.043s) [163.393943] [020/131] (928s left) kms_cursor_edge_walk (256x256-top-edge) [163.493787] Starting subtest: 256x256-top-edge [163.496496] Starting dynamic subtest: pipe-A-eDP-1 [166.950796] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.455s) [166.959505] Starting dynamic subtest: pipe-D-eDP-1 [170.046504] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.094s) [170.048680] Subtest 256x256-top-edge: SUCCESS (6.551s) [170.866610] [021/131] (920s left) gem_eio (in-flight-contexts-10ms) [171.071517] Starting subtest: in-flight-contexts-10ms [182.730776] Subtest in-flight-contexts-10ms: SUCCESS (11.655s) [182.910362] [022/131] (908s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180) [183.012725] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180 [183.989803] Subtest x-tiled-max-hw-stride-32bpp-rotate-180: SUCCESS (0.978s) [184.119307] [023/131] (907s left) prime_self_import (basic-llseek-bad) [184.153823] Starting subtest: basic-llseek-bad [184.185192] Subtest basic-llseek-bad: SUCCESS (0.031s) [184.273071] [024/131] (907s left) kms_plane_scaling (planes-downscale-factor-0-5) [184.358324] Starting subtest: planes-downscale-factor-0-5 [184.360306] Starting dynamic subtest: pipe-A [184.369089] Dynamic subtest pipe-A: SKIP (0.005s) [184.378068] Starting dynamic subtest: pipe-B [184.385835] Dynamic subtest pipe-B: SKIP (0.015s) [184.393829] Starting dynamic subtest: pipe-C [184.401943] Dynamic subtest pipe-C: SKIP (0.015s) [184.409656] Starting dynamic subtest: pipe-D [184.416686] Dynamic subtest pipe-D: SKIP (0.016s) [184.420023] Subtest planes-downscale-factor-0-5: SKIP (0.052s) [184.511124] [025/131] (907s left) prime_vgem (wait) [184.585505] Starting subtest: wait [184.587557] Starting dynamic subtest: rcs0 [184.658854] Dynamic subtest rcs0: SUCCESS (0.073s) [184.666363] Starting dynamic subtest: bcs0 [184.730908] Dynamic subtest bcs0: SUCCESS (0.072s) [184.737912] Starting dynamic subtest: vcs0 [184.782127] Dynamic subtest vcs0: SUCCESS (0.051s) [184.789319] Starting dynamic subtest: vcs1 [184.827610] Dynamic subtest vcs1: SUCCESS (0.045s) [184.834854] Starting dynamic subtest: vecs0 [184.873621] Dynamic subtest vecs0: SUCCESS (0.046s) [184.880889] Starting dynamic subtest: ccs0 [184.919190] Dynamic subtest ccs0: SUCCESS (0.045s) [184.921163] Subtest wait: SUCCESS (0.334s) [185.054631] [026/131] (906s left) kms_content_protection (type1) [185.231199] Starting subtest: type1 [188.604860] Subtest type1: SKIP (3.372s) [189.779621] [027/131] (901s left) perf_pmu (busy-check-all) [189.819932] Starting subtest: busy-check-all [189.822186] Starting dynamic subtest: rcs0 [190.393195] Dynamic subtest rcs0: SUCCESS (0.572s) [190.404636] Starting dynamic subtest: bcs0 [190.945314] Dynamic subtest bcs0: SUCCESS (0.552s) [190.956836] Starting dynamic subtest: vcs0 [192.753764] Dynamic subtest vcs0: SUCCESS (1.806s) [192.763890] Starting dynamic subtest: vcs1 [194.737644] Dynamic subtest vcs1: SUCCESS (1.983s) [194.748792] Starting dynamic subtest: vecs0 [196.721794] Dynamic subtest vecs0: SUCCESS (1.983s) [196.732070] Starting dynamic subtest: ccs0 [197.278056] Dynamic subtest ccs0: SUCCESS (0.557s) [197.280456] Subtest busy-check-all: SUCCESS (7.458s) [197.368853] [028/131] (894s left) kms_getfb (getfb-handle-not-fb) [197.426867] Starting subtest: getfb-handle-not-fb [197.468593] Subtest getfb-handle-not-fb: SUCCESS (0.045s) [197.581819] [029/131] (894s left) kms_psr (psr2-cursor-blt) [197.675553] Starting subtest: psr2-cursor-blt [197.677924] Starting dynamic subtest: eDP-1 [199.350781] Dynamic subtest eDP-1: SUCCESS (1.672s) [199.353038] Subtest psr2-cursor-blt: SUCCESS (1.673s) [200.132967] [030/131] (891s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-pri-indfb-draw-blt) [200.238781] Starting subtest: fbcpsr-1p-primscrn-pri-indfb-draw-blt [205.405382] Subtest fbcpsr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (5.168s) [205.542121] [031/131] (886s left) kms_ccs (bad-rotation-90-4-tiled-mtl-mc-ccs) [205.644793] Starting subtest: bad-rotation-90-4-tiled-mtl-mc-ccs [205.647090] Starting dynamic subtest: pipe-A-eDP-1 [206.144456] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.498s) [206.155142] Starting dynamic subtest: pipe-B-eDP-1 [206.176547] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.002s) [206.184864] Starting dynamic subtest: pipe-C-eDP-1 [206.204433] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.003s) [206.212512] Starting dynamic subtest: pipe-D-eDP-1 [206.232140] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.004s) [206.234404] Subtest bad-rotation-90-4-tiled-mtl-mc-ccs: SUCCESS (0.510s) [208.436181] [032/131] (883s left) kms_vrr (lobf) [208.524716] Starting subtest: lobf [208.528987] Subtest lobf: SKIP (0.000s) [208.591163] [033/131] (883s left) kms_flip (2x-absolute-wf_vblank) [208.692976] Starting subtest: 2x-absolute-wf_vblank [208.703945] Subtest 2x-absolute-wf_vblank: SKIP (0.011s) [208.775828] [034/131] (883s left) kms_chamelium_hpd (vga-hpd-enable-disable-mode) [209.149342] Subtest vga-hpd-enable-disable-mode: SKIP (0.000s) [209.939873] [035/131] (882s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-render) [210.045971] Starting subtest: psr-1p-primscrn-pri-indfb-draw-render [215.115270] Subtest psr-1p-primscrn-pri-indfb-draw-render: SUCCESS (5.070s) [215.230007] [036/131] (876s left) gem_exec_store (cachelines) [215.298462] Starting subtest: cachelines [215.300791] Starting dynamic subtest: rcs0 [215.388738] Dynamic subtest rcs0: SUCCESS (0.091s) [215.399510] Starting dynamic subtest: bcs0 [215.450073] Dynamic subtest bcs0: SUCCESS (0.060s) [215.460339] Starting dynamic subtest: vcs0 [215.508515] Dynamic subtest vcs0: SUCCESS (0.056s) [215.517974] Starting dynamic subtest: vcs1 [215.574723] Dynamic subtest vcs1: SUCCESS (0.066s) [215.585413] Starting dynamic subtest: vecs0 [215.631358] Dynamic subtest vecs0: SUCCESS (0.055s) [215.640359] Starting dynamic subtest: ccs0 [215.685708] Dynamic subtest ccs0: SUCCESS (0.054s) [215.688121] Subtest cachelines: SUCCESS (0.389s) [215.867972] [037/131] (876s left) gem_ctx_sseu (mmap-args) [215.938995] Subtest mmap-args: SKIP (0.000s) [216.029687] [038/131] (876s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [216.144143] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [216.148045] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [216.260043] [039/131] (875s left) i915_pm_rpm (gem-execbuf) [217.900955] Starting subtest: gem-execbuf [217.903948] Starting dynamic subtest: smem0 [219.873360] Dynamic subtest smem0: SUCCESS (1.971s) [219.875354] Subtest gem-execbuf: SUCCESS (1.972s) [219.952676] [040/131] (872s left) gem_exec_schedule (promotion) [220.024890] Starting subtest: promotion [220.026926] Starting dynamic subtest: rcs0 [220.118360] Dynamic subtest rcs0: SUCCESS (0.100s) [220.129520] Starting dynamic subtest: vcs0 [220.199780] Dynamic subtest vcs0: SUCCESS (0.082s) [220.211687] Starting dynamic subtest: vcs1 [220.276641] Dynamic subtest vcs1: SUCCESS (0.077s) [220.287465] Starting dynamic subtest: vecs0 [220.353174] Dynamic subtest vecs0: SUCCESS (0.075s) [220.366692] Starting dynamic subtest: ccs0 [220.442465] Dynamic subtest ccs0: SUCCESS (0.090s) [220.444949] Subtest promotion: SUCCESS (0.425s) [221.849902] [041/131] (870s left) kms_flip (flip-vs-modeset-vs-hang) [221.961789] Starting subtest: flip-vs-modeset-vs-hang [221.964038] Starting dynamic subtest: A-eDP1 [273.224808] Dynamic subtest A-eDP1: SUCCESS (51.258s) [273.237933] Starting dynamic subtest: D-eDP1 [323.205263] Dynamic subtest D-eDP1: SUCCESS (49.977s) [323.207714] Subtest flip-vs-modeset-vs-hang: SUCCESS (101.238s) [323.572194] [042/131] (768s left) kms_rotation_crc (primary-y-tiled-reflect-x-0) [323.660049] Starting subtest: primary-y-tiled-reflect-x-0 [323.721317] Subtest primary-y-tiled-reflect-x-0: SKIP (0.059s) [323.816704] [043/131] (768s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [323.922082] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [323.926436] Subtest psr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [324.021722] [044/131] (768s left) gem_ctx_persistence (legacy-engines-queued) [324.091157] Starting subtest: legacy-engines-queued [324.093481] Starting dynamic subtest: render [324.179370] Dynamic subtest render: SUCCESS (0.088s) [324.190763] Starting dynamic subtest: bsd1 [325.711498] Dynamic subtest bsd1: SUCCESS (1.527s) [325.723542] Starting dynamic subtest: bsd2 [327.696536] Dynamic subtest bsd2: SUCCESS (1.982s) [327.713600] Starting dynamic subtest: blt [327.782425] Dynamic subtest blt: SUCCESS (0.084s) [327.792444] Starting dynamic subtest: vebox [329.678725] Dynamic subtest vebox: SUCCESS (1.892s) [329.681537] Subtest legacy-engines-queued: SUCCESS (5.586s) [329.749727] [045/131] (762s left) kms_frontbuffer_tracking (fbcpsr-rgb565-draw-mmap-wc) [329.862028] Starting subtest: fbcpsr-rgb565-draw-mmap-wc [334.428963] Subtest fbcpsr-rgb565-draw-mmap-wc: SUCCESS (4.570s) [334.547261] [046/131] (757s left) gem_pxp (verify-pxp-stale-buf-execution) [334.675007] Starting subtest: verify-pxp-stale-buf-execution [335.734307] Subtest verify-pxp-stale-buf-execution: SUCCESS (1.061s) [335.871830] [047/131] (756s left) gem_mmap_gtt (medium-copy) [335.929835] Subtest medium-copy: SKIP (0.000s) [336.035225] [048/131] (756s left) kms_cursor_crc (cursor-size-hints) [336.152242] Starting subtest: cursor-size-hints [336.154389] Starting dynamic subtest: pipe-A-eDP-1 [336.781619] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.627s) [336.791041] Starting dynamic subtest: pipe-D-eDP-1 [337.995076] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.212s) [337.997481] Subtest cursor-size-hints: SUCCESS (1.841s) [338.774909] [049/131] (753s left) gem_exec_balancer (sequential) [338.841471] Starting subtest: sequential [341.760539] Subtest sequential: SUCCESS (2.918s) [342.093106] [050/131] (750s left) kms_vblank (query-busy) [342.198791] Starting subtest: query-busy [342.201155] Starting dynamic subtest: pipe-A-eDP-1 [344.088606] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.888s) [344.104976] Starting dynamic subtest: pipe-D-eDP-1 [346.637826] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.545s) [346.640181] Subtest query-busy: SUCCESS (4.437s) [347.434817] [051/131] (745s left) kms_async_flips (test-time-stamp) [347.535867] Starting subtest: test-time-stamp [347.921899] Starting dynamic subtest: pipe-A-eDP-1 [348.735408] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.813s) [349.101543] Starting dynamic subtest: pipe-B-eDP-1 [349.857661] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.762s) [350.218995] Starting dynamic subtest: pipe-C-eDP-1 [350.981310] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.766s) [351.342275] Starting dynamic subtest: pipe-D-eDP-1 [352.107323] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.769s) [352.109734] Subtest test-time-stamp: SUCCESS (4.569s) [353.250978] [052/131] (739s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [353.358099] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [353.371121] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.011s) [353.440931] [053/131] (739s left) kms_big_fb (4-tiled-32bpp-rotate-180) [353.548084] Starting subtest: 4-tiled-32bpp-rotate-180 [355.258339] Subtest 4-tiled-32bpp-rotate-180: SUCCESS (1.712s) [355.421101] [054/131] (737s left) api_intel_bb (delta-check) [355.472614] Starting subtest: delta-check [355.476879] Subtest delta-check: SUCCESS (0.006s) [355.587485] [055/131] (737s left) gem_ctx_isolation (preservation-reset) [355.754992] Starting subtest: preservation-reset [355.757739] Starting dynamic subtest: rcs0 [356.150151] Dynamic subtest rcs0: SUCCESS (0.395s) [356.161268] Starting dynamic subtest: bcs0 [356.640349] Dynamic subtest bcs0: SUCCESS (0.489s) [356.651657] Starting dynamic subtest: vcs0 [357.098417] Dynamic subtest vcs0: SUCCESS (0.458s) [357.109786] Starting dynamic subtest: vcs1 [359.137796] Dynamic subtest vcs1: SUCCESS (2.038s) [359.149194] Starting dynamic subtest: vecs0 [361.189611] Dynamic subtest vecs0: SUCCESS (2.052s) [361.197897] Starting dynamic subtest: ccs0 [363.145964] Dynamic subtest ccs0: SUCCESS (1.955s) [363.148311] Subtest preservation-reset: SUCCESS (7.392s) [363.340798] [056/131] (729s left) kms_frontbuffer_tracking (psr-modesetfrombusy) [363.451980] Starting subtest: psr-modesetfrombusy [367.541827] Subtest psr-modesetfrombusy: SUCCESS (4.094s) [367.676162] [057/131] (725s left) sw_sync (sync_multi_consumer_producer) [367.714845] Starting subtest: sync_multi_consumer_producer [368.038695] Subtest sync_multi_consumer_producer: SUCCESS (0.323s) [368.093271] [058/131] (724s left) gem_exec_whisper (basic-fds-forked) [368.164356] Starting subtest: basic-fds-forked [393.517197] Subtest basic-fds-forked: SUCCESS (25.347s) [393.691385] [059/131] (699s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-indfb-draw-pwrite) [393.799251] Starting subtest: fbc-2p-primscrn-pri-indfb-draw-pwrite [393.803446] Subtest fbc-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [393.914042] [060/131] (698s left) i915_query (query-regions-unallocated) [393.976622] Starting subtest: query-regions-unallocated [393.979516] Subtest query-regions-unallocated: SUCCESS (0.000s) [394.083248] [061/131] (698s left) gem_bad_reloc (negative-reloc) [394.144802] Subtest negative-reloc: SKIP (0.000s) [394.225654] [062/131] (698s left) kms_frontbuffer_tracking (fbc-suspend) [394.341999] Starting subtest: fbc-suspend [430.768644] Subtest fbc-suspend: SUCCESS (6.115s) [430.911949] [063/131] (692s left) kms_psr2_sf (fbc-pr-overlay-plane-update-continuous-sf) [436.168910] Starting subtest: fbc-pr-overlay-plane-update-continuous-sf [436.173640] Subtest fbc-pr-overlay-plane-update-continuous-sf: SKIP (0.002s) [437.022778] [064/131] (686s left) kms_psr (fbc-psr-sprite-mmap-gtt) [437.129057] Starting subtest: fbc-psr-sprite-mmap-gtt [437.130945] Starting dynamic subtest: eDP-1 [437.135061] Dynamic subtest eDP-1: SKIP (0.000s) [437.139178] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s) [437.197935] [065/131] (686s left) api_intel_bb (object-reloc-keep-cache) [437.261396] Starting subtest: object-reloc-keep-cache [437.266040] Subtest object-reloc-keep-cache: SKIP (0.003s) [437.391340] [066/131] (686s left) kms_chamelium_frames (dp-crc-multiple) [437.781834] Subtest dp-crc-multiple: SKIP (0.000s) [438.536878] [067/131] (684s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-blt) [438.644847] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-blt [443.222166] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-blt: SUCCESS (4.579s) [443.373900] [068/131] (680s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu) [443.486125] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu [443.490126] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-cpu: SKIP (0.000s) [443.572033] [069/131] (679s left) perf (disabled-read-error) [443.652397] Starting subtest: disabled-read-error [443.682133] Subtest disabled-read-error: SUCCESS (0.028s) [443.716377] [070/131] (679s left) kms_rmfb (close-fd) [443.813871] Starting subtest: close-fd [443.815693] Starting dynamic subtest: pipe-A-eDP-1 [443.932669] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.116s) [443.942923] Starting dynamic subtest: pipe-B-eDP-1 [445.083069] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.151s) [445.093503] Starting dynamic subtest: pipe-C-eDP-1 [446.211921] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.125s) [446.222900] Starting dynamic subtest: pipe-D-eDP-1 [447.339214] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.129s) [447.341596] Subtest close-fd: SUCCESS (3.526s) [448.445656] [071/131] (675s left) i915_pm_rps (engine-order) [448.514349] Starting subtest: engine-order [453.339559] Subtest engine-order: SUCCESS (4.790s) [453.405986] [072/131] (670s left) gem_mmap_wc (write-read) [453.498938] Subtest write-read: SKIP (0.000s) [453.559926] [073/131] (670s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-blt) [453.664123] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-blt [453.668427] Subtest psr-2p-scndscrn-cur-indfb-draw-blt: SKIP (0.000s) [453.774732] [074/131] (669s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-pwrite) [453.871897] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-pwrite [453.876051] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [453.948414] [075/131] (669s left) gem_exec_reloc (basic-wc-noreloc) [454.010471] Subtest basic-wc-noreloc: SKIP (0.000s) [454.082463] [076/131] (669s left) kms_plane_alpha_blend (alpha-basic) [454.168884] Starting subtest: alpha-basic [454.578219] Starting dynamic subtest: pipe-A-eDP-1 [456.488034] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.907s) [456.511334] Starting dynamic subtest: pipe-D-eDP-1 [459.099408] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.594s) [459.101836] Subtest alpha-basic: SUCCESS (4.928s) [459.903221] [077/131] (663s left) kms_cursor_legacy (flip-vs-cursor-atomic-transitions-varying-size) [460.028234] Starting subtest: flip-vs-cursor-atomic-transitions-varying-size [468.158216] Subtest flip-vs-cursor-atomic-transitions-varying-size: SUCCESS (8.129s) [469.023106] [078/131] (654s left) gem_userptr_blits (mmap-offset-banned) [469.092831] Starting subtest: mmap-offset-banned [469.095379] Starting dynamic subtest: wb [469.097556] Dynamic subtest wb: SUCCESS (0.000s) [469.106564] Starting dynamic subtest: wc [469.108489] Dynamic subtest wc: SUCCESS (0.000s) [469.117046] Starting dynamic subtest: uc [469.118926] Dynamic subtest uc: SUCCESS (0.000s) [469.120802] Subtest mmap-offset-banned: SUCCESS (0.002s) [469.227947] [079/131] (654s left) kms_flip_scaled_crc (flip-64bpp-4tile-to-16bpp-4tile-upscaling) [469.336091] Starting subtest: flip-64bpp-4tile-to-16bpp-4tile-upscaling [469.338392] Starting dynamic subtest: pipe-A-default-mode [472.018148] Dynamic subtest pipe-A-default-mode: SUCCESS (2.679s) [472.020454] Subtest flip-64bpp-4tile-to-16bpp-4tile-upscaling: SUCCESS (2.680s) [472.801491] [080/131] (651s left) kms_pm_rpm (i2c) [474.334405] Starting subtest: i2c [479.955789] Subtest i2c: SUCCESS (5.619s) [480.069875] [081/131] (643s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-0) [480.181040] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-0 [481.149512] Subtest 4-tiled-max-hw-stride-32bpp-rotate-0: SUCCESS (0.967s) [481.340677] [082/131] (642s left) kms_psr (psr-primary-blt) [481.440630] Starting subtest: psr-primary-blt [481.443001] Starting dynamic subtest: eDP-1 [483.225871] Dynamic subtest eDP-1: SUCCESS (1.785s) [483.228284] Subtest psr-primary-blt: SUCCESS (1.786s) [484.088037] [083/131] (639s left) kms_chamelium_hpd (dp-hpd-storm-disable) [484.472495] Subtest dp-hpd-storm-disable: SKIP (0.000s) [485.285714] [084/131] (638s left) vgem_basic (create) [485.331514] Starting subtest: create [485.333853] Subtest create: SUCCESS (0.000s) [485.382286] [085/131] (638s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-rc-ccs) [485.480606] Starting subtest: crc-primary-rotation-180-4-tiled-mtl-rc-ccs [485.482900] Starting dynamic subtest: pipe-A-eDP-1 [486.320832] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.830s) [486.332201] Starting dynamic subtest: pipe-B-eDP-1 [487.819180] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.495s) [487.828564] Starting dynamic subtest: pipe-C-eDP-1 [489.325240] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.505s) [489.335327] Starting dynamic subtest: pipe-D-eDP-1 [490.751792] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.425s) [490.754127] Subtest crc-primary-rotation-180-4-tiled-mtl-rc-ccs: SUCCESS (5.259s) [491.954317] [086/131] (632s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [492.076128] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [492.080462] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [492.175550] [087/131] (632s left) dmabuf_sync_file (export-before-signal) [492.217102] Starting subtest: export-before-signal [492.219030] Subtest export-before-signal: SUCCESS (0.001s) [492.266695] [088/131] (631s left) perf_pmu (idle) [492.304865] Starting subtest: idle [492.307238] Starting dynamic subtest: rcs0 [492.854747] Dynamic subtest rcs0: SUCCESS (0.548s) [492.866715] Starting dynamic subtest: bcs0 [493.382427] Dynamic subtest bcs0: SUCCESS (0.525s) [493.394871] Starting dynamic subtest: vcs0 [493.911725] Dynamic subtest vcs0: SUCCESS (0.527s) [493.923456] Starting dynamic subtest: vcs1 [494.441666] Dynamic subtest vcs1: SUCCESS (0.528s) [494.454167] Starting dynamic subtest: vecs0 [494.960130] Dynamic subtest vecs0: SUCCESS (0.515s) [494.973132] Starting dynamic subtest: ccs0 [495.495197] Dynamic subtest ccs0: SUCCESS (0.532s) [495.499022] Subtest idle: SUCCESS (3.188s) [495.612137] [089/131] (628s left) syncobj_timeline (multi-wait-all-for-submit-available-signaled) [495.670937] Starting subtest: multi-wait-all-for-submit-available-signaled [495.673213] Subtest multi-wait-all-for-submit-available-signaled: SUCCESS (0.000s) [495.789275] [090/131] (628s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [495.919476] Starting subtest: basic-flip-before-cursor-atomic [496.823220] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.903s) [497.652250] [091/131] (626s left) kms_frontbuffer_tracking (fbc-tiling-y) [497.754512] Starting subtest: fbc-tiling-y [497.758983] Subtest fbc-tiling-y: SKIP (0.000s) [497.832006] [092/131] (626s left) gem_exec_schedule (fairslice-all) [497.900069] Starting subtest: fairslice-all [499.954066] Subtest fairslice-all: SUCCESS (2.059s) [501.070072] [093/131] (623s left) gen9_exec_parse (basic-rejected-ctx-param) [501.133653] Subtest basic-rejected-ctx-param: SKIP (0.000s) [501.209343] [094/131] (623s left) gem_eio (in-flight-immediate) [501.439103] Starting subtest: in-flight-immediate [509.870475] Subtest in-flight-immediate: SUCCESS (8.428s) [510.051286] [095/131] (614s left) vgem_basic (busy-fence) [510.102796] Starting subtest: busy-fence [510.105057] Subtest busy-fence: SUCCESS (0.000s) [510.152931] [096/131] (614s left) kms_plane (planar-pixel-format-settings) [510.252573] Starting subtest: planar-pixel-format-settings [510.281925] Subtest planar-pixel-format-settings: SUCCESS (0.027s) [510.377408] [097/131] (614s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt) [510.490562] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt [510.495023] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [510.600053] [098/131] (613s left) gem_mmap_wc (write-prefaulted) [510.653698] Subtest write-prefaulted: SKIP (0.000s) [510.709234] [099/131] (613s left) kms_chamelium_audio (hdmi-audio) [511.089496] Subtest hdmi-audio: SKIP (0.000s) [511.860685] [100/131] (612s left) kms_pipe_crc_basic (compare-crc-sanitycheck-nv12) [511.961688] Starting subtest: compare-crc-sanitycheck-nv12 [511.963894] Starting dynamic subtest: pipe-A-eDP-1 [512.628861] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.667s) [512.640320] Starting dynamic subtest: pipe-B-eDP-1 [513.933631] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.303s) [513.943506] Starting dynamic subtest: pipe-C-eDP-1 [515.106458] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.170s) [515.115915] Starting dynamic subtest: pipe-D-eDP-1 [516.327615] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.219s) [516.329938] Subtest compare-crc-sanitycheck-nv12: SUCCESS (4.365s) [517.179902] [101/131] (607s left) kms_flip_scaled_crc (flip-64bpp-yftile-to-32bpp-yftile-downscaling) [517.270658] Starting subtest: flip-64bpp-yftile-to-32bpp-yftile-downscaling [517.272990] Starting dynamic subtest: pipe-A-default-mode [517.556727] Dynamic subtest pipe-A-default-mode: SKIP (0.282s) [517.561658] Subtest flip-64bpp-yftile-to-32bpp-yftile-downscaling: SKIP (0.283s) [518.401038] [102/131] (606s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [518.496822] Starting subtest: bad-pixel-format-yf-tiled-ccs [518.499093] Starting dynamic subtest: pipe-A-eDP-1 [518.520666] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [518.529880] Starting dynamic subtest: pipe-B-eDP-1 [518.550796] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [518.559428] Starting dynamic subtest: pipe-C-eDP-1 [518.580916] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [518.588900] Starting dynamic subtest: pipe-D-eDP-1 [518.611880] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [518.616308] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s) [520.655894] [103/131] (604s left) gem_exec_reloc (basic-wc-cpu) [520.714506] Subtest basic-wc-cpu: SKIP (0.000s) [520.798689] [104/131] (603s left) kms_dp_link_training (non-uhbr-sst) [520.904976] Starting subtest: non-uhbr-sst [520.913918] Subtest non-uhbr-sst: SKIP (0.000s) [520.975344] [105/131] (603s left) gem_render_copy (y-tiled-ccs-to-yf-tiled) [521.024220] Starting subtest: y-tiled-ccs-to-yf-tiled [521.028526] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s) [521.200359] [106/131] (603s left) kms_big_fb (yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip) [521.305008] Starting subtest: yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip [521.309494] Subtest yf-tiled-max-hw-stride-32bpp-rotate-0-hflip-async-flip: SKIP (0.000s) [521.413517] [107/131] (603s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-draw-mmap-gtt) [521.525522] Starting subtest: psr-2p-primscrn-cur-indfb-draw-mmap-gtt [521.530038] Subtest psr-2p-primscrn-cur-indfb-draw-mmap-gtt: SKIP (0.000s) [521.626139] [108/131] (603s left) kms_addfb_basic (bo-too-small-due-to-tiling) [521.714024] Starting subtest: bo-too-small-due-to-tiling [521.718428] Subtest bo-too-small-due-to-tiling: SKIP (0.000s) [521.822746] [109/131] (603s left) kms_psr2_sf (pr-plane-move-sf-dmg-area) [526.790030] Starting subtest: pr-plane-move-sf-dmg-area [526.794390] Subtest pr-plane-move-sf-dmg-area: SKIP (0.002s) [527.645889] [110/131] (597s left) gem_workarounds (reset-context) [527.723280] Starting subtest: reset-context [527.900832] Subtest reset-context: SUCCESS (0.177s) [528.042143] [111/131] (597s left) gem_ctx_isolation (clean) [528.110551] Starting subtest: clean [528.113004] Starting dynamic subtest: rcs0 [528.188759] Dynamic subtest rcs0: SUCCESS (0.078s) [528.203104] Starting dynamic subtest: bcs0 [528.289379] Dynamic subtest bcs0: SUCCESS (0.099s) [528.301683] Starting dynamic subtest: vcs0 [528.379295] Dynamic subtest vcs0: SUCCESS (0.091s) [528.391038] Starting dynamic subtest: vcs1 [530.150415] Dynamic subtest vcs1: SUCCESS (1.771s) [530.162181] Starting dynamic subtest: vecs0 [532.085587] Dynamic subtest vecs0: SUCCESS (1.934s) [532.097612] Starting dynamic subtest: ccs0 [534.121853] Dynamic subtest ccs0: SUCCESS (2.036s) [534.124855] Subtest clean: SUCCESS (6.013s) [534.301270] [112/131] (590s left) gem_lmem_swapping (massive-random) [534.345011] Subtest massive-random: SKIP (0.000s) [534.385064] [113/131] (590s left) gem_eio (wait-wedge-10ms) [534.623850] Starting subtest: wait-wedge-10ms [536.102937] Subtest wait-wedge-10ms: SUCCESS (1.480s) [536.251081] [114/131] (588s left) kms_properties (plane-properties-atomic) [536.339992] Starting subtest: plane-properties-atomic [536.342287] Starting dynamic subtest: pipe-A-eDP-1 [536.902422] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.559s) [536.911865] Starting dynamic subtest: pipe-B-eDP-1 [538.205775] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.305s) [538.218259] Starting dynamic subtest: pipe-C-eDP-1 [539.434051] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.226s) [539.444214] Starting dynamic subtest: pipe-D-eDP-1 [540.658881] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.224s) [540.661255] Subtest plane-properties-atomic: SUCCESS (4.318s) [541.445387] [115/131] (583s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-mmap-wc) [541.549318] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-mmap-wc [544.139763] Subtest fbc-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (2.595s) [544.261885] [116/131] (580s left) prime_mmap (test_refcounting) [544.320375] Starting subtest: test_refcounting [544.322129] Starting dynamic subtest: test_refcounting-smem [544.348989] Dynamic subtest test_refcounting-smem: SUCCESS (0.031s) [544.351597] Subtest test_refcounting: SUCCESS (0.031s) [544.438049] [117/131] (580s left) gem_eio (in-flight-suspend) [544.655358] Starting subtest: in-flight-suspend [587.892575] Subtest in-flight-suspend: SUCCESS (13.561s) [588.064941] [118/131] (566s left) kms_prop_blob (blob-multiple) [588.127448] Starting subtest: blob-multiple [588.130387] Subtest blob-multiple: SUCCESS (0.002s) [588.250002] [119/131] (566s left) kms_joiner (switch-modeset-ultra-joiner-big-joiner) [588.372727] Starting subtest: switch-modeset-ultra-joiner-big-joiner [588.378807] Subtest switch-modeset-ultra-joiner-big-joiner: SKIP (0.000s) [588.429271] [120/131] (566s left) gem_exec_flush (basic-batch-kernel-default-cmd) [588.498639] Starting subtest: basic-batch-kernel-default-cmd [588.503688] Subtest basic-batch-kernel-default-cmd: SKIP (0.000s) [588.677018] [121/131] (566s left) kms_psr (fbc-pr-sprite-plane-move) [588.779728] Starting subtest: fbc-pr-sprite-plane-move [588.784977] Subtest fbc-pr-sprite-plane-move: SKIP (0.000s) [588.845849] [122/131] (566s left) kms_psr (fbc-psr2-sprite-render) [588.944737] Starting subtest: fbc-psr2-sprite-render [588.947528] Starting dynamic subtest: eDP-1 [588.952565] Dynamic subtest eDP-1: SKIP (0.000s) [588.957522] Subtest fbc-psr2-sprite-render: SKIP (0.001s) [589.015875] [123/131] (566s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt) [589.124553] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt [589.129358] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-gtt: SKIP (0.000s) [589.206440] [124/131] (566s left) kms_big_fb (y-tiled-8bpp-rotate-0) [589.308599] Starting subtest: y-tiled-8bpp-rotate-0 [589.313673] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s) [589.388885] [125/131] (565s left) sw_sync (sync_random_merge) [589.429301] Starting subtest: sync_random_merge [589.463184] Subtest sync_random_merge: SUCCESS (0.036s) [589.524656] [126/131] (565s left) kms_rotation_crc (primary-4-tiled-reflect-x-180) [589.615310] Starting subtest: primary-4-tiled-reflect-x-180 [596.844181] Subtest primary-4-tiled-reflect-x-180: SUCCESS (7.219s) [597.995370] [127/131] (557s left) gem_exec_reloc (basic-cpu-wc-active) [598.056650] Subtest basic-cpu-wc-active: SKIP (0.000s) [598.119447] [128/131] (557s left) kms_flip_scaled_crc (flip-32bpp-4tile-to-64bpp-4tile-upscaling) [598.223797] Starting subtest: flip-32bpp-4tile-to-64bpp-4tile-upscaling [598.226741] Starting dynamic subtest: pipe-A-default-mode [600.903815] Dynamic subtest pipe-A-default-mode: SUCCESS (2.675s) [600.906652] Subtest flip-32bpp-4tile-to-64bpp-4tile-upscaling: SUCCESS (2.676s) [601.776139] [129/131] (553s left) gem_exec_parallel (basic) [601.836578] Starting subtest: basic [601.839352] Starting dynamic subtest: rcs0 [603.571314] Dynamic subtest rcs0: SUCCESS (1.732s) [603.582369] Starting dynamic subtest: bcs0 [605.311620] Dynamic subtest bcs0: SUCCESS (1.739s) [605.323606] Starting dynamic subtest: vcs0 [608.705668] Dynamic subtest vcs0: SUCCESS (3.389s) [608.719438] Starting dynamic subtest: vcs1 [610.709148] Dynamic subtest vcs1: SUCCESS (2.000s) [610.721804] Starting dynamic subtest: vecs0 [612.698005] Dynamic subtest vecs0: SUCCESS (1.984s) [612.708989] Starting dynamic subtest: ccs0 [614.516877] Dynamic subtest ccs0: SUCCESS (1.818s) [614.519803] Subtest basic: SUCCESS (12.672s) [614.699168] [130/131] (540s left) kms_flip (modeset-vs-vblank-race-interruptible) [614.811468] Starting subtest: modeset-vs-vblank-race-interruptible [614.813840] Starting dynamic subtest: A-eDP1 [619.474473] Dynamic subtest A-eDP1: SUCCESS (4.660s) [619.485838] Starting dynamic subtest: B-eDP1 [624.162810] Dynamic subtest B-eDP1: SUCCESS (4.686s) [624.174461] Starting dynamic subtest: C-eDP1 [628.832722] Dynamic subtest C-eDP1: SUCCESS (4.669s) [628.841954] Starting dynamic subtest: D-eDP1 [633.435690] Dynamic subtest D-eDP1: SUCCESS (4.600s) [633.438599] Subtest modeset-vs-vblank-race-interruptible: SUCCESS (18.625s) [634.578197] [131/131] (520s left) gem_pread (bench) [634.637423] Subtest bench: SKIP (0.000s) [634.691901] Closing watchdogs Done.