[58.804928] Initializing watchdogs [58.804974] /dev/watchdog0 [58.818059] [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] [58.822303] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [58.824415] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [58.827495] [001/133] (960s left) syncobj_basic (bad-create-flags) [58.893799] Starting subtest: bad-create-flags [58.895733] Subtest bad-create-flags: SUCCESS (0.000s) [59.054540] [002/133] (960s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area-big-fb) [64.119303] Starting subtest: psr2-primary-plane-update-sf-dmg-area-big-fb [64.121705] Starting dynamic subtest: pipe-A-eDP-1 [71.094498] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.963s) [71.103320] Starting dynamic subtest: pipe-B-eDP-1 [77.996861] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.895s) [77.999147] Subtest psr2-primary-plane-update-sf-dmg-area-big-fb: SUCCESS (13.861s) [78.886207] [003/133] (940s left) gem_ccs (block-copy-compressed) [78.956764] Starting subtest: block-copy-compressed [78.961200] Subtest block-copy-compressed: SKIP (0.000s) [79.079197] [004/133] (940s left) kms_sequence (get-forked-busy) [79.172064] Starting subtest: get-forked-busy [79.174447] Starting dynamic subtest: pipe-A-eDP-1 [81.109551] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.933s) [81.119284] Starting dynamic subtest: pipe-B-eDP-1 [83.763024] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.650s) [83.775187] Starting dynamic subtest: pipe-C-eDP-1 [86.385866] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.622s) [86.393083] Starting dynamic subtest: pipe-D-eDP-1 [89.005323] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.616s) [89.007653] Subtest get-forked-busy: SUCCESS (9.824s) [89.820671] [005/133] (929s left) sysfs_preempt_timeout (timeout) [89.891550] Starting subtest: timeout [89.893596] Starting dynamic subtest: vecs0 [99.929596] Dynamic subtest vecs0: SUCCESS (10.031s) [99.939513] Starting dynamic subtest: ccs0 [101.322036] Dynamic subtest ccs0: SUCCESS (1.391s) [101.331850] Starting dynamic subtest: vcs0 [110.892298] Dynamic subtest vcs0: SUCCESS (9.566s) [110.904360] Starting dynamic subtest: bcs0 [112.303876] Dynamic subtest bcs0: SUCCESS (1.411s) [112.313577] Starting dynamic subtest: rcs0 [113.613257] Dynamic subtest rcs0: SUCCESS (1.308s) [113.625472] Starting dynamic subtest: vcs1 [122.931934] Dynamic subtest vcs1: SUCCESS (9.315s) [122.934680] Subtest timeout: SUCCESS (33.030s) [123.025634] [006/133] (896s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-pgflip-blt) [123.124705] Starting subtest: psr-2p-scndscrn-indfb-pgflip-blt [123.129343] Subtest psr-2p-scndscrn-indfb-pgflip-blt: SKIP (0.000s) [123.251728] [007/133] (896s left) gem_ctx_persistence (legacy-engines-queued) [123.309037] Starting subtest: legacy-engines-queued [123.311062] Starting dynamic subtest: render [123.402954] Dynamic subtest render: SUCCESS (0.096s) [123.413704] Starting dynamic subtest: bsd1 [124.851596] Dynamic subtest bsd1: SUCCESS (1.444s) [124.862100] Starting dynamic subtest: bsd2 [126.898223] Dynamic subtest bsd2: SUCCESS (2.044s) [126.909333] Starting dynamic subtest: blt [126.976107] Dynamic subtest blt: SUCCESS (0.077s) [126.985703] Starting dynamic subtest: vebox [128.882070] Dynamic subtest vebox: SUCCESS (1.902s) [128.884793] Subtest legacy-engines-queued: SUCCESS (5.574s) [128.981805] [008/133] (890s left) drm_read (short-buffer-block) [129.148652] Starting subtest: short-buffer-block [129.151142] Subtest short-buffer-block: SUCCESS (0.000s) [129.309635] [009/133] (890s left) gem_render_copy_redux (normal) [129.376464] Starting subtest: normal [129.621952] Subtest normal: SUCCESS (0.244s) [129.760272] [010/133] (889s left) kms_big_fb (y-tiled-32bpp-rotate-90) [129.865690] Starting subtest: y-tiled-32bpp-rotate-90 [129.870061] Subtest y-tiled-32bpp-rotate-90: SKIP (0.000s) [129.978202] [011/133] (889s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-indfb-draw-blt) [130.078079] Starting subtest: psr-1p-primscrn-pri-indfb-draw-blt [137.346297] Subtest psr-1p-primscrn-pri-indfb-draw-blt: SUCCESS (7.270s) [137.517352] [012/133] (882s left) gem_exec_suspend (basic) [137.591872] Starting subtest: basic [137.594485] Starting dynamic subtest: smem [138.900288] Dynamic subtest smem: SUCCESS (1.306s) [138.903621] Subtest basic: SUCCESS (1.308s) [139.101125] [013/133] (880s left) kms_hdmi_inject (inject-audio) [139.471516] Starting subtest: inject-audio [139.749667] Subtest inject-audio: SUCCESS (0.279s) [140.317790] [014/133] (879s left) kms_cursor_crc (cursor-sliding-32x10) [140.477345] Starting subtest: cursor-sliding-32x10 [140.532531] Subtest cursor-sliding-32x10: SKIP (0.050s) [140.845357] [015/133] (879s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc) [140.955630] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc [147.381087] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-mmap-wc: SUCCESS (6.428s) [147.538013] [016/133] (872s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite) [147.650175] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite [147.654596] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-pwrite: SKIP (0.000s) [147.778937] [017/133] (872s left) gem_render_copy (y-tiled-ccs-to-linear) [147.852062] Starting subtest: y-tiled-ccs-to-linear [147.856072] Subtest y-tiled-ccs-to-linear: SKIP (0.000s) [148.055545] [018/133] (871s left) kms_big_fb (4-tiled-16bpp-rotate-90) [148.163025] Starting subtest: 4-tiled-16bpp-rotate-90 [148.182744] Subtest 4-tiled-16bpp-rotate-90: SKIP (0.019s) [148.342268] [019/133] (871s left) syncobj_timeline (transfer-timeline-point) [148.412220] Starting subtest: transfer-timeline-point [148.414598] Subtest transfer-timeline-point: SUCCESS (0.001s) [148.529063] [020/133] (871s left) syncobj_wait (invalid-multi-wait-unsubmitted-submitted) [148.592793] Starting subtest: invalid-multi-wait-unsubmitted-submitted [148.595013] Subtest invalid-multi-wait-unsubmitted-submitted: SUCCESS (0.000s) [148.711671] [021/133] (871s left) kms_ccs (random-ccs-data-y-tiled-gen12-rc-ccs-cc) [148.804257] Starting subtest: random-ccs-data-y-tiled-gen12-rc-ccs-cc [148.806456] Starting dynamic subtest: pipe-A-eDP-1 [148.830943] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [148.840983] Starting dynamic subtest: pipe-B-eDP-1 [148.865271] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [148.875020] Starting dynamic subtest: pipe-C-eDP-1 [148.898974] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [148.907875] Starting dynamic subtest: pipe-D-eDP-1 [148.931718] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [148.936569] Subtest random-ccs-data-y-tiled-gen12-rc-ccs-cc: SKIP (0.003s) [151.083548] [022/133] (869s left) kms_pm_rpm (dpms-mode-unset-non-lpsp) [153.112538] Starting subtest: dpms-mode-unset-non-lpsp [154.265400] Subtest dpms-mode-unset-non-lpsp: SKIP (1.154s) [154.654300] [023/133] (865s left) kms_frontbuffer_tracking (psr-rgb565-draw-mmap-wc) [154.761494] Starting subtest: psr-rgb565-draw-mmap-wc [161.392752] Subtest psr-rgb565-draw-mmap-wc: SUCCESS (6.634s) [161.554126] [024/133] (858s left) kms_chamelium_edid (vga-edid-read) [161.961362] Subtest vga-edid-read: SKIP (0.000s) [162.738737] [025/133] (857s left) gem_render_copy (yf-tiled-to-vebox-y-tiled) [162.803019] Starting subtest: yf-tiled-to-vebox-y-tiled [162.807668] Subtest yf-tiled-to-vebox-y-tiled: SKIP (0.000s) [163.018512] [026/133] (857s left) kms_flip (dpms-off-confusion) [163.123558] Starting subtest: dpms-off-confusion [163.125877] Starting dynamic subtest: A-eDP1 [171.841192] Dynamic subtest A-eDP1: SUCCESS (8.718s) [171.853635] Starting dynamic subtest: B-eDP1 [180.542643] Dynamic subtest B-eDP1: SUCCESS (8.699s) [180.552499] Starting dynamic subtest: C-eDP1 [189.226447] Dynamic subtest C-eDP1: SUCCESS (8.682s) [189.233978] Starting dynamic subtest: D-eDP1 [197.924320] Dynamic subtest D-eDP1: SUCCESS (8.697s) [197.929166] Subtest dpms-off-confusion: SUCCESS (34.808s) [199.177510] [027/133] (821s left) gem_exec_big (single) [199.237431] Starting subtest: single [201.588863] Subtest single: SUCCESS (2.349s) [201.812083] [028/133] (818s left) gem_exec_flush (basic-wb-ro-default) [201.919478] Starting subtest: basic-wb-ro-default [207.381305] Subtest basic-wb-ro-default: SUCCESS (5.462s) [207.591124] [029/133] (812s left) kms_async_flips (async-flip-with-page-flip-events-linear) [207.717593] Starting subtest: async-flip-with-page-flip-events-linear [208.092484] Starting dynamic subtest: pipe-A-eDP-1 [210.901214] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.808s) [211.276484] Starting dynamic subtest: pipe-B-eDP-1 [213.991968] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.721s) [214.376759] Starting dynamic subtest: pipe-C-eDP-1 [217.107815] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.738s) [217.470810] Starting dynamic subtest: pipe-D-eDP-1 [220.194294] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.734s) [220.196827] Subtest async-flip-with-page-flip-events-linear: SUCCESS (12.477s) [221.394493] [030/133] (799s left) kms_plane_scaling (planes-downscale-factor-0-75) [221.496735] Starting subtest: planes-downscale-factor-0-75 [221.498887] Starting dynamic subtest: pipe-A [221.519915] Dynamic subtest pipe-A: SKIP (0.018s) [221.529573] Starting dynamic subtest: pipe-B [221.549870] Dynamic subtest pipe-B: SKIP (0.031s) [221.558148] Starting dynamic subtest: pipe-C [221.581247] Dynamic subtest pipe-C: SKIP (0.030s) [221.589055] Starting dynamic subtest: pipe-D [221.614149] Dynamic subtest pipe-D: SKIP (0.030s) [221.618166] Subtest planes-downscale-factor-0-75: SKIP (0.112s) [221.740773] [031/133] (798s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-shrfb-draw-pwrite) [221.848256] Starting subtest: psr-2p-scndscrn-pri-shrfb-draw-pwrite [221.852392] Subtest psr-2p-scndscrn-pri-shrfb-draw-pwrite: SKIP (0.000s) [221.977905] [032/133] (798s left) kms_properties (colorop-properties-legacy) [222.083759] Starting subtest: colorop-properties-legacy [222.086053] Starting dynamic subtest: pipe-A-eDP-1 [222.513868] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.427s) [222.526349] Starting dynamic subtest: pipe-B-eDP-1 [223.591684] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.077s) [223.600442] Starting dynamic subtest: pipe-C-eDP-1 [224.691994] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.099s) [224.700220] Starting dynamic subtest: pipe-D-eDP-1 [225.786580] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.092s) [225.788876] Subtest colorop-properties-legacy: SUCCESS (3.700s) [226.670456] [033/133] (793s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu) [226.768460] Starting subtest: fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu [226.772727] Subtest fbcpsr-2p-primscrn-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [226.879975] [034/133] (793s left) kms_ccs (bad-aux-stride-4-tiled-mtl-rc-ccs) [226.979277] Starting subtest: bad-aux-stride-4-tiled-mtl-rc-ccs [226.981576] Starting dynamic subtest: pipe-A-eDP-1 [227.002077] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s) [227.010877] Starting dynamic subtest: pipe-B-eDP-1 [227.029799] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s) [227.037060] Starting dynamic subtest: pipe-C-eDP-1 [227.056531] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s) [227.063909] Starting dynamic subtest: pipe-D-eDP-1 [227.083469] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s) [227.085371] Subtest bad-aux-stride-4-tiled-mtl-rc-ccs: SUCCESS (0.007s) [229.278178] [035/133] (791s left) gem_wait (wait) [229.360986] Starting subtest: wait [229.363435] Starting dynamic subtest: all-engines [230.931635] Dynamic subtest all-engines: SUCCESS (1.571s) [230.940974] Starting dynamic subtest: rcs0 [231.976427] Dynamic subtest rcs0: SUCCESS (1.043s) [231.986945] Starting dynamic subtest: bcs0 [233.024291] Dynamic subtest bcs0: SUCCESS (1.046s) [233.035373] Starting dynamic subtest: vcs0 [234.069268] Dynamic subtest vcs0: SUCCESS (1.043s) [234.080073] Starting dynamic subtest: vcs1 [235.114423] Dynamic subtest vcs1: SUCCESS (1.043s) [235.124907] Starting dynamic subtest: vecs0 [236.159074] Dynamic subtest vecs0: SUCCESS (1.043s) [236.169245] Starting dynamic subtest: ccs0 [237.207961] Dynamic subtest ccs0: SUCCESS (1.047s) [237.210448] Subtest wait: SUCCESS (7.850s) [237.459658] [036/133] (783s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-mmap-wc) [237.579983] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-mmap-wc [237.584270] Subtest fbc-2p-primscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s) [237.694411] [037/133] (783s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-0-hflip) [237.801411] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-0-hflip [238.803150] Subtest 4-tiled-max-hw-stride-64bpp-rotate-0-hflip: SUCCESS (1.001s) [238.997538] [038/133] (781s left) gem_exec_reloc (basic-concurrent0) [239.072106] Subtest basic-concurrent0: SKIP (0.000s) [239.156282] [039/133] (781s left) kms_big_fb (yf-tiled-32bpp-rotate-180) [239.264891] Starting subtest: yf-tiled-32bpp-rotate-180 [239.268254] Subtest yf-tiled-32bpp-rotate-180: SKIP (0.000s) [239.374789] [040/133] (781s left) kms_lease (cursor-implicit-plane) [239.477388] Starting subtest: cursor-implicit-plane [239.479389] Starting dynamic subtest: pipe-A-eDP-1 [239.935992] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.459s) [239.945283] Starting dynamic subtest: pipe-B-eDP-1 [241.042195] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.102s) [241.056676] Starting dynamic subtest: pipe-C-eDP-1 [242.132026] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.087s) [242.142225] Starting dynamic subtest: pipe-D-eDP-1 [243.224810] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.092s) [243.227035] Subtest cursor-implicit-plane: SUCCESS (3.747s) [244.075094] [041/133] (776s left) gem_exec_schedule (u-semaphore-resolve) [244.158912] Starting subtest: u-semaphore-resolve [244.187034] Subtest u-semaphore-resolve: SUCCESS (0.034s) [244.541993] [042/133] (776s left) gem_exec_whisper (basic-fds-priority) [244.609514] Starting subtest: basic-fds-priority [268.874173] Subtest basic-fds-priority: SUCCESS (24.259s) [269.078401] [043/133] (751s left) i915_query (query-topology-known-pci-ids) [269.131780] Starting subtest: query-topology-known-pci-ids [269.136193] Subtest query-topology-known-pci-ids: SKIP (0.000s) [269.249993] [044/133] (751s left) kms_big_fb (yf-tiled-64bpp-rotate-90) [269.355679] Starting subtest: yf-tiled-64bpp-rotate-90 [269.360268] Subtest yf-tiled-64bpp-rotate-90: SKIP (0.000s) [269.491379] [045/133] (751s left) perf_pmu (idle) [269.536836] Starting subtest: idle [269.539151] Starting dynamic subtest: rcs0 [270.114717] Dynamic subtest rcs0: SUCCESS (0.577s) [270.124237] Starting dynamic subtest: bcs0 [270.638836] Dynamic subtest bcs0: SUCCESS (0.521s) [270.650709] Starting dynamic subtest: vcs0 [271.167247] Dynamic subtest vcs0: SUCCESS (0.526s) [271.178517] Starting dynamic subtest: vcs1 [271.690866] Dynamic subtest vcs1: SUCCESS (0.521s) [271.703055] Starting dynamic subtest: vecs0 [272.217971] Dynamic subtest vecs0: SUCCESS (0.524s) [272.229654] Starting dynamic subtest: ccs0 [272.746045] Dynamic subtest ccs0: SUCCESS (0.526s) [272.748840] Subtest idle: SUCCESS (3.210s) [272.883460] [046/133] (748s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-draw-pwrite) [272.985982] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-draw-pwrite [272.990113] Subtest fbcpsr-2p-primscrn-cur-indfb-draw-pwrite: SKIP (0.000s) [273.100541] [047/133] (748s left) gem_exec_flush (basic-uc-pro-default) [273.171473] Starting subtest: basic-uc-pro-default [278.627773] Subtest basic-uc-pro-default: SUCCESS (5.458s) [278.849714] [048/133] (742s left) gem_basic (bad-close) [278.903329] Starting subtest: bad-close [278.907543] Subtest bad-close: SUCCESS (0.000s) [279.039887] [049/133] (742s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc) [279.150453] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc [279.154568] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [279.257914] [050/133] (742s left) kms_plane (pixel-format) [279.350252] Starting subtest: pixel-format [279.380527] Starting dynamic subtest: pipe-A-plane-0 [284.224430] Dynamic subtest pipe-A-plane-0: SUCCESS (4.844s) [284.235180] Starting dynamic subtest: pipe-A-plane-3 [286.468733] Dynamic subtest pipe-A-plane-3: SUCCESS (2.243s) [286.477766] Starting dynamic subtest: pipe-A-plane-5 [286.680496] Dynamic subtest pipe-A-plane-5: SUCCESS (0.210s) [287.807936] Starting dynamic subtest: pipe-B-plane-0 [292.683726] Dynamic subtest pipe-B-plane-0: SUCCESS (4.889s) [292.694417] Starting dynamic subtest: pipe-B-plane-3 [294.972734] Dynamic subtest pipe-B-plane-3: SUCCESS (2.287s) [294.982076] Starting dynamic subtest: pipe-B-plane-5 [295.184114] Dynamic subtest pipe-B-plane-5: SUCCESS (0.210s) [295.498093] Subtest pixel-format: SUCCESS (16.148s) [296.365457] [051/133] (724s left) kms_psr (fbc-psr2-no-drrs) [296.467850] Starting subtest: fbc-psr2-no-drrs [296.470436] Starting dynamic subtest: eDP-1 [296.474388] Dynamic subtest eDP-1: SKIP (0.000s) [296.478370] Subtest fbc-psr2-no-drrs: SKIP (0.001s) [296.550069] [052/133] (724s left) gem_mmap (bad-size) [296.614361] Subtest bad-size: SKIP (0.000s) [296.678356] [053/133] (724s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt) [296.788014] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt [296.791839] Subtest fbc-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [296.897744] [054/133] (724s left) api_intel_bb (crc32) [296.965433] Starting subtest: crc32 [296.967684] Starting dynamic subtest: rcs0-smem0 [297.240467] Dynamic subtest rcs0-smem0: SUCCESS (0.275s) [297.253569] Starting dynamic subtest: bcs0-smem0 [297.538309] Dynamic subtest bcs0-smem0: SUCCESS (0.295s) [297.549072] Starting dynamic subtest: vcs0-smem0 [297.902334] Dynamic subtest vcs0-smem0: SUCCESS (0.363s) [297.914480] Starting dynamic subtest: vcs1-smem0 [298.290790] Dynamic subtest vcs1-smem0: SUCCESS (0.384s) [298.301330] Starting dynamic subtest: vecs0-smem0 [298.606450] Dynamic subtest vecs0-smem0: SUCCESS (0.313s) [298.616664] Starting dynamic subtest: ccs0-smem0 [298.933412] Dynamic subtest ccs0-smem0: SUCCESS (0.325s) [298.936187] Subtest crc32: SUCCESS (1.970s) [299.067809] [055/133] (722s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt) [299.166059] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt [299.170235] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [299.289600] [056/133] (722s left) kms_psr (psr2-cursor-render) [299.380045] Starting subtest: psr2-cursor-render [299.382315] Starting dynamic subtest: eDP-1 [301.083999] Dynamic subtest eDP-1: SUCCESS (1.705s) [301.086431] Subtest psr2-cursor-render: SUCCESS (1.706s) [301.966130] [057/133] (719s left) kms_flip (2x-flip-vs-wf_vblank-interruptible) [302.067806] Starting subtest: 2x-flip-vs-wf_vblank-interruptible [302.079916] Subtest 2x-flip-vs-wf_vblank-interruptible: SKIP (0.010s) [302.178381] [058/133] (719s left) kms_ccs (crc-sprite-planes-basic-4-tiled-mtl-rc-ccs) [302.292398] Starting subtest: crc-sprite-planes-basic-4-tiled-mtl-rc-ccs [302.294809] Starting dynamic subtest: pipe-A-eDP-1 [302.743542] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.425s) [302.754080] Starting dynamic subtest: pipe-B-eDP-1 [304.165335] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.418s) [304.176479] Starting dynamic subtest: pipe-C-eDP-1 [305.533115] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.366s) [305.544095] Starting dynamic subtest: pipe-D-eDP-1 [306.941289] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.409s) [306.943573] Subtest crc-sprite-planes-basic-4-tiled-mtl-rc-ccs: SUCCESS (4.624s) [308.170146] [059/133] (713s left) kms_dp_linktrain_fallback (dp-fallback) [308.261761] Starting subtest: dp-fallback [308.268397] Subtest dp-fallback: SKIP (0.000s) [308.359098] [060/133] (713s left) gem_readwrite (beyond-eob) [308.412129] Subtest beyond-EOB: SKIP (0.000s) [308.467381] [061/133] (713s left) kms_frontbuffer_tracking (fbc-1p-primscrn-shrfb-pgflip-blt) [308.566781] Starting subtest: fbc-1p-primscrn-shrfb-pgflip-blt [312.998516] Subtest fbc-1p-primscrn-shrfb-pgflip-blt: SUCCESS (4.435s) [314.181196] [062/133] (707s left) prime_vgem (basic-fence-read) [314.321833] Starting subtest: basic-fence-read [314.330973] Subtest basic-fence-read: SKIP (0.007s) [314.480506] [FACT prime_vgem (basic-fence-read)] new: kernel.kmod_is_loaded.vgem: true [314.483769] [063/133] (707s left) perf_pmu (interrupts) [314.527170] Starting subtest: interrupts [315.625823] Subtest interrupts: SUCCESS (1.098s) [315.770597] [064/133] (706s left) i915_pm_rpm (system-suspend-devices) [318.087362] Starting subtest: system-suspend-devices [325.878413] Subtest system-suspend-devices: SUCCESS (7.791s) [326.283310] [065/133] (695s left) kms_flip (flip-vs-dpms-on-nop-interruptible) [326.398185] Starting subtest: flip-vs-dpms-on-nop-interruptible [326.400508] Starting dynamic subtest: A-eDP1 [328.217666] Dynamic subtest A-eDP1: SUCCESS (1.818s) [328.227523] Starting dynamic subtest: B-eDP1 [330.105866] Dynamic subtest B-eDP1: SUCCESS (1.886s) [330.117216] Starting dynamic subtest: C-eDP1 [331.895556] Dynamic subtest C-eDP1: SUCCESS (1.788s) [331.905473] Starting dynamic subtest: D-eDP1 [333.691303] Dynamic subtest D-eDP1: SUCCESS (1.793s) [333.693508] Subtest flip-vs-dpms-on-nop-interruptible: SUCCESS (7.296s) [334.970049] [066/133] (686s left) kms_ccs (crc-primary-basic-y-tiled-ccs) [335.079892] Starting subtest: crc-primary-basic-y-tiled-ccs [335.082240] Starting dynamic subtest: pipe-A-eDP-1 [335.105642] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [335.117563] Starting dynamic subtest: pipe-B-eDP-1 [335.140105] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [335.151180] Starting dynamic subtest: pipe-C-eDP-1 [335.173057] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [335.182077] Starting dynamic subtest: pipe-D-eDP-1 [335.204129] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [335.208200] Subtest crc-primary-basic-y-tiled-ccs: SKIP (0.006s) [337.367056] [067/133] (684s left) kms_color (ctm-0-75) [337.472362] Starting subtest: ctm-0-75 [337.474646] Starting dynamic subtest: pipe-A-eDP-1 [342.385794] Dynamic subtest pipe-A-eDP-1: SUCCESS (4.913s) [342.395633] Starting dynamic subtest: pipe-B-eDP-1 [347.993448] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.608s) [348.003974] Starting dynamic subtest: pipe-C-eDP-1 [353.349467] Dynamic subtest pipe-C-eDP-1: SUCCESS (5.355s) [353.359885] Starting dynamic subtest: pipe-D-eDP-1 [358.650286] Dynamic subtest pipe-D-eDP-1: SUCCESS (5.301s) [358.652918] Subtest ctm-0-75: SUCCESS (21.179s) [359.475724] [068/133] (662s left) gem_mmap_offset (partial-mmap) [359.546895] Starting subtest: partial-mmap [359.549162] Starting dynamic subtest: smem0 [359.551487] Dynamic subtest smem0: SUCCESS (0.004s) [359.553645] Subtest partial-mmap: SUCCESS (0.005s) [359.707651] [069/133] (662s left) syncobj_timeline (device-signal-unordered) [359.770140] Starting subtest: device-signal-unordered [359.772288] Subtest device-signal-unordered: SUCCESS (0.000s) [359.909059] [070/133] (662s left) kms_pm_dc (dc6-psr) [361.028358] Starting subtest: dc6-psr [363.917245] Subtest dc6-psr: SUCCESS (2.889s) [364.774495] [071/133] (657s left) kms_cursor_legacy (cursorb-vs-flipb-varying-size) [364.896289] Starting subtest: cursorB-vs-flipB-varying-size [364.900702] Subtest cursorB-vs-flipB-varying-size: SKIP (0.001s) [365.067163] [072/133] (657s left) kms_addfb_basic (no-handle) [365.115191] Starting subtest: no-handle [365.117459] Subtest no-handle: SUCCESS (0.000s) [365.280441] [073/133] (656s left) gem_pxp (create-regular-buffer) [365.403653] Starting subtest: create-regular-buffer [365.406088] Subtest create-regular-buffer: SUCCESS (0.000s) [365.532987] [074/133] (656s left) kms_flip (2x-dpms-vs-vblank-race) [365.633581] Starting subtest: 2x-dpms-vs-vblank-race [365.643681] Subtest 2x-dpms-vs-vblank-race: SKIP (0.011s) [365.748860] [075/133] (656s left) kms_psr (psr-dpms) [365.847521] Starting subtest: psr-dpms [365.849501] Starting dynamic subtest: eDP-1 [368.810709] Dynamic subtest eDP-1: SUCCESS (2.964s) [368.813078] Subtest psr-dpms: SUCCESS (2.964s) [369.664515] [076/133] (652s left) gem_lmem_swapping (massive-random) [369.711324] Subtest massive-random: SKIP (0.000s) [369.759715] [077/133] (652s left) gen9_exec_parse (bb-secure) [369.817528] Subtest bb-secure: SKIP (0.000s) [369.898029] [078/133] (652s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-indfb-draw-render) [370.005391] Starting subtest: psr-2p-primscrn-pri-indfb-draw-render [370.009602] Subtest psr-2p-primscrn-pri-indfb-draw-render: SKIP (0.000s) [370.142139] [079/133] (652s left) i915_suspend (fence-restore-untiled) [370.210458] Starting subtest: fence-restore-untiled [370.214746] Subtest fence-restore-untiled: SKIP (0.000s) [370.340558] [080/133] (652s left) syncobj_wait (wait-delayed-signal) [370.410589] Starting subtest: wait-delayed-signal [370.515214] Subtest wait-delayed-signal: SUCCESS (0.103s) [370.615505] [081/133] (651s left) kms_ccs (bad-pixel-format-yf-tiled-ccs) [370.708349] Starting subtest: bad-pixel-format-yf-tiled-ccs [370.710541] Starting dynamic subtest: pipe-A-eDP-1 [370.732812] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [370.744519] Starting dynamic subtest: pipe-B-eDP-1 [370.765686] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [370.775008] Starting dynamic subtest: pipe-C-eDP-1 [370.795541] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [370.805507] Starting dynamic subtest: pipe-D-eDP-1 [370.826765] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [370.830682] Subtest bad-pixel-format-yf-tiled-ccs: SKIP (0.004s) [372.960862] [082/133] (649s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-draw-render) [373.066166] Starting subtest: fbc-2p-scndscrn-cur-indfb-draw-render [373.070081] Subtest fbc-2p-scndscrn-cur-indfb-draw-render: SKIP (0.000s) [373.183663] [083/133] (649s left) kms_chamelium_hpd (dp-hpd-fast) [373.562163] Subtest dp-hpd-fast: SKIP (0.000s) [374.422283] [084/133] (648s left) gem_exec_balancer (bonded-false-hang) [374.686525] Starting subtest: bonded-false-hang [374.691099] Subtest bonded-false-hang: SKIP (0.000s) [374.830025] [085/133] (647s left) kms_ccs (crc-primary-suspend-yf-tiled-ccs) [374.935767] Starting subtest: crc-primary-suspend-yf-tiled-ccs [374.937919] Starting dynamic subtest: pipe-A-eDP-1 [374.946319] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s) [374.956683] Starting dynamic subtest: pipe-B-eDP-1 [374.965154] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s) [374.974739] Starting dynamic subtest: pipe-C-eDP-1 [374.982748] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s) [374.991630] Starting dynamic subtest: pipe-D-eDP-1 [374.999711] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s) [375.003656] Subtest crc-primary-suspend-yf-tiled-ccs: SKIP (0.004s) [377.166087] [086/133] (645s left) gem_exec_fence (syncobj-timeline-invalid-flags) [377.701260] Starting subtest: syncobj-timeline-invalid-flags [377.704079] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.000s) [378.998424] [087/133] (643s left) kms_plane_cursor (overlay) [379.096328] Starting subtest: overlay [379.100816] Starting dynamic subtest: pipe-A-eDP-1-size-64 [381.559922] Dynamic subtest pipe-A-eDP-1-size-64: SUCCESS (2.464s) [381.620501] Starting dynamic subtest: pipe-A-eDP-1-size-128 [384.081436] Dynamic subtest pipe-A-eDP-1-size-128: SUCCESS (2.471s) [384.143768] Starting dynamic subtest: pipe-A-eDP-1-size-256 [386.630072] Dynamic subtest pipe-A-eDP-1-size-256: SUCCESS (2.493s) [386.978127] Starting dynamic subtest: pipe-B-eDP-1-size-64 [390.239880] Dynamic subtest pipe-B-eDP-1-size-64: SUCCESS (3.272s) [390.301223] Starting dynamic subtest: pipe-B-eDP-1-size-128 [392.763966] Dynamic subtest pipe-B-eDP-1-size-128: SUCCESS (2.471s) [392.825114] Starting dynamic subtest: pipe-B-eDP-1-size-256 [395.320068] Dynamic subtest pipe-B-eDP-1-size-256: SUCCESS (2.504s) [395.669814] Starting dynamic subtest: pipe-C-eDP-1-size-64 [398.529306] Dynamic subtest pipe-C-eDP-1-size-64: SUCCESS (2.872s) [398.570517] Starting dynamic subtest: pipe-C-eDP-1-size-128 [400.651966] Dynamic subtest pipe-C-eDP-1-size-128: SUCCESS (2.091s) [400.690217] Starting dynamic subtest: pipe-C-eDP-1-size-256 [402.807479] Dynamic subtest pipe-C-eDP-1-size-256: SUCCESS (2.124s) [403.136334] Starting dynamic subtest: pipe-D-eDP-1-size-64 [405.886579] Dynamic subtest pipe-D-eDP-1-size-64: SUCCESS (2.762s) [405.926181] Starting dynamic subtest: pipe-D-eDP-1-size-128 [407.998450] Dynamic subtest pipe-D-eDP-1-size-128: SUCCESS (2.080s) [408.035970] Starting dynamic subtest: pipe-D-eDP-1-size-256 [410.198600] Dynamic subtest pipe-D-eDP-1-size-256: SUCCESS (2.169s) [410.518119] Subtest overlay: SUCCESS (31.420s) [411.364336] [088/133] (611s left) gem_ctx_param (basic-default) [411.428951] Starting subtest: basic-default [411.431380] Subtest basic-default: SUCCESS (0.000s) [411.528986] [089/133] (611s left) api_intel_allocator (two-level-inception-interruptible) [411.592028] Starting subtest: two-level-inception-interruptible [416.997936] Subtest two-level-inception-interruptible: SUCCESS (5.406s) [417.157792] [090/133] (605s left) kms_dsc (dsc-with-bpc-formats) [417.254294] Starting subtest: dsc-with-bpc-formats [417.367077] Subtest dsc-with-bpc-formats: SKIP (0.003s) [417.410524] [091/133] (605s left) kms_cursor_crc (cursor-alpha-opaque) [417.512098] Starting subtest: cursor-alpha-opaque [417.514329] Starting dynamic subtest: pipe-A-eDP-1 [418.153897] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.641s) [418.164852] Starting dynamic subtest: pipe-D-eDP-1 [419.493021] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.336s) [419.495490] Subtest cursor-alpha-opaque: SUCCESS (1.980s) [420.371412] [092/133] (602s left) syncobj_timeline (multi-wait-all-signaled) [420.435725] Starting subtest: multi-wait-all-signaled [420.438180] Subtest multi-wait-all-signaled: SUCCESS (0.000s) [420.579674] [093/133] (602s left) i915_drm_fdinfo (isolation) [420.626630] Starting subtest: isolation [420.628563] Starting dynamic subtest: rcs0 [420.671439] Dynamic subtest rcs0: SKIP (0.044s) [420.684031] Starting dynamic subtest: bcs0 [420.687948] Dynamic subtest bcs0: SKIP (0.000s) [420.697967] Starting dynamic subtest: vcs0 [420.702232] Dynamic subtest vcs0: SKIP (0.000s) [420.711190] Starting dynamic subtest: vcs1 [420.715226] Dynamic subtest vcs1: SKIP (0.000s) [420.724299] Starting dynamic subtest: vecs0 [420.728263] Dynamic subtest vecs0: SKIP (0.000s) [420.738220] Starting dynamic subtest: ccs0 [420.742291] Dynamic subtest ccs0: SKIP (0.000s) [420.746420] Subtest isolation: SKIP (0.051s) [420.787126] [094/133] (602s left) kms_flip_scaled_crc (flip-p016-linear-to-p016-linear-reflect-x) [420.886677] Starting subtest: flip-P016-linear-to-P016-linear-reflect-x [420.888948] Starting dynamic subtest: pipe-A-default-mode [422.064675] Dynamic subtest pipe-A-default-mode: SKIP (1.175s) [422.068773] Subtest flip-P016-linear-to-P016-linear-reflect-x: SKIP (1.177s) [422.266086] [095/133] (600s left) gem_ctx_isolation (preservation-s3) [422.329295] Starting subtest: preservation-S3 [422.331586] Starting dynamic subtest: rcs0 [438.103175] Dynamic subtest rcs0: SUCCESS (1.368s) [438.116104] Starting dynamic subtest: bcs0 [454.113167] Dynamic subtest bcs0: SUCCESS (1.349s) [454.125819] Starting dynamic subtest: vcs0 [470.104927] Dynamic subtest vcs0: SUCCESS (2.913s) [470.114952] Starting dynamic subtest: vcs1 [488.119189] Dynamic subtest vcs1: SUCCESS (4.906s) [488.131204] Starting dynamic subtest: vecs0 [506.117367] Dynamic subtest vecs0: SUCCESS (3.961s) [506.129070] Starting dynamic subtest: ccs0 [524.116763] Dynamic subtest ccs0: SUCCESS (3.052s) [524.120538] Subtest preservation-S3: SUCCESS (17.556s) [524.406786] [096/133] (498s left) gem_eio (reset-stress) [524.645138] Starting subtest: reset-stress [524.647539] Starting dynamic subtest: render [530.131744] Dynamic subtest render: SUCCESS (5.375s) [530.147859] Starting dynamic subtest: bsd1 [548.413477] Dynamic subtest bsd1: SUCCESS (18.185s) [548.430890] Starting dynamic subtest: bsd2 [566.424019] Dynamic subtest bsd2: SUCCESS (18.001s) [566.442113] Starting dynamic subtest: blt [566.447047] Dynamic subtest blt: SKIP (0.000s) [566.458158] Starting dynamic subtest: vebox [584.477523] Dynamic subtest vebox: SUCCESS (18.049s) [584.479748] Subtest reset-stress: SUCCESS (59.615s) [585.943154] [097/133] (437s left) gem_softpin (evict-snoop-interruptible) [586.024819] Starting subtest: evict-snoop-interruptible [586.030529] Subtest evict-snoop-interruptible: SKIP (0.000s) [586.181475] [098/133] (437s left) i915_module_load (reload-no-display) [586.219050] Starting subtest: reload-no-display [592.174814] Subtest reload-no-display: SUCCESS (5.956s) [592.205430] [FACT i915_module_load (reload-no-display)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [592.206128] [FACT i915_module_load (reload-no-display)] deleted: kernel.kmod_is_loaded.i915: true [592.209648] [099/133] (431s left) kms_flip (2x-flip-vs-modeset) [594.996010] Starting subtest: 2x-flip-vs-modeset [595.005688] Subtest 2x-flip-vs-modeset: SKIP (0.010s) [595.126179] [FACT kms_flip (2x-flip-vs-modeset)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [595.127362] [FACT kms_flip (2x-flip-vs-modeset)] new: kernel.kmod_is_loaded.i915: true [595.131365] [100/133] (428s left) kms_flip_scaled_crc (flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling) [595.232149] Starting subtest: flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling [595.234921] Starting dynamic subtest: pipe-A-default-mode [595.526104] Dynamic subtest pipe-A-default-mode: SKIP (0.291s) [595.531871] Subtest flip-32bpp-ytile-to-32bpp-ytilegen12rcccs-upscaling: SKIP (0.292s) [596.369605] [101/133] (427s left) kms_content_protection (type1) [596.522987] Starting subtest: type1 [596.528894] Subtest type1: SKIP (0.000s) [596.684740] [102/133] (426s left) kms_big_fb (4-tiled-16bpp-rotate-180) [596.811047] Starting subtest: 4-tiled-16bpp-rotate-180 [598.156810] Subtest 4-tiled-16bpp-rotate-180: SUCCESS (1.348s) [598.341073] [103/133] (425s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-render) [598.445576] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-render [598.449627] Subtest fbc-2p-scndscrn-spr-indfb-draw-render: SKIP (0.000s) [598.581122] [104/133] (424s left) gem_ppgtt (flink-and-close-vma-leak) [598.648918] Starting subtest: flink-and-close-vma-leak [598.690473] Subtest flink-and-close-vma-leak: SUCCESS (0.041s) [598.844053] [105/133] (424s left) syncobj_wait (signal) [598.902335] Starting subtest: signal [598.904864] Subtest signal: SUCCESS (0.000s) [599.032411] [106/133] (424s left) kms_cursor_crc (cursor-rapid-movement-128x128) [599.241114] Starting subtest: cursor-rapid-movement-128x128 [599.245921] Starting dynamic subtest: pipe-A-eDP-1 [599.775632] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.530s) [599.813947] Starting dynamic subtest: pipe-D-eDP-1 [600.959774] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.153s) [600.961769] Subtest cursor-rapid-movement-128x128: SUCCESS (1.716s) [601.836770] [107/133] (421s left) kms_psr2_sf (fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf) [606.883969] Starting subtest: fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf [606.886845] Starting dynamic subtest: pipe-A-eDP-1 [607.681019] Dynamic subtest pipe-A-eDP-1: SKIP (0.794s) [607.691607] Starting dynamic subtest: pipe-B-eDP-1 [608.815001] Dynamic subtest pipe-B-eDP-1: SKIP (1.132s) [608.819890] Subtest fbc-psr2-cursor-plane-move-continuous-exceed-fully-sf: SKIP (1.930s) [610.027231] [108/133] (413s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc) [610.128956] Starting subtest: fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc [616.607516] Subtest fbcpsr-1p-offscreen-pri-shrfb-draw-mmap-wc: SUCCESS (6.478s) [616.778669] [109/133] (406s left) kms_vblank (query-forked-busy) [616.875649] Starting subtest: query-forked-busy [616.877984] Starting dynamic subtest: pipe-A-eDP-1 [618.751703] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s) [618.772524] Starting dynamic subtest: pipe-D-eDP-1 [621.293342] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.538s) [621.296003] Subtest query-forked-busy: SUCCESS (4.416s) [622.120867] [110/133] (401s left) syncobj_timeline (invalid-transfer-non-existent-point) [622.186573] Starting subtest: invalid-transfer-non-existent-point [622.188931] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [622.294561] [111/133] (401s left) kms_big_fb (x-tiled-16bpp-rotate-0) [622.401490] Starting subtest: x-tiled-16bpp-rotate-0 [623.600964] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.200s) [623.754770] [112/133] (400s left) kms_psr (fbc-psr-primary-blt) [623.846766] Starting subtest: fbc-psr-primary-blt [623.848828] Starting dynamic subtest: eDP-1 [623.852789] Dynamic subtest eDP-1: SKIP (0.000s) [623.856620] Subtest fbc-psr-primary-blt: SKIP (0.001s) [623.944242] [113/133] (399s left) syncobj_timeline (etime-multi-wait-all-for-submit-available-unsubmitted-submi [624.005846] Starting subtest: etime-multi-wait-all-for-submit-available-unsubmitted-submitted [624.108463] Subtest etime-multi-wait-all-for-submit-available-unsubmitted-submitted: SUCCESS (0.104s) [624.209445] [114/133] (399s left) kms_frontbuffer_tracking (fbc-2p-primscrn-pri-shrfb-draw-mmap-wc) [624.311900] Starting subtest: fbc-2p-primscrn-pri-shrfb-draw-mmap-wc [624.317250] Subtest fbc-2p-primscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [624.423030] [115/133] (399s left) gem_exec_reloc (basic-cpu-active) [624.477125] Subtest basic-cpu-active: SKIP (0.000s) [624.564440] [116/133] (399s left) perf (rc6-disable) [624.718375] Starting subtest: rc6-disable [624.898874] Subtest rc6-disable: SUCCESS (0.181s) [624.952288] [117/133] (399s left) gem_ctx_shared (q-independent) [625.012103] Starting subtest: Q-independent [625.014807] Starting dynamic subtest: rcs0 [625.078000] Dynamic subtest rcs0: SUCCESS (0.068s) [625.091087] Starting dynamic subtest: vcs0 [625.118745] Dynamic subtest vcs0: SUCCESS (0.040s) [625.129125] Starting dynamic subtest: vcs1 [625.150999] Dynamic subtest vcs1: SUCCESS (0.032s) [625.160905] Starting dynamic subtest: vecs0 [625.185399] Dynamic subtest vecs0: SUCCESS (0.034s) [625.196117] Starting dynamic subtest: ccs0 [625.228872] Dynamic subtest ccs0: SUCCESS (0.042s) [625.231840] Subtest Q-independent: SUCCESS (0.220s) [627.040504] [118/133] (397s left) perf (non-zero-reason) [627.149816] Starting subtest: non-zero-reason [627.152813] Starting dynamic subtest: 0-rcs0 [632.454525] Dynamic subtest 0-rcs0: SUCCESS (5.305s) [632.467219] Starting dynamic subtest: 1-vcs0 [636.298435] Dynamic subtest 1-vcs0: SUCCESS (3.844s) [636.301556] Subtest non-zero-reason: SUCCESS (9.151s) [636.347780] [119/133] (387s left) kms_psr (pr-dpms) [636.441728] Starting subtest: pr-dpms [636.446874] Subtest pr-dpms: SKIP (0.000s) [636.543901] [120/133] (387s left) kms_rotation_crc (primary-rotation-180) [636.640833] Starting subtest: primary-rotation-180 [643.646836] Subtest primary-rotation-180: SUCCESS (7.009s) [644.876841] [121/133] (379s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-render) [644.981574] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-render [652.173368] Subtest psr-1p-primscrn-pri-shrfb-draw-render: SUCCESS (7.196s) [652.332445] [122/133] (371s left) gem_create (create-size-update) [652.396540] Starting subtest: create-size-update [652.398892] Subtest create-size-update: SUCCESS (0.000s) [652.649315] [123/133] (371s left) prime_vgem (basic-fence-blt) [652.741960] Starting subtest: basic-fence-blt [652.837795] Subtest basic-fence-blt: SUCCESS (0.098s) [652.997901] [124/133] (371s left) kms_getfb (getfb2-into-addfb2) [653.087638] Starting subtest: getfb2-into-addfb2 [653.090002] Subtest getfb2-into-addfb2: SUCCESS (0.000s) [653.201763] [125/133] (371s left) gem_pxp (verify-pxp-execution-after-suspend-resume) [653.314047] Starting subtest: verify-pxp-execution-after-suspend-resume [660.413520] Subtest verify-pxp-execution-after-suspend-resume: SUCCESS (7.099s) [660.560431] [126/133] (363s left) syncobj_basic (bad-pad-fd-to-handle) [660.620601] Starting subtest: bad-pad-fd-to-handle [660.623291] Subtest bad-pad-fd-to-handle: SUCCESS (0.000s) [660.765676] [127/133] (363s left) dmabuf_sync_file (export-before-signal) [660.830121] Starting subtest: export-before-signal [660.832676] Subtest export-before-signal: SUCCESS (0.001s) [660.914821] [128/133] (363s left) kms_flip (2x-flip-vs-panning-vs-hang) [661.005106] Starting subtest: 2x-flip-vs-panning-vs-hang [661.015853] Subtest 2x-flip-vs-panning-vs-hang: SKIP (0.010s) [661.158296] [129/133] (363s left) gem_softpin (allocator-nopin-reserve) [661.222963] Starting subtest: allocator-nopin-reserve [661.324827] Subtest allocator-nopin-reserve: SUCCESS (0.102s) [661.494219] [130/133] (363s left) kms_pipe_crc_basic (read-crc-frame-sequence) [661.587132] Starting subtest: read-crc-frame-sequence [661.589634] Starting dynamic subtest: pipe-A-eDP-1 [662.288728] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.702s) [662.300533] Starting dynamic subtest: pipe-B-eDP-1 [663.641984] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.352s) [663.652083] Starting dynamic subtest: pipe-C-eDP-1 [665.025982] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.380s) [665.036007] Starting dynamic subtest: pipe-D-eDP-1 [666.380096] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.352s) [666.382661] Subtest read-crc-frame-sequence: SUCCESS (4.792s) [667.437421] [131/133] (357s left) kms_frontbuffer_tracking (pipe-fbc-rte) [667.549985] Starting subtest: pipe-fbc-rte [667.557917] Starting dynamic subtest: pipe-B-eDP-1 [673.015968] Dynamic subtest pipe-B-eDP-1: SUCCESS (5.471s) [673.024002] Subtest pipe-fbc-rte: SUCCESS (5.474s) [675.355008] [132/133] (349s left) kms_addfb_basic (too-wide) [675.452941] Starting subtest: too-wide [675.455978] Subtest too-wide: SUCCESS (0.000s) [675.588991] [133/133] (349s left) gem_exec_schedule (pi-shared-iova) [675.770606] Starting subtest: pi-shared-iova [675.773036] Starting dynamic subtest: rcs0 [675.850891] Dynamic subtest rcs0: SUCCESS (0.082s) [675.861336] Starting dynamic subtest: vcs0 [675.906627] Dynamic subtest vcs0: SUCCESS (0.053s) [675.916467] Starting dynamic subtest: vcs1 [675.961729] Dynamic subtest vcs1: SUCCESS (0.054s) [675.972748] Starting dynamic subtest: vecs0 [676.009663] Dynamic subtest vecs0: SUCCESS (0.047s) [676.020892] Starting dynamic subtest: ccs0 [676.061368] Dynamic subtest ccs0: SUCCESS (0.051s) [676.064092] Subtest pi-shared-iova: SUCCESS (0.293s) [678.039802] Closing watchdogs results: parsing output: 0/ for test: syncobj_basic results: parsing output: 1/ for test: kms_psr2_sf results: parsing output: 2/ for test: gem_ccs results: parsing output: 3/ for test: kms_sequence results: parsing output: 4/ for test: sysfs_preempt_timeout results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_ctx_persistence results: parsing output: 7/ for test: drm_read results: parsing output: 8/ for test: gem_render_copy_redux results: parsing output: 9/ for test: kms_big_fb results: parsing output: 10/ for test: kms_frontbuffer_tracking results: parsing output: 11/ for test: gem_exec_suspend results: parsing output: 12/ for test: kms_hdmi_inject results: parsing output: 13/ for test: kms_cursor_crc results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: kms_frontbuffer_tracking results: parsing output: 16/ for test: gem_render_copy results: parsing output: 17/ for test: kms_big_fb results: parsing output: 18/ for test: syncobj_timeline results: parsing output: 19/ for test: syncobj_wait results: parsing output: 20/ for test: kms_ccs results: parsing output: 21/ for test: kms_pm_rpm results: parsing output: 22/ for test: kms_frontbuffer_tracking results: parsing output: 23/ for test: kms_chamelium_edid results: parsing output: 24/ for test: gem_render_copy results: parsing output: 25/ for test: kms_flip results: parsing output: 26/ for test: gem_exec_big results: parsing output: 27/ for test: gem_exec_flush results: parsing output: 28/ for test: kms_async_flips results: parsing output: 29/ for test: kms_plane_scaling results: parsing output: 30/ for test: kms_frontbuffer_tracking results: parsing output: 31/ for test: kms_properties results: parsing output: 32/ for test: kms_frontbuffer_tracking results: parsing output: 33/ for test: kms_ccs results: parsing output: 34/ for test: gem_wait results: parsing output: 35/ for test: kms_frontbuffer_tracking results: parsing output: 36/ for test: kms_big_fb results: parsing output: 37/ for test: gem_exec_reloc results: parsing output: 38/ for test: kms_big_fb results: parsing output: 39/ for test: kms_lease results: parsing output: 40/ for test: gem_exec_schedule results: parsing output: 41/ for test: gem_exec_whisper results: parsing output: 42/ for test: i915_query results: parsing output: 43/ for test: kms_big_fb results: parsing output: 44/ for test: perf_pmu results: parsing output: 45/ for test: kms_frontbuffer_tracking results: parsing output: 46/ for test: gem_exec_flush results: parsing output: 47/ for test: gem_basic results: parsing output: 48/ for test: kms_frontbuffer_tracking results: parsing output: 49/ for test: kms_plane results: parsing output: 50/ for test: kms_psr results: parsing output: 51/ for test: gem_mmap results: parsing output: 52/ for test: kms_frontbuffer_tracking results: parsing output: 53/ for test: api_intel_bb results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_psr results: parsing output: 56/ for test: kms_flip results: parsing output: 57/ for test: kms_ccs results: parsing output: 58/ for test: kms_dp_linktrain_fallback results: parsing output: 59/ for test: gem_readwrite results: parsing output: 60/ for test: kms_frontbuffer_tracking results: parsing output: 61/ for test: prime_vgem results: parsing output: 62/ for test: perf_pmu results: parsing output: 63/ for test: i915_pm_rpm results: parsing output: 64/ for test: kms_flip results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: kms_color results: parsing output: 67/ for test: gem_mmap_offset results: parsing output: 68/ for test: syncobj_timeline results: parsing output: 69/ for test: kms_pm_dc results: parsing output: 70/ for test: kms_cursor_legacy results: parsing output: 71/ for test: kms_addfb_basic results: parsing output: 72/ for test: gem_pxp results: parsing output: 73/ for test: kms_flip results: parsing output: 74/ for test: kms_psr results: parsing output: 75/ for test: gem_lmem_swapping results: parsing output: 76/ for test: gen9_exec_parse results: parsing output: 77/ for test: kms_frontbuffer_tracking results: parsing output: 78/ for test: i915_suspend results: parsing output: 79/ for test: syncobj_wait results: parsing output: 80/ for test: kms_ccs results: parsing output: 81/ for test: kms_frontbuffer_tracking results: parsing output: 82/ for test: kms_chamelium_hpd results: parsing output: 83/ for test: gem_exec_balancer results: parsing output: 84/ for test: kms_ccs results: parsing output: 85/ for test: gem_exec_fence results: parsing output: 86/ for test: kms_plane_cursor results: parsing output: 87/ for test: gem_ctx_param results: parsing output: 88/ for test: api_intel_allocator results: parsing output: 89/ for test: kms_dsc results: parsing output: 90/ for test: kms_cursor_crc results: parsing output: 91/ for test: syncobj_timeline results: parsing output: 92/ for test: i915_drm_fdinfo results: parsing output: 93/ for test: kms_flip_scaled_crc results: parsing output: 94/ for test: gem_ctx_isolation results: parsing output: 95/ for test: gem_eio results: parsing output: 96/ for test: gem_softpin results: parsing output: 97/ for test: i915_module_load results: parsing output: 98/ for test: kms_flip results: parsing output: 99/ for test: kms_flip_scaled_crc results: parsing output: 100/ for test: kms_content_protection results: parsing output: 101/ for test: kms_big_fb results: parsing output: 102/ for test: kms_frontbuffer_tracking results: parsing output: 103/ for test: gem_ppgtt results: parsing output: 104/ for test: syncobj_wait results: parsing output: 105/ for test: kms_cursor_crc results: parsing output: 106/ for test: kms_psr2_sf results: parsing output: 107/ for test: kms_frontbuffer_tracking results: parsing output: 108/ for test: kms_vblank results: parsing output: 109/ for test: syncobj_timeline results: parsing output: 110/ for test: kms_big_fb results: parsing output: 111/ for test: kms_psr results: parsing output: 112/ for test: syncobj_timeline results: parsing output: 113/ for test: kms_frontbuffer_tracking results: parsing output: 114/ for test: gem_exec_reloc results: parsing output: 115/ for test: perf results: parsing output: 116/ for test: gem_ctx_shared results: parsing output: 117/ for test: perf results: parsing output: 118/ for test: kms_psr results: parsing output: 119/ for test: kms_rotation_crc results: parsing output: 120/ for test: kms_frontbuffer_tracking results: parsing output: 121/ for test: gem_create results: parsing output: 122/ for test: prime_vgem results: parsing output: 123/ for test: kms_getfb results: parsing output: 124/ for test: gem_pxp results: parsing output: 125/ for test: syncobj_basic results: parsing output: 126/ for test: dmabuf_sync_file results: parsing output: 127/ for test: kms_flip results: parsing output: 128/ for test: gem_softpin results: parsing output: 129/ for test: kms_pipe_crc_basic results: parsing output: 130/ for test: kms_frontbuffer_tracking results: parsing output: 131/ for test: kms_addfb_basic results: parsing output: 132/ for test: gem_exec_schedule Done.