[28.948013] Initializing watchdogs [28.948062] /dev/watchdog0 [28.952223] [001/171] (960s left) i915_module_load (load) [28.991779] Starting subtest: load [29.550354] Subtest load: SUCCESS (0.558s) [29.558121] [002/171] (959s left) core_auth (basic-auth) [29.595523] Starting subtest: basic-auth [29.596207] Subtest basic-auth: SUCCESS (0.000s) [29.644404] [003/171] (959s left) debugfs_test (read_all_entries) [29.697639] Starting subtest: read_all_entries [29.733924] Subtest read_all_entries: SUCCESS (0.036s) [29.828063] [004/171] (959s left) debugfs_test (basic-hwmon) [29.864868] Starting subtest: basic-hwmon [29.866311] Subtest basic-hwmon: SKIP (0.000s) [29.941872] [005/171] (959s left) fbdev (eof) [29.984144] Starting subtest: eof [29.985055] Subtest eof: SUCCESS (0.000s) [30.035843] [006/171] (959s left) fbdev (info) [30.092097] Starting subtest: info [30.093120] Subtest info: SUCCESS (0.000s) [30.153418] [007/171] (959s left) fbdev (nullptr) [30.217148] Starting subtest: nullptr [30.218016] Subtest nullptr: SUCCESS (0.000s) [30.269651] [008/171] (959s left) fbdev (read) [30.316983] Starting subtest: read [30.894054] Subtest read: SUCCESS (0.576s) [30.925755] [009/171] (958s left) fbdev (write) [30.967018] Starting subtest: write [31.353637] Subtest write: SUCCESS (0.386s) [31.395700] [010/171] (958s left) gem_basic (bad-close) [31.437245] Starting subtest: bad-close [31.439028] Subtest bad-close: SUCCESS (0.000s) [31.506661] [011/171] (958s left) gem_basic (create-close) [31.551825] Starting subtest: create-close [31.553210] Subtest create-close: SUCCESS (0.000s) [31.644247] [012/171] (957s left) gem_basic (create-fd-close) [31.702714] Starting subtest: create-fd-close [31.704137] Subtest create-fd-close: SUCCESS (0.000s) [31.794913] [013/171] (957s left) gem_busy (busy@all-engines) [31.858720] Starting subtest: busy [31.859475] Starting dynamic subtest: all-engines [31.871802] Dynamic subtest all-engines: SUCCESS (0.013s) [31.872446] Subtest busy: SUCCESS (0.013s) [32.224496] [014/171] (957s left) gem_close_race (basic-process) [32.266500] Starting subtest: basic-process [32.295737] Subtest basic-process: SUCCESS (0.029s) [32.479665] [015/171] (957s left) gem_close_race (basic-threads) [32.542564] Starting subtest: basic-threads [33.728431] Subtest basic-threads: SUCCESS (1.186s) [33.920465] [016/171] (955s left) gem_ctx_create (basic) [33.987305] Starting subtest: basic [33.987956] Subtest basic: SUCCESS (0.000s) [34.178957] [017/171] (955s left) gem_ctx_create (basic-files) [34.237766] Starting subtest: basic-files [36.244357] Subtest basic-files: SUCCESS (2.007s) [36.429443] [018/171] (953s left) gem_ctx_exec (basic) [36.486150] Starting subtest: basic [36.487465] Subtest basic: SUCCESS (0.001s) [36.602607] [019/171] (953s left) gem_exec_basic (basic) [36.656690] Starting subtest: basic [36.657367] Starting dynamic subtest: rcs0-smem [36.658025] Dynamic subtest rcs0-smem: SUCCESS (0.000s) [36.660784] Starting dynamic subtest: bcs0-smem [36.661421] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [36.664037] Starting dynamic subtest: vcs0-smem [36.664685] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [36.667268] Starting dynamic subtest: vecs0-smem [36.667901] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [36.668723] Subtest basic: SUCCESS (0.002s) [36.823778] [020/171] (952s left) gem_exec_create (basic) [36.867344] Starting subtest: basic [36.868017] Starting dynamic subtest: smem [38.911973] Dynamic subtest smem: SUCCESS (2.045s) [38.912664] Subtest basic: SUCCESS (2.045s) [39.090749] [021/171] (950s left) gem_exec_fence (basic-busy) [39.259861] Starting subtest: basic-busy [39.261181] Starting dynamic subtest: rcs0 [39.311215] Dynamic subtest rcs0: SUCCESS (0.051s) [39.324737] Starting dynamic subtest: bcs0 [39.344811] Dynamic subtest bcs0: SUCCESS (0.034s) [39.354920] Starting dynamic subtest: vcs0 [39.389292] Dynamic subtest vcs0: SUCCESS (0.044s) [39.402432] Starting dynamic subtest: vecs0 [39.416050] Dynamic subtest vecs0: SUCCESS (0.027s) [39.417795] Subtest basic-busy: SUCCESS (0.156s) [39.864239] [022/171] (949s left) gem_exec_fence (basic-wait) [40.035134] Starting subtest: basic-wait [40.037060] Starting dynamic subtest: rcs0 [40.087189] Dynamic subtest rcs0: SUCCESS (0.052s) [40.101625] Starting dynamic subtest: bcs0 [40.119225] Dynamic subtest bcs0: SUCCESS (0.032s) [40.132123] Starting dynamic subtest: vcs0 [40.154314] Dynamic subtest vcs0: SUCCESS (0.035s) [40.166848] Starting dynamic subtest: vecs0 [40.189537] Dynamic subtest vecs0: SUCCESS (0.035s) [40.191610] Subtest basic-wait: SUCCESS (0.154s) [40.627628] [023/171] (949s left) gem_exec_fence (basic-await) [40.802624] Starting subtest: basic-await [40.804581] Starting dynamic subtest: rcs0 [40.879457] Dynamic subtest rcs0: SUCCESS (0.076s) [40.893115] Starting dynamic subtest: bcs0 [40.955854] Dynamic subtest bcs0: SUCCESS (0.076s) [40.969402] Starting dynamic subtest: vcs0 [41.036424] Dynamic subtest vcs0: SUCCESS (0.080s) [41.049171] Starting dynamic subtest: vecs0 [41.112928] Dynamic subtest vecs0: SUCCESS (0.076s) [41.114548] Subtest basic-await: SUCCESS (0.311s) [41.540416] [024/171] (948s left) gem_exec_fence (nb-await) [41.711353] Starting subtest: nb-await [41.712954] Starting dynamic subtest: rcs0 [41.772759] Dynamic subtest rcs0: SUCCESS (0.061s) [41.787236] Starting dynamic subtest: bcs0 [41.836709] Dynamic subtest bcs0: SUCCESS (0.064s) [41.851089] Starting dynamic subtest: vcs0 [41.900109] Dynamic subtest vcs0: SUCCESS (0.063s) [41.914791] Starting dynamic subtest: vecs0 [41.963229] Dynamic subtest vecs0: SUCCESS (0.063s) [41.964959] Subtest nb-await: SUCCESS (0.252s) [42.392519] [025/171] (947s left) gem_exec_gttfill (basic) [42.452550] Starting subtest: basic [44.953424] Subtest basic: SUCCESS (2.501s) [45.132724] [026/171] (944s left) gem_exec_parallel (engines) [45.221377] Starting subtest: engines [45.222103] Starting dynamic subtest: basic [48.039149] Dynamic subtest basic: SUCCESS (2.818s) [48.042982] Starting dynamic subtest: contexts [50.177820] Dynamic subtest contexts: SUCCESS (2.138s) [50.188669] Starting dynamic subtest: fds [51.947364] Dynamic subtest fds: SUCCESS (1.769s) [51.959780] Starting dynamic subtest: userptr [53.667161] Dynamic subtest userptr: SUCCESS (1.720s) [53.667859] Subtest engines: SUCCESS (8.446s) [53.846273] [027/171] (936s left) gem_exec_store (basic) [53.907268] Starting subtest: basic [53.950610] Subtest basic: SUCCESS (0.043s) [54.126551] [028/171] (935s left) gem_flink_basic (bad-flink) [54.177189] Starting subtest: bad-flink [54.178046] Subtest bad-flink: SUCCESS (0.000s) [54.248373] [029/171] (935s left) gem_flink_basic (bad-open) [54.302670] Starting subtest: bad-open [54.303358] Subtest bad-open: SUCCESS (0.000s) [54.350493] [030/171] (935s left) gem_flink_basic (basic) [54.404400] Starting subtest: basic [54.405114] Subtest basic: SUCCESS (0.000s) [54.487607] [031/171] (935s left) gem_flink_basic (double-flink) [54.535473] Starting subtest: double-flink [54.536186] Subtest double-flink: SUCCESS (0.000s) [54.629095] [032/171] (935s left) gem_flink_basic (flink-lifetime) [54.684306] Starting subtest: flink-lifetime [54.685028] Subtest flink-lifetime: SUCCESS (0.001s) [54.776246] [033/171] (935s left) gem_huc_copy (huc-copy) [54.834437] Starting subtest: huc-copy [54.835728] Subtest huc-copy: SKIP (0.000s) [54.929592] [034/171] (935s left) gem_linear_blits (basic) [55.033889] Starting subtest: basic [55.037838] Subtest basic: SUCCESS (0.004s) [55.135196] [035/171] (934s left) gem_mmap (basic) [55.214117] Starting subtest: basic [55.217730] Subtest basic: SUCCESS (0.000s) [55.301986] [036/171] (934s left) gem_mmap_gtt (basic) [55.348384] Starting subtest: basic [55.349119] Subtest basic: SUCCESS (0.000s) [55.394078] [037/171] (934s left) gem_render_linear_blits (basic) [55.448863] Starting subtest: basic [55.473258] Subtest basic: SUCCESS (0.024s) [55.508401] [038/171] (934s left) gem_render_tiled_blits (basic) [55.571324] Starting subtest: basic [55.587229] Subtest basic: SUCCESS (0.016s) [55.645907] [039/171] (934s left) gem_ringfill (basic-all) [55.847953] Starting subtest: basic-all [56.953371] Subtest basic-all: SUCCESS (1.107s) [57.074253] [040/171] (933s left) gem_softpin (allocator-basic) [57.129151] Starting subtest: allocator-basic [57.174281] Subtest allocator-basic: SUCCESS (0.045s) [57.280933] [041/171] (932s left) gem_softpin (allocator-basic-reserve) [57.335775] Starting subtest: allocator-basic-reserve [57.383252] Subtest allocator-basic-reserve: SUCCESS (0.047s) [57.492697] [042/171] (932s left) gem_softpin (safe-alignment) [57.547621] Starting subtest: safe-alignment [57.552647] Subtest safe-alignment: SUCCESS (0.005s) [57.665745] [043/171] (932s left) gem_sync (basic-all) [57.721259] Starting subtest: basic-all [59.804043] Subtest basic-all: SUCCESS (2.084s) [59.965489] [044/171] (930s left) gem_sync (basic-each) [60.016371] Starting subtest: basic-each [62.073991] Subtest basic-each: SUCCESS (2.059s) [62.273365] [045/171] (927s left) gem_tiled_blits (basic) [62.390304] Starting subtest: basic [62.399029] Subtest basic: SUCCESS (0.009s) [62.520184] [046/171] (927s left) gem_tiled_fence_blits (basic) [62.640719] Starting subtest: basic [62.660025] Subtest basic: SUCCESS (0.019s) [62.770252] [047/171] (927s left) gem_tiled_pread_basic [62.874452] [048/171] (927s left) gem_wait (busy@all-engines) [62.917743] Starting subtest: busy [62.918476] Starting dynamic subtest: all-engines [63.445500] Dynamic subtest all-engines: SUCCESS (0.527s) [63.446546] Subtest busy: SUCCESS (0.527s) [63.630454] [049/171] (926s left) gem_wait (wait@all-engines) [63.688183] Starting subtest: wait [63.688931] Starting dynamic subtest: all-engines [64.738216] Dynamic subtest all-engines: SUCCESS (1.049s) [64.740112] Subtest wait: SUCCESS (1.049s) [64.928510] [050/171] (925s left) i915_getparams_basic (basic-eu-total) [64.971726] Starting subtest: basic-eu-total [64.973191] Subtest basic-eu-total: SUCCESS (0.000s) [65.043160] [051/171] (925s left) i915_getparams_basic (basic-subslice-total) [65.084991] Starting subtest: basic-subslice-total [65.086444] Subtest basic-subslice-total: SUCCESS (0.000s) [65.160992] [052/171] (925s left) i915_hangman (error-state-basic) [65.219201] Starting subtest: error-state-basic [65.222782] Subtest error-state-basic: SUCCESS (0.004s) [65.314336] [053/171] (925s left) i915_pciid [65.444905] [054/171] (924s left) kms_addfb_basic (addfb25-bad-modifier) [65.497694] Starting subtest: addfb25-bad-modifier [65.498538] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [65.616411] [055/171] (924s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [65.654325] Starting subtest: addfb25-framebuffer-vs-set-tiling [65.655088] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [65.742589] [056/171] (924s left) kms_addfb_basic (addfb25-modifier-no-flag) [65.777885] Starting subtest: addfb25-modifier-no-flag [65.778650] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [65.906172] [057/171] (924s left) kms_addfb_basic (addfb25-x-tiled-legacy) [65.944700] Starting subtest: addfb25-x-tiled-legacy [65.945378] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [66.042547] [058/171] (924s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [66.079930] Starting subtest: addfb25-x-tiled-mismatch-legacy [66.080683] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [66.176097] [059/171] (924s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [66.246113] Starting subtest: addfb25-yf-tiled-legacy [66.246901] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [66.334820] [060/171] (924s left) kms_addfb_basic (addfb25-y-tiled-legacy) [66.412074] Starting subtest: addfb25-y-tiled-legacy [66.412925] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [66.503109] [061/171] (923s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [66.580879] Starting subtest: addfb25-y-tiled-small-legacy [66.581595] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [66.642825] [062/171] (923s left) kms_addfb_basic (bad-pitch-0) [66.679527] Starting subtest: bad-pitch-0 [66.680210] Subtest bad-pitch-0: SUCCESS (0.000s) [66.776248] [063/171] (923s left) kms_addfb_basic (bad-pitch-1024) [66.811895] Starting subtest: bad-pitch-1024 [66.812671] Subtest bad-pitch-1024: SUCCESS (0.000s) [66.909592] [064/171] (923s left) kms_addfb_basic (bad-pitch-128) [66.945942] Starting subtest: bad-pitch-128 [66.946691] Subtest bad-pitch-128: SUCCESS (0.000s) [67.042535] [065/171] (923s left) kms_addfb_basic (bad-pitch-256) [67.080488] Starting subtest: bad-pitch-256 [67.081191] Subtest bad-pitch-256: SUCCESS (0.000s) [67.193498] [066/171] (923s left) kms_addfb_basic (bad-pitch-32) [67.240219] Starting subtest: bad-pitch-32 [67.240884] Subtest bad-pitch-32: SUCCESS (0.000s) [67.346177] [067/171] (923s left) kms_addfb_basic (bad-pitch-63) [67.388893] Starting subtest: bad-pitch-63 [67.389599] Subtest bad-pitch-63: SUCCESS (0.000s) [67.497388] [068/171] (923s left) kms_addfb_basic (bad-pitch-65536) [67.551532] Starting subtest: bad-pitch-65536 [67.552229] Subtest bad-pitch-65536: SUCCESS (0.000s) [67.642660] [069/171] (922s left) kms_addfb_basic (bad-pitch-999) [67.678022] Starting subtest: bad-pitch-999 [67.678752] Subtest bad-pitch-999: SUCCESS (0.000s) [67.776586] [070/171] (922s left) kms_addfb_basic (basic) [67.814230] Starting subtest: basic [67.814984] Subtest basic: SUCCESS (0.000s) [67.935079] [071/171] (922s left) kms_addfb_basic (basic-x-tiled-legacy) [67.973646] Starting subtest: basic-x-tiled-legacy [67.974480] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [68.076776] [072/171] (922s left) kms_addfb_basic (basic-y-tiled-legacy) [68.114814] Starting subtest: basic-y-tiled-legacy [68.115463] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [68.226182] [073/171] (922s left) kms_addfb_basic (bo-too-small) [68.295695] Starting subtest: bo-too-small [68.296359] Subtest bo-too-small: SUCCESS (0.000s) [68.383844] [074/171] (922s left) kms_addfb_basic (bo-too-small-due-to-tiling) [68.461810] Starting subtest: bo-too-small-due-to-tiling [68.462577] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [68.559560] [075/171] (922s left) kms_addfb_basic (clobberred-modifier) [68.601787] Starting subtest: clobberred-modifier [68.602453] Subtest clobberred-modifier: SUCCESS (0.000s) [68.719868] [076/171] (921s left) kms_addfb_basic (framebuffer-vs-set-tiling) [68.762609] Starting subtest: framebuffer-vs-set-tiling [68.763252] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [68.885543] [077/171] (921s left) kms_addfb_basic (invalid-get-prop) [68.928774] Starting subtest: invalid-get-prop [68.929425] Subtest invalid-get-prop: SUCCESS (0.000s) [69.060565] [078/171] (921s left) kms_addfb_basic (invalid-get-prop-any) [69.112094] Starting subtest: invalid-get-prop-any [69.112914] Subtest invalid-get-prop-any: SUCCESS (0.000s) [69.243538] [079/171] (921s left) kms_addfb_basic (invalid-set-prop) [69.295707] Starting subtest: invalid-set-prop [69.296405] Subtest invalid-set-prop: SUCCESS (0.000s) [69.426371] [080/171] (921s left) kms_addfb_basic (invalid-set-prop-any) [69.479419] Starting subtest: invalid-set-prop-any [69.480132] Subtest invalid-set-prop-any: SUCCESS (0.000s) [69.576106] [081/171] (921s left) kms_addfb_basic (no-handle) [69.623335] Starting subtest: no-handle [69.624045] Subtest no-handle: SUCCESS (0.000s) [69.757592] [082/171] (920s left) kms_addfb_basic (size-max) [69.844760] Starting subtest: size-max [69.845573] Subtest size-max: SUCCESS (0.000s) [69.942625] [083/171] (920s left) kms_addfb_basic (small-bo) [70.027774] Starting subtest: small-bo [70.028414] Subtest small-bo: SUCCESS (0.000s) [70.093113] [084/171] (920s left) kms_addfb_basic (tile-pitch-mismatch) [70.141535] Starting subtest: tile-pitch-mismatch [70.142184] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [70.272182] [085/171] (920s left) kms_addfb_basic (too-high) [70.349313] Starting subtest: too-high [70.350031] Subtest too-high: SUCCESS (0.000s) [70.435105] [086/171] (920s left) kms_addfb_basic (too-wide) [70.521832] Starting subtest: too-wide [70.522548] Subtest too-wide: SUCCESS (0.000s) [70.595896] [087/171] (920s left) kms_addfb_basic (unused-handle) [70.649446] Starting subtest: unused-handle [70.650174] Subtest unused-handle: SUCCESS (0.000s) [70.773523] [088/171] (920s left) kms_addfb_basic (unused-modifier) [70.826522] Starting subtest: unused-modifier [70.827327] Subtest unused-modifier: SUCCESS (0.000s) [70.926932] [089/171] (919s left) kms_addfb_basic (unused-offsets) [70.978226] Starting subtest: unused-offsets [70.978944] Subtest unused-offsets: SUCCESS (0.000s) [71.103344] [090/171] (919s left) kms_addfb_basic (unused-pitches) [71.157379] Starting subtest: unused-pitches [71.163177] Subtest unused-pitches: SUCCESS (0.000s) [71.261154] [091/171] (919s left) kms_busy (basic) [71.351078] Starting subtest: basic [71.351814] Starting dynamic subtest: flip [71.904999] Dynamic subtest flip: SUCCESS (0.554s) [71.908575] Starting dynamic subtest: modeset [72.534526] Dynamic subtest modeset: SUCCESS (0.629s) [72.535214] Subtest basic: SUCCESS (1.184s) [72.667258] [092/171] (918s left) kms_chamelium_hpd (dp-hpd-fast) [72.813711] Subtest dp-hpd-fast: SKIP (0.000s) [72.874219] [093/171] (918s left) kms_chamelium_edid (dp-edid-read) [73.022609] Subtest dp-edid-read: SKIP (0.000s) [73.083499] [094/171] (917s left) kms_chamelium_frames (dp-crc-fast) [73.231618] Subtest dp-crc-fast: SKIP (0.000s) [73.291731] [095/171] (917s left) kms_chamelium_hpd (hdmi-hpd-fast) [73.441716] Subtest hdmi-hpd-fast: SKIP (0.000s) [73.501941] [096/171] (917s left) kms_chamelium_edid (hdmi-edid-read) [73.652156] Subtest hdmi-edid-read: SKIP (0.000s) [73.712704] [097/171] (917s left) kms_chamelium_frames (hdmi-crc-fast) [73.845427] Subtest hdmi-crc-fast: SKIP (0.000s) [73.906582] [098/171] (917s left) kms_chamelium_hpd (vga-hpd-fast) [74.040165] Subtest vga-hpd-fast: SKIP (0.000s) [74.098667] [099/171] (916s left) kms_chamelium_edid (vga-edid-read) [74.248934] Subtest vga-edid-read: SKIP (0.000s) [74.310747] [100/171] (916s left) kms_prop_blob (basic) [74.346641] Starting subtest: basic [74.347372] Subtest basic: SUCCESS (0.000s) [74.396620] [101/171] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [74.464827] Starting subtest: basic-busy-flip-before-cursor-atomic [74.466173] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [74.513480] [102/171] (916s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [74.581976] Starting subtest: basic-busy-flip-before-cursor-legacy [74.583355] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [74.630141] [103/171] (916s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [74.699164] Starting subtest: basic-flip-after-cursor-atomic [75.659502] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.962s) [75.758851] [104/171] (915s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [75.828168] Starting subtest: basic-flip-after-cursor-legacy [76.802411] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.975s) [76.917691] [105/171] (914s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [76.986107] Starting subtest: basic-flip-after-cursor-varying-size [77.928391] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.943s) [78.069647] [106/171] (912s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [78.138032] Starting subtest: basic-flip-before-cursor-atomic [79.098435] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.962s) [79.221672] [107/171] (911s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [79.290566] Starting subtest: basic-flip-before-cursor-legacy [80.249584] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.959s) [80.368536] [108/171] (910s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [80.436973] Starting subtest: basic-flip-before-cursor-varying-size [81.398469] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.962s) [81.521847] [109/171] (909s left) kms_flip (basic-flip-vs-dpms) [81.586796] Starting subtest: basic-flip-vs-dpms [81.587441] Starting dynamic subtest: A-HDMI-A1 [82.528307] Dynamic subtest A-HDMI-A1: SUCCESS (0.941s) [82.532139] Starting dynamic subtest: B-HDMI-A1 [83.422326] Dynamic subtest B-HDMI-A1: SUCCESS (0.894s) [83.426141] Starting dynamic subtest: C-HDMI-A1 [84.305035] Dynamic subtest C-HDMI-A1: SUCCESS (0.882s) [84.305775] Subtest basic-flip-vs-dpms: SUCCESS (2.720s) [84.419842] [110/171] (906s left) kms_flip (basic-flip-vs-modeset) [84.485689] Starting subtest: basic-flip-vs-modeset [84.486337] Starting dynamic subtest: A-HDMI-A1 [85.442111] Dynamic subtest A-HDMI-A1: SUCCESS (0.955s) [85.446375] Starting dynamic subtest: B-HDMI-A1 [86.222443] Dynamic subtest B-HDMI-A1: SUCCESS (0.781s) [86.226259] Starting dynamic subtest: C-HDMI-A1 [87.112913] Dynamic subtest C-HDMI-A1: SUCCESS (0.890s) [87.113582] Subtest basic-flip-vs-modeset: SUCCESS (2.629s) [87.230670] [111/171] (903s left) kms_flip (basic-flip-vs-wf_vblank) [87.295912] Starting subtest: basic-flip-vs-wf_vblank [87.296618] Starting dynamic subtest: A-HDMI-A1 [88.467016] Dynamic subtest A-HDMI-A1: SUCCESS (1.171s) [88.470656] Starting dynamic subtest: B-HDMI-A1 [89.596586] Dynamic subtest B-HDMI-A1: SUCCESS (1.129s) [89.602150] Starting dynamic subtest: C-HDMI-A1 [90.738275] Dynamic subtest C-HDMI-A1: SUCCESS (1.141s) [90.739374] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.444s) [90.917289] [112/171] (900s left) kms_flip (basic-plain-flip) [90.981960] Starting subtest: basic-plain-flip [90.982705] Starting dynamic subtest: A-HDMI-A1 [91.872310] Dynamic subtest A-HDMI-A1: SUCCESS (0.889s) [91.879667] Starting dynamic subtest: B-HDMI-A1 [92.734717] Dynamic subtest B-HDMI-A1: SUCCESS (0.861s) [92.740682] Starting dynamic subtest: C-HDMI-A1 [93.593169] Dynamic subtest C-HDMI-A1: SUCCESS (0.858s) [93.594300] Subtest basic-plain-flip: SUCCESS (2.613s) [93.755365] [113/171] (897s left) kms_force_connector_basic (force-connector-state) [93.876141] Starting subtest: force-connector-state [94.781063] Subtest force-connector-state: SUCCESS (0.905s) [95.032365] [114/171] (896s left) kms_force_connector_basic (force-edid) [95.152420] Starting subtest: force-edid [95.290154] Subtest force-edid: SUCCESS (0.138s) [95.448886] [115/171] (895s left) kms_force_connector_basic (force-load-detect) [95.568425] Starting subtest: force-load-detect [95.569824] Subtest force-load-detect: SKIP (0.000s) [95.732449] [116/171] (895s left) kms_force_connector_basic (prune-stale-modes) [95.851879] Starting subtest: prune-stale-modes [95.990032] Subtest prune-stale-modes: SUCCESS (0.138s) [96.148918] [117/171] (894s left) kms_frontbuffer_tracking (basic) [96.220623] Starting subtest: basic [98.990807] Subtest basic: SUCCESS (2.771s) [99.106706] [118/171] (892s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [99.192137] Starting subtest: compare-crc-sanitycheck [99.192996] Starting dynamic subtest: pipe-A-HDMI-A-1 [99.626776] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.434s) [99.630452] Starting dynamic subtest: pipe-B-HDMI-A-1 [100.205384] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.578s) [100.210035] Starting dynamic subtest: pipe-C-HDMI-A-1 [100.984566] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.778s) [100.985435] Subtest compare-crc-sanitycheck: SUCCESS (1.793s) [101.096873] [119/171] (890s left) kms_pipe_crc_basic (hang-read-crc) [101.167411] Starting subtest: hang-read-crc [101.168281] Starting dynamic subtest: pipe-A-HDMI-A-1 [102.207377] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.028s) [102.211198] Starting dynamic subtest: pipe-B-HDMI-A-1 [103.560750] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (1.360s) [103.564459] Starting dynamic subtest: pipe-C-HDMI-A-1 [105.342593] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (1.785s) [105.343318] Subtest hang-read-crc: SUCCESS (4.176s) [105.469529] [120/171] (885s left) kms_pipe_crc_basic (nonblocking-crc) [105.575236] Starting subtest: nonblocking-crc [105.575929] Starting dynamic subtest: pipe-A-HDMI-A-1 [106.163229] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.588s) [106.166920] Starting dynamic subtest: pipe-B-HDMI-A-1 [106.904403] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.739s) [106.908083] Starting dynamic subtest: pipe-C-HDMI-A-1 [107.845441] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.941s) [107.846091] Subtest nonblocking-crc: SUCCESS (2.271s) [107.939596] [121/171] (883s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [108.007989] Starting subtest: nonblocking-crc-frame-sequence [108.008785] Starting dynamic subtest: pipe-A-HDMI-A-1 [108.601510] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.593s) [108.605221] Starting dynamic subtest: pipe-B-HDMI-A-1 [109.345449] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.743s) [109.349198] Starting dynamic subtest: pipe-C-HDMI-A-1 [110.291599] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.945s) [110.292323] Subtest nonblocking-crc-frame-sequence: SUCCESS (2.284s) [110.385093] [122/171] (880s left) kms_pipe_crc_basic (read-crc) [110.455456] Starting subtest: read-crc [110.456324] Starting dynamic subtest: pipe-A-HDMI-A-1 [110.981161] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.525s) [110.985030] Starting dynamic subtest: pipe-B-HDMI-A-1 [111.649535] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.668s) [111.654149] Starting dynamic subtest: pipe-C-HDMI-A-1 [112.549800] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.898s) [112.550479] Subtest read-crc: SUCCESS (2.095s) [112.645157] [123/171] (878s left) kms_pipe_crc_basic (read-crc-frame-sequence) [112.714084] Starting subtest: read-crc-frame-sequence [112.714806] Starting dynamic subtest: pipe-A-HDMI-A-1 [113.223387] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.509s) [113.227130] Starting dynamic subtest: pipe-B-HDMI-A-1 [113.905322] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.681s) [113.909804] Starting dynamic subtest: pipe-C-HDMI-A-1 [114.788294] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.881s) [114.789029] Subtest read-crc-frame-sequence: SUCCESS (2.074s) [114.880429] [124/171] (876s left) kms_psr (primary_page_flip) [114.918093] Subtest primary_page_flip: SKIP (0.000s) [114.942201] [125/171] (876s left) kms_psr (cursor_plane_move) [114.978537] Subtest cursor_plane_move: SKIP (0.000s) [114.991959] [126/171] (876s left) kms_psr (sprite_plane_onoff) [115.028958] Subtest sprite_plane_onoff: SKIP (0.000s) [115.041579] [127/171] (876s left) kms_psr (primary_mmap_gtt) [115.077490] Subtest primary_mmap_gtt: SKIP (0.000s) [115.091868] [128/171] (876s left) kms_setmode (basic-clone-single-crtc) [115.132606] Starting subtest: basic-clone-single-crtc [115.134690] Subtest basic-clone-single-crtc: SKIP (0.000s) [115.193163] [129/171] (876s left) i915_pm_backlight (basic-brightness) [115.279313] Subtest basic-brightness: SKIP (0.000s) [115.291868] [130/171] (875s left) i915_pm_rpm (basic-pci-d3-state) [116.794198] Starting subtest: basic-pci-d3-state [117.263588] Subtest basic-pci-d3-state: SUCCESS (0.470s) [117.594818] [131/171] (873s left) i915_pm_rpm (basic-rte) [117.642661] Starting subtest: basic-rte [119.440790] Subtest basic-rte: SUCCESS (1.798s) [120.125718] [132/171] (871s left) i915_pm_rps (basic-api) [120.163493] Starting subtest: basic-api [120.165263] Subtest basic-api: SUCCESS (0.001s) [120.247453] [133/171] (871s left) prime_self_import (basic-llseek-bad) [120.297901] Starting subtest: basic-llseek-bad [120.298703] Subtest basic-llseek-bad: SUCCESS (0.001s) [120.378102] [134/171] (870s left) prime_self_import (basic-llseek-size) [120.419182] Starting subtest: basic-llseek-size [120.420916] Subtest basic-llseek-size: SUCCESS (0.001s) [120.513581] [135/171] (870s left) prime_self_import (basic-with_fd_dup) [120.563595] Starting subtest: basic-with_fd_dup [120.565457] Subtest basic-with_fd_dup: SUCCESS (0.001s) [120.642375] [136/171] (870s left) prime_self_import (basic-with_one_bo) [120.692597] Starting subtest: basic-with_one_bo [120.694402] Subtest basic-with_one_bo: SUCCESS (0.001s) [120.746184] [137/171] (870s left) prime_self_import (basic-with_one_bo_two_files) [120.795038] Starting subtest: basic-with_one_bo_two_files [120.796680] Subtest basic-with_one_bo_two_files: SUCCESS (0.002s) [120.879027] [138/171] (870s left) prime_self_import (basic-with_two_bos) [120.919553] Starting subtest: basic-with_two_bos [120.921533] Subtest basic-with_two_bos: SUCCESS (0.001s) [121.013417] [139/171] (870s left) prime_vgem (basic-fence-flip) [121.085689] Starting subtest: basic-fence-flip [121.482433] Subtest basic-fence-flip: SUCCESS (0.396s) [121.577948] [140/171] (869s left) prime_vgem (basic-fence-mmap) [121.641034] Starting subtest: basic-fence-mmap [121.654674] Subtest basic-fence-mmap: SUCCESS (0.014s) [121.765980] [141/171] (869s left) prime_vgem (basic-fence-read) [121.847396] Starting subtest: basic-fence-read [121.853122] Subtest basic-fence-read: SKIP (0.005s) [121.965868] [142/171] (869s left) prime_vgem (basic-gtt) [122.035301] Starting subtest: basic-gtt [122.041815] Subtest basic-gtt: SUCCESS (0.007s) [122.148394] [143/171] (869s left) prime_vgem (basic-read) [122.200683] Starting subtest: basic-read [122.204487] Subtest basic-read: SKIP (0.003s) [122.314778] [144/171] (869s left) prime_vgem (basic-write) [122.385632] Starting subtest: basic-write [122.389600] Subtest basic-write: SKIP (0.003s) [122.499544] [145/171] (869s left) prime_vgem (basic-userptr) [122.568809] Starting subtest: basic-userptr [122.572921] Subtest basic-userptr: SKIP (0.003s) [122.661903] [146/171] (868s left) vgem_basic (setversion) [122.732805] Starting subtest: setversion [122.734592] Subtest setversion: SUCCESS (0.000s) [122.795292] [147/171] (868s left) vgem_basic (create) [122.848513] Starting subtest: create [122.849228] Subtest create: SUCCESS (0.000s) [122.904992] [148/171] (868s left) vgem_basic (debugfs) [122.948596] Starting subtest: debugfs [122.949249] Subtest debugfs: SUCCESS (0.000s) [123.003301] [149/171] (868s left) vgem_basic (dmabuf-export) [123.065514] Starting subtest: dmabuf-export [123.067163] Subtest dmabuf-export: SUCCESS (0.001s) [123.164800] [150/171] (868s left) vgem_basic (dmabuf-fence) [123.215267] Starting subtest: dmabuf-fence [123.216009] Subtest dmabuf-fence: SUCCESS (0.000s) [123.271558] [151/171] (868s left) vgem_basic (dmabuf-fence-before) [123.332154] Starting subtest: dmabuf-fence-before [123.332900] Subtest dmabuf-fence-before: SUCCESS (0.000s) [123.391391] [152/171] (868s left) vgem_basic (dmabuf-mmap) [123.448550] Starting subtest: dmabuf-mmap [123.455389] Subtest dmabuf-mmap: SUCCESS (0.007s) [123.501030] [153/171] (868s left) vgem_basic (mmap) [123.548639] Starting subtest: mmap [123.553019] Subtest mmap: SUCCESS (0.004s) [123.610770] [154/171] (868s left) vgem_basic (second-client) [123.665539] Starting subtest: second-client [123.716825] Subtest second-client: SUCCESS (0.050s) [123.781322] [155/171] (867s left) vgem_basic (sysfs) [123.832023] Starting subtest: sysfs [123.832762] Subtest sysfs: SUCCESS (0.000s) [123.888571] [156/171] (867s left) core_hotunplug (unbind-rebind) [123.965818] Starting subtest: unbind-rebind [124.828592] Subtest unbind-rebind: SUCCESS (0.863s) [124.840673] [157/171] (866s left) vgem_basic (unload) [124.879169] Starting subtest: unload [153.653517] Subtest unload: SUCCESS (28.773s) [153.762159] [158/171] (838s left) i915_module_load (reload) [153.810219] Starting subtest: reload [155.114069] Subtest reload: SUCCESS (1.304s) [155.123558] [159/171] (836s left) gem_lmem_swapping (basic) [155.180680] Subtest basic: SKIP (0.000s) [155.202607] [160/171] (836s left) gem_lmem_swapping (parallel-random-engines) [155.241291] Subtest parallel-random-engines: SKIP (0.000s) [155.252846] [161/171] (836s left) gem_lmem_swapping (random-engines) [155.291226] Subtest random-engines: SKIP (0.000s) [155.302837] [162/171] (836s left) gem_lmem_swapping (verify-random) [155.340418] Subtest verify-random: SKIP (0.000s) [155.352327] [163/171] (836s left) i915_pm_rpm (module-reload) [157.168798] Starting subtest: module-reload [163.676457] Subtest module-reload: SUCCESS (6.507s) [163.690435] [164/171] (828s left) i915_selftest (live) [163.730528] Starting subtest: live [163.731414] Starting dynamic subtest: sanitycheck [164.121446] Dynamic subtest sanitycheck: SUCCESS (0.391s) [164.124611] Starting dynamic subtest: uncore [164.499605] Dynamic subtest uncore: SUCCESS (0.375s) [164.503438] Starting dynamic subtest: workarounds [165.062366] Dynamic subtest workarounds: SUCCESS (0.566s) [165.065457] Starting dynamic subtest: gt_engines [165.916306] Dynamic subtest gt_engines: SUCCESS (0.854s) [165.919400] Starting dynamic subtest: gt_timelines [171.015379] Dynamic subtest gt_timelines: SUCCESS (5.099s) [171.018582] Starting dynamic subtest: gt_contexts [171.499327] Dynamic subtest gt_contexts: SUCCESS (0.484s) [171.503439] Starting dynamic subtest: gt_lrc [174.163365] Dynamic subtest gt_lrc: SUCCESS (2.664s) [174.166373] Starting dynamic subtest: gt_mocs [174.630340] Dynamic subtest gt_mocs: SUCCESS (0.467s) [174.633465] Starting dynamic subtest: gt_pm [186.157484] Dynamic subtest gt_pm: SUCCESS (11.527s) [186.160618] Starting dynamic subtest: gt_heartbeat [186.666386] Dynamic subtest gt_heartbeat: SUCCESS (0.509s) [186.669568] Starting dynamic subtest: requests [193.258451] Dynamic subtest requests: SUCCESS (6.592s) [193.261813] Starting dynamic subtest: migrate [196.407326] Dynamic subtest migrate: SUCCESS (3.149s) [196.410684] Starting dynamic subtest: active [196.790535] Dynamic subtest active: SUCCESS (0.383s) [196.793664] Starting dynamic subtest: objects [197.708367] Dynamic subtest objects: SUCCESS (0.918s) [197.711461] Starting dynamic subtest: mman [201.473421] Dynamic subtest mman: SUCCESS (3.765s) [201.476733] Starting dynamic subtest: dmabuf [201.887154] Dynamic subtest dmabuf: SUCCESS (0.414s) [201.890348] Starting dynamic subtest: vma [202.294438] Dynamic subtest vma: SUCCESS (0.407s) [202.297602] Starting dynamic subtest: coherency [203.403318] Dynamic subtest coherency: SUCCESS (1.109s) [203.406413] Starting dynamic subtest: gtt [213.318366] Dynamic subtest gtt: SUCCESS (9.915s) [213.321472] Starting dynamic subtest: gem [213.829351] Dynamic subtest gem: SUCCESS (0.511s) [213.832459] Starting dynamic subtest: evict [214.719233] Dynamic subtest evict: SUCCESS (0.890s) [214.722447] Starting dynamic subtest: hugepages [220.758323] Dynamic subtest hugepages: SUCCESS (6.039s) [220.761523] Starting dynamic subtest: gem_contexts [231.950456] Dynamic subtest gem_contexts: SUCCESS (11.192s) [231.953639] Starting dynamic subtest: client [232.322263] Dynamic subtest client: SUCCESS (0.372s) [232.325464] Starting dynamic subtest: gem_migrate [232.677345] Dynamic subtest gem_migrate: SUCCESS (0.355s) [232.680651] Starting dynamic subtest: reset [236.272627] Dynamic subtest reset: SUCCESS (3.595s) [236.275813] Starting dynamic subtest: memory_region [236.638203] Dynamic subtest memory_region: SUCCESS (0.365s) [236.641642] Starting dynamic subtest: hangcheck [260.086365] Dynamic subtest hangcheck: SUCCESS (23.448s) [260.090810] Starting dynamic subtest: execlists [267.695382] Dynamic subtest execlists: SUCCESS (7.609s) [267.698760] Starting dynamic subtest: ring_submission [268.041301] Dynamic subtest ring_submission: SUCCESS (0.346s) [268.044522] Starting dynamic subtest: perf [268.501409] Dynamic subtest perf: SUCCESS (0.460s) [268.504811] Starting dynamic subtest: slpc [268.911453] Dynamic subtest slpc: SUCCESS (0.410s) [268.914820] Starting dynamic subtest: guc [269.281345] Dynamic subtest guc: SUCCESS (0.370s) [269.284608] Starting dynamic subtest: guc_multi_lrc [269.635239] Dynamic subtest guc_multi_lrc: SUCCESS (0.354s) [269.639598] Starting dynamic subtest: guc_hang [269.998555] Dynamic subtest guc_hang: SUCCESS (0.363s) [270.001702] Starting dynamic subtest: late_gt_pm [270.373425] Dynamic subtest late_gt_pm: SUCCESS (0.374s) [270.374231] Subtest live: SUCCESS (106.643s) [270.451614] [165/171] (721s left) dmabuf (all-tests) [270.496549] Starting subtest: all-tests [270.497295] Starting dynamic subtest: sanitycheck [270.516353] Dynamic subtest sanitycheck: SUCCESS (0.019s) [270.521326] Starting dynamic subtest: dma_fence [270.642034] Dynamic subtest dma_fence: SUCCESS (0.126s) [270.645225] Starting dynamic subtest: dma_fence_chain [280.331077] Dynamic subtest dma_fence_chain: SUCCESS (9.689s) [280.334617] Starting dynamic subtest: dma_fence_unwrap [280.352406] Dynamic subtest dma_fence_unwrap: SUCCESS (0.021s) [280.357098] Starting dynamic subtest: dma_resv [280.388347] Dynamic subtest dma_resv: SUCCESS (0.035s) [280.390130] Subtest all-tests: SUCCESS (9.891s) [280.413336] [166/171] (711s left) i915_suspend (basic-s2idle-without-i915) [280.456930] Starting subtest: basic-s2idle-without-i915 [297.180408] Subtest basic-s2idle-without-i915: SUCCESS (1.761s) [303.287831] [167/171] (709s left) i915_suspend (basic-s3-without-i915) [303.334366] Starting subtest: basic-s3-without-i915 [325.440462] Subtest basic-s3-without-i915: SUCCESS (16.548s) [331.553125] [168/171] (692s left) gem_exec_suspend (basic-s0) [331.602165] Starting subtest: basic-S0 [331.602861] Starting dynamic subtest: smem [349.425652] Dynamic subtest smem: SUCCESS (3.358s) [349.426372] Subtest basic-S0: SUCCESS (3.358s) [354.577125] [169/171] (689s left) gem_exec_suspend (basic-s3) [354.624552] Starting subtest: basic-S3 [354.625342] Starting dynamic subtest: smem [383.572486] Dynamic subtest smem: SUCCESS (17.537s) [383.573139] Subtest basic-S3: SUCCESS (17.537s) [388.708733] [170/171] (671s left) kms_chamelium_hpd (common-hpd-after-suspend) [388.862859] Subtest common-hpd-after-suspend: SKIP (0.000s) [388.922927] [171/171] (671s left) kms_pipe_crc_basic (suspend-read-crc) [388.985352] Starting subtest: suspend-read-crc [388.986163] Starting dynamic subtest: pipe-A-HDMI-A-1 [423.630855] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (5.469s) [423.636030] Starting dynamic subtest: pipe-B-HDMI-A-1 [444.790396] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.548s) [444.795974] Starting dynamic subtest: pipe-C-HDMI-A-1 [467.026483] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.661s) [467.027164] Subtest suspend-read-crc: SUCCESS (18.681s) [472.092972] Closing watchdogs Done.