[29.108277] Initializing watchdogs [29.108337] /dev/watchdog0 [29.112853] [001/170] (960s left) i915_module_load (load) [29.168119] Starting subtest: load [30.097713] Subtest load: SUCCESS (0.928s) [30.122416] [002/170] (959s left) core_auth (basic-auth) [30.195999] Starting subtest: basic-auth [30.197245] Subtest basic-auth: SUCCESS (0.001s) [30.237594] [003/170] (959s left) debugfs_test (read_all_entries) [30.289478] Starting subtest: read_all_entries [30.330292] Subtest read_all_entries: SUCCESS (0.040s) [30.417073] [004/170] (959s left) debugfs_test (basic-hwmon) [30.469600] Starting subtest: basic-hwmon [30.471928] Subtest basic-hwmon: SKIP (0.000s) [30.549164] [005/170] (959s left) fbdev (eof) [30.604512] Starting subtest: eof [30.605507] Subtest eof: SUCCESS (0.000s) [30.637633] [006/170] (959s left) fbdev (info) [30.683451] Starting subtest: info [30.684472] Subtest info: SUCCESS (0.000s) [30.716989] [007/170] (958s left) fbdev (nullptr) [30.771110] Starting subtest: nullptr [30.772110] Subtest nullptr: SUCCESS (0.000s) [30.803737] [008/170] (958s left) fbdev (read) [30.854336] Starting subtest: read [31.501913] Subtest read: SUCCESS (0.646s) [31.533017] [009/170] (958s left) fbdev (write) [31.588251] Starting subtest: write [32.025651] Subtest write: SUCCESS (0.437s) [32.058212] [010/170] (957s left) gem_basic (bad-close) [32.104756] Starting subtest: bad-close [32.106773] Subtest bad-close: SUCCESS (0.000s) [32.144401] [011/170] (957s left) gem_basic (create-close) [32.203226] Starting subtest: create-close [32.205719] Subtest create-close: SUCCESS (0.000s) [32.244197] [012/170] (957s left) gem_basic (create-fd-close) [32.295585] Starting subtest: create-fd-close [32.297564] Subtest create-fd-close: SUCCESS (0.000s) [32.354887] [013/170] (957s left) gem_busy (busy@all-engines) [32.418145] Starting subtest: busy [32.419165] Starting dynamic subtest: all-engines [32.443845] Dynamic subtest all-engines: SUCCESS (0.026s) [32.444916] Subtest busy: SUCCESS (0.026s) [32.757026] [014/170] (956s left) gem_close_race (basic-process) [32.821115] Starting subtest: basic-process [32.861994] Subtest basic-process: SUCCESS (0.041s) [33.014387] [015/170] (956s left) gem_close_race (basic-threads) [33.076324] Starting subtest: basic-threads [34.204943] Subtest basic-threads: SUCCESS (1.128s) [34.362567] [016/170] (955s left) gem_ctx_create (basic) [34.425713] Starting subtest: basic [34.426717] Subtest basic: SUCCESS (0.000s) [34.581594] [017/170] (955s left) gem_ctx_create (basic-files) [34.645943] Starting subtest: basic-files [36.655191] Subtest basic-files: SUCCESS (2.009s) [36.822214] [018/170] (952s left) gem_ctx_exec (basic) [36.879318] Starting subtest: basic [36.881443] Subtest basic: SUCCESS (0.002s) [36.946156] [019/170] (952s left) gem_exec_basic (basic) [37.004681] Starting subtest: basic [37.005953] Starting dynamic subtest: rcs0-smem [37.007099] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [37.010989] Starting dynamic subtest: bcs0-smem [37.012118] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [37.015728] Starting dynamic subtest: vcs0-smem [37.016697] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [37.020102] Starting dynamic subtest: vecs0-smem [37.021126] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [37.022096] Subtest basic: SUCCESS (0.002s) [37.165878] [020/170] (952s left) gem_exec_create (basic) [37.225751] Starting subtest: basic [37.226775] Starting dynamic subtest: smem [39.255789] Dynamic subtest smem: SUCCESS (2.030s) [39.257287] Subtest basic: SUCCESS (2.030s) [39.406741] [021/170] (950s left) gem_exec_fence (basic-busy) [39.583290] Starting subtest: basic-busy [39.584963] Starting dynamic subtest: rcs0 [39.615121] Dynamic subtest rcs0: SUCCESS (0.032s) [39.623861] Starting dynamic subtest: bcs0 [39.634655] Dynamic subtest bcs0: SUCCESS (0.020s) [39.642488] Starting dynamic subtest: vcs0 [39.661082] Dynamic subtest vcs0: SUCCESS (0.026s) [39.669588] Starting dynamic subtest: vecs0 [39.681512] Dynamic subtest vecs0: SUCCESS (0.021s) [39.682899] Subtest basic-busy: SUCCESS (0.099s) [40.124531] [022/170] (949s left) gem_exec_fence (basic-wait) [40.309191] Starting subtest: basic-wait [40.310653] Starting dynamic subtest: rcs0 [40.338345] Dynamic subtest rcs0: SUCCESS (0.031s) [40.347533] Starting dynamic subtest: bcs0 [40.368868] Dynamic subtest bcs0: SUCCESS (0.031s) [40.377257] Starting dynamic subtest: vcs0 [40.392062] Dynamic subtest vcs0: SUCCESS (0.023s) [40.400277] Starting dynamic subtest: vecs0 [40.417900] Dynamic subtest vecs0: SUCCESS (0.026s) [40.419311] Subtest basic-wait: SUCCESS (0.111s) [40.840938] [023/170] (949s left) gem_exec_fence (basic-await) [41.024086] Starting subtest: basic-await [41.026176] Starting dynamic subtest: rcs0 [41.101865] Dynamic subtest rcs0: SUCCESS (0.078s) [41.111933] Starting dynamic subtest: bcs0 [41.183597] Dynamic subtest bcs0: SUCCESS (0.083s) [41.192129] Starting dynamic subtest: vcs0 [41.266286] Dynamic subtest vcs0: SUCCESS (0.082s) [41.276601] Starting dynamic subtest: vecs0 [41.351929] Dynamic subtest vecs0: SUCCESS (0.086s) [41.353506] Subtest basic-await: SUCCESS (0.329s) [41.776169] [024/170] (948s left) gem_exec_fence (nb-await) [41.960313] Starting subtest: nb-await [41.961859] Starting dynamic subtest: rcs0 [42.022074] Dynamic subtest rcs0: SUCCESS (0.062s) [42.030766] Starting dynamic subtest: bcs0 [42.082226] Dynamic subtest bcs0: SUCCESS (0.061s) [42.090745] Starting dynamic subtest: vcs0 [42.142525] Dynamic subtest vcs0: SUCCESS (0.060s) [42.152949] Starting dynamic subtest: vecs0 [42.206400] Dynamic subtest vecs0: SUCCESS (0.064s) [42.207709] Subtest nb-await: SUCCESS (0.247s) [42.633644] [025/170] (947s left) gem_exec_gttfill (basic) [42.688271] Starting subtest: basic [46.155107] Subtest basic: SUCCESS (3.466s) [46.299048] [026/170] (943s left) gem_exec_parallel (engines) [46.412443] Starting subtest: engines [46.414181] Starting dynamic subtest: basic [47.934079] Dynamic subtest basic: SUCCESS (1.521s) [47.939745] Starting dynamic subtest: contexts [50.207205] Dynamic subtest contexts: SUCCESS (2.273s) [50.211398] Starting dynamic subtest: fds [53.299840] Dynamic subtest fds: SUCCESS (3.093s) [53.310869] Starting dynamic subtest: userptr [54.931756] Dynamic subtest userptr: SUCCESS (1.632s) [54.932805] Subtest engines: SUCCESS (8.519s) [55.085889] [027/170] (934s left) gem_exec_store (basic) [55.147544] Starting subtest: basic [55.195248] Subtest basic: SUCCESS (0.047s) [55.352303] [028/170] (934s left) gem_flink_basic (bad-flink) [55.399351] Starting subtest: bad-flink [55.400370] Subtest bad-flink: SUCCESS (0.000s) [55.438379] [029/170] (934s left) gem_flink_basic (bad-open) [55.488247] Starting subtest: bad-open [55.489246] Subtest bad-open: SUCCESS (0.000s) [55.520626] [030/170] (934s left) gem_flink_basic (basic) [55.569232] Starting subtest: basic [55.570235] Subtest basic: SUCCESS (0.000s) [55.621138] [031/170] (934s left) gem_flink_basic (double-flink) [55.675253] Starting subtest: double-flink [55.676884] Subtest double-flink: SUCCESS (0.000s) [55.724897] [032/170] (934s left) gem_flink_basic (flink-lifetime) [55.779471] Starting subtest: flink-lifetime [55.780532] Subtest flink-lifetime: SUCCESS (0.001s) [55.832725] [033/170] (934s left) gem_huc_copy (huc-copy) [55.886564] Starting subtest: huc-copy [55.888592] Subtest huc-copy: SKIP (0.000s) [55.952250] [034/170] (934s left) gem_linear_blits (basic) [56.064956] Starting subtest: basic [56.070175] Subtest basic: SUCCESS (0.006s) [56.175936] [035/170] (933s left) gem_mmap (basic) [56.300762] Starting subtest: basic [56.305843] Subtest basic: SUCCESS (0.000s) [56.367403] [036/170] (933s left) gem_mmap_gtt (basic) [56.416216] Starting subtest: basic [56.417299] Subtest basic: SUCCESS (0.000s) [56.459647] [037/170] (933s left) gem_render_linear_blits (basic) [56.514227] Starting subtest: basic [56.532768] Subtest basic: SUCCESS (0.018s) [56.556127] [038/170] (933s left) gem_render_tiled_blits (basic) [56.605263] Starting subtest: basic [56.626574] Subtest basic: SUCCESS (0.021s) [56.655197] [039/170] (933s left) gem_ringfill (basic-all) [56.835914] Starting subtest: basic-all [57.960695] Subtest basic-all: SUCCESS (1.126s) [58.044827] [040/170] (932s left) gem_softpin (allocator-basic) [58.123533] Starting subtest: allocator-basic [58.185998] Subtest allocator-basic: SUCCESS (0.063s) [58.244741] [041/170] (931s left) gem_softpin (allocator-basic-reserve) [58.296127] Starting subtest: allocator-basic-reserve [58.359989] Subtest allocator-basic-reserve: SUCCESS (0.063s) [58.427055] [042/170] (931s left) gem_softpin (safe-alignment) [58.476777] Starting subtest: safe-alignment [58.483895] Subtest safe-alignment: SUCCESS (0.007s) [58.553116] [043/170] (931s left) gem_sync (basic-all) [58.620297] Starting subtest: basic-all [60.754495] Subtest basic-all: SUCCESS (2.137s) [60.913826] [044/170] (929s left) gem_sync (basic-each) [60.979061] Starting subtest: basic-each [63.095096] Subtest basic-each: SUCCESS (2.118s) [63.262882] [045/170] (926s left) gem_tiled_blits (basic) [63.388265] Starting subtest: basic [63.400912] Subtest basic: SUCCESS (0.013s) [63.509925] [046/170] (926s left) gem_tiled_fence_blits (basic) [63.677663] Starting subtest: basic [63.698856] Subtest basic: SUCCESS (0.021s) [63.812874] [047/170] (926s left) gem_tiled_pread_basic [64.046042] [048/170] (926s left) gem_wait (busy@all-engines) [64.109196] Starting subtest: busy [64.110391] Starting dynamic subtest: all-engines [64.621284] Dynamic subtest all-engines: SUCCESS (0.512s) [64.622224] Subtest busy: SUCCESS (0.512s) [64.796579] [049/170] (925s left) gem_wait (wait@all-engines) [64.858188] Starting subtest: wait [64.859249] Starting dynamic subtest: all-engines [65.883932] Dynamic subtest all-engines: SUCCESS (1.025s) [65.885636] Subtest wait: SUCCESS (1.025s) [66.053014] [050/170] (924s left) i915_getparams_basic (basic-eu-total) [66.105624] Starting subtest: basic-eu-total [66.107624] Subtest basic-eu-total: SUCCESS (0.000s) [66.142975] [051/170] (924s left) i915_getparams_basic (basic-subslice-total) [66.190666] Starting subtest: basic-subslice-total [66.192702] Subtest basic-subslice-total: SUCCESS (0.000s) [66.224410] [052/170] (924s left) i915_hangman (error-state-basic) [66.282264] Starting subtest: error-state-basic [66.287991] Subtest error-state-basic: SUCCESS (0.005s) [66.370596] [053/170] (923s left) i915_pciid [66.465214] [054/170] (923s left) kms_addfb_basic (addfb25-bad-modifier) [66.516062] Starting subtest: addfb25-bad-modifier [66.517741] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [66.627287] [055/170] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [66.674263] Starting subtest: addfb25-framebuffer-vs-set-tiling [66.675271] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [66.790412] [056/170] (923s left) kms_addfb_basic (addfb25-modifier-no-flag) [66.840296] Starting subtest: addfb25-modifier-no-flag [66.841320] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [66.940331] [057/170] (923s left) kms_addfb_basic (addfb25-x-tiled-legacy) [66.994211] Starting subtest: addfb25-x-tiled-legacy [66.995256] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [67.099421] [058/170] (923s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [67.150421] Starting subtest: addfb25-x-tiled-mismatch-legacy [67.151408] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [67.260410] [059/170] (923s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [67.356482] Starting subtest: addfb25-yf-tiled-legacy [67.357464] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [67.410478] [060/170] (923s left) kms_addfb_basic (addfb25-y-tiled-legacy) [67.511106] Starting subtest: addfb25-y-tiled-legacy [67.512110] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [67.564327] [061/170] (922s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [67.659478] Starting subtest: addfb25-y-tiled-small-legacy [67.660542] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [67.714303] [062/170] (922s left) kms_addfb_basic (bad-pitch-0) [67.761239] Starting subtest: bad-pitch-0 [67.762313] Subtest bad-pitch-0: SUCCESS (0.000s) [67.860419] [063/170] (922s left) kms_addfb_basic (bad-pitch-1024) [67.907886] Starting subtest: bad-pitch-1024 [67.908968] Subtest bad-pitch-1024: SUCCESS (0.000s) [68.016077] [064/170] (922s left) kms_addfb_basic (bad-pitch-128) [68.068360] Starting subtest: bad-pitch-128 [68.069428] Subtest bad-pitch-128: SUCCESS (0.000s) [68.168906] [065/170] (922s left) kms_addfb_basic (bad-pitch-256) [68.216619] Starting subtest: bad-pitch-256 [68.217740] Subtest bad-pitch-256: SUCCESS (0.000s) [68.323897] [066/170] (922s left) kms_addfb_basic (bad-pitch-32) [68.375682] Starting subtest: bad-pitch-32 [68.376743] Subtest bad-pitch-32: SUCCESS (0.000s) [68.482570] [067/170] (922s left) kms_addfb_basic (bad-pitch-63) [68.532691] Starting subtest: bad-pitch-63 [68.533688] Subtest bad-pitch-63: SUCCESS (0.000s) [68.640511] [068/170] (921s left) kms_addfb_basic (bad-pitch-65536) [68.687522] Starting subtest: bad-pitch-65536 [68.688540] Subtest bad-pitch-65536: SUCCESS (0.000s) [68.793845] [069/170] (921s left) kms_addfb_basic (bad-pitch-999) [68.840073] Starting subtest: bad-pitch-999 [68.841437] Subtest bad-pitch-999: SUCCESS (0.000s) [68.944086] [070/170] (921s left) kms_addfb_basic (basic) [68.991337] Starting subtest: basic [68.992413] Subtest basic: SUCCESS (0.000s) [69.081140] [071/170] (921s left) kms_addfb_basic (basic-x-tiled-legacy) [69.130455] Starting subtest: basic-x-tiled-legacy [69.132076] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [69.232709] [072/170] (921s left) kms_addfb_basic (basic-y-tiled-legacy) [69.282807] Starting subtest: basic-y-tiled-legacy [69.283940] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [69.385889] [073/170] (921s left) kms_addfb_basic (bo-too-small) [69.480857] Starting subtest: bo-too-small [69.481943] Subtest bo-too-small: SUCCESS (0.000s) [69.531498] [074/170] (921s left) kms_addfb_basic (bo-too-small-due-to-tiling) [69.626036] Starting subtest: bo-too-small-due-to-tiling [69.627056] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [69.683554] [075/170] (920s left) kms_addfb_basic (clobberred-modifier) [69.734090] Starting subtest: clobberred-modifier [69.735032] Subtest clobberred-modifier: SUCCESS (0.000s) [69.844204] [076/170] (920s left) kms_addfb_basic (framebuffer-vs-set-tiling) [69.892539] Starting subtest: framebuffer-vs-set-tiling [69.893501] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [69.989522] [077/170] (920s left) kms_addfb_basic (invalid-get-prop) [70.036775] Starting subtest: invalid-get-prop [70.037796] Subtest invalid-get-prop: SUCCESS (0.000s) [70.135801] [078/170] (920s left) kms_addfb_basic (invalid-get-prop-any) [70.187709] Starting subtest: invalid-get-prop-any [70.189330] Subtest invalid-get-prop-any: SUCCESS (0.000s) [70.289595] [079/170] (920s left) kms_addfb_basic (invalid-set-prop) [70.336605] Starting subtest: invalid-set-prop [70.337635] Subtest invalid-set-prop: SUCCESS (0.000s) [70.441213] [080/170] (920s left) kms_addfb_basic (invalid-set-prop-any) [70.491543] Starting subtest: invalid-set-prop-any [70.492673] Subtest invalid-set-prop-any: SUCCESS (0.000s) [70.599989] [081/170] (920s left) kms_addfb_basic (no-handle) [70.649725] Starting subtest: no-handle [70.650853] Subtest no-handle: SUCCESS (0.000s) [70.740383] [082/170] (919s left) kms_addfb_basic (size-max) [70.836865] Starting subtest: size-max [70.837977] Subtest size-max: SUCCESS (0.000s) [70.881492] [083/170] (919s left) kms_addfb_basic (small-bo) [70.982083] Starting subtest: small-bo [70.983100] Subtest small-bo: SUCCESS (0.000s) [71.044345] [084/170] (919s left) kms_addfb_basic (tile-pitch-mismatch) [71.091761] Starting subtest: tile-pitch-mismatch [71.092880] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [71.191105] [085/170] (919s left) kms_addfb_basic (too-high) [71.289100] Starting subtest: too-high [71.290638] Subtest too-high: SUCCESS (0.000s) [71.350659] [086/170] (919s left) kms_addfb_basic (too-wide) [71.447277] Starting subtest: too-wide [71.448259] Subtest too-wide: SUCCESS (0.000s) [71.498296] [087/170] (919s left) kms_addfb_basic (unused-handle) [71.545279] Starting subtest: unused-handle [71.546235] Subtest unused-handle: SUCCESS (0.000s) [71.657675] [088/170] (919s left) kms_addfb_basic (unused-modifier) [71.708201] Starting subtest: unused-modifier [71.709168] Subtest unused-modifier: SUCCESS (0.000s) [71.810938] [089/170] (918s left) kms_addfb_basic (unused-offsets) [71.859922] Starting subtest: unused-offsets [71.861607] Subtest unused-offsets: SUCCESS (0.000s) [71.966265] [090/170] (918s left) kms_addfb_basic (unused-pitches) [72.015772] Starting subtest: unused-pitches [72.016825] Subtest unused-pitches: SUCCESS (0.000s) [72.123223] [091/170] (918s left) kms_busy (basic) [72.223302] Starting subtest: basic [72.224413] Starting dynamic subtest: flip [72.661557] Dynamic subtest flip: SUCCESS (0.438s) [72.668069] Starting dynamic subtest: modeset [73.180248] Dynamic subtest modeset: SUCCESS (0.518s) [73.181302] Subtest basic: SUCCESS (0.957s) [73.290894] [092/170] (917s left) kms_chamelium_hpd (dp-hpd-fast) [73.438232] Subtest dp-hpd-fast: SKIP (0.000s) [73.494189] [093/170] (917s left) kms_chamelium_edid (dp-edid-read) [73.648153] Subtest dp-edid-read: SKIP (0.000s) [73.715972] [094/170] (917s left) kms_chamelium_frames (dp-crc-fast) [73.859766] Subtest dp-crc-fast: SKIP (0.000s) [73.916023] [095/170] (916s left) kms_chamelium_hpd (hdmi-hpd-fast) [74.068779] Subtest hdmi-hpd-fast: SKIP (0.000s) [74.132777] [096/170] (916s left) kms_chamelium_edid (hdmi-edid-read) [74.287745] Subtest hdmi-edid-read: SKIP (0.000s) [74.352123] [097/170] (916s left) kms_chamelium_frames (hdmi-crc-fast) [74.504218] Subtest hdmi-crc-fast: SKIP (0.000s) [74.563252] [098/170] (916s left) kms_chamelium_hpd (vga-hpd-fast) [74.714437] Subtest vga-hpd-fast: SKIP (0.000s) [74.772336] [099/170] (916s left) kms_chamelium_edid (vga-edid-read) [74.917518] Subtest vga-edid-read: SKIP (0.000s) [74.976596] [100/170] (915s left) kms_prop_blob (basic) [75.029508] Starting subtest: basic [75.030546] Subtest basic: SUCCESS (0.000s) [75.062292] [101/170] (915s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [75.158346] Starting subtest: basic-busy-flip-before-cursor-atomic [75.160409] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [75.200580] [102/170] (915s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [75.294160] Starting subtest: basic-busy-flip-before-cursor-legacy [75.296073] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [75.331070] [103/170] (915s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [75.442078] Starting subtest: basic-flip-after-cursor-atomic [75.982817] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.541s) [76.086693] [104/170] (914s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [76.183206] Starting subtest: basic-flip-after-cursor-legacy [76.708476] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.524s) [76.808951] [105/170] (914s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [76.904862] Starting subtest: basic-flip-after-cursor-varying-size [77.415739] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.510s) [77.503933] [106/170] (913s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [77.609032] Starting subtest: basic-flip-before-cursor-atomic [78.116467] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.509s) [78.200089] [107/170] (912s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [78.299382] Starting subtest: basic-flip-before-cursor-legacy [78.820932] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.521s) [78.908605] [108/170] (912s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [79.006510] Starting subtest: basic-flip-before-cursor-varying-size [79.527666] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.520s) [79.624191] [109/170] (911s left) kms_flip (basic-flip-vs-dpms) [79.706975] Starting subtest: basic-flip-vs-dpms [79.709366] Starting dynamic subtest: A-HDMI-A1 [80.429918] Dynamic subtest A-HDMI-A1: SUCCESS (0.721s) [80.435543] Starting dynamic subtest: B-HDMI-A1 [81.072595] Dynamic subtest B-HDMI-A1: SUCCESS (0.642s) [81.078221] Starting dynamic subtest: C-HDMI-A1 [81.742285] Dynamic subtest C-HDMI-A1: SUCCESS (0.668s) [81.748415] Starting dynamic subtest: D-HDMI-A1 [82.339776] Dynamic subtest D-HDMI-A1: SUCCESS (0.598s) [82.343464] Subtest basic-flip-vs-dpms: SUCCESS (2.636s) [82.427630] [110/170] (908s left) kms_flip (basic-flip-vs-modeset) [82.520247] Starting subtest: basic-flip-vs-modeset [82.525030] Starting dynamic subtest: A-HDMI-A1 [83.269029] Dynamic subtest A-HDMI-A1: SUCCESS (0.742s) [83.274613] Starting dynamic subtest: B-HDMI-A1 [83.930036] Dynamic subtest B-HDMI-A1: SUCCESS (0.662s) [83.935682] Starting dynamic subtest: C-HDMI-A1 [84.580613] Dynamic subtest C-HDMI-A1: SUCCESS (0.651s) [84.587315] Starting dynamic subtest: D-HDMI-A1 [85.245725] Dynamic subtest D-HDMI-A1: SUCCESS (0.664s) [85.249008] Subtest basic-flip-vs-modeset: SUCCESS (2.727s) [85.324831] [111/170] (905s left) kms_flip (basic-flip-vs-wf_vblank) [85.417220] Starting subtest: basic-flip-vs-wf_vblank [85.420140] Starting dynamic subtest: A-HDMI-A1 [86.239931] Dynamic subtest A-HDMI-A1: SUCCESS (0.820s) [86.249155] Starting dynamic subtest: B-HDMI-A1 [87.029896] Dynamic subtest B-HDMI-A1: SUCCESS (0.790s) [87.036634] Starting dynamic subtest: C-HDMI-A1 [87.814710] Dynamic subtest C-HDMI-A1: SUCCESS (0.784s) [87.822199] Starting dynamic subtest: D-HDMI-A1 [88.590818] Dynamic subtest D-HDMI-A1: SUCCESS (0.775s) [88.596197] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.177s) [88.695724] [112/170] (902s left) kms_flip (basic-plain-flip) [88.782736] Starting subtest: basic-plain-flip [88.786704] Starting dynamic subtest: A-HDMI-A1 [89.466827] Dynamic subtest A-HDMI-A1: SUCCESS (0.681s) [89.475618] Starting dynamic subtest: B-HDMI-A1 [90.120802] Dynamic subtest B-HDMI-A1: SUCCESS (0.653s) [90.127409] Starting dynamic subtest: C-HDMI-A1 [90.762630] Dynamic subtest C-HDMI-A1: SUCCESS (0.641s) [90.771431] Starting dynamic subtest: D-HDMI-A1 [91.403841] Dynamic subtest D-HDMI-A1: SUCCESS (0.640s) [91.406330] Subtest basic-plain-flip: SUCCESS (2.624s) [91.522804] [113/170] (899s left) kms_force_connector_basic (force-connector-state) [91.660883] Starting subtest: force-connector-state [93.090468] Subtest force-connector-state: SUCCESS (1.429s) [93.373941] [114/170] (897s left) kms_force_connector_basic (force-edid) [93.515132] Starting subtest: force-edid [93.666272] Subtest force-edid: SUCCESS (0.148s) [93.826624] [115/170] (897s left) kms_force_connector_basic (force-load-detect) [93.963906] Starting subtest: force-load-detect [93.966698] Subtest force-load-detect: SKIP (0.000s) [94.122277] [116/170] (896s left) kms_force_connector_basic (prune-stale-modes) [94.261330] Starting subtest: prune-stale-modes [94.407736] Subtest prune-stale-modes: SUCCESS (0.148s) [94.565329] [117/170] (896s left) kms_frontbuffer_tracking (basic) [94.668716] Starting subtest: basic [96.025606] Subtest basic: SUCCESS (1.359s) [96.091292] [118/170] (895s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [96.203771] Starting subtest: compare-crc-sanitycheck [96.205340] Starting dynamic subtest: pipe-A-HDMI-A-1 [96.447104] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.238s) [96.452683] Starting dynamic subtest: pipe-B-HDMI-A-1 [96.967669] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.516s) [96.975464] Starting dynamic subtest: pipe-C-HDMI-A-1 [97.759202] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.788s) [97.765396] Starting dynamic subtest: pipe-D-HDMI-A-1 [97.976824] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (0.216s) [97.977924] Subtest compare-crc-sanitycheck: SUCCESS (1.773s) [98.072017] [119/170] (893s left) kms_pipe_crc_basic (hang-read-crc) [98.178382] Starting subtest: hang-read-crc [98.179511] Starting dynamic subtest: pipe-A-HDMI-A-1 [98.779479] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.598s) [98.788884] Starting dynamic subtest: pipe-B-HDMI-A-1 [99.942686] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.161s) [99.952997] Starting dynamic subtest: pipe-C-HDMI-A-1 [101.635883] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.688s) [101.643990] Starting dynamic subtest: pipe-D-HDMI-A-1 [103.815227] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (2.176s) [103.816639] Subtest hang-read-crc: SUCCESS (5.635s) [103.890763] [120/170] (887s left) kms_pipe_crc_basic (nonblocking-crc) [104.003266] Starting subtest: nonblocking-crc [104.004438] Starting dynamic subtest: pipe-A-HDMI-A-1 [104.323031] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.317s) [104.329811] Starting dynamic subtest: pipe-B-HDMI-A-1 [104.927117] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.601s) [104.935890] Starting dynamic subtest: pipe-C-HDMI-A-1 [105.812265] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.877s) [105.821132] Starting dynamic subtest: pipe-D-HDMI-A-1 [106.966649] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.152s) [106.967799] Subtest nonblocking-crc: SUCCESS (2.963s) [107.041310] [121/170] (884s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [107.150257] Starting subtest: nonblocking-crc-frame-sequence [107.153322] Starting dynamic subtest: pipe-A-HDMI-A-1 [107.467881] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.314s) [107.474204] Starting dynamic subtest: pipe-B-HDMI-A-1 [108.070687] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.600s) [108.080666] Starting dynamic subtest: pipe-C-HDMI-A-1 [108.949647] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.876s) [108.956989] Starting dynamic subtest: pipe-D-HDMI-A-1 [110.115684] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.161s) [110.116834] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.964s) [110.191088] [122/170] (880s left) kms_pipe_crc_basic (read-crc) [110.300532] Starting subtest: read-crc [110.301709] Starting dynamic subtest: pipe-A-HDMI-A-1 [110.585349] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.282s) [110.592998] Starting dynamic subtest: pipe-B-HDMI-A-1 [111.145850] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.559s) [111.155726] Starting dynamic subtest: pipe-C-HDMI-A-1 [111.986091] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.836s) [111.994079] Starting dynamic subtest: pipe-D-HDMI-A-1 [113.112223] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.119s) [113.113798] Subtest read-crc: SUCCESS (2.808s) [113.184082] [123/170] (877s left) kms_pipe_crc_basic (read-crc-frame-sequence) [113.294583] Starting subtest: read-crc-frame-sequence [113.295710] Starting dynamic subtest: pipe-A-HDMI-A-1 [113.578714] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.282s) [113.587576] Starting dynamic subtest: pipe-B-HDMI-A-1 [114.143236] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.563s) [114.154477] Starting dynamic subtest: pipe-C-HDMI-A-1 [114.983584] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.836s) [114.993559] Starting dynamic subtest: pipe-D-HDMI-A-1 [116.108229] Dynamic subtest pipe-D-HDMI-A-1: SUCCESS (1.123s) [116.111209] Subtest read-crc-frame-sequence: SUCCESS (2.814s) [116.192179] [124/170] (874s left) kms_psr (primary_page_flip) [116.253209] Subtest primary_page_flip: SKIP (0.000s) [116.274653] [125/170] (874s left) kms_psr (cursor_plane_move) [116.329324] Subtest cursor_plane_move: SKIP (0.000s) [116.347601] [126/170] (874s left) kms_psr (sprite_plane_onoff) [116.400589] Subtest sprite_plane_onoff: SKIP (0.000s) [116.430874] [127/170] (874s left) kms_psr (primary_mmap_gtt) [116.486738] Subtest primary_mmap_gtt: SKIP (0.000s) [116.515950] [128/170] (874s left) kms_setmode (basic-clone-single-crtc) [116.574161] Starting subtest: basic-clone-single-crtc [116.577152] Subtest basic-clone-single-crtc: SKIP (0.001s) [116.617706] [129/170] (874s left) i915_pm_backlight (basic-brightness) [116.722254] Subtest basic-brightness: SKIP (0.000s) [116.739099] [130/170] (874s left) i915_pm_rpm (basic-pci-d3-state) [118.267165] Starting subtest: basic-pci-d3-state [119.471111] Subtest basic-pci-d3-state: SUCCESS (1.204s) [121.280668] [131/170] (870s left) i915_pm_rpm (basic-rte) [121.333641] Starting subtest: basic-rte [123.399294] Subtest basic-rte: SUCCESS (2.065s) [124.512830] [132/170] (866s left) i915_pm_rps (basic-api) [124.566700] Starting subtest: basic-api [124.569479] Subtest basic-api: SUCCESS (0.002s) [124.604038] [133/170] (866s left) prime_self_import (basic-llseek-bad) [124.651210] Starting subtest: basic-llseek-bad [124.653168] Subtest basic-llseek-bad: SUCCESS (0.001s) [124.706207] [134/170] (866s left) prime_self_import (basic-llseek-size) [124.755995] Starting subtest: basic-llseek-size [124.758147] Subtest basic-llseek-size: SUCCESS (0.002s) [124.805893] [135/170] (866s left) prime_self_import (basic-with_fd_dup) [124.855221] Starting subtest: basic-with_fd_dup [124.858232] Subtest basic-with_fd_dup: SUCCESS (0.002s) [124.923642] [136/170] (866s left) prime_self_import (basic-with_one_bo) [124.973122] Starting subtest: basic-with_one_bo [124.975369] Subtest basic-with_one_bo: SUCCESS (0.002s) [125.015337] [137/170] (866s left) prime_self_import (basic-with_one_bo_two_files) [125.061632] Starting subtest: basic-with_one_bo_two_files [125.063853] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [125.120808] [138/170] (866s left) prime_self_import (basic-with_two_bos) [125.167612] Starting subtest: basic-with_two_bos [125.169862] Subtest basic-with_two_bos: SUCCESS (0.002s) [125.221101] [139/170] (866s left) prime_vgem (basic-fence-flip) [125.277574] Starting subtest: basic-fence-flip [125.523903] Subtest basic-fence-flip: SUCCESS (0.247s) [125.581121] [140/170] (865s left) prime_vgem (basic-fence-mmap) [125.636466] Starting subtest: basic-fence-mmap [125.654628] Subtest basic-fence-mmap: SUCCESS (0.017s) [125.711786] [141/170] (865s left) prime_vgem (basic-fence-read) [125.769858] Starting subtest: basic-fence-read [125.797232] Subtest basic-fence-read: SUCCESS (0.027s) [125.861470] [142/170] (865s left) prime_vgem (basic-gtt) [125.919568] Starting subtest: basic-gtt [125.927591] Subtest basic-gtt: SUCCESS (0.008s) [125.983883] [143/170] (865s left) prime_vgem (basic-read) [126.051031] Starting subtest: basic-read [126.063207] Subtest basic-read: SUCCESS (0.012s) [126.125436] [144/170] (865s left) prime_vgem (basic-write) [126.186088] Starting subtest: basic-write [126.200088] Subtest basic-write: SUCCESS (0.015s) [126.238283] [145/170] (865s left) vgem_basic (setversion) [126.291576] Starting subtest: setversion [126.293525] Subtest setversion: SUCCESS (0.000s) [126.324654] [146/170] (865s left) vgem_basic (create) [126.376786] Starting subtest: create [126.378481] Subtest create: SUCCESS (0.000s) [126.404439] [147/170] (865s left) vgem_basic (debugfs) [126.458318] Starting subtest: debugfs [126.459330] Subtest debugfs: SUCCESS (0.000s) [126.488177] [148/170] (865s left) vgem_basic (dmabuf-export) [126.541707] Starting subtest: dmabuf-export [126.543876] Subtest dmabuf-export: SUCCESS (0.002s) [126.600390] [149/170] (864s left) vgem_basic (dmabuf-fence) [126.658476] Starting subtest: dmabuf-fence [126.659511] Subtest dmabuf-fence: SUCCESS (0.000s) [126.687662] [150/170] (864s left) vgem_basic (dmabuf-fence-before) [126.741852] Starting subtest: dmabuf-fence-before [126.742842] Subtest dmabuf-fence-before: SUCCESS (0.000s) [126.771467] [151/170] (864s left) vgem_basic (dmabuf-mmap) [126.825201] Starting subtest: dmabuf-mmap [126.832515] Subtest dmabuf-mmap: SUCCESS (0.008s) [126.864062] [152/170] (864s left) vgem_basic (mmap) [126.916762] Starting subtest: mmap [126.922061] Subtest mmap: SUCCESS (0.006s) [126.954905] [153/170] (864s left) vgem_basic (second-client) [127.009545] Starting subtest: second-client [127.032379] Subtest second-client: SUCCESS (0.025s) [127.066699] [154/170] (864s left) vgem_basic (sysfs) [127.125199] Starting subtest: sysfs [127.126217] Subtest sysfs: SUCCESS (0.000s) [127.155120] [155/170] (864s left) core_hotunplug (unbind-rebind) [127.241287] Starting subtest: unbind-rebind [128.082086] Subtest unbind-rebind: SUCCESS (0.841s) [128.096988] [156/170] (863s left) vgem_basic (unload) [128.159825] Starting subtest: unload [157.042968] Subtest unload: SUCCESS (28.882s) [157.109957] [157/170] (834s left) i915_module_load (reload) [157.157849] Starting subtest: reload [158.908467] Subtest reload: SUCCESS (1.751s) [158.933090] [158/170] (832s left) gem_lmem_swapping (basic) [159.011066] Subtest basic: SKIP (0.000s) [159.032777] [159/170] (832s left) gem_lmem_swapping (parallel-random-engines) [159.086793] Subtest parallel-random-engines: SKIP (0.000s) [159.106021] [160/170] (832s left) gem_lmem_swapping (random-engines) [159.157478] Subtest random-engines: SKIP (0.000s) [159.174395] [161/170] (832s left) gem_lmem_swapping (verify-random) [159.227419] Subtest verify-random: SKIP (0.000s) [159.249454] [162/170] (832s left) i915_pm_rpm (module-reload) [160.843850] Starting subtest: module-reload [168.427118] Subtest module-reload: SUCCESS (7.582s) [168.449625] [163/170] (823s left) i915_selftest (live) [168.517188] Starting subtest: live [168.518894] Starting dynamic subtest: sanitycheck [169.049279] Dynamic subtest sanitycheck: SUCCESS (0.531s) [169.057224] Starting dynamic subtest: uncore [169.551447] Dynamic subtest uncore: SUCCESS (0.501s) [169.559256] Starting dynamic subtest: workarounds [170.300051] Dynamic subtest workarounds: SUCCESS (0.747s) [170.308586] Starting dynamic subtest: gt_engines [171.264521] Dynamic subtest gt_engines: SUCCESS (0.964s) [171.272428] Starting dynamic subtest: gt_timelines [177.473392] Dynamic subtest gt_timelines: SUCCESS (6.208s) [177.481104] Starting dynamic subtest: gt_contexts [178.061280] Dynamic subtest gt_contexts: SUCCESS (0.587s) [178.070598] Starting dynamic subtest: gt_lrc [180.941358] Dynamic subtest gt_lrc: SUCCESS (2.879s) [180.950838] Starting dynamic subtest: gt_mocs [181.497331] Dynamic subtest gt_mocs: SUCCESS (0.555s) [181.506538] Starting dynamic subtest: gt_pm [196.588292] Dynamic subtest gt_pm: SUCCESS (15.090s) [196.598260] Starting dynamic subtest: gt_heartbeat [197.236460] Dynamic subtest gt_heartbeat: SUCCESS (0.647s) [197.244558] Starting dynamic subtest: gt_tlb [198.893196] Dynamic subtest gt_tlb: SUCCESS (1.656s) [198.901072] Starting dynamic subtest: requests [205.647199] Dynamic subtest requests: SUCCESS (6.753s) [205.655177] Starting dynamic subtest: migrate [208.875442] Dynamic subtest migrate: SUCCESS (3.227s) [208.883411] Starting dynamic subtest: active [209.361383] Dynamic subtest active: SUCCESS (0.485s) [209.369506] Starting dynamic subtest: objects [210.446292] Dynamic subtest objects: SUCCESS (1.084s) [210.454288] Starting dynamic subtest: mman [214.558386] Dynamic subtest mman: SUCCESS (4.111s) [214.566798] Starting dynamic subtest: dmabuf [215.069257] Dynamic subtest dmabuf: SUCCESS (0.510s) [215.077049] Starting dynamic subtest: vma [215.537316] Dynamic subtest vma: SUCCESS (0.467s) [215.548284] Starting dynamic subtest: coherency [217.227417] Dynamic subtest coherency: SUCCESS (1.689s) [217.237503] Starting dynamic subtest: gtt [225.479182] Dynamic subtest gtt: SUCCESS (8.251s) [225.487173] Starting dynamic subtest: gem [226.409299] Dynamic subtest gem: SUCCESS (0.929s) [226.419612] Starting dynamic subtest: evict [227.646633] Dynamic subtest evict: SUCCESS (1.236s) [227.656168] Starting dynamic subtest: hugepages [233.771216] Dynamic subtest hugepages: SUCCESS (6.124s) [233.779153] Starting dynamic subtest: gem_contexts [245.331444] Dynamic subtest gem_contexts: SUCCESS (11.559s) [245.339540] Starting dynamic subtest: client [245.851292] Dynamic subtest client: SUCCESS (0.519s) [245.859563] Starting dynamic subtest: gem_migrate [246.370370] Dynamic subtest gem_migrate: SUCCESS (0.518s) [246.378648] Starting dynamic subtest: reset [250.587188] Dynamic subtest reset: SUCCESS (4.216s) [250.595565] Starting dynamic subtest: memory_region [251.084474] Dynamic subtest memory_region: SUCCESS (0.496s) [251.092601] Starting dynamic subtest: hangcheck [274.718366] Dynamic subtest hangcheck: SUCCESS (23.633s) [274.726701] Starting dynamic subtest: execlists [283.139310] Dynamic subtest execlists: SUCCESS (8.420s) [283.147585] Starting dynamic subtest: ring_submission [283.613210] Dynamic subtest ring_submission: SUCCESS (0.473s) [283.621774] Starting dynamic subtest: perf [284.168521] Dynamic subtest perf: SUCCESS (0.554s) [284.179184] Starting dynamic subtest: slpc [284.639507] Dynamic subtest slpc: SUCCESS (0.470s) [284.648291] Starting dynamic subtest: guc [285.128478] Dynamic subtest guc: SUCCESS (0.488s) [285.137420] Starting dynamic subtest: guc_multi_lrc [285.627258] Dynamic subtest guc_multi_lrc: SUCCESS (0.498s) [285.636098] Starting dynamic subtest: guc_hang [286.120890] Dynamic subtest guc_hang: SUCCESS (0.492s) [286.129441] Starting dynamic subtest: late_gt_pm [286.633365] Dynamic subtest late_gt_pm: SUCCESS (0.512s) [286.634990] Subtest live: SUCCESS (118.115s) [286.799168] [164/170] (704s left) dmabuf (all-tests) [286.865720] Starting subtest: all-tests [286.867435] Starting dynamic subtest: sanitycheck [286.932331] Dynamic subtest sanitycheck: SUCCESS (0.067s) [286.944183] Starting dynamic subtest: dma_fence [287.104663] Dynamic subtest dma_fence: SUCCESS (0.172s) [287.116826] Starting dynamic subtest: dma_fence_chain [297.451560] Dynamic subtest dma_fence_chain: SUCCESS (10.346s) [297.461584] Starting dynamic subtest: dma_fence_unwrap [297.514964] Dynamic subtest dma_fence_unwrap: SUCCESS (0.063s) [297.525608] Starting dynamic subtest: dma_resv [297.575179] Dynamic subtest dma_resv: SUCCESS (0.059s) [297.576894] Subtest all-tests: SUCCESS (10.712s) [297.594895] [165/170] (694s left) i915_suspend (basic-s2idle-without-i915) [297.645876] Starting subtest: basic-s2idle-without-i915 [317.566145] Subtest basic-s2idle-without-i915: SUCCESS (5.189s) [324.677744] [166/170] (688s left) i915_suspend (basic-s3-without-i915) [324.732561] Starting subtest: basic-s3-without-i915