[47.108721] Initializing watchdogs [47.108890] /dev/watchdog0 [47.119104] [001/171] (960s left) i915_module_load (load) [47.245361] Starting subtest: load [49.644517] Subtest load: SUCCESS (2.399s) [49.669211] [002/171] (957s left) core_auth (basic-auth) [49.787932] Starting subtest: basic-auth [49.789267] Subtest basic-auth: SUCCESS (0.001s) [49.858537] [003/171] (957s left) debugfs_test (read_all_entries) [49.982645] Starting subtest: read_all_entries [50.063879] Subtest read_all_entries: SUCCESS (0.080s) [50.157150] [004/171] (957s left) debugfs_test (basic-hwmon) [50.275897] Starting subtest: basic-hwmon [50.278049] Subtest basic-hwmon: SKIP (0.000s) [50.373459] [005/171] (957s left) fbdev (eof) [50.512231] Starting subtest: eof [50.513805] Subtest eof: SUCCESS (0.000s) [50.576769] [006/171] (957s left) fbdev (info) [50.705144] Starting subtest: info [50.706592] Subtest info: SUCCESS (0.000s) [50.776759] [007/171] (956s left) fbdev (nullptr) [50.929797] Starting subtest: nullptr [50.931454] Subtest nullptr: SUCCESS (0.000s) [50.993311] [008/171] (956s left) fbdev (read) [51.112461] Starting subtest: read [58.228263] Subtest read: SUCCESS (7.081s) [58.258624] [009/171] (949s left) fbdev (write) [58.379655] Starting subtest: write [62.139286] Subtest write: SUCCESS (3.726s) [62.174695] [010/171] (945s left) gem_basic (bad-close) [62.289649] Starting subtest: bad-close [62.291736] Subtest bad-close: SUCCESS (0.000s) [62.357974] [011/171] (945s left) gem_basic (create-close) [62.470590] Starting subtest: create-close [62.472618] Subtest create-close: SUCCESS (0.000s) [62.574304] [012/171] (945s left) gem_basic (create-fd-close) [62.688511] Starting subtest: create-fd-close [62.690691] Subtest create-fd-close: SUCCESS (0.000s) [62.792445] [013/171] (945s left) gem_busy (busy@all-engines) [62.921976] Starting subtest: busy [62.923158] Starting dynamic subtest: all-engines [62.982482] Dynamic subtest all-engines: SUCCESS (0.060s) [62.983864] Subtest busy: SUCCESS (0.060s) [63.358866] [014/171] (944s left) gem_close_race (basic-process) [63.493117] Starting subtest: basic-process [63.568845] Subtest basic-process: SUCCESS (0.075s) [63.760572] [015/171] (944s left) gem_close_race (basic-threads) [63.894545] Starting subtest: basic-threads [65.059121] Subtest basic-threads: SUCCESS (1.164s) [65.270208] [016/171] (942s left) gem_ctx_create (basic) [65.421160] Starting subtest: basic [65.422503] Subtest basic: SUCCESS (0.000s) [65.626732] [017/171] (942s left) gem_ctx_create (basic-files) [65.752332] Starting subtest: basic-files [67.773185] Subtest basic-files: SUCCESS (2.021s) [67.990329] [018/171] (940s left) gem_ctx_exec (basic) [68.118186] Starting subtest: basic [68.123209] Subtest basic: SUCCESS (0.005s) [68.226312] [019/171] (939s left) gem_exec_basic (basic) [68.347178] Starting subtest: basic [68.348307] Starting dynamic subtest: rcs0-smem [68.349336] Dynamic subtest rcs0-smem: SUCCESS (0.002s) [68.360207] Starting dynamic subtest: bcs0-smem [68.361377] Dynamic subtest bcs0-smem: SUCCESS (0.001s) [68.371344] Starting dynamic subtest: vcs0-smem [68.372534] Dynamic subtest vcs0-smem: SUCCESS (0.001s) [68.382489] Starting dynamic subtest: vecs0-smem [68.383690] Dynamic subtest vecs0-smem: SUCCESS (0.001s) [68.384986] Subtest basic: SUCCESS (0.005s) [68.542269] [020/171] (939s left) gem_exec_create (basic) [68.667280] Starting subtest: basic [68.668352] Starting dynamic subtest: smem [70.713838] Dynamic subtest smem: SUCCESS (2.046s) [70.715015] Subtest basic: SUCCESS (2.047s) [70.927907] [021/171] (937s left) gem_exec_fence (basic-busy) [71.210716] Starting subtest: basic-busy [71.212125] Starting dynamic subtest: rcs0 [71.230844] Dynamic subtest rcs0: SUCCESS (0.028s) [71.245105] Starting dynamic subtest: bcs0 [71.250593] Dynamic subtest bcs0: SUCCESS (0.020s) [71.261478] Starting dynamic subtest: vcs0 [71.272394] Dynamic subtest vcs0: SUCCESS (0.022s) [71.283121] Starting dynamic subtest: vecs0 [71.290715] Dynamic subtest vecs0: SUCCESS (0.018s) [71.292211] Subtest basic-busy: SUCCESS (0.089s) [71.876271] [022/171] (936s left) gem_exec_fence (basic-wait) [72.148093] Starting subtest: basic-wait [72.149550] Starting dynamic subtest: rcs0 [72.181871] Dynamic subtest rcs0: SUCCESS (0.041s) [72.198359] Starting dynamic subtest: bcs0 [72.201280] Dynamic subtest bcs0: SUCCESS (0.020s) [72.212797] Starting dynamic subtest: vcs0 [72.219317] Dynamic subtest vcs0: SUCCESS (0.018s) [72.230366] Starting dynamic subtest: vecs0 [72.247716] Dynamic subtest vecs0: SUCCESS (0.028s) [72.249048] Subtest basic-wait: SUCCESS (0.108s) [72.776384] [023/171] (935s left) gem_exec_fence (basic-await) [73.045743] Starting subtest: basic-await [73.046951] Starting dynamic subtest: rcs0 [73.126616] Dynamic subtest rcs0: SUCCESS (0.088s) [73.152368] Starting dynamic subtest: bcs0 [73.239646] Dynamic subtest bcs0: SUCCESS (0.112s) [73.265552] Starting dynamic subtest: vcs0 [73.359881] Dynamic subtest vcs0: SUCCESS (0.120s) [73.386210] Starting dynamic subtest: vecs0 [73.478817] Dynamic subtest vecs0: SUCCESS (0.118s) [73.481094] Subtest basic-await: SUCCESS (0.441s) [74.049350] [024/171] (934s left) gem_exec_fence (nb-await) [74.318165] Starting subtest: nb-await [74.319378] Starting dynamic subtest: rcs0 [74.376778] Dynamic subtest rcs0: SUCCESS (0.066s) [74.398891] Starting dynamic subtest: bcs0 [74.447961] Dynamic subtest bcs0: SUCCESS (0.070s) [74.474858] Starting dynamic subtest: vcs0 [74.521206] Dynamic subtest vcs0: SUCCESS (0.073s) [74.549216] Starting dynamic subtest: vecs0 [74.592906] Dynamic subtest vecs0: SUCCESS (0.071s) [74.594975] Subtest nb-await: SUCCESS (0.283s) [75.180034] [025/171] (932s left) gem_exec_gttfill (basic) [75.307383] Starting subtest: basic [82.699486] Subtest basic: SUCCESS (7.384s) [82.881877] [026/171] (925s left) gem_exec_parallel (engines) [83.078785] Starting subtest: engines [83.080061] Starting dynamic subtest: basic [85.456384] Dynamic subtest basic: SUCCESS (2.356s) [85.468616] Starting dynamic subtest: contexts [88.861757] Dynamic subtest contexts: SUCCESS (3.418s) [88.874112] Starting dynamic subtest: fds [93.005317] Dynamic subtest fds: SUCCESS (4.151s) [93.035980] Starting dynamic subtest: userptr [95.468469] Dynamic subtest userptr: SUCCESS (2.445s) [95.469883] Subtest engines: SUCCESS (12.371s) [95.670623] [027/171] (912s left) gem_exec_store (basic) [95.799577] Starting subtest: basic [95.850959] Subtest basic: SUCCESS (0.051s) [96.045138] [028/171] (912s left) gem_flink_basic (bad-flink) [96.156700] Starting subtest: bad-flink [96.157866] Subtest bad-flink: SUCCESS (0.000s) [96.228626] [029/171] (912s left) gem_flink_basic (bad-open) [96.338686] Starting subtest: bad-open [96.339888] Subtest bad-open: SUCCESS (0.000s) [96.410618] [030/171] (911s left) gem_flink_basic (basic) [96.522063] Starting subtest: basic [96.523383] Subtest basic: SUCCESS (0.000s) [96.610579] [031/171] (911s left) gem_flink_basic (double-flink) [96.723135] Starting subtest: double-flink [96.724178] Subtest double-flink: SUCCESS (0.000s) [96.827341] [032/171] (911s left) gem_flink_basic (flink-lifetime) [96.937831] Starting subtest: flink-lifetime [96.939064] Subtest flink-lifetime: SUCCESS (0.002s) [97.048137] [033/171] (911s left) gem_huc_copy (huc-copy) [97.165995] Starting subtest: huc-copy [97.168216] Subtest huc-copy: SKIP (0.000s) [97.277512] [034/171] (911s left) gem_linear_blits (basic) [97.546949] Starting subtest: basic [97.558864] Subtest basic: SUCCESS (0.012s) [97.678819] [035/171] (910s left) gem_mmap (basic) [97.857800] Starting subtest: basic [97.862983] Subtest basic: SUCCESS (0.001s) [97.961091] [036/171] (910s left) gem_mmap_gtt (basic) [98.073922] Starting subtest: basic [98.075331] Subtest basic: SUCCESS (0.001s) [98.162322] [037/171] (910s left) gem_render_linear_blits (basic) [98.279157] Starting subtest: basic [98.328457] Subtest basic: SUCCESS (0.049s) [98.397445] [038/171] (910s left) gem_render_tiled_blits (basic) [98.516410] Starting subtest: basic [98.576851] Subtest basic: SUCCESS (0.060s) [98.628912] [039/171] (909s left) gem_ringfill (basic-all) [98.887942] Starting subtest: basic-all [100.132396] Subtest basic-all: SUCCESS (1.236s) [100.212137] [040/171] (908s left) gem_softpin (allocator-basic) [100.335451] Starting subtest: allocator-basic [100.500837] Subtest allocator-basic: SUCCESS (0.157s) [100.614120] [041/171] (907s left) gem_softpin (allocator-basic-reserve) [100.742694] Starting subtest: allocator-basic-reserve [100.900486] Subtest allocator-basic-reserve: SUCCESS (0.151s) [101.011962] [042/171] (907s left) gem_softpin (safe-alignment) [101.146810] Starting subtest: safe-alignment [101.164305] Subtest safe-alignment: SUCCESS (0.017s) [101.278549] [043/171] (907s left) gem_sync (basic-all) [101.406557] Starting subtest: basic-all [103.888642] Subtest basic-all: SUCCESS (2.483s) [104.103610] [044/171] (904s left) gem_sync (basic-each) [104.233523] Starting subtest: basic-each [106.467228] Subtest basic-each: SUCCESS (2.233s) [106.690024] [045/171] (901s left) gem_tiled_blits (basic) [106.956578] Starting subtest: basic [106.987935] Subtest basic: SUCCESS (0.031s) [107.114061] [046/171] (901s left) gem_tiled_fence_blits (basic) [107.456485] Starting subtest: basic [107.482859] Subtest basic: SUCCESS (0.027s) [107.627308] [047/171] (901s left) gem_tiled_pread_basic [108.146151] [048/171] (900s left) gem_wait (busy@all-engines) [108.276526] Starting subtest: busy [108.277751] Starting dynamic subtest: all-engines [108.803749] Dynamic subtest all-engines: SUCCESS (0.527s) [108.804959] Subtest busy: SUCCESS (0.527s) [109.046379] [049/171] (899s left) gem_wait (wait@all-engines) [109.175148] Starting subtest: wait [109.176344] Starting dynamic subtest: all-engines [110.226192] Dynamic subtest all-engines: SUCCESS (1.050s) [110.228075] Subtest wait: SUCCESS (1.051s) [110.463119] [050/171] (898s left) i915_getparams_basic (basic-eu-total) [110.572528] Starting subtest: basic-eu-total [110.574833] Subtest basic-eu-total: SUCCESS (0.000s) [110.645118] [051/171] (898s left) i915_getparams_basic (basic-subslice-total) [110.754526] Starting subtest: basic-subslice-total [110.756793] Subtest basic-subslice-total: SUCCESS (0.000s) [110.827967] [052/171] (897s left) i915_hangman (error-state-basic) [110.951487] Starting subtest: error-state-basic [110.965714] Subtest error-state-basic: SUCCESS (0.013s) [111.044867] [053/171] (897s left) i915_pciid [111.228469] [054/171] (897s left) kms_addfb_basic (addfb25-bad-modifier) [111.372263] Starting subtest: addfb25-bad-modifier [111.373326] Subtest addfb25-bad-modifier: SUCCESS (0.000s) [111.511316] [055/171] (897s left) kms_addfb_basic (addfb25-framebuffer-vs-set-tiling) [111.649733] Starting subtest: addfb25-framebuffer-vs-set-tiling [111.650833] Subtest addfb25-framebuffer-vs-set-tiling: SUCCESS (0.000s) [111.795102] [056/171] (897s left) kms_addfb_basic (addfb25-modifier-no-flag) [111.932138] Starting subtest: addfb25-modifier-no-flag [111.933182] Subtest addfb25-modifier-no-flag: SUCCESS (0.000s) [112.078121] [057/171] (896s left) kms_addfb_basic (addfb25-x-tiled-legacy) [112.214744] Starting subtest: addfb25-x-tiled-legacy [112.215912] Subtest addfb25-x-tiled-legacy: SUCCESS (0.000s) [112.361937] [058/171] (896s left) kms_addfb_basic (addfb25-x-tiled-mismatch-legacy) [112.497885] Starting subtest: addfb25-x-tiled-mismatch-legacy [112.499232] Subtest addfb25-x-tiled-mismatch-legacy: SUCCESS (0.000s) [112.644671] [059/171] (896s left) kms_addfb_basic (addfb25-yf-tiled-legacy) [112.806608] Starting subtest: addfb25-yf-tiled-legacy [112.807731] Subtest addfb25-yf-tiled-legacy: SUCCESS (0.000s) [112.928270] [060/171] (896s left) kms_addfb_basic (addfb25-y-tiled-legacy) [113.089808] Starting subtest: addfb25-y-tiled-legacy [113.090853] Subtest addfb25-y-tiled-legacy: SUCCESS (0.000s) [113.211403] [061/171] (895s left) kms_addfb_basic (addfb25-y-tiled-small-legacy) [113.371203] Starting subtest: addfb25-y-tiled-small-legacy [113.372374] Subtest addfb25-y-tiled-small-legacy: SUCCESS (0.000s) [113.495153] [062/171] (895s left) kms_addfb_basic (bad-pitch-0) [113.605787] Starting subtest: bad-pitch-0 [113.607063] Subtest bad-pitch-0: SUCCESS (0.000s) [113.778203] [063/171] (895s left) kms_addfb_basic (bad-pitch-1024) [113.887226] Starting subtest: bad-pitch-1024 [113.888308] Subtest bad-pitch-1024: SUCCESS (0.000s) [114.061614] [064/171] (895s left) kms_addfb_basic (bad-pitch-128) [114.174112] Starting subtest: bad-pitch-128 [114.175385] Subtest bad-pitch-128: SUCCESS (0.000s) [114.344935] [065/171] (894s left) kms_addfb_basic (bad-pitch-256) [114.454708] Starting subtest: bad-pitch-256 [114.455981] Subtest bad-pitch-256: SUCCESS (0.000s) [114.644902] [066/171] (894s left) kms_addfb_basic (bad-pitch-32) [114.753788] Starting subtest: bad-pitch-32 [114.755050] Subtest bad-pitch-32: SUCCESS (0.000s) [114.928131] [067/171] (894s left) kms_addfb_basic (bad-pitch-63) [115.038087] Starting subtest: bad-pitch-63 [115.039228] Subtest bad-pitch-63: SUCCESS (0.000s) [115.211919] [068/171] (893s left) kms_addfb_basic (bad-pitch-65536) [115.320364] Starting subtest: bad-pitch-65536 [115.321422] Subtest bad-pitch-65536: SUCCESS (0.000s) [115.499999] [069/171] (893s left) kms_addfb_basic (bad-pitch-999) [115.609720] Starting subtest: bad-pitch-999 [115.610868] Subtest bad-pitch-999: SUCCESS (0.000s) [115.778517] [070/171] (893s left) kms_addfb_basic (basic) [115.886833] Starting subtest: basic [115.888039] Subtest basic: SUCCESS (0.000s) [116.061865] [071/171] (893s left) kms_addfb_basic (basic-x-tiled-legacy) [116.247359] Starting subtest: basic-x-tiled-legacy [116.248452] Subtest basic-x-tiled-legacy: SUCCESS (0.000s) [116.361587] [072/171] (892s left) kms_addfb_basic (basic-y-tiled-legacy) [116.546679] Starting subtest: basic-y-tiled-legacy [116.547908] Subtest basic-y-tiled-legacy: SUCCESS (0.000s) [116.644985] [073/171] (892s left) kms_addfb_basic (bo-too-small) [116.780400] Starting subtest: bo-too-small [116.781513] Subtest bo-too-small: SUCCESS (0.000s) [116.928176] [074/171] (892s left) kms_addfb_basic (bo-too-small-due-to-tiling) [117.065454] Starting subtest: bo-too-small-due-to-tiling [117.066502] Subtest bo-too-small-due-to-tiling: SUCCESS (0.000s) [117.211403] [075/171] (892s left) kms_addfb_basic (clobberred-modifier) [117.321124] Starting subtest: clobberred-modifier [117.322257] Subtest clobberred-modifier: SUCCESS (0.000s) [117.494996] [076/171] (891s left) kms_addfb_basic (framebuffer-vs-set-tiling) [117.679557] Starting subtest: framebuffer-vs-set-tiling [117.680737] Subtest framebuffer-vs-set-tiling: SUCCESS (0.000s) [117.778526] [077/171] (891s left) kms_addfb_basic (invalid-get-prop) [117.964214] Starting subtest: invalid-get-prop [117.965380] Subtest invalid-get-prop: SUCCESS (0.000s) [118.061519] [078/171] (891s left) kms_addfb_basic (invalid-get-prop-any) [118.247811] Starting subtest: invalid-get-prop-any [118.248949] Subtest invalid-get-prop-any: SUCCESS (0.000s) [118.328570] [079/171] (891s left) kms_addfb_basic (invalid-set-prop) [118.514337] Starting subtest: invalid-set-prop [118.515456] Subtest invalid-set-prop: SUCCESS (0.000s) [118.611750] [080/171] (890s left) kms_addfb_basic (invalid-set-prop-any) [118.797271] Starting subtest: invalid-set-prop-any [118.798315] Subtest invalid-set-prop-any: SUCCESS (0.000s) [118.895080] [081/171] (890s left) kms_addfb_basic (no-handle) [119.004761] Starting subtest: no-handle [119.006042] Subtest no-handle: SUCCESS (0.000s) [119.178310] [082/171] (890s left) kms_addfb_basic (size-max) [119.314416] Starting subtest: size-max [119.315445] Subtest size-max: SUCCESS (0.000s) [119.461817] [083/171] (890s left) kms_addfb_basic (small-bo) [119.597790] Starting subtest: small-bo [119.598837] Subtest small-bo: SUCCESS (0.000s) [119.754540] [084/171] (889s left) kms_addfb_basic (tile-pitch-mismatch) [119.940457] Starting subtest: tile-pitch-mismatch [119.941637] Subtest tile-pitch-mismatch: SUCCESS (0.000s) [120.045104] [085/171] (889s left) kms_addfb_basic (too-high) [120.181547] Starting subtest: too-high [120.182699] Subtest too-high: SUCCESS (0.001s) [120.328165] [086/171] (889s left) kms_addfb_basic (too-wide) [120.464569] Starting subtest: too-wide [120.465718] Subtest too-wide: SUCCESS (0.000s) [120.611598] [087/171] (889s left) kms_addfb_basic (unused-handle) [120.720920] Starting subtest: unused-handle [120.722249] Subtest unused-handle: SUCCESS (0.000s) [120.894821] [088/171] (888s left) kms_addfb_basic (unused-modifier) [121.004751] Starting subtest: unused-modifier [121.005909] Subtest unused-modifier: SUCCESS (0.000s) [121.178415] [089/171] (888s left) kms_addfb_basic (unused-offsets) [121.288682] Starting subtest: unused-offsets [121.289863] Subtest unused-offsets: SUCCESS (0.000s) [121.461491] [090/171] (888s left) kms_addfb_basic (unused-pitches) [121.571947] Starting subtest: unused-pitches [121.573127] Subtest unused-pitches: SUCCESS (0.000s) [121.745304] [091/171] (888s left) kms_busy (basic) [121.894637] Starting subtest: basic [121.898214] Starting dynamic subtest: flip [122.865969] Dynamic subtest flip: SUCCESS (0.969s) [122.882246] Starting dynamic subtest: modeset [126.669730] Dynamic subtest modeset: SUCCESS (3.803s) [126.670868] Subtest basic: SUCCESS (4.774s) [127.586349] [092/171] (882s left) kms_chamelium_hpd (dp-hpd-fast) [128.036739] Subtest dp-hpd-fast: SKIP (0.000s) [128.940619] [093/171] (880s left) kms_chamelium_edid (dp-edid-read) [129.392486] Subtest dp-edid-read: SKIP (0.000s) [130.287162] [094/171] (879s left) kms_chamelium_frames (dp-crc-fast) [130.739547] Subtest dp-crc-fast: SKIP (0.000s) [131.629122] [095/171] (878s left) kms_chamelium_hpd (hdmi-hpd-fast) [132.078337] Subtest hdmi-hpd-fast: SKIP (0.000s) [132.975231] [096/171] (876s left) kms_chamelium_edid (hdmi-edid-read) [133.429588] Subtest hdmi-edid-read: SKIP (0.000s) [134.318193] [097/171] (875s left) kms_chamelium_frames (hdmi-crc-fast) [134.769658] Subtest hdmi-crc-fast: SKIP (0.000s) [135.663240] [098/171] (874s left) kms_chamelium_hpd (vga-hpd-fast) [136.113903] Subtest vga-hpd-fast: SKIP (0.000s) [137.007103] [099/171] (872s left) kms_chamelium_edid (vga-edid-read) [137.461318] Subtest vga-edid-read: SKIP (0.000s) [138.352091] [100/171] (871s left) kms_prop_blob (basic) [138.463868] Starting subtest: basic [138.465166] Subtest basic: SUCCESS (0.000s) [138.552999] [101/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic) [138.691229] Starting subtest: basic-busy-flip-before-cursor-atomic [138.693334] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s) [138.765477] [102/171] (871s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy) [138.902349] Starting subtest: basic-busy-flip-before-cursor-legacy [138.904436] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s) [138.981853] [103/171] (871s left) kms_cursor_legacy (basic-flip-after-cursor-atomic) [139.118919] Starting subtest: basic-flip-after-cursor-atomic [140.412368] Subtest basic-flip-after-cursor-atomic: SUCCESS (1.294s) [141.344452] [104/171] (868s left) kms_cursor_legacy (basic-flip-after-cursor-legacy) [141.481865] Starting subtest: basic-flip-after-cursor-legacy [142.762260] Subtest basic-flip-after-cursor-legacy: SUCCESS (1.280s) [143.713501] [105/171] (866s left) kms_cursor_legacy (basic-flip-after-cursor-varying-size) [143.853087] Starting subtest: basic-flip-after-cursor-varying-size [145.140669] Subtest basic-flip-after-cursor-varying-size: SUCCESS (1.289s) [146.079208] [106/171] (864s left) kms_cursor_legacy (basic-flip-before-cursor-atomic) [146.218968] Starting subtest: basic-flip-before-cursor-atomic [147.509074] Subtest basic-flip-before-cursor-atomic: SUCCESS (1.291s) [148.448115] [107/171] (861s left) kms_cursor_legacy (basic-flip-before-cursor-legacy) [148.587342] Starting subtest: basic-flip-before-cursor-legacy [149.876203] Subtest basic-flip-before-cursor-legacy: SUCCESS (1.289s) [150.816660] [108/171] (859s left) kms_cursor_legacy (basic-flip-before-cursor-varying-size) [150.956070] Starting subtest: basic-flip-before-cursor-varying-size [152.245297] Subtest basic-flip-before-cursor-varying-size: SUCCESS (1.289s) [153.182788] [109/171] (857s left) kms_flip (basic-flip-vs-dpms) [153.303175] Starting subtest: basic-flip-vs-dpms [153.306537] Starting dynamic subtest: A-eDP1 [156.190284] Dynamic subtest A-eDP1: SUCCESS (2.884s) [156.206331] Starting dynamic subtest: B-eDP1 [158.569054] Dynamic subtest B-eDP1: SUCCESS (2.366s) [158.582913] Starting dynamic subtest: C-eDP1 [160.923478] Dynamic subtest C-eDP1: SUCCESS (2.365s) [160.934222] Subtest basic-flip-vs-dpms: SUCCESS (7.623s) [161.888038] [110/171] (848s left) kms_flip (basic-flip-vs-modeset) [162.008341] Starting subtest: basic-flip-vs-modeset [162.011378] Starting dynamic subtest: A-eDP1 [164.888150] Dynamic subtest A-eDP1: SUCCESS (2.876s) [164.904681] Starting dynamic subtest: B-eDP1 [167.241576] Dynamic subtest B-eDP1: SUCCESS (2.353s) [167.259086] Starting dynamic subtest: C-eDP1 [169.628496] Dynamic subtest C-eDP1: SUCCESS (2.386s) [169.629617] Subtest basic-flip-vs-modeset: SUCCESS (7.622s) [170.590142] [111/171] (839s left) kms_flip (basic-flip-vs-wf_vblank) [170.710747] Starting subtest: basic-flip-vs-wf_vblank [170.713897] Starting dynamic subtest: A-eDP1 [173.062649] Dynamic subtest A-eDP1: SUCCESS (2.349s) [173.078448] Starting dynamic subtest: B-eDP1 [175.345681] Dynamic subtest B-eDP1: SUCCESS (2.282s) [175.361532] Starting dynamic subtest: C-eDP1 [177.587087] Dynamic subtest C-eDP1: SUCCESS (2.241s) [177.589554] Subtest basic-flip-vs-wf_vblank: SUCCESS (6.880s) [178.846341] [112/171] (831s left) kms_flip (basic-plain-flip) [178.966038] Starting subtest: basic-plain-flip [178.969368] Starting dynamic subtest: A-eDP1 [181.031501] Dynamic subtest A-eDP1: SUCCESS (2.063s) [181.047250] Starting dynamic subtest: B-eDP1 [182.994499] Dynamic subtest B-eDP1: SUCCESS (1.962s) [183.010455] Starting dynamic subtest: C-eDP1 [184.982984] Dynamic subtest C-eDP1: SUCCESS (1.988s) [184.985527] Subtest basic-plain-flip: SUCCESS (6.021s) [186.271723] [113/171] (824s left) kms_force_connector_basic (force-connector-state) [186.389920] Starting subtest: force-connector-state [188.076412] Subtest force-connector-state: SUCCESS (1.687s) [188.681111] [114/171] (821s left) kms_force_connector_basic (force-edid) [188.799646] Starting subtest: force-edid [189.049705] Subtest force-edid: SUCCESS (0.251s) [189.164127] [115/171] (821s left) kms_force_connector_basic (force-load-detect) [189.281500] Starting subtest: force-load-detect [189.283726] Subtest force-load-detect: SKIP (0.000s) [189.397585] [116/171] (821s left) kms_force_connector_basic (prune-stale-modes) [189.513893] Starting subtest: prune-stale-modes [189.819894] Subtest prune-stale-modes: SUCCESS (0.307s) [189.931191] [117/171] (820s left) kms_frontbuffer_tracking (basic) [190.077313] Starting subtest: basic [193.382132] Subtest basic: SUCCESS (3.304s) [193.482621] [118/171] (816s left) kms_pipe_crc_basic (compare-crc-sanitycheck) [193.626216] Starting subtest: compare-crc-sanitycheck [193.629281] Starting dynamic subtest: pipe-A-eDP-1 [194.320072] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.687s) [194.335679] Starting dynamic subtest: pipe-B-eDP-1 [195.667254] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.347s) [195.683348] Starting dynamic subtest: pipe-C-eDP-1 [197.222267] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.552s) [197.223345] Subtest compare-crc-sanitycheck: SUCCESS (3.595s) [198.187703] [119/171] (812s left) kms_pipe_crc_basic (hang-read-crc) [198.337848] Starting subtest: hang-read-crc [198.339045] Starting dynamic subtest: pipe-A-eDP-1 [200.657929] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.317s) [200.673504] Starting dynamic subtest: pipe-B-eDP-1 [203.627332] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.968s) [203.643825] Starting dynamic subtest: pipe-C-eDP-1 [206.949521] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.318s) [206.950799] Subtest hang-read-crc: SUCCESS (8.612s) [207.897780] [120/171] (802s left) kms_pipe_crc_basic (nonblocking-crc) [208.039435] Starting subtest: nonblocking-crc [208.042523] Starting dynamic subtest: pipe-A-eDP-1 [208.909386] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.867s) [208.927683] Starting dynamic subtest: pipe-B-eDP-1 [210.460575] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.547s) [210.476398] Starting dynamic subtest: pipe-C-eDP-1 [212.160377] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.698s) [212.161569] Subtest nonblocking-crc: SUCCESS (4.121s) [213.082097] [121/171] (797s left) kms_pipe_crc_basic (nonblocking-crc-frame-sequence) [213.224061] Starting subtest: nonblocking-crc-frame-sequence [213.225232] Starting dynamic subtest: pipe-A-eDP-1 [214.077597] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.851s) [214.095557] Starting dynamic subtest: pipe-B-eDP-1 [215.632405] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.553s) [215.650057] Starting dynamic subtest: pipe-C-eDP-1 [217.345283] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.708s) [217.346422] Subtest nonblocking-crc-frame-sequence: SUCCESS (4.120s) [218.266797] [122/171] (792s left) kms_pipe_crc_basic (read-crc) [218.408842] Starting subtest: read-crc [218.412255] Starting dynamic subtest: pipe-A-eDP-1 [219.210229] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.799s) [219.227863] Starting dynamic subtest: pipe-B-eDP-1 [220.706327] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.492s) [220.721982] Starting dynamic subtest: pipe-C-eDP-1 [222.362693] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.653s) [222.363997] Subtest read-crc: SUCCESS (3.952s) [223.322896] [123/171] (787s left) kms_pipe_crc_basic (read-crc-frame-sequence) [223.463051] Starting subtest: read-crc-frame-sequence [223.466460] Starting dynamic subtest: pipe-A-eDP-1 [224.250695] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.785s) [224.267016] Starting dynamic subtest: pipe-B-eDP-1 [225.724592] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.470s) [225.740409] Starting dynamic subtest: pipe-C-eDP-1 [227.362862] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.637s) [227.364078] Subtest read-crc-frame-sequence: SUCCESS (3.901s) [228.315086] [124/171] (782s left) kms_psr (primary_page_flip) [228.458612] Starting subtest: primary_page_flip [232.763383] Subtest primary_page_flip: SUCCESS (4.282s) [233.691296] [125/171] (776s left) kms_psr (cursor_plane_move) [233.831710] Starting subtest: cursor_plane_move [237.992836] Subtest cursor_plane_move: SUCCESS (4.160s) [238.939320] [126/171] (771s left) kms_psr (sprite_plane_onoff) [239.083299] Starting subtest: sprite_plane_onoff [243.328152] Subtest sprite_plane_onoff: SUCCESS (4.246s) [244.251391] [127/171] (766s left) kms_psr (primary_mmap_gtt) [244.394404] Starting subtest: primary_mmap_gtt [248.656545] Subtest primary_mmap_gtt: SUCCESS (4.262s) [249.563039] [128/171] (761s left) kms_setmode (basic-clone-single-crtc) [249.676835] Starting subtest: basic-clone-single-crtc [249.680386] Subtest basic-clone-single-crtc: SKIP (0.000s) [249.763063] [129/171] (760s left) i915_pm_backlight (basic-brightness) [249.902420] Starting subtest: basic-brightness [250.028277] Starting dynamic subtest: eDP-1 [250.575749] Dynamic subtest eDP-1: SUCCESS (0.561s) [250.577194] Subtest basic-brightness: SUCCESS (0.674s) [251.494846] [130/171] (759s left) i915_pm_rpm (basic-pci-d3-state) [253.353952] Starting subtest: basic-pci-d3-state [257.725645] Subtest basic-pci-d3-state: SUCCESS (4.364s) [257.919210] [131/171] (752s left) i915_pm_rpm (basic-rte) [258.036760] Starting subtest: basic-rte [264.187548] Subtest basic-rte: SUCCESS (6.145s) [269.489621] [132/171] (741s left) i915_pm_rps (basic-api) [269.608943] Starting subtest: basic-api [269.613518] Subtest basic-api: SUCCESS (0.005s) [269.705696] [133/171] (741s left) prime_self_import (basic-llseek-bad) [269.817857] Starting subtest: basic-llseek-bad [269.819260] Subtest basic-llseek-bad: SUCCESS (0.003s) [269.921363] [134/171] (740s left) prime_self_import (basic-llseek-size) [270.030401] Starting subtest: basic-llseek-size [270.034031] Subtest basic-llseek-size: SUCCESS (0.004s) [270.144142] [135/171] (740s left) prime_self_import (basic-with_fd_dup) [270.251944] Starting subtest: basic-with_fd_dup [270.257414] Subtest basic-with_fd_dup: SUCCESS (0.004s) [270.359924] [136/171] (740s left) prime_self_import (basic-with_one_bo) [270.469859] Starting subtest: basic-with_one_bo [270.474400] Subtest basic-with_one_bo: SUCCESS (0.005s) [270.557152] [137/171] (740s left) prime_self_import (basic-with_one_bo_two_files) [270.665964] Starting subtest: basic-with_one_bo_two_files [270.671430] Subtest basic-with_one_bo_two_files: SUCCESS (0.003s) [270.777158] [138/171] (740s left) prime_self_import (basic-with_two_bos) [270.887015] Starting subtest: basic-with_two_bos [270.892466] Subtest basic-with_two_bos: SUCCESS (0.004s) [270.994292] [139/171] (740s left) prime_vgem (basic-fence-flip) [271.136852] Starting subtest: basic-fence-flip [271.655028] Subtest basic-fence-flip: SUCCESS (0.516s) [271.774849] [140/171] (739s left) prime_vgem (basic-fence-mmap) [271.911808] Starting subtest: basic-fence-mmap [271.954129] Subtest basic-fence-mmap: SUCCESS (0.042s) [272.041490] [141/171] (739s left) prime_vgem (basic-fence-read) [272.178338] Starting subtest: basic-fence-read [272.245282] Subtest basic-fence-read: SUCCESS (0.067s) [272.327300] [142/171] (738s left) prime_vgem (basic-gtt) [272.461602] Starting subtest: basic-gtt [272.483983] Subtest basic-gtt: SUCCESS (0.022s) [272.593529] [143/171] (738s left) prime_vgem (basic-read) [272.733138] Starting subtest: basic-read [272.766963] Subtest basic-read: SUCCESS (0.034s) [272.872388] [144/171] (738s left) prime_vgem (basic-write) [272.994514] Starting subtest: basic-write [273.034828] Subtest basic-write: SUCCESS (0.040s) [273.125845] [145/171] (738s left) prime_vgem (basic-userptr) [273.270303] Starting subtest: basic-userptr [273.283099] Subtest basic-userptr: SKIP (0.014s) [273.398336] [146/171] (737s left) vgem_basic (setversion) [273.520898] Starting subtest: setversion [273.523568] Subtest setversion: SUCCESS (0.000s) [273.592187] [147/171] (737s left) vgem_basic (create) [273.721522] Starting subtest: create [273.723220] Subtest create: SUCCESS (0.000s) [273.793454] [148/171] (737s left) vgem_basic (debugfs) [273.920543] Starting subtest: debugfs [273.921776] Subtest debugfs: SUCCESS (0.001s) [273.992058] [149/171] (737s left) vgem_basic (dmabuf-export) [274.121063] Starting subtest: dmabuf-export [274.124733] Subtest dmabuf-export: SUCCESS (0.003s) [274.227056] [150/171] (737s left) vgem_basic (dmabuf-fence) [274.355754] Starting subtest: dmabuf-fence [274.356934] Subtest dmabuf-fence: SUCCESS (0.001s) [274.422590] [151/171] (736s left) vgem_basic (dmabuf-fence-before) [274.555760] Starting subtest: dmabuf-fence-before [274.557161] Subtest dmabuf-fence-before: SUCCESS (0.001s) [274.622729] [152/171] (736s left) vgem_basic (dmabuf-mmap) [274.756150] Starting subtest: dmabuf-mmap [274.781265] Subtest dmabuf-mmap: SUCCESS (0.026s) [274.855950] [153/171] (736s left) vgem_basic (mmap) [274.988903] Starting subtest: mmap [275.004909] Subtest mmap: SUCCESS (0.017s) [275.072235] [154/171] (736s left) vgem_basic (second-client) [275.205772] Starting subtest: second-client [275.255482] Subtest second-client: SUCCESS (0.049s) [275.322832] [155/171] (736s left) vgem_basic (sysfs) [275.455807] Starting subtest: sysfs [275.457033] Subtest sysfs: SUCCESS (0.001s) [275.522132] [156/171] (735s left) core_hotunplug (unbind-rebind) [275.672622] Starting subtest: unbind-rebind [278.051416] Subtest unbind-rebind: SUCCESS (2.380s) [278.083637] [157/171] (733s left) vgem_basic (unload) [278.208075] Starting subtest: unload [307.012295] Subtest unload: SUCCESS (28.795s) [307.139913] [158/171] (704s left) i915_module_load (reload) [307.252754] Starting subtest: reload [310.414284] Subtest reload: SUCCESS (3.161s) [310.441691] [159/171] (701s left) gem_lmem_swapping (basic) [310.573545] Subtest basic: SKIP (0.000s) [310.614718] [160/171] (700s left) gem_lmem_swapping (parallel-random-engines) [310.737506] Subtest parallel-random-engines: SKIP (0.000s) [310.781032] [161/171] (700s left) gem_lmem_swapping (random-engines) [310.922357] Subtest random-engines: SKIP (0.000s) [310.965778] [162/171] (700s left) gem_lmem_swapping (verify-random) [311.087155] Subtest verify-random: SKIP (0.000s) [311.131485] [163/171] (700s left) i915_pm_rpm (module-reload) [323.617373] Starting subtest: module-reload [357.733810] Subtest module-reload: SUCCESS (34.108s) [357.752696] [164/171] (653s left) i915_selftest (live) [357.878732] Starting subtest: live [357.880122] Starting dynamic subtest: sanitycheck [359.709402] Dynamic subtest sanitycheck: SUCCESS (1.823s) [359.723803] Starting dynamic subtest: uncore [361.492451] Dynamic subtest uncore: SUCCESS (1.782s) [361.506581] Starting dynamic subtest: workarounds [363.499544] Dynamic subtest workarounds: SUCCESS (2.006s) [363.513972] Starting dynamic subtest: gt_engines [365.731407] Dynamic subtest gt_engines: SUCCESS (2.231s) [365.745684] Starting dynamic subtest: gt_timelines [377.613790] Dynamic subtest gt_timelines: SUCCESS (11.881s) [377.628052] Starting dynamic subtest: gt_contexts [379.476601] Dynamic subtest gt_contexts: SUCCESS (1.862s) [379.490814] Starting dynamic subtest: gt_lrc [383.782432] Dynamic subtest gt_lrc: SUCCESS (4.305s) [383.796785] Starting dynamic subtest: gt_mocs [385.628457] Dynamic subtest gt_mocs: SUCCESS (1.845s) [385.642845] Starting dynamic subtest: gt_pm [390.635894] Dynamic subtest gt_pm: SUCCESS (5.006s) [390.650326] Starting dynamic subtest: gt_heartbeat [392.473556] Dynamic subtest gt_heartbeat: SUCCESS (1.837s) [392.487954] Starting dynamic subtest: requests [400.007633] Dynamic subtest requests: SUCCESS (7.533s) [400.022241] Starting dynamic subtest: migrate [404.544614] Dynamic subtest migrate: SUCCESS (4.536s) [404.559043] Starting dynamic subtest: active [406.298518] Dynamic subtest active: SUCCESS (1.753s) [406.312998] Starting dynamic subtest: objects [409.623474] Dynamic subtest objects: SUCCESS (3.324s) [409.637867] Starting dynamic subtest: mman [416.505600] Dynamic subtest mman: SUCCESS (6.881s) [416.520175] Starting dynamic subtest: dmabuf [418.348556] Dynamic subtest dmabuf: SUCCESS (1.842s) [418.362931] Starting dynamic subtest: vma [420.184484] Dynamic subtest vma: SUCCESS (1.835s) [420.198936] Starting dynamic subtest: coherency [424.558435] Dynamic subtest coherency: SUCCESS (4.373s) [424.573027] Starting dynamic subtest: gtt [435.638575] Dynamic subtest gtt: SUCCESS (11.079s) [435.653062] Starting dynamic subtest: gem [437.569437] Dynamic subtest gem: SUCCESS (1.930s) [437.584085] Starting dynamic subtest: evict [441.185454] Dynamic subtest evict: SUCCESS (3.615s) [441.199897] Starting dynamic subtest: hugepages [447.991528] Dynamic subtest hugepages: SUCCESS (6.805s) [448.006364] Starting dynamic subtest: gem_contexts [462.917598] Dynamic subtest gem_contexts: SUCCESS (14.925s) [462.932411] Starting dynamic subtest: client [464.739505] Dynamic subtest client: SUCCESS (1.821s) [464.754393] Starting dynamic subtest: gem_migrate [466.510567] Dynamic subtest gem_migrate: SUCCESS (1.770s) [466.525502] Starting dynamic subtest: reset [471.860812] Dynamic subtest reset: SUCCESS (5.349s) [471.875822] Starting dynamic subtest: memory_region [473.614553] Dynamic subtest memory_region: SUCCESS (1.753s) [473.629401] Starting dynamic subtest: hangcheck [497.953825] Dynamic subtest hangcheck: SUCCESS (24.338s) [497.968880] Starting dynamic subtest: execlists [507.803578] Dynamic subtest execlists: SUCCESS (9.849s) [507.818557] Starting dynamic subtest: ring_submission [509.591867] Dynamic subtest ring_submission: SUCCESS (1.787s) [509.606886] Starting dynamic subtest: perf [511.453765] Dynamic subtest perf: SUCCESS (1.861s) [511.469690] Starting dynamic subtest: slpc [513.233613] Dynamic subtest slpc: SUCCESS (1.779s) [513.248666] Starting dynamic subtest: guc [514.969517] Dynamic subtest guc: SUCCESS (1.735s) [514.984621] Starting dynamic subtest: guc_multi_lrc [516.749562] Dynamic subtest guc_multi_lrc: SUCCESS (1.779s) [516.764576] Starting dynamic subtest: guc_hang [518.497547] Dynamic subtest guc_hang: SUCCESS (1.747s) [518.512531] Starting dynamic subtest: late_gt_pm [520.275451] Dynamic subtest late_gt_pm: SUCCESS (1.777s) [520.276694] Subtest live: SUCCESS (162.390s) [520.357900] [165/171] (491s left) dmabuf (all-tests) [520.478304] Starting subtest: all-tests [520.480120] Starting dynamic subtest: sanitycheck [520.512184] Dynamic subtest sanitycheck: SUCCESS (0.033s) [520.526370] Starting dynamic subtest: dma_fence [520.650814] Dynamic subtest dma_fence: SUCCESS (0.138s) [520.662376] Starting dynamic subtest: dma_fence_chain [538.031245] Dynamic subtest dma_fence_chain: SUCCESS (17.371s) [538.044276] Starting dynamic subtest: dma_fence_unwrap [538.051468] Dynamic subtest dma_fence_unwrap: SUCCESS (0.028s) [538.063629] Starting dynamic subtest: dma_resv [538.078609] Dynamic subtest dma_resv: SUCCESS (0.026s) [538.079833] Subtest all-tests: SUCCESS (17.601s) [538.103321] [166/171] (473s left) i915_suspend (basic-s2idle-without-i915) [538.212766] Starting subtest: basic-s2idle-without-i915 [561.166897] Subtest basic-s2idle-without-i915: SUCCESS (8.063s) [561.509021] [167/171] (465s left) i915_suspend (basic-s3-without-i915) [561.625089] Starting subtest: basic-s3-without-i915 [584.234579] Subtest basic-s3-without-i915: SUCCESS (6.842s) [584.537293] [168/171] (457s left) gem_exec_suspend (basic-s0) [584.672362] Starting subtest: basic-S0 [584.673584] Starting dynamic subtest: smem [603.280689] Dynamic subtest smem: SUCCESS (3.628s) [603.281775] Subtest basic-S0: SUCCESS (3.629s) [603.432562] [169/171] (454s left) gem_exec_suspend (basic-s3) [603.559822] Starting subtest: basic-S3 [603.561029] Starting dynamic subtest: smem [622.265161] Dynamic subtest smem: SUCCESS (3.489s) [622.266233] Subtest basic-S3: SUCCESS (3.490s) [622.412677] [170/171] (450s left) kms_chamelium_hpd (common-hpd-after-suspend) [622.873825] Subtest common-hpd-after-suspend: SKIP (0.000s) [623.774550] [171/171] (448s left) kms_pipe_crc_basic (suspend-read-crc) [623.917872] Starting subtest: suspend-read-crc [623.918962] Starting dynamic subtest: pipe-A-eDP-1 [641.263587] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.408s) [641.282655] Starting dynamic subtest: pipe-B-eDP-1 [659.239075] Dynamic subtest pipe-B-eDP-1: SUCCESS (3.069s) [659.259689] Starting dynamic subtest: pipe-C-eDP-1 [678.219651] Dynamic subtest pipe-C-eDP-1: SUCCESS (3.204s) [678.220830] Subtest suspend-read-crc: SUCCESS (8.690s) [679.112897] Closing watchdogs Done.