[68.557562] Initializing watchdogs [68.557700] /dev/watchdog0 [68.577356] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:0102 Intel Sandybridge (Gen6) 2nd Generation Core Processor Family Integrated Graphics Controller (XPS 8300) [68.587302] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [68.590903] [FACT before any test] new: kernel.kmod_is_loaded.i915: true [68.593966] [001/130] (960s left) kms_plane_scaling (plane-upscale-20x20-with-rotation) [68.962096] Starting subtest: plane-upscale-20x20-with-rotation [68.962555] Starting dynamic subtest: pipe-A [68.963783] Dynamic subtest pipe-A: SKIP (0.002s) [68.973617] Starting dynamic subtest: pipe-B [68.975195] Dynamic subtest pipe-B: SKIP (0.001s) [68.976271] Subtest plane-upscale-20x20-with-rotation: SKIP (0.004s) [69.437830] [002/130] (959s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-cur-indfb-move) [69.802647] Starting subtest: fbc-2p-scndscrn-cur-indfb-move [69.803619] Subtest fbc-2p-scndscrn-cur-indfb-move: SKIP (0.000s) [70.268291] [003/130] (958s left) kms_big_fb (linear-8bpp-rotate-180) [70.636436] Starting subtest: linear-8bpp-rotate-180 [72.059428] Subtest linear-8bpp-rotate-180: SUCCESS (1.424s) [72.566240] [004/130] (956s left) kms_flip (blocking-absolute-wf_vblank-interruptible) [72.929907] Starting subtest: blocking-absolute-wf_vblank-interruptible [72.931078] Starting dynamic subtest: A-VGA1 [80.673559] Dynamic subtest A-VGA1: SUCCESS (7.745s) [80.682489] Starting dynamic subtest: B-VGA1 [88.361537] Dynamic subtest B-VGA1: SUCCESS (7.689s) [88.371827] Starting dynamic subtest: A-HDMI-A1 [96.234369] Dynamic subtest A-HDMI-A1: SUCCESS (7.873s) [96.243946] Starting dynamic subtest: B-HDMI-A1 [104.136435] Dynamic subtest B-HDMI-A1: SUCCESS (7.901s) [104.137727] Subtest blocking-absolute-wf_vblank-interruptible: SUCCESS (31.213s) [104.766297] [005/130] (924s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu) [105.128628] Starting subtest: fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu [105.129673] Subtest fbcpsr-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s) [105.595441] [006/130] (923s left) kms_frontbuffer_tracking (fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu) [105.961353] Starting subtest: fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu [105.962522] Subtest fbcpsr-1p-offscren-pri-indfb-draw-mmap-cpu: SKIP (0.000s) [106.394101] [007/130] (922s left) gem_ctx_exec (basic-norecovery) [106.449768] Starting subtest: basic-norecovery [106.460990] Subtest basic-norecovery: SUCCESS (0.012s) [106.592547] [008/130] (922s left) kms_psr (psr-primary-page-flip) [106.951223] Subtest psr-primary-page-flip: SKIP (0.000s) [107.171805] [009/130] (922s left) core_getstats [107.345546] [010/130] (922s left) i915_hangman (detector) [107.406990] Starting subtest: detector [107.407490] Starting dynamic subtest: rcs0 [111.051743] Dynamic subtest rcs0: SUCCESS (3.645s) [111.061777] Starting dynamic subtest: bcs0 [114.998796] Dynamic subtest bcs0: SUCCESS (3.947s) [115.010360] Starting dynamic subtest: vcs0 [119.032830] Dynamic subtest vcs0: SUCCESS (4.033s) [119.034174] Subtest detector: SUCCESS (11.626s) [119.079980] [011/130] (910s left) kms_ccs (crc-primary-rotation-180-4-tiled-mtl-mc-ccs) [119.132351] Subtest crc-primary-rotation-180-4-tiled-mtl-mc-ccs: SKIP (0.000s) [119.178258] [012/130] (910s left) gem_lmem_swapping (parallel-random-engines) [119.234291] Subtest parallel-random-engines: SKIP (0.000s) [119.282213] [013/130] (910s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-gtt) [119.642076] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-gtt [119.643126] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s) [120.082816] [014/130] (909s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip) [120.447881] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip [120.449257] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.000s) [120.922175] [015/130] (908s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc) [121.283958] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc [121.285160] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-wc: SKIP (0.000s) [121.748697] [016/130] (907s left) gem_ctx_persistence (legacy-engines-hostile) [121.802720] Subtest legacy-engines-hostile: SKIP (0.000s) [121.861017] [017/130] (907s left) prime_vgem (shrink) [121.976660] Starting subtest: shrink [121.988436] Subtest shrink: SUCCESS (0.011s) [122.134841] [FACT prime_vgem (shrink)] new: kernel.kmod_is_loaded.vgem: true [122.137522] [018/130] (907s left) gem_exec_schedule (preempt-queue-chain) [122.204606] Subtest preempt-queue-chain: SKIP (0.000s) [122.417238] [019/130] (907s left) kms_flip (flip-vs-panning-vs-hang) [122.780664] Starting subtest: flip-vs-panning-vs-hang [122.781946] Starting dynamic subtest: A-VGA1 [134.902532] Dynamic subtest A-VGA1: SUCCESS (12.121s) [134.913942] Starting dynamic subtest: B-VGA1 [146.873375] Dynamic subtest B-VGA1: SUCCESS (11.970s) [146.882790] Starting dynamic subtest: A-HDMI-A1 [158.906464] Dynamic subtest A-HDMI-A1: SUCCESS (12.033s) [158.919150] Starting dynamic subtest: B-HDMI-A1 [170.873113] Dynamic subtest B-HDMI-A1: SUCCESS (11.963s) [170.873842] Subtest flip-vs-panning-vs-hang: SUCCESS (48.091s) [171.504473] [020/130] (858s left) kms_cursor_crc (cursor-rapid-movement-256x256) [171.865143] Starting subtest: cursor-rapid-movement-256x256 [171.867087] Starting dynamic subtest: pipe-A-HDMI-A-1 [172.228315] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.356s) [172.265867] Starting dynamic subtest: pipe-B-HDMI-A-1 [172.619827] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.363s) [172.620353] Subtest cursor-rapid-movement-256x256: SUCCESS (0.755s) [173.218839] [021/130] (856s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-indfb-draw-pwrite) [173.580356] Starting subtest: fbc-2p-scndscrn-pri-indfb-draw-pwrite [173.581395] Subtest fbc-2p-scndscrn-pri-indfb-draw-pwrite: SKIP (0.000s) [174.068162] [022/130] (855s left) gem_exec_balancer (sliced) [174.125829] Subtest sliced: SKIP (0.000s) [174.245423] [023/130] (855s left) kms_psr (fbc-psr-suspend) [174.601960] Subtest fbc-psr-suspend: SKIP (0.000s) [174.834993] [024/130] (855s left) kms_frontbuffer_tracking (fbcpsr-stridechange) [175.198860] Starting subtest: fbcpsr-stridechange [175.199954] Subtest fbcpsr-stridechange: SKIP (0.000s) [175.657715] [025/130] (854s left) kms_big_fb (4-tiled-32bpp-rotate-180) [176.027530] Starting subtest: 4-tiled-32bpp-rotate-180 [176.028683] Subtest 4-tiled-32bpp-rotate-180: SKIP (0.000s) [176.510769] [026/130] (853s left) gem_mmap_gtt (basic-read-write-distinct) [176.564912] Starting subtest: basic-read-write-distinct [176.581152] Subtest basic-read-write-distinct: SUCCESS (0.016s) [176.724936] [027/130] (853s left) perf_pmu (busy-accuracy-2) [176.781806] Starting subtest: busy-accuracy-2 [176.782466] Starting dynamic subtest: rcs0 [176.783808] Dynamic subtest rcs0: SKIP (0.000s) [176.793385] Starting dynamic subtest: bcs0 [176.794898] Dynamic subtest bcs0: SKIP (0.000s) [176.809139] Starting dynamic subtest: vcs0 [176.811088] Dynamic subtest vcs0: SKIP (0.000s) [176.812450] Subtest busy-accuracy-2: SKIP (0.001s) [176.905120] [028/130] (853s left) gem_create (create-ext-set-pat) [177.067904] Starting subtest: create-ext-set-pat [177.069565] Subtest create-ext-set-pat: SKIP (0.000s) [177.187307] [029/130] (853s left) gem_exec_reloc (basic-wc-cpu-active) [177.238860] Starting subtest: basic-wc-cpu-active [177.349248] Subtest basic-wc-cpu-active: SUCCESS (0.110s) [178.124585] [030/130] (852s left) gem_ctx_persistence (userptr) [178.183194] Subtest userptr: SKIP (0.000s) [178.246189] [031/130] (852s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted) [178.300805] Starting subtest: multi-wait-all-for-submit-unsubmitted [178.403250] Subtest multi-wait-all-for-submit-unsubmitted: SUCCESS (0.102s) [178.535584] [032/130] (851s left) gem_busy (close-race) [178.601431] Starting subtest: close-race [200.543486] Subtest close-race: SUCCESS (21.942s) [200.913337] [033/130] (829s left) kms_addfb_basic (small-bo) [201.360711] Starting subtest: small-bo [201.362461] Subtest small-bo: SUCCESS (0.000s) [201.841995] [034/130] (828s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-render) [202.215041] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-render [204.136988] Subtest fbc-1p-primscrn-pri-shrfb-draw-render: SUCCESS (1.923s) [204.635485] [035/130] (826s left) syncobj_timeline (invalid-transfer-non-existent-point) [204.698571] Starting subtest: invalid-transfer-non-existent-point [204.699436] Subtest invalid-transfer-non-existent-point: SUCCESS (0.000s) [204.815546] [036/130] (825s left) kms_lease (lease-revoke) [205.170244] Starting subtest: lease-revoke [205.170790] Starting dynamic subtest: pipe-A-HDMI-A-1 [205.224987] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.051s) [205.235163] Starting dynamic subtest: pipe-B-HDMI-A-1 [205.264596] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.041s) [205.265081] Subtest lease-revoke: SUCCESS (0.096s) [205.730128] [037/130] (825s left) kms_frontbuffer_tracking (psr-rgb101010-draw-pwrite) [206.094580] Starting subtest: psr-rgb101010-draw-pwrite [206.095518] Subtest psr-rgb101010-draw-pwrite: SKIP (0.000s) [206.566557] [038/130] (824s left) gem_mmap_offset (partial-remap) [206.623548] Starting subtest: partial-remap [206.624216] Starting dynamic subtest: smem0 [206.629442] Dynamic subtest smem0: SUCCESS (0.005s) [206.630156] Subtest partial-remap: SUCCESS (0.005s) [206.777822] [039/130] (824s left) gem_exec_whisper (basic-fds-priority) [206.846029] Starting subtest: basic-fds-priority [206.848348] Subtest basic-fds-priority: SKIP (0.001s) [207.081257] [040/130] (823s left) gem_softpin (allocator-nopin) [207.139843] Subtest allocator-nopin: SKIP (0.000s) [207.260905] [041/130] (823s left) gem_exec_reloc (basic-concurrent16) [207.319173] Starting subtest: basic-concurrent16 [212.712559] Subtest basic-concurrent16: SUCCESS (5.393s) [213.494095] [042/130] (817s left) kms_vrr (negative-basic) [213.855031] Starting subtest: negative-basic [213.856614] Subtest negative-basic: SKIP (0.000s) [214.332301] [043/130] (816s left) syncobj_timeline (single-wait-all-signaled) [214.388375] Starting subtest: single-wait-all-signaled [214.389853] Subtest single-wait-all-signaled: SUCCESS (0.001s) [214.514855] [044/130] (816s left) kms_psr (fbc-psr2-primary-page-flip) [214.870480] Subtest fbc-psr2-primary-page-flip: SKIP (0.000s) [215.107197] [045/130] (816s left) kms_feature_discovery (display-4x) [215.464409] Starting subtest: display-4x [215.465782] Subtest display-4x: SKIP (0.000s) [215.929476] [046/130] (815s left) kms_pm_rpm (universal-planes) [227.557712] Subtest universal-planes: SKIP (0.000s) [227.781432] [047/130] (803s left) kms_big_fb (x-tiled-max-hw-stride-64bpp-rotate-180-hflip) [228.151332] Starting subtest: x-tiled-max-hw-stride-64bpp-rotate-180-hflip [228.172382] Subtest x-tiled-max-hw-stride-64bpp-rotate-180-hflip: SKIP (0.020s) [228.637835] [048/130] (802s left) gem_exec_reloc (basic-cpu-gtt-noreloc) [228.697751] Starting subtest: basic-cpu-gtt-noreloc [228.700185] Subtest basic-cpu-gtt-noreloc: SUCCESS (0.003s) [229.470661] [049/130] (801s left) kms_scaling_modes (scaling-mode-full-aspect) [229.825019] Starting subtest: scaling-mode-full-aspect [229.826816] Subtest scaling-mode-full-aspect: SKIP (0.000s) [230.282461] [050/130] (801s left) kms_color (degamma) [230.642327] Starting subtest: degamma [230.642800] Starting dynamic subtest: pipe-A-HDMI-A-1 [230.643796] Dynamic subtest pipe-A-HDMI-A-1: SKIP (0.001s) [230.654595] Starting dynamic subtest: pipe-B-HDMI-A-1 [230.655641] Dynamic subtest pipe-B-HDMI-A-1: SKIP (0.001s) [230.656640] Subtest degamma: SKIP (0.004s) [231.117332] [051/130] (800s left) kms_cursor_crc (cursor-offscreen-256x85) [231.487146] Starting subtest: cursor-offscreen-256x85 [231.553808] Subtest cursor-offscreen-256x85: SKIP (0.066s) [232.029424] [052/130] (799s left) kms_cursor_legacy (cursora-vs-flipb-atomic-transitions-varying-size) [232.378468] Starting subtest: cursorA-vs-flipB-atomic-transitions-varying-size [232.380189] Subtest cursorA-vs-flipB-atomic-transitions-varying-size: SKIP (0.001s) [232.843139] [053/130] (798s left) perf_pmu (busy-start) [232.903263] Starting subtest: busy-start [232.903978] Starting dynamic subtest: rcs0 [235.428309] Dynamic subtest rcs0: SUCCESS (2.524s) [235.441993] Starting dynamic subtest: bcs0 [237.943927] Dynamic subtest bcs0: SUCCESS (2.512s) [237.961070] Starting dynamic subtest: vcs0 [240.959340] Dynamic subtest vcs0: SUCCESS (3.015s) [240.960564] Subtest busy-start: SUCCESS (8.057s) [241.107276] [054/130] (790s left) gem_spin_batch (spin-each) [241.170355] Starting subtest: spin-each [244.503551] Subtest spin-each: SUCCESS (3.333s) [244.797259] [055/130] (786s left) kms_frontbuffer_tracking (fbc-1p-indfb-fliptrack-mmap-gtt) [245.153760] Starting subtest: fbc-1p-indfb-fliptrack-mmap-gtt [247.715387] Subtest fbc-1p-indfb-fliptrack-mmap-gtt: SUCCESS (2.561s) [248.198949] [056/130] (783s left) kms_chamelium_frames (hdmi-crc-multiple) [248.633387] Subtest hdmi-crc-multiple: SKIP (0.000s) [248.983121] [057/130] (782s left) gen9_exec_parse (bb-start-out) [249.039822] Subtest bb-start-out: SKIP (0.000s) [249.096611] [058/130] (782s left) kms_cursor_legacy (cursorb-vs-flipa-atomic-transitions) [249.448700] Starting subtest: cursorB-vs-flipA-atomic-transitions [249.450493] Subtest cursorB-vs-flipA-atomic-transitions: SKIP (0.002s) [249.902464] [059/130] (781s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-blt) [250.266607] Starting subtest: psr-2p-primscrn-spr-indfb-draw-blt [250.267629] Subtest psr-2p-primscrn-spr-indfb-draw-blt: SKIP (0.000s) [250.715238] [060/130] (781s left) kms_ccs (bad-pixel-format-4-tiled-dg2-rc-ccs-cc) [250.770401] Subtest bad-pixel-format-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [250.826107] [061/130] (781s left) kms_flip (absolute-wf_vblank) [251.181898] Starting subtest: absolute-wf_vblank [251.183306] Starting dynamic subtest: A-VGA1 [258.949609] Dynamic subtest A-VGA1: SUCCESS (7.766s) [258.962769] Starting dynamic subtest: B-VGA1 [266.675282] Dynamic subtest B-VGA1: SUCCESS (7.723s) [266.689127] Starting dynamic subtest: A-HDMI-A1 [274.565306] Dynamic subtest A-HDMI-A1: SUCCESS (7.887s) [274.580989] Starting dynamic subtest: B-HDMI-A1 [282.499425] Dynamic subtest B-HDMI-A1: SUCCESS (7.931s) [282.502013] Subtest absolute-wf_vblank: SUCCESS (31.319s) [283.154192] [062/130] (748s left) syncobj_timeline (etime-multi-wait-all-for-submit-submitted-signaled) [283.209531] Starting subtest: etime-multi-wait-all-for-submit-submitted-signaled [283.315491] Subtest etime-multi-wait-all-for-submit-submitted-signaled: SUCCESS (0.105s) [283.451592] [063/130] (748s left) syncobj_timeline (invalid-multi-wait-all-unsubmitted-signaled) [283.507098] Starting subtest: invalid-multi-wait-all-unsubmitted-signaled [283.508747] Subtest invalid-multi-wait-all-unsubmitted-signaled: SUCCESS (0.001s) [283.635688] [064/130] (748s left) kms_flip (2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible) [283.992854] Starting subtest: 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible [283.994704] Starting dynamic subtest: AB-VGA1-HDMI-A1 [285.568725] Dynamic subtest AB-VGA1-HDMI-A1: SUCCESS (1.574s) [285.570331] Subtest 2x-single-buffer-flip-vs-dpms-off-vs-modeset-interruptible: SUCCESS (1.577s) [286.175319] [065/130] (746s left) kms_cursor_crc (cursor-onscreen-128x42) [286.539189] Starting subtest: cursor-onscreen-128x42 [286.599380] Subtest cursor-onscreen-128x42: SKIP (0.059s) [287.056606] [066/130] (745s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc) [287.115671] Subtest crc-sprite-planes-basic-4-tiled-dg2-rc-ccs-cc: SKIP (0.000s) [287.184404] [067/130] (745s left) kms_ccs (crc-primary-basic-4-tiled-dg2-rc-ccs) [287.240801] Subtest crc-primary-basic-4-tiled-dg2-rc-ccs: SKIP (0.000s) [287.306922] [068/130] (745s left) kms_vblank (query-idle) [287.654727] Starting subtest: query-idle [287.655407] Starting dynamic subtest: pipe-A-HDMI-A-1 [289.837838] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (2.182s) [289.857159] Starting dynamic subtest: pipe-B-HDMI-A-1 [292.066391] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (2.227s) [292.066974] Subtest query-idle: SUCCESS (4.414s) [292.632590] [069/130] (739s left) gem_exec_reloc (basic-cpu-read-active) [292.689609] Starting subtest: basic-cpu-read-active [292.799551] Subtest basic-cpu-read-active: SUCCESS (0.110s) [293.563572] [070/130] (738s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt) [293.924243] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt [293.925252] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [294.384564] [071/130] (738s left) kms_psr2_sf (fbc-psr2-plane-move-sf-dmg-area) [294.745899] Subtest fbc-psr2-plane-move-sf-dmg-area: SKIP (0.000s) [294.971596] [072/130] (737s left) kms_frontbuffer_tracking (fbc-1p-primscrn-pri-shrfb-draw-pwrite) [295.335437] Starting subtest: fbc-1p-primscrn-pri-shrfb-draw-pwrite [297.356386] Subtest fbc-1p-primscrn-pri-shrfb-draw-pwrite: SUCCESS (2.021s) [297.856019] [073/130] (734s left) kms_frontbuffer_tracking (psr-2p-primscrn-pri-shrfb-draw-blt) [298.213070] Starting subtest: psr-2p-primscrn-pri-shrfb-draw-blt [298.214109] Subtest psr-2p-primscrn-pri-shrfb-draw-blt: SKIP (0.000s) [298.684788] [074/130] (733s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-move) [299.047650] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-move [299.048865] Subtest fbcpsr-1p-primscrn-spr-indfb-move: SKIP (0.000s) [299.517493] [075/130] (733s left) kms_frontbuffer_tracking (fbc-modesetfrombusy) [299.882482] Starting subtest: fbc-modesetfrombusy [300.817854] Subtest fbc-modesetfrombusy: SUCCESS (0.937s) [301.303851] [076/130] (731s left) gem_tiled_blits (basic) [301.515278] Starting subtest: basic [301.528920] Subtest basic: SUCCESS (0.014s) [301.691797] [077/130] (731s left) gem_eio (context-create) [301.835167] Starting subtest: context-create [301.864507] Subtest context-create: SUCCESS (0.026s) [302.633681] [078/130] (730s left) gem_render_copy (x-tiled-to-vebox-y-tiled) [302.700324] Starting subtest: x-tiled-to-vebox-y-tiled [302.701572] Subtest x-tiled-to-vebox-y-tiled: SKIP (0.000s) [302.900459] [079/130] (729s left) kms_cursor_legacy (basic-busy-flip-before-cursor-varying-size) [303.258360] Starting subtest: basic-busy-flip-before-cursor-varying-size [303.259387] Subtest basic-busy-flip-before-cursor-varying-size: SKIP (0.000s) [303.731215] [080/130] (729s left) kms_plane_alpha_blend (alpha-7efc) [304.088816] Starting subtest: alpha-7efc [304.258655] Subtest alpha-7efc: SKIP (0.170s) [304.920634] [081/130] (728s left) i915_selftest (perf) [305.842116] Starting subtest: perf [305.842648] Starting dynamic subtest: engine_cs [307.521672] Dynamic subtest engine_cs: SUCCESS (1.680s) [307.537638] Starting dynamic subtest: request [312.063706] Dynamic subtest request: SUCCESS (4.539s) [312.076139] Starting dynamic subtest: migrate [313.644581] Dynamic subtest migrate: SUCCESS (1.579s) [313.656967] Starting dynamic subtest: region [316.996561] Dynamic subtest region: SUCCESS (3.348s) [316.997100] Subtest perf: SUCCESS (11.155s) [317.027578] [FACT i915_selftest (perf)] deleted: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [317.028842] [FACT i915_selftest (perf)] deleted: kernel.kmod_is_loaded.i915: true [317.031062] [082/130] (716s left) kms_cursor_legacy (short-flip-before-cursor-toggle) [319.190815] Starting subtest: short-flip-before-cursor-toggle [320.370623] Subtest short-flip-before-cursor-toggle: SUCCESS (1.180s) [320.982985] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0 [320.984629] [FACT kms_cursor_legacy (short-flip-before-cursor-toggle)] new: kernel.kmod_is_loaded.i915: true [320.988221] [083/130] (712s left) kms_pm_rpm (modeset-lpsp-stress) [332.578508] Subtest modeset-lpsp-stress: SKIP (0.000s) [332.814701] [084/130] (700s left) gem_exec_flush (basic-wb-rw-before-default) [332.886633] Starting subtest: basic-wb-rw-before-default [338.344195] Subtest basic-wb-rw-before-default: SUCCESS (5.458s) [338.567247] [085/130] (694s left) kms_big_fb (4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip) [338.940404] Starting subtest: 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip [338.941465] Subtest 4-tiled-max-hw-stride-64bpp-rotate-180-hflip-async-flip: SKIP (0.000s) [339.418869] [086/130] (693s left) i915_query (query-regions-unallocated) [339.474225] Starting subtest: query-regions-unallocated [339.474697] Subtest query-regions-unallocated: SUCCESS (0.000s) [339.599146] [087/130] (693s left) gem_exec_flush (basic-batch-kernel-default-wb) [339.663634] Starting subtest: basic-batch-kernel-default-wb [345.228703] Subtest basic-batch-kernel-default-wb: SUCCESS (5.565s) [345.476830] [088/130] (687s left) syncobj_wait (multi-wait-all-signaled) [345.532026] Starting subtest: multi-wait-all-signaled [345.533017] Subtest multi-wait-all-signaled: SUCCESS (0.001s) [345.656689] [089/130] (687s left) kms_dirtyfb (fbc-dirtyfb-ioctl) [346.010978] Starting subtest: fbc-dirtyfb-ioctl [346.011583] Starting dynamic subtest: A-HDMI-A-1 [347.369138] Dynamic subtest A-HDMI-A-1: SUCCESS (1.356s) [347.369883] Subtest fbc-dirtyfb-ioctl: SUCCESS (1.358s) [347.964613] [090/130] (685s left) kms_psr2_sf (psr2-overlay-plane-update-continuous-sf) [348.320328] Subtest psr2-overlay-plane-update-continuous-sf: SKIP (0.000s) [348.556131] [091/130] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-shrfb-pgflip-blt) [348.913694] Starting subtest: fbcpsr-2p-scndscrn-shrfb-pgflip-blt [348.914860] Subtest fbcpsr-2p-scndscrn-shrfb-pgflip-blt: SKIP (0.000s) [349.381671] [092/130] (684s left) kms_fbcon_fbt (fbc-suspend) [349.439379] Starting subtest: fbc-suspend [396.860471] Subtest fbc-suspend: SUCCESS (16.326s) [398.934200] [093/130] (636s left) kms_big_fb (y-tiled-8bpp-rotate-270) [399.352852] Starting subtest: y-tiled-8bpp-rotate-270 [399.354184] Subtest y-tiled-8bpp-rotate-270: SKIP (0.000s) [399.820643] [094/130] (635s left) gem_exec_schedule (u-submit-early-slice) [399.893075] Subtest u-submit-early-slice: SKIP (0.000s) [400.138348] [095/130] (635s left) vgem_basic (debugfs) [400.205949] Starting subtest: debugfs [400.206528] Subtest debugfs: SUCCESS (0.002s) [400.320792] [096/130] (635s left) gen7_exec_parse (batch-without-end) [400.377157] Subtest batch-without-end: SKIP (0.000s) [400.438736] [097/130] (635s left) kms_frontbuffer_tracking (fbcpsr-1p-pri-indfb-multidraw) [400.806569] Starting subtest: fbcpsr-1p-pri-indfb-multidraw [400.807520] Subtest fbcpsr-1p-pri-indfb-multidraw: SKIP (0.000s) [401.295670] [098/130] (634s left) dmabuf_sync_file (export-basic) [401.379030] Starting subtest: export-basic [401.379529] Subtest export-basic: SUCCESS (0.002s) [401.499022] [099/130] (634s left) kms_ccs (random-ccs-data-y-tiled-ccs) [401.556054] Subtest random-ccs-data-y-tiled-ccs: SKIP (0.000s) [401.623353] [100/130] (634s left) kms_cursor_legacy (cursorb-vs-flipb-atomic) [401.976654] Starting subtest: cursorB-vs-flipB-atomic [401.977668] Subtest cursorB-vs-flipB-atomic: SKIP (0.001s) [402.448268] [101/130] (633s left) gem_mmap_gtt (cpuset-medium-copy-xy) [402.508002] Starting subtest: cpuset-medium-copy-XY [404.213951] Subtest cpuset-medium-copy-XY: SUCCESS (1.698s) [404.362777] [102/130] (631s left) gem_pxp (protected-encrypted-src-copy-not-readible) [407.026073] Starting subtest: protected-encrypted-src-copy-not-readible [407.027317] Subtest protected-encrypted-src-copy-not-readible: SKIP (0.000s) [407.164640] [103/130] (628s left) kms_flip_scaled_crc (flip-32bpp-linear-to-64bpp-linear-downscaling) [407.221165] Subtest flip-32bpp-linear-to-64bpp-linear-downscaling: SKIP (0.000s) [407.292211] [104/130] (628s left) kms_frontbuffer_tracking (fbcpsr-tiling-y) [407.659008] Starting subtest: fbcpsr-tiling-y [407.661290] Subtest fbcpsr-tiling-y: SKIP (0.000s) [408.130212] [105/130] (628s left) gem_exec_fence (syncobj-timeline-invalid-flags) [408.452220] Starting subtest: syncobj-timeline-invalid-flags [408.452958] Subtest syncobj-timeline-invalid-flags: SUCCESS (0.001s) [408.713505] [106/130] (627s left) gem_basic (create-close) [408.768352] Starting subtest: create-close [408.769501] Subtest create-close: SUCCESS (0.000s) [408.915130] [107/130] (627s left) api_intel_allocator (reloc-allocator) [408.968617] Starting subtest: reloc-allocator [408.969574] Starting dynamic subtest: basic [408.973498] Dynamic subtest basic: SUCCESS (0.006s) [408.991064] Starting dynamic subtest: parallel-one [408.991733] Dynamic subtest parallel-one: SUCCESS (0.007s) [409.007674] Starting dynamic subtest: print [409.008357] Dynamic subtest print: SUCCESS (0.000s) [409.023913] Starting dynamic subtest: reuse [409.025018] Dynamic subtest reuse: SUCCESS (0.000s) [409.044048] Starting dynamic subtest: fork-reopen-allocator [409.045227] Dynamic subtest fork-reopen-allocator: SUCCESS (0.018s) [409.046219] Subtest reloc-allocator: SUCCESS (0.039s) [409.167915] [108/130] (627s left) kms_psr (pr-primary-blt) [409.525997] Subtest pr-primary-blt: SKIP (0.000s) [409.770186] [109/130] (626s left) gem_ctx_bad_destroy (double-destroy) [409.827747] Starting subtest: double-destroy [409.828319] Subtest double-destroy: SUCCESS (0.000s) [409.965410] [110/130] (626s left) core_getclient [410.133933] [111/130] (626s left) syncobj_wait (wait-all-delayed-signal) [410.195014] Starting subtest: wait-all-delayed-signal [410.297681] Subtest wait-all-delayed-signal: SUCCESS (0.102s) [410.419577] [112/130] (626s left) kms_frontbuffer_tracking (psr-2p-scndscrn-pri-indfb-draw-mmap-wc) [410.772739] Starting subtest: psr-2p-scndscrn-pri-indfb-draw-mmap-wc [410.773840] Subtest psr-2p-scndscrn-pri-indfb-draw-mmap-wc: SKIP (0.000s) [411.249597] [113/130] (625s left) kms_big_fb (yf-tiled-16bpp-rotate-0) [411.611574] Starting subtest: yf-tiled-16bpp-rotate-0 [411.612642] Subtest yf-tiled-16bpp-rotate-0: SKIP (0.000s) [412.084340] [114/130] (624s left) kms_async_flips (test-time-stamp) [412.442466] Starting subtest: test-time-stamp [412.583355] Starting dynamic subtest: pipe-A-HDMI-A-1 [412.784835] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.200s) [412.951966] Starting dynamic subtest: pipe-B-HDMI-A-1 [413.090239] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.151s) [413.091435] Subtest test-time-stamp: SUCCESS (0.648s) [413.822484] [115/130] (622s left) kms_invalid_mode (bad-vsync-end) [414.174338] Starting subtest: bad-vsync-end [414.174771] Starting dynamic subtest: pipe-A-HDMI-A-1 [414.248843] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.074s) [414.265121] Starting dynamic subtest: pipe-B-HDMI-A-1 [414.266121] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.000s) [414.267084] Subtest bad-vsync-end: SUCCESS (0.079s) [414.688565] [116/130] (622s left) gem_exec_suspend (basic) [414.753261] Starting subtest: basic [414.753968] Starting dynamic subtest: smem [415.031190] Dynamic subtest smem: SUCCESS (0.278s) [415.034155] Subtest basic: SUCCESS (0.280s) [415.267023] [117/130] (621s left) api_intel_bb (blit-noreloc-purge-cache) [415.328318] Starting subtest: blit-noreloc-purge-cache [415.329304] Subtest blit-noreloc-purge-cache: SKIP (0.000s) [415.480313] [118/130] (621s left) kms_plane (pixel-format-source-clamping) [415.837976] Starting subtest: pixel-format-source-clamping [415.876722] Starting dynamic subtest: pipe-A-plane-0 [418.240334] Dynamic subtest pipe-A-plane-0: SUCCESS (2.361s) [418.261971] Starting dynamic subtest: pipe-A-plane-1 [419.306016] Dynamic subtest pipe-A-plane-1: SUCCESS (1.062s) [419.326308] Starting dynamic subtest: pipe-A-plane-2 [419.326907] Dynamic subtest pipe-A-plane-2: SUCCESS (0.000s) [419.562595] Starting dynamic subtest: pipe-B-plane-0 [421.832005] Dynamic subtest pipe-B-plane-0: SUCCESS (2.294s) [421.848952] Starting dynamic subtest: pipe-B-plane-1 [422.897377] Dynamic subtest pipe-B-plane-1: SUCCESS (1.062s) [422.917372] Starting dynamic subtest: pipe-B-plane-2 [422.918137] Dynamic subtest pipe-B-plane-2: SUCCESS (0.000s) [422.998825] Subtest pixel-format-source-clamping: SUCCESS (7.154s) [423.590176] [119/130] (613s left) i915_query (query-topology-kernel-writes) [423.651159] Starting subtest: query-topology-kernel-writes [423.652851] Subtest query-topology-kernel-writes: SKIP (0.000s) [423.789027] [120/130] (613s left) kms_chamelium_edid (hdmi-edid-change-during-suspend) [424.216599] Subtest hdmi-edid-change-during-suspend: SKIP (0.000s) [424.562893] [121/130] (612s left) gem_exec_reloc (basic-cpu-active) [424.620794] Starting subtest: basic-cpu-active [424.729326] Subtest basic-cpu-active: SUCCESS (0.110s) [425.478394] [122/130] (611s left) gem_exec_fence (concurrent) [425.647729] Subtest concurrent: SKIP (0.000s) [426.061798] [123/130] (611s left) perf (short-reads) [426.249453] Subtest short-reads: SKIP (0.000s) [426.305624] [124/130] (611s left) dumb_buffer (create-clear) [426.358887] Starting subtest: create-clear [466.183783] Subtest create-clear: SUCCESS (39.823s) [466.347246] [125/130] (571s left) kms_psr2_su (page_flip-p010) [466.404093] Subtest page_flip-P010: SKIP (0.000s) [466.486474] [126/130] (570s left) i915_pm_rc6_residency (rc6-idle) [466.538344] Starting subtest: rc6-idle [466.544609] Subtest rc6-idle: SKIP (0.003s) [466.685976] [127/130] (570s left) kms_plane_scaling (plane-scaler-unity-scaling-with-rotation) [467.043732] Starting subtest: plane-scaler-unity-scaling-with-rotation [467.045538] Starting dynamic subtest: pipe-A [467.047160] Dynamic subtest pipe-A: SKIP (0.001s) [467.061189] Starting dynamic subtest: pipe-B [467.062554] Dynamic subtest pipe-B: SKIP (0.001s) [467.063515] Subtest plane-scaler-unity-scaling-with-rotation: SKIP (0.005s) [467.528515] [128/130] (570s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt) [467.888076] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt [467.889065] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s) [468.357142] [129/130] (569s left) kms_cursor_legacy (cursor-vs-flip-legacy) [468.710322] Starting subtest: cursor-vs-flip-legacy [499.395050] Subtest cursor-vs-flip-legacy: SUCCESS (30.680s) [499.979024] [130/130] (537s left) syncobj_timeline (multi-wait-available-submitted-signaled) [500.037441] Starting subtest: multi-wait-available-submitted-signaled [500.038387] Subtest multi-wait-available-submitted-signaled: SUCCESS (0.001s) [500.173412] Closing watchdogs results: parsing output: 0/ for test: kms_plane_scaling results: parsing output: 1/ for test: kms_frontbuffer_tracking results: parsing output: 2/ for test: kms_big_fb results: parsing output: 3/ for test: kms_flip results: parsing output: 4/ for test: kms_frontbuffer_tracking results: parsing output: 5/ for test: kms_frontbuffer_tracking results: parsing output: 6/ for test: gem_ctx_exec results: parsing output: 7/ for test: kms_psr results: parsing output: 8/ for test: core_getstats results: parsing output: 9/ for test: i915_hangman results: parsing output: 10/ for test: kms_ccs results: parsing output: 11/ for test: gem_lmem_swapping results: parsing output: 12/ for test: kms_frontbuffer_tracking results: parsing output: 13/ for test: kms_big_fb results: parsing output: 14/ for test: kms_frontbuffer_tracking results: parsing output: 15/ for test: gem_ctx_persistence results: parsing output: 16/ for test: prime_vgem results: parsing output: 17/ for test: gem_exec_schedule results: parsing output: 18/ for test: kms_flip results: parsing output: 19/ for test: kms_cursor_crc results: parsing output: 20/ for test: kms_frontbuffer_tracking results: parsing output: 21/ for test: gem_exec_balancer results: parsing output: 22/ for test: kms_psr results: parsing output: 23/ for test: kms_frontbuffer_tracking results: parsing output: 24/ for test: kms_big_fb results: parsing output: 25/ for test: gem_mmap_gtt results: parsing output: 26/ for test: perf_pmu results: parsing output: 27/ for test: gem_create results: parsing output: 28/ for test: gem_exec_reloc results: parsing output: 29/ for test: gem_ctx_persistence results: parsing output: 30/ for test: syncobj_wait results: parsing output: 31/ for test: gem_busy results: parsing output: 32/ for test: kms_addfb_basic results: parsing output: 33/ for test: kms_frontbuffer_tracking results: parsing output: 34/ for test: syncobj_timeline results: parsing output: 35/ for test: kms_lease results: parsing output: 36/ for test: kms_frontbuffer_tracking results: parsing output: 37/ for test: gem_mmap_offset results: parsing output: 38/ for test: gem_exec_whisper results: parsing output: 39/ for test: gem_softpin results: parsing output: 40/ for test: gem_exec_reloc results: parsing output: 41/ for test: kms_vrr results: parsing output: 42/ for test: syncobj_timeline results: parsing output: 43/ for test: kms_psr results: parsing output: 44/ for test: kms_feature_discovery results: parsing output: 45/ for test: kms_pm_rpm results: parsing output: 46/ for test: kms_big_fb results: parsing output: 47/ for test: gem_exec_reloc results: parsing output: 48/ for test: kms_scaling_modes results: parsing output: 49/ for test: kms_color results: parsing output: 50/ for test: kms_cursor_crc results: parsing output: 51/ for test: kms_cursor_legacy results: parsing output: 52/ for test: perf_pmu results: parsing output: 53/ for test: gem_spin_batch results: parsing output: 54/ for test: kms_frontbuffer_tracking results: parsing output: 55/ for test: kms_chamelium_frames results: parsing output: 56/ for test: gen9_exec_parse results: parsing output: 57/ for test: kms_cursor_legacy results: parsing output: 58/ for test: kms_frontbuffer_tracking results: parsing output: 59/ for test: kms_ccs results: parsing output: 60/ for test: kms_flip results: parsing output: 61/ for test: syncobj_timeline results: parsing output: 62/ for test: syncobj_timeline results: parsing output: 63/ for test: kms_flip results: parsing output: 64/ for test: kms_cursor_crc results: parsing output: 65/ for test: kms_ccs results: parsing output: 66/ for test: kms_ccs results: parsing output: 67/ for test: kms_vblank results: parsing output: 68/ for test: gem_exec_reloc results: parsing output: 69/ for test: kms_frontbuffer_tracking results: parsing output: 70/ for test: kms_psr2_sf results: parsing output: 71/ for test: kms_frontbuffer_tracking results: parsing output: 72/ for test: kms_frontbuffer_tracking results: parsing output: 73/ for test: kms_frontbuffer_tracking results: parsing output: 74/ for test: kms_frontbuffer_tracking results: parsing output: 75/ for test: gem_tiled_blits results: parsing output: 76/ for test: gem_eio results: parsing output: 77/ for test: gem_render_copy results: parsing output: 78/ for test: kms_cursor_legacy results: parsing output: 79/ for test: kms_plane_alpha_blend results: parsing output: 80/ for test: i915_selftest results: parsing output: 81/ for test: kms_cursor_legacy results: parsing output: 82/ for test: kms_pm_rpm results: parsing output: 83/ for test: gem_exec_flush results: parsing output: 84/ for test: kms_big_fb results: parsing output: 85/ for test: i915_query results: parsing output: 86/ for test: gem_exec_flush results: parsing output: 87/ for test: syncobj_wait results: parsing output: 88/ for test: kms_dirtyfb results: parsing output: 89/ for test: kms_psr2_sf results: parsing output: 90/ for test: kms_frontbuffer_tracking results: parsing output: 91/ for test: kms_fbcon_fbt results: parsing output: 92/ for test: kms_big_fb results: parsing output: 93/ for test: gem_exec_schedule results: parsing output: 94/ for test: vgem_basic results: parsing output: 95/ for test: gen7_exec_parse results: parsing output: 96/ for test: kms_frontbuffer_tracking results: parsing output: 97/ for test: dmabuf_sync_file results: parsing output: 98/ for test: kms_ccs results: parsing output: 99/ for test: kms_cursor_legacy results: parsing output: 100/ for test: gem_mmap_gtt results: parsing output: 101/ for test: gem_pxp results: parsing output: 102/ for test: kms_flip_scaled_crc results: parsing output: 103/ for test: kms_frontbuffer_tracking results: parsing output: 104/ for test: gem_exec_fence results: parsing output: 105/ for test: gem_basic results: parsing output: 106/ for test: api_intel_allocator results: parsing output: 107/ for test: kms_psr results: parsing output: 108/ for test: gem_ctx_bad_destroy results: parsing output: 109/ for test: core_getclient results: parsing output: 110/ for test: syncobj_wait results: parsing output: 111/ for test: kms_frontbuffer_tracking results: parsing output: 112/ for test: kms_big_fb results: parsing output: 113/ for test: kms_async_flips results: parsing output: 114/ for test: kms_invalid_mode results: parsing output: 115/ for test: gem_exec_suspend results: parsing output: 116/ for test: api_intel_bb results: parsing output: 117/ for test: kms_plane results: parsing output: 118/ for test: i915_query results: parsing output: 119/ for test: kms_chamelium_edid results: parsing output: 120/ for test: gem_exec_reloc results: parsing output: 121/ for test: gem_exec_fence results: parsing output: 122/ for test: perf results: parsing output: 123/ for test: dumb_buffer results: parsing output: 124/ for test: kms_psr2_su results: parsing output: 125/ for test: i915_pm_rc6_residency results: parsing output: 126/ for test: kms_plane_scaling results: parsing output: 127/ for test: kms_frontbuffer_tracking results: parsing output: 128/ for test: kms_cursor_legacy results: parsing output: 129/ for test: syncobj_timeline Done.