[28.748421] Initializing watchdogs [28.748483] /dev/watchdog0 [28.751828] [001/171] (960s left) i915_module_load (load) [28.843909] Starting subtest: load [29.438849] Subtest load: SUCCESS (0.595s) [29.447216] [002/171] (959s left) core_auth (basic-auth) [29.490457] Starting subtest: basic-auth [29.491149] Subtest basic-auth: SUCCESS (0.000s) [29.550403] [003/171] (959s left) debugfs_test (read_all_entries) [29.595819] Starting subtest: read_all_entries [29.638982] Subtest read_all_entries: SUCCESS (0.043s) [29.731433] [004/171] (959s left) debugfs_test (basic-hwmon) [29.773862] Starting subtest: basic-hwmon [29.775190] Subtest basic-hwmon: SKIP (0.000s) [29.864512] [005/171] (959s left) fbdev (eof) [29.921974] Starting subtest: eof [29.922765] Subtest eof: SUCCESS (0.000s) [29.964251] [006/171] (959s left) fbdev (info) [30.004662] Starting subtest: info [30.005424] Subtest info: SUCCESS (0.000s) [30.055470] [007/171] (959s left) fbdev (nullptr) [30.121920] Starting subtest: nullptr [30.122703] Subtest nullptr: SUCCESS (0.000s) [30.173893] [008/171] (959s left) fbdev (read) [30.238732] Starting subtest: read [30.817281] Subtest read: SUCCESS (0.578s) [30.848499] [009/171] (958s left) fbdev (write) [30.905960] Starting subtest: write [31.293401] Subtest write: SUCCESS (0.387s) [31.334068] [010/171] (958s left) gem_basic (bad-close) [31.380654] Starting subtest: bad-close [31.382427] Subtest bad-close: SUCCESS (0.000s) [31.438126] [011/171] (957s left) gem_basic (create-close) [31.488592] Starting subtest: create-close [31.490048] Subtest create-close: SUCCESS (0.000s) [31.581049] [012/171] (957s left) gem_basic (create-fd-close) [31.643714] Starting subtest: create-fd-close [31.645212] Subtest create-fd-close: SUCCESS (0.000s) [31.731803] [013/171] (957s left) gem_busy (busy@all-engines) [31.800503] Starting subtest: busy [31.801399] Starting dynamic subtest: all-engines [31.817045] Dynamic subtest all-engines: SUCCESS (0.017s) [31.817735] Subtest busy: SUCCESS (0.017s) [32.164500] [014/171] (957s left) gem_close_race (basic-process) [32.211179] Starting subtest: basic-process [32.242774] Subtest basic-process: SUCCESS (0.031s) [32.415360] [015/171] (956s left) gem_close_race (basic-threads) [32.481797] Starting subtest: basic-threads [33.678400] Subtest basic-threads: SUCCESS (1.196s) [33.881589] [016/171] (955s left) gem_ctx_create (basic) [33.948172] Starting subtest: basic [33.949189] Subtest basic: SUCCESS (0.000s) [34.134023] [017/171] (955s left) gem_ctx_create (basic-files) [34.199414] Starting subtest: basic-files [36.206600] Subtest basic-files: SUCCESS (2.007s) [36.399640] [018/171] (953s left) gem_ctx_exec (basic) [36.461703] Starting subtest: basic [36.463418] Subtest basic: SUCCESS (0.002s) [36.575191] [019/171] (952s left) gem_exec_basic (basic) [36.625922] Starting subtest: basic [36.626678] Starting dynamic subtest: rcs0-smem [36.627506] Dynamic subtest rcs0-smem: SUCCESS (0.001s) [36.630556] Starting dynamic subtest: bcs0-smem [36.631285] Dynamic subtest bcs0-smem: SUCCESS (0.000s) [36.634021] Starting dynamic subtest: vcs0-smem [36.634772] Dynamic subtest vcs0-smem: SUCCESS (0.000s) [36.637477] Starting dynamic subtest: vecs0-smem [36.638144] Dynamic subtest vecs0-smem: SUCCESS (0.000s) [36.638872] Subtest basic: SUCCESS (0.002s) [36.800657] [020/171] (952s left) gem_exec_create (basic) [36.854342] Starting subtest: basic [36.855135] Starting dynamic subtest: smem [38.901602] Dynamic subtest smem: SUCCESS (2.047s) [38.902648] Subtest basic: SUCCESS (2.047s) [39.083537] [021/171] (950s left) gem_exec_fence (basic-busy) [39.266713] Starting subtest: basic-busy [39.267445] Starting dynamic subtest: rcs0 [39.322546] Dynamic subtest rcs0: SUCCESS (0.055s) [39.336774] Starting dynamic subtest: bcs0 [39.357321] Dynamic subtest bcs0: SUCCESS (0.035s) [39.369702] Starting dynamic subtest: vcs0 [39.383528] Dynamic subtest vcs0: SUCCESS (0.026s) [39.394482] Starting dynamic subtest: vecs0 [39.414561] Dynamic subtest vecs0: SUCCESS (0.031s) [39.416685] Subtest basic-busy: SUCCESS (0.147s) [39.881722] [022/171] (949s left) gem_exec_fence (basic-wait) [40.067566] Starting subtest: basic-wait [40.069478] Starting dynamic subtest: rcs0 [40.118537] Dynamic subtest rcs0: SUCCESS (0.051s) [40.132893] Starting dynamic subtest: bcs0 [40.148633] Dynamic subtest bcs0: SUCCESS (0.030s) [40.162221] Starting dynamic subtest: vcs0 [40.176827] Dynamic subtest vcs0: SUCCESS (0.028s) [40.188556] Starting dynamic subtest: vecs0 [40.210764] Dynamic subtest vecs0: SUCCESS (0.034s) [40.213084] Subtest basic-wait: SUCCESS (0.143s) [40.666993] [023/171] (948s left) gem_exec_fence (basic-await) [40.846089] Starting subtest: basic-await [40.847904] Starting dynamic subtest: rcs0 [40.922310] Dynamic subtest rcs0: SUCCESS (0.076s) [40.934541] Starting dynamic subtest: bcs0 [41.001307] Dynamic subtest bcs0: SUCCESS (0.078s) [41.014529] Starting dynamic subtest: vcs0 [41.080594] Dynamic subtest vcs0: SUCCESS (0.079s) [41.093942] Starting dynamic subtest: vecs0 [41.160142] Dynamic subtest vecs0: SUCCESS (0.079s) [41.162419] Subtest basic-await: SUCCESS (0.314s) [41.617363] [024/171] (947s left) gem_exec_fence (nb-await) [41.811857] Starting subtest: nb-await [41.813410] Starting dynamic subtest: rcs0 [41.875062] Dynamic subtest rcs0: SUCCESS (0.062s) [41.879288] Starting dynamic subtest: bcs0 [41.932102] Dynamic subtest bcs0: SUCCESS (0.057s) [41.936326] Starting dynamic subtest: vcs0 [41.988569] Dynamic subtest vcs0: SUCCESS (0.056s) [41.995052] Starting dynamic subtest: vecs0 [42.047068] Dynamic subtest vecs0: SUCCESS (0.058s) [42.048833] Subtest nb-await: SUCCESS (0.235s) [42.498467] [025/171] (947s left) gem_exec_gttfill (basic) [42.563819] Starting subtest: basic [45.383410] Subtest basic: SUCCESS (2.819s) [45.552350] [026/171] (944s left) gem_exec_parallel (engines) [45.648050] Starting subtest: engines [45.648836] Starting dynamic subtest: basic [48.619217] Dynamic subtest basic: SUCCESS (2.971s) [48.623176] Starting dynamic subtest: contexts [50.922696] Dynamic subtest contexts: SUCCESS (2.303s) [50.926914] Starting dynamic subtest: fds [52.753063] Dynamic subtest fds: SUCCESS (1.829s) [52.770457] Starting dynamic subtest: userptr [54.573136] Dynamic subtest userptr: SUCCESS (1.821s) [54.573950] Subtest engines: SUCCESS (8.925s) [54.767868] [027/171] (934s left) gem_exec_store (basic) [54.821937] Starting subtest: basic [54.884920] Subtest basic: SUCCESS (0.061s) [55.068834] [028/171] (934s left) gem_flink_basic (bad-flink) [55.117379] Starting subtest: bad-flink [55.118121] Subtest bad-flink: SUCCESS (0.000s) [55.177607] [029/171] (934s left) gem_flink_basic (bad-open) [55.235915] Starting subtest: bad-open [55.236596] Subtest bad-open: SUCCESS (0.000s) [55.293562] [030/171] (934s left) gem_flink_basic (basic) [55.351402] Starting subtest: basic [55.352298] Subtest basic: SUCCESS (0.000s) [55.431966] [031/171] (934s left) gem_flink_basic (double-flink) [55.490850] Starting subtest: double-flink [55.491608] Subtest double-flink: SUCCESS (0.000s) [55.584191] [032/171] (934s left) gem_flink_basic (flink-lifetime) [55.642946] Starting subtest: flink-lifetime [55.643669] Subtest flink-lifetime: SUCCESS (0.001s) [55.730534] [033/171] (934s left) gem_huc_copy (huc-copy) [55.787819] Starting subtest: huc-copy [55.789455] Subtest huc-copy: SKIP (0.000s) [55.884178] [034/171] (933s left) gem_linear_blits (basic) [56.010966] Starting subtest: basic [56.014597] Subtest basic: SUCCESS (0.004s) [56.125098] [035/171] (933s left) gem_mmap (basic) [56.214352] Starting subtest: basic [56.217777] Subtest basic: SUCCESS (0.000s) [56.300019] [036/171] (933s left) gem_mmap_gtt (basic) [56.349646] Starting subtest: basic [56.350489] Subtest basic: SUCCESS (0.000s) [56.399636] [037/171] (933s left) gem_render_linear_blits (basic) [56.458945] Starting subtest: basic [56.484320] Subtest basic: SUCCESS (0.025s) [56.534433] [038/171] (933s left) gem_render_tiled_blits (basic) [56.587809] Starting subtest: basic [56.607048] Subtest basic: SUCCESS (0.019s) [56.643872] [039/171] (933s left) gem_ringfill (basic-all) [56.850562] Starting subtest: basic-all [57.958107] Subtest basic-all: SUCCESS (1.110s) [58.064513] [040/171] (931s left) gem_softpin (allocator-basic) [58.122556] Starting subtest: allocator-basic [58.183767] Subtest allocator-basic: SUCCESS (0.061s) [58.280350] [041/171] (931s left) gem_softpin (allocator-basic-reserve) [58.329983] Starting subtest: allocator-basic-reserve [58.390993] Subtest allocator-basic-reserve: SUCCESS (0.061s) [58.483302] [042/171] (931s left) gem_softpin (safe-alignment) [58.541046] Starting subtest: safe-alignment [58.547235] Subtest safe-alignment: SUCCESS (0.006s) [58.651771] [043/171] (931s left) gem_sync (basic-all) [58.716938] Starting subtest: basic-all [60.763145] Subtest basic-all: SUCCESS (2.047s) [60.938432] [044/171] (929s left) gem_sync (basic-each) [60.993935] Starting subtest: basic-each [63.062194] Subtest basic-each: SUCCESS (2.070s) [63.265410] [045/171] (926s left) gem_tiled_blits (basic) [63.364691] Starting subtest: basic [63.375466] Subtest basic: SUCCESS (0.011s) [63.492255] [046/171] (926s left) gem_tiled_fence_blits (basic) [63.629142] Starting subtest: basic [63.650207] Subtest basic: SUCCESS (0.021s) [63.757720] [047/171] (926s left) gem_tiled_pread_basic [63.882149] [048/171] (926s left) gem_wait (busy@all-engines) [63.942493] Starting subtest: busy [63.943228] Starting dynamic subtest: all-engines [64.456049] Dynamic subtest all-engines: SUCCESS (0.513s) [64.456840] Subtest busy: SUCCESS (0.514s) [64.666008] [049/171] (925s left) gem_wait (wait@all-engines) [64.716786] Starting subtest: wait [64.717530] Starting dynamic subtest: all-engines [65.758289] Dynamic subtest all-engines: SUCCESS (1.040s) [65.759992] Subtest wait: SUCCESS (1.041s) [65.965304] [050/171] (924s left) i915_getparams_basic (basic-eu-total) [66.011171] Starting subtest: basic-eu-total [66.012670] Subtest basic-eu-total: SUCCESS (0.000s) [66.087504] [051/171] (923s left) i915_getparams_basic (basic-subslice-total) [66.135905] Starting subtest: basic-subslice-total [66.137447] Subtest basic-subslice-total: SUCCESS (0.000s) [66.192098] [052/171] (923s left) i915_hangman (error-state-basic) [66.252657] Starting subtest: error-state-basic [66.257177] Subtest error-state-basic: SUCCESS (0.004s) [66.352859] [053/171] (923s left) i915_pciid [66.481380] [054/171] (923s left) kms_addfb_basic (addfb25-bad-modifier) [66.576126] Starting subtest: addfb25-bad-modifier [66.576819] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [66.731986] [055/171] (923s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [66.806530] Starting subtest: addfb25-framebuffer-vs-set-tiling [66.807388] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [66.949183] [056/171] (923s left) kms_addfb_basic (addfb25-modifier-no-flag) [67.025163] Starting subtest: addfb25-modifier-no-flag [67.025909] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [67.181804] [057/171] (922s left) kms_addfb_basic (addfb25-x-tiled-legacy) [67.257566] Starting subtest: addfb25-x-tiled-legacy [67.258318] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [67.398981] [058/171] (922s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [67.474938] Starting subtest: addfb25-x-tiled-mismatch-legacy [67.475628] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [67.615203] [059/171] (922s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [67.723713] Starting subtest: addfb25-yf-tiled-legacy [67.724503] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [67.832263] [060/171] (922s left) kms_addfb_basic (addfb25-y-tiled-legacy) [67.941152] Starting subtest: addfb25-y-tiled-legacy [67.941893] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [68.048688] [061/171] (922s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [68.157212] Starting subtest: addfb25-y-tiled-small-legacy [68.157970] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [68.265202] [062/171] (921s left) kms_addfb_basic (bad-pitch-0) [68.305296] Starting subtest: bad-pitch-0 [68.306167] Subtest bad-pitch-0: SUCCESS (0.000s) [68.482495] [063/171] (921s left) kms_addfb_basic (bad-pitch-1024) [68.522119] Starting subtest: bad-pitch-1024 [68.522829] Subtest bad-pitch-1024: SUCCESS (0.000s) [68.682120] [064/171] (921s left) kms_addfb_basic (bad-pitch-128) [68.722454] Starting subtest: bad-pitch-128 [68.723146] Subtest bad-pitch-128: SUCCESS (0.000s) [68.898624] [065/171] (921s left) kms_addfb_basic (bad-pitch-256) [68.938388] Starting subtest: bad-pitch-256 [68.939129] Subtest bad-pitch-256: SUCCESS (0.000s) [69.115406] [066/171] (921s left) kms_addfb_basic (bad-pitch-32) [69.156019] Starting subtest: bad-pitch-32 [69.156758] Subtest bad-pitch-32: SUCCESS (0.000s) [69.315593] [067/171] (920s left) kms_addfb_basic (bad-pitch-63) [69.355607] Starting subtest: bad-pitch-63 [69.356446] Subtest bad-pitch-63: SUCCESS (0.000s) [69.531885] [068/171] (920s left) kms_addfb_basic (bad-pitch-65536) [69.571603] Starting subtest: bad-pitch-65536 [69.572301] Subtest bad-pitch-65536: SUCCESS (0.000s) [69.748399] [069/171] (920s left) kms_addfb_basic (bad-pitch-999) [69.788183] Starting subtest: bad-pitch-999 [69.788881] Subtest bad-pitch-999: SUCCESS (0.000s) [69.964998] [070/171] (920s left) kms_addfb_basic (basic) [70.004885] Starting subtest: basic [70.005572] Subtest basic: SUCCESS (0.000s) [70.181784] [071/171] (920s left) kms_addfb_basic (basic-x-tiled-legacy) [70.326885] Starting subtest: basic-x-tiled-legacy [70.327593] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [70.398607] [072/171] (919s left) kms_addfb_basic (basic-y-tiled-legacy) [70.539055] Starting subtest: basic-y-tiled-legacy [70.539888] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [70.598645] [073/171] (919s left) kms_addfb_basic (bo-too-small) [70.673068] Starting subtest: bo-too-small [70.673824] Subtest bo-too-small: SUCCESS (0.000s) [70.815293] [074/171] (919s left) kms_addfb_basic (bo-too-small-due-to-tiling) [70.890585] Starting subtest: bo-too-small-due-to-tiling [70.891363] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [71.032238] [075/171] (919s left) kms_addfb_basic (clobberred-modifier) [71.072124] Starting subtest: clobberred-modifier [71.072862] Subtest clobberred-modifier: SUCCESS (0.000s) [71.248865] [076/171] (919s left) kms_addfb_basic (framebuffer-vs-set-tiling) [71.391412] Starting subtest: framebuffer-vs-set-tiling [71.392211] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [71.448775] [077/171] (918s left) kms_addfb_basic (invalid-get-prop) [71.590928] Starting subtest: invalid-get-prop [71.591614] Subtest invalid-get-prop: SUCCESS (0.000s) [71.665283] [078/171] (918s left) kms_addfb_basic (invalid-get-prop-any) [71.805998] Starting subtest: invalid-get-prop-any [71.806786] Subtest invalid-get-prop-any: SUCCESS (0.000s) [71.882279] [079/171] (918s left) kms_addfb_basic (invalid-set-prop) [72.024276] Starting subtest: invalid-set-prop [72.024958] Subtest invalid-set-prop: SUCCESS (0.000s) [72.115130] [080/171] (918s left) kms_addfb_basic (invalid-set-prop-any) [72.256985] Starting subtest: invalid-set-prop-any [72.257678] Subtest invalid-set-prop-any: SUCCESS (0.000s) [72.315211] [081/171] (918s left) kms_addfb_basic (no-handle) [72.355207] Starting subtest: no-handle [72.355920] Subtest no-handle: SUCCESS (0.000s) [72.531811] [082/171] (917s left) kms_addfb_basic (size-max) [72.608222] Starting subtest: size-max [72.608999] Subtest size-max: SUCCESS (0.000s) [72.732537] [083/171] (917s left) kms_addfb_basic (small-bo) [72.809253] Starting subtest: small-bo [72.810014] Subtest small-bo: SUCCESS (0.000s) [72.932290] [084/171] (917s left) kms_addfb_basic (tile-pitch-mismatch) [73.074250] Starting subtest: tile-pitch-mismatch [73.074927] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [73.148996] [085/171] (917s left) kms_addfb_basic (too-high) [73.223404] Starting subtest: too-high [73.224107] Subtest too-high: SUCCESS (0.000s) [73.382290] [086/171] (917s left) kms_addfb_basic (too-wide) [73.457221] Starting subtest: too-wide [73.457923] Subtest too-wide: SUCCESS (0.000s) [73.582160] [087/171] (916s left) kms_addfb_basic (unused-handle) [73.622524] Starting subtest: unused-handle [73.623317] Subtest unused-handle: SUCCESS (0.000s) [73.798214] [088/171] (916s left) kms_addfb_basic (unused-modifier) [73.839028] Starting subtest: unused-modifier [73.839768] Subtest unused-modifier: SUCCESS (0.000s) [74.015637] [089/171] (916s left) kms_addfb_basic (unused-offsets) [74.055844] Starting subtest: unused-offsets [74.056593] Subtest unused-offsets: SUCCESS (0.000s) [74.232278] [090/171] (916s left) kms_addfb_basic (unused-pitches) [74.272497] Starting subtest: unused-pitches [74.273325] Subtest unused-pitches: SUCCESS (0.000s) [74.448892] [091/171] (916s left) kms_busy (basic) [74.528525] Starting subtest: basic [74.529450] Starting dynamic subtest: flip [75.093113] Dynamic subtest flip: SUCCESS (0.565s) [75.096889] Starting dynamic subtest: modeset [75.633890] Dynamic subtest modeset: SUCCESS (0.540s) [75.634622] Subtest basic: SUCCESS (1.105s) [75.782697] [092/171] (914s left) kms_chamelium_hpd (dp-hpd-fast) [75.926687] Subtest dp-hpd-fast: SKIP (0.000s) [75.989346] [093/171] (914s left) kms_chamelium_edid (dp-edid-read) [76.136921] Subtest dp-edid-read: SKIP (0.000s) [76.198574] [094/171] (914s left) kms_chamelium_frames (dp-crc-fast) [76.347380] Subtest dp-crc-fast: SKIP (0.000s) [76.408184] [095/171] (914s left) kms_chamelium_hpd (hdmi-hpd-fast) [76.556762] Subtest hdmi-hpd-fast: SKIP (0.000s) [76.618522] [096/171] (913s left) kms_chamelium_edid (hdmi-edid-read) [76.765660] Subtest hdmi-edid-read: SKIP (0.000s) [76.827604] [097/171] (913s left) kms_chamelium_frames (hdmi-crc-fast) [76.975128] Subtest hdmi-crc-fast: SKIP (0.000s) [77.037388] [098/171] (913s left) kms_chamelium_hpd (vga-hpd-fast) [77.184553] Subtest vga-hpd-fast: SKIP (0.000s) [77.246118] [099/171] (913s left) kms_chamelium_edid (vga-edid-read) [77.395846] Subtest vga-edid-read: SKIP (0.000s) [77.457563] [100/171] (913s left) kms_prop_blob (basic) [77.498728] Starting subtest: basic [77.499591] Subtest basic: SUCCESS (0.000s) [77.543207] [101/171] (913s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [77.617860] Starting subtest: basic-busy-flip-before-cursor-atomic [77.619437] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [77.676759] [102/171] (912s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [77.752577] Starting subtest: basic-busy-flip-before-cursor-legacy [77.754203] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [77.809665] [103/171] (912s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [77.884724] Starting subtest: basic-flip-after-cursor-atomic [78.836778] Subtest basic-flip-after-cursor-atomic: SUCCESS (0.953s) [78.986940] [104/171] (911s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [79.062360] Starting subtest: basic-flip-after-cursor-legacy [80.016856] Subtest basic-flip-after-cursor-legacy: SUCCESS (0.955s) [80.136344] [105/171] (910s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [80.211235] Starting subtest: basic-flip-after-cursor-varying-size [81.178834] Subtest basic-flip-after-cursor-varying-size: SUCCESS (0.968s) [81.301356] [106/171] (909s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [81.376523] Starting subtest: basic-flip-before-cursor-atomic [82.344722] Subtest basic-flip-before-cursor-atomic: SUCCESS (0.969s) [82.469695] [107/171] (908s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [82.546577] Starting subtest: basic-flip-before-cursor-legacy [83.498035] Subtest basic-flip-before-cursor-legacy: SUCCESS (0.952s) [83.624768] [108/171] (907s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [83.700761] Starting subtest: basic-flip-before-cursor-varying-size [84.650889] Subtest basic-flip-before-cursor-varying-size: SUCCESS (0.951s) [84.764007] [109/171] (905s left) kms_flip (basic-flip-vs-dpms) [84.833779] Starting subtest: basic-flip-vs-dpms [84.834548] Starting dynamic subtest: A-HDMI-A1 [85.770094] Dynamic subtest A-HDMI-A1: SUCCESS (0.935s) [85.773994] Starting dynamic subtest: B-HDMI-A1 [86.545731] Dynamic subtest B-HDMI-A1: SUCCESS (0.775s) [86.549471] Starting dynamic subtest: C-HDMI-A1 [87.411057] Dynamic subtest C-HDMI-A1: SUCCESS (0.865s) [87.411843] Subtest basic-flip-vs-dpms: SUCCESS (2.578s) [87.540874] [110/171] (903s left) kms_flip (basic-flip-vs-modeset) [87.610595] Starting subtest: basic-flip-vs-modeset [87.612959] Starting dynamic subtest: A-HDMI-A1 [88.571157] Dynamic subtest A-HDMI-A1: SUCCESS (0.959s) [88.574963] Starting dynamic subtest: B-HDMI-A1 [89.352539] Dynamic subtest B-HDMI-A1: SUCCESS (0.781s) [89.356392] Starting dynamic subtest: C-HDMI-A1 [90.227247] Dynamic subtest C-HDMI-A1: SUCCESS (0.874s) [90.228022] Subtest basic-flip-vs-modeset: SUCCESS (2.618s) [90.345040] [111/171] (900s left) kms_flip (basic-flip-vs-wf_vblank) [90.415555] Starting subtest: basic-flip-vs-wf_vblank [90.417880] Starting dynamic subtest: A-HDMI-A1 [91.589443] Dynamic subtest A-HDMI-A1: SUCCESS (1.173s) [91.593646] Starting dynamic subtest: B-HDMI-A1 [92.709701] Dynamic subtest B-HDMI-A1: SUCCESS (1.120s) [92.713978] Starting dynamic subtest: C-HDMI-A1 [93.829803] Dynamic subtest C-HDMI-A1: SUCCESS (1.120s) [93.830583] Subtest basic-flip-vs-wf_vblank: SUCCESS (3.415s) [93.993474] [112/171] (896s left) kms_flip (basic-plain-flip) [94.063048] Starting subtest: basic-plain-flip [94.063753] Starting dynamic subtest: A-HDMI-A1 [94.955936] Dynamic subtest A-HDMI-A1: SUCCESS (0.891s) [94.962501] Starting dynamic subtest: B-HDMI-A1 [95.809398] Dynamic subtest B-HDMI-A1: SUCCESS (0.852s) [95.815483] Starting dynamic subtest: C-HDMI-A1 [96.662182] Dynamic subtest C-HDMI-A1: SUCCESS (0.852s) [96.663172] Subtest basic-plain-flip: SUCCESS (2.601s) [96.825278] [113/171] (893s left) kms_force_connector_basic (force-connector-state) [96.951408] Starting subtest: force-connector-state [97.252579] Subtest force-connector-state: SUCCESS (0.302s) [97.500129] [114/171] (893s left) kms_force_connector_basic (force-edid) [97.624500] Starting subtest: force-edid [97.763340] Subtest force-edid: SUCCESS (0.139s) [97.933367] [115/171] (892s left) kms_force_connector_basic (force-load-detect) [98.056746] Starting subtest: force-load-detect [98.058110] Subtest force-load-detect: SKIP (0.000s) [98.216014] [116/171] (892s left) kms_force_connector_basic (prune-stale-modes) [98.341510] Starting subtest: prune-stale-modes [98.478918] Subtest prune-stale-modes: SUCCESS (0.138s) [98.649753] [117/171] (892s left) kms_frontbuffer_tracking (basic) [98.728832] Starting subtest: basic [101.572782] Subtest basic: SUCCESS (2.846s) [101.685594] [118/171] (889s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [101.771663] Starting subtest: compare-crc-sanitycheck [101.772457] Starting dynamic subtest: pipe-A-HDMI-A-1 [102.209548] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.439s) [102.213398] Starting dynamic subtest: pipe-B-HDMI-A-1 [102.553690] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.344s) [102.557610] Starting dynamic subtest: pipe-C-HDMI-A-1 [102.918574] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.365s) [102.919351] Subtest compare-crc-sanitycheck: SUCCESS (1.148s) [103.040815] [119/171] (887s left) kms_pipe_crc_basic (hang-read-crc) [103.116736] Starting subtest: hang-read-crc [103.117536] Starting dynamic subtest: pipe-A-HDMI-A-1 [104.135554] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (1.020s) [104.139381] Starting dynamic subtest: pipe-B-HDMI-A-1 [105.032577] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.897s) [105.036714] Starting dynamic subtest: pipe-C-HDMI-A-1 [105.933704] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.901s) [105.934507] Subtest hang-read-crc: SUCCESS (2.818s) [106.027065] [120/171] (884s left) kms_pipe_crc_basic (nonblocking-crc) [106.102616] Starting subtest: nonblocking-crc [106.103399] Starting dynamic subtest: pipe-A-HDMI-A-1 [106.686405] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.585s) [106.690236] Starting dynamic subtest: pipe-B-HDMI-A-1 [107.195441] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.509s) [107.199381] Starting dynamic subtest: pipe-C-HDMI-A-1 [107.709546] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.514s) [107.710340] Subtest nonblocking-crc: SUCCESS (1.608s) [107.837753] [121/171] (882s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [107.913858] Starting subtest: nonblocking-crc-frame-sequence [107.914643] Starting dynamic subtest: pipe-A-HDMI-A-1 [108.497435] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.585s) [108.501293] Starting dynamic subtest: pipe-B-HDMI-A-1 [109.006444] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.509s) [109.010333] Starting dynamic subtest: pipe-C-HDMI-A-1 [109.519045] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.512s) [109.519799] Subtest nonblocking-crc-frame-sequence: SUCCESS (1.607s) [109.622388] [122/171] (881s left) kms_pipe_crc_basic (read-crc) [109.697351] Starting subtest: read-crc [109.698126] Starting dynamic subtest: pipe-A-HDMI-A-1 [110.206436] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.509s) [110.210365] Starting dynamic subtest: pipe-B-HDMI-A-1 [110.649422] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.443s) [110.653215] Starting dynamic subtest: pipe-C-HDMI-A-1 [111.094505] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.445s) [111.095286] Subtest read-crc: SUCCESS (1.398s) [111.188165] [123/171] (879s left) kms_pipe_crc_basic (read-crc-frame-sequence) [111.263609] Starting subtest: read-crc-frame-sequence [111.264411] Starting dynamic subtest: pipe-A-HDMI-A-1 [111.782331] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (0.520s) [111.786102] Starting dynamic subtest: pipe-B-HDMI-A-1 [112.227052] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (0.444s) [112.230926] Starting dynamic subtest: pipe-C-HDMI-A-1 [112.672534] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (0.446s) [112.673222] Subtest read-crc-frame-sequence: SUCCESS (1.410s) [112.767642] [124/171] (878s left) kms_psr (primary_page_flip) [112.820544] Subtest primary_page_flip: SKIP (0.000s) [112.829324] [125/171] (877s left) kms_psr (cursor_plane_move) [112.870656] Subtest cursor_plane_move: SKIP (0.000s) [112.898093] [126/171] (877s left) kms_psr (sprite_plane_onoff) [112.953616] Subtest sprite_plane_onoff: SKIP (0.000s) [112.980292] [127/171] (877s left) kms_psr (primary_mmap_gtt) [113.027157] Subtest primary_mmap_gtt: SKIP (0.000s) [113.045341] [128/171] (877s left) kms_setmode (basic-clone-single-crtc) [113.095564] Starting subtest: basic-clone-single-crtc [113.097551] Subtest basic-clone-single-crtc: SKIP (0.000s) [113.168178] [129/171] (877s left) i915_pm_backlight (basic-brightness) [113.260152] Subtest basic-brightness: SKIP (0.000s) [113.279325] [130/171] (877s left) i915_pm_rpm (basic-pci-d3-state) [114.781241] Starting subtest: basic-pci-d3-state [115.128807] Subtest basic-pci-d3-state: SUCCESS (0.348s) [115.455364] [131/171] (875s left) i915_pm_rpm (basic-rte) [115.510124] Starting subtest: basic-rte [117.373908] Subtest basic-rte: SUCCESS (1.863s) [118.059613] [132/171] (872s left) i915_pm_rps (basic-api) [118.102364] Starting subtest: basic-api [118.104033] Subtest basic-api: SUCCESS (0.002s) [118.171595] [133/171] (872s left) prime_self_import (basic-llseek-bad) [118.218474] Starting subtest: basic-llseek-bad [118.219258] Subtest basic-llseek-bad: SUCCESS (0.001s) [118.314372] [134/171] (872s left) prime_self_import (basic-llseek-size) [118.367829] Starting subtest: basic-llseek-size [118.369595] Subtest basic-llseek-size: SUCCESS (0.001s) [118.463446] [135/171] (872s left) prime_self_import (basic-with_fd_dup) [118.517061] Starting subtest: basic-with_fd_dup [118.519094] Subtest basic-with_fd_dup: SUCCESS (0.001s) [118.608381] [136/171] (872s left) prime_self_import (basic-with_one_bo) [118.664104] Starting subtest: basic-with_one_bo [118.665904] Subtest basic-with_one_bo: SUCCESS (0.002s) [118.729657] [137/171] (872s left) prime_self_import (basic-with_one_bo_two_files) [118.784509] Starting subtest: basic-with_one_bo_two_files [118.785278] Subtest basic-with_one_bo_two_files: SUCCESS (0.001s) [118.879857] [138/171] (872s left) prime_self_import (basic-with_two_bos) [118.934487] Starting subtest: basic-with_two_bos [118.936282] Subtest basic-with_two_bos: SUCCESS (0.001s) [119.031554] [139/171] (872s left) prime_vgem (basic-fence-flip) [119.101988] Starting subtest: basic-fence-flip [119.483266] Subtest basic-fence-flip: SUCCESS (0.380s) [119.591828] [140/171] (871s left) prime_vgem (basic-fence-mmap) [119.660188] Starting subtest: basic-fence-mmap [119.676488] Subtest basic-fence-mmap: SUCCESS (0.016s) [119.781853] [141/171] (871s left) prime_vgem (basic-fence-read) [119.834879] Starting subtest: basic-fence-read [119.839394] Subtest basic-fence-read: SKIP (0.004s) [119.948449] [142/171] (871s left) prime_vgem (basic-gtt) [120.025695] Starting subtest: basic-gtt [120.033716] Subtest basic-gtt: SUCCESS (0.008s) [120.130670] [143/171] (870s left) prime_vgem (basic-read) [120.217094] Starting subtest: basic-read [120.223209] Subtest basic-read: SKIP (0.006s) [120.332308] [144/171] (870s left) prime_vgem (basic-write) [120.384812] Starting subtest: basic-write [120.389280] Subtest basic-write: SKIP (0.004s) [120.477544] [145/171] (870s left) prime_vgem (basic-userptr) [120.553591] Starting subtest: basic-userptr [120.559561] Subtest basic-userptr: SKIP (0.006s) [120.662078] [146/171] (870s left) vgem_basic (setversion) [120.732959] Starting subtest: setversion [120.734845] Subtest setversion: SUCCESS (0.000s) [120.795211] [147/171] (870s left) vgem_basic (create) [120.865911] Starting subtest: create [120.866800] Subtest create: SUCCESS (0.000s) [120.927804] [148/171] (870s left) vgem_basic (debugfs) [120.982501] Starting subtest: debugfs [120.983327] Subtest debugfs: SUCCESS (0.000s) [121.041520] [149/171] (870s left) vgem_basic (dmabuf-export) [121.099218] Starting subtest: dmabuf-export [121.111660] Subtest dmabuf-export: SUCCESS (0.011s) [121.197696] [150/171] (870s left) vgem_basic (dmabuf-fence) [121.249069] Starting subtest: dmabuf-fence [121.249843] Subtest dmabuf-fence: SUCCESS (0.000s) [121.307397] [151/171] (869s left) vgem_basic (dmabuf-fence-before) [121.365518] Starting subtest: dmabuf-fence-before [121.366344] Subtest dmabuf-fence-before: SUCCESS (0.000s) [121.420250] [152/171] (869s left) vgem_basic (dmabuf-mmap) [121.482631] Starting subtest: dmabuf-mmap [121.490970] Subtest dmabuf-mmap: SUCCESS (0.009s) [121.532439] [153/171] (869s left) vgem_basic (mmap) [121.582243] Starting subtest: mmap [121.587760] Subtest mmap: SUCCESS (0.006s) [121.633603] [154/171] (869s left) vgem_basic (second-client) [121.698937] Starting subtest: second-client [121.750790] Subtest second-client: SUCCESS (0.051s) [121.814935] [155/171] (869s left) vgem_basic (sysfs) [121.882293] Starting subtest: sysfs [121.883181] Subtest sysfs: SUCCESS (0.000s) [121.945056] [156/171] (869s left) core_hotunplug (unbind-rebind) [122.015784] Starting subtest: unbind-rebind [122.884907] Subtest unbind-rebind: SUCCESS (0.869s) [122.895236] [157/171] (868s left) vgem_basic (unload) [122.937779] Starting subtest: unload [151.706611] Subtest unload: SUCCESS (28.767s) [151.811252] [158/171] (839s left) i915_module_load (reload) [151.864283] Starting subtest: reload [153.154328] Subtest reload: SUCCESS (1.291s) [153.163036] [159/171] (838s left) gem_lmem_swapping (basic) [153.230285] Subtest basic: SKIP (0.000s) [153.243293] [160/171] (838s left) gem_lmem_swapping (parallel-random-engines) [153.288792] Subtest parallel-random-engines: SKIP (0.000s) [153.309964] [161/171] (838s left) gem_lmem_swapping (random-engines) [153.353856] Subtest random-engines: SKIP (0.000s) [153.376996] [162/171] (838s left) gem_lmem_swapping (verify-random) [153.421657] Subtest verify-random: SKIP (0.000s) [153.443441] [163/171] (837s left) i915_pm_rpm (module-reload) [155.288890] Starting subtest: module-reload [161.937465] Subtest module-reload: SUCCESS (6.648s) [161.954393] [164/171] (829s left) i915_selftest (live) [162.015932] Starting subtest: live [162.016775] Starting dynamic subtest: sanitycheck [162.411738] Dynamic subtest sanitycheck: SUCCESS (0.387s) [162.414986] Starting dynamic subtest: uncore [162.814383] Dynamic subtest uncore: SUCCESS (0.402s) [162.817525] Starting dynamic subtest: workarounds [163.414080] Dynamic subtest workarounds: SUCCESS (0.603s) [163.417271] Starting dynamic subtest: gt_engines [164.274703] Dynamic subtest gt_engines: SUCCESS (0.866s) [164.277896] Starting dynamic subtest: gt_timelines [169.857853] Dynamic subtest gt_timelines: SUCCESS (5.583s) [169.860986] Starting dynamic subtest: gt_contexts [170.334724] Dynamic subtest gt_contexts: SUCCESS (0.476s) [170.338060] Starting dynamic subtest: gt_lrc [173.098819] Dynamic subtest gt_lrc: SUCCESS (2.764s) [173.101923] Starting dynamic subtest: gt_mocs [173.579804] Dynamic subtest gt_mocs: SUCCESS (0.481s) [173.583516] Starting dynamic subtest: gt_pm [185.244758] Dynamic subtest gt_pm: SUCCESS (11.665s) [185.247942] Starting dynamic subtest: gt_heartbeat [185.769757] Dynamic subtest gt_heartbeat: SUCCESS (0.525s) [185.772909] Starting dynamic subtest: requests [192.326736] Dynamic subtest requests: SUCCESS (6.557s) [192.330379] Starting dynamic subtest: migrate [195.549836] Dynamic subtest migrate: SUCCESS (3.223s) [195.552958] Starting dynamic subtest: active [195.949028] Dynamic subtest active: SUCCESS (0.399s) [195.952386] Starting dynamic subtest: objects [196.982627] Dynamic subtest objects: SUCCESS (1.033s) [196.985711] Starting dynamic subtest: mman [200.954698] Dynamic subtest mman: SUCCESS (3.972s) [200.957821] Starting dynamic subtest: dmabuf [201.419849] Dynamic subtest dmabuf: SUCCESS (0.465s) [201.422992] Starting dynamic subtest: vma [201.862786] Dynamic subtest vma: SUCCESS (0.443s) [201.866009] Starting dynamic subtest: coherency [203.001661] Dynamic subtest coherency: SUCCESS (1.139s) [203.004830] Starting dynamic subtest: gtt [212.948646] Dynamic subtest gtt: SUCCESS (9.947s) [212.951796] Starting dynamic subtest: gem [213.455613] Dynamic subtest gem: SUCCESS (0.507s) [213.458788] Starting dynamic subtest: evict [214.466628] Dynamic subtest evict: SUCCESS (1.011s) [214.469782] Starting dynamic subtest: hugepages [220.505825] Dynamic subtest hugepages: SUCCESS (6.039s) [220.509097] Starting dynamic subtest: gem_contexts [231.993678] Dynamic subtest gem_contexts: SUCCESS (11.488s) [231.996832] Starting dynamic subtest: client [232.400672] Dynamic subtest client: SUCCESS (0.407s) [232.403938] Starting dynamic subtest: gem_migrate [232.809680] Dynamic subtest gem_migrate: SUCCESS (0.409s) [232.813109] Starting dynamic subtest: reset [236.468703] Dynamic subtest reset: SUCCESS (3.659s) [236.471953] Starting dynamic subtest: memory_region [236.885239] Dynamic subtest memory_region: SUCCESS (0.408s) [236.888617] Starting dynamic subtest: hangcheck [260.394791] Dynamic subtest hangcheck: SUCCESS (23.518s) [260.398754] Starting dynamic subtest: execlists [268.470716] Dynamic subtest execlists: SUCCESS (8.076s) [268.473976] Starting dynamic subtest: ring_submission [268.872735] Dynamic subtest ring_submission: SUCCESS (0.402s) [268.875985] Starting dynamic subtest: perf [269.322774] Dynamic subtest perf: SUCCESS (0.450s) [269.326181] Starting dynamic subtest: slpc [269.712773] Dynamic subtest slpc: SUCCESS (0.390s) [269.716026] Starting dynamic subtest: guc [270.108769] Dynamic subtest guc: SUCCESS (0.396s) [270.112020] Starting dynamic subtest: guc_multi_lrc [270.493777] Dynamic subtest guc_multi_lrc: SUCCESS (0.385s) [270.497156] Starting dynamic subtest: guc_hang [270.868852] Dynamic subtest guc_hang: SUCCESS (0.375s) [270.872130] Starting dynamic subtest: late_gt_pm [271.322781] Dynamic subtest late_gt_pm: SUCCESS (0.454s) [271.323577] Subtest live: SUCCESS (109.307s) [271.401059] [165/171] (720s left) dmabuf (all-tests) [271.452264] Starting subtest: all-tests [271.453225] Starting dynamic subtest: sanitycheck [271.471108] Dynamic subtest sanitycheck: SUCCESS (0.019s) [271.475129] Starting dynamic subtest: dma_fence [271.601020] Dynamic subtest dma_fence: SUCCESS (0.130s) [271.604448] Starting dynamic subtest: dma_fence_chain [282.669201] Dynamic subtest dma_fence_chain: SUCCESS (11.068s) [282.672952] Starting dynamic subtest: dma_fence_unwrap [282.703363] Dynamic subtest dma_fence_unwrap: SUCCESS (0.033s) [282.709899] Starting dynamic subtest: dma_resv [282.740068] Dynamic subtest dma_resv: SUCCESS (0.035s) [282.742287] Subtest all-tests: SUCCESS (11.287s) [282.770074] [166/171] (708s left) i915_suspend (basic-s2idle-without-i915) [282.820040] Starting subtest: basic-s2idle-without-i915 [299.336559] Subtest basic-s2idle-without-i915: SUCCESS (3.649s) [306.452932] [167/171] (704s left) i915_suspend (basic-s3-without-i915) [306.501531] Starting subtest: basic-s3-without-i915 [327.524554] Subtest basic-s3-without-i915: SUCCESS (15.500s) [332.637975] [168/171] (689s left) gem_exec_suspend (basic-s0) [332.698687] Starting subtest: basic-S0 [332.699386] Starting dynamic subtest: smem [350.619637] Dynamic subtest smem: SUCCESS (4.485s) [350.620398] Subtest basic-S0: SUCCESS (4.486s) [360.788830] [169/171] (684s left) gem_exec_suspend (basic-s3) [360.841263] Starting subtest: basic-S3 [360.841952] Starting dynamic subtest: smem [381.673572] Dynamic subtest smem: SUCCESS (12.442s) [381.674336] Subtest basic-S3: SUCCESS (12.442s) [386.367691] [170/171] (671s left) kms_chamelium_hpd (common-hpd-after-suspend) [386.513061] Subtest common-hpd-after-suspend: SKIP (0.000s) [386.575100] [171/171] (671s left) kms_pipe_crc_basic (suspend-read-crc) [386.649118] Starting subtest: suspend-read-crc [386.649782] Starting dynamic subtest: pipe-A-HDMI-A-1 [413.746577] Dynamic subtest pipe-A-HDMI-A-1: SUCCESS (6.005s) [413.751530] Starting dynamic subtest: pipe-B-HDMI-A-1 [435.735047] Dynamic subtest pipe-B-HDMI-A-1: SUCCESS (6.470s) [435.740958] Starting dynamic subtest: pipe-C-HDMI-A-1 [462.843979] Dynamic subtest pipe-C-HDMI-A-1: SUCCESS (6.588s) [462.844788] Subtest suspend-read-crc: SUCCESS (19.065s) [467.912226] Closing watchdogs Done.